builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0221 starttime: 1493153325.95 results: success (0) buildid: 20170425121527 builduid: 02063c45b9d643b19f6cfac5abf7918c revision: 872f6a669f11224a26f0e71e81bec4e9d723b450 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:45.948006) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:45.948491) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:45.948836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:45.989291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-25 13:48:45.989639) ========= 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.gLLs9PSvL8/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.rlce0fmAhD/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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-25 13:48:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.1M=0.001s 2017-04-25 13:48:46 (22.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116647 ========= master_lag: 3.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-25 13:48:49.523225) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:49.523571) ========= 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.gLLs9PSvL8/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.rlce0fmAhD/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.026823 ========= master_lag: 0.47 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:50.020402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 13:48:50.020774) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 872f6a669f11224a26f0e71e81bec4e9d723b450 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 872f6a669f11224a26f0e71e81bec4e9d723b450 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gLLs9PSvL8/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.rlce0fmAhD/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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-25 13:48:50,134 truncating revision to first 12 chars 2017-04-25 13:48:50,134 Setting DEBUG logging. 2017-04-25 13:48:50,134 attempt 1/10 2017-04-25 13:48:50,134 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/872f6a669f11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 13:48:51,944 unpacking tar archive at: mozilla-beta-872f6a669f11/testing/mozharness/ program finished with exit code 0 elapsedTime=2.104499 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-25 13:48:52.150919) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:52.151312) ========= script_repo_revision: 872f6a669f11224a26f0e71e81bec4e9d723b450 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:52.151816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:52.152138) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 13:48:52.174351) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-04-25 13:48:52.174895) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gLLs9PSvL8/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.rlce0fmAhD/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:48:52 INFO - MultiFileLogger online at 20170425 13:48:52 in /builds/slave/test 13:48:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:48:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:52 INFO - {'append_to_log': False, 13:48:52 INFO - 'base_work_dir': '/builds/slave/test', 13:48:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:48:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:52 INFO - 'branch': 'Mozilla-Beta', 13:48:52 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:52 INFO - 'config_files': ('talos/mac_config.py',), 13:48:52 INFO - 'default_actions': ('clobber', 13:48:52 INFO - 'read-buildbot-config', 13:48:52 INFO - 'download-and-extract', 13:48:52 INFO - 'populate-webroot', 13:48:52 INFO - 'create-virtualenv', 13:48:52 INFO - 'install', 13:48:52 INFO - 'run-tests'), 13:48:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:52 INFO - 'download_minidump_stackwalk': True, 13:48:52 INFO - 'download_symbols': 'ondemand', 13:48:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:52 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:52 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:52 INFO - 'gecko_profile': False, 13:48:52 INFO - 'gecko_profile_interval': 0, 13:48:52 INFO - 'installer_path': 'installer.exe', 13:48:52 INFO - 'log_level': 'info', 13:48:52 INFO - 'log_name': 'talos', 13:48:52 INFO - 'log_to_console': True, 13:48:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:48:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:48:52 INFO - 'opt_config_files': (), 13:48:52 INFO - 'pip_index': False, 13:48:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:52 INFO - 'cmd': ('bash', 13:48:52 INFO - '-c', 13:48:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:52 INFO - 'enabled': True, 13:48:52 INFO - 'halt_on_failure': False, 13:48:52 INFO - 'name': 'check_screen_resolution'},), 13:48:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:52 INFO - 'cmd': ('bash', 13:48:52 INFO - '-c', 13:48:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:52 INFO - 'enabled': True, 13:48:52 INFO - 'halt_on_failure': False, 13:48:52 INFO - 'name': 'check_screen_resolution'},), 13:48:52 INFO - 'run_cmd_checks_enabled': True, 13:48:52 INFO - 'suite': 'dromaeojs-e10s', 13:48:52 INFO - 'system_bits': '32', 13:48:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:52 INFO - 'title': 't-yosemite-r7-0221', 13:48:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:52 INFO - 'use_talos_json': True, 13:48:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:52 INFO - 'work_dir': 'build'} 13:48:52 INFO - [mozharness: 2017-04-25 20:48:52.395611Z] Running clobber step. 13:48:52 INFO - Running pre-action listener: _resource_record_pre_action 13:48:52 INFO - Running main action method: clobber 13:48:52 INFO - rmtree: /builds/slave/test/build 13:48:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:54 INFO - Running post-action listener: _resource_record_post_action 13:48:54 INFO - [mozharness: 2017-04-25 20:48:54.959603Z] Finished clobber step (success) 13:48:54 INFO - [mozharness: 2017-04-25 20:48:54.959710Z] Running read-buildbot-config step. 13:48:54 INFO - Running pre-action listener: _resource_record_pre_action 13:48:54 INFO - Running main action method: read_buildbot_config 13:48:54 INFO - Using buildbot properties: 13:48:54 INFO - { 13:48:54 INFO - "project": "", 13:48:54 INFO - "product": "firefox", 13:48:54 INFO - "script_repo_revision": "production", 13:48:54 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:48:54 INFO - "repository": "", 13:48:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:48:54 INFO - "buildid": "20170425121527", 13:48:54 INFO - "pgo_build": "False", 13:48:54 INFO - "basedir": "/builds/slave/test", 13:48:54 INFO - "buildnumber": 9, 13:48:54 INFO - "slavename": "t-yosemite-r7-0221", 13:48:54 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:48:54 INFO - "platform": "yosemite_r7", 13:48:54 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:48:54 INFO - "branch": "mozilla-beta", 13:48:54 INFO - "repo_path": "releases/mozilla-beta", 13:48:54 INFO - "revision": "872f6a669f11224a26f0e71e81bec4e9d723b450", 13:48:54 INFO - "stage_platform": "macosx64", 13:48:54 INFO - "builduid": "02063c45b9d643b19f6cfac5abf7918c", 13:48:54 INFO - "slavebuilddir": "test" 13:48:54 INFO - } 13:48:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 13:48:54 INFO - Running post-action listener: _resource_record_post_action 13:48:54 INFO - [mozharness: 2017-04-25 20:48:54.963337Z] Finished read-buildbot-config step (success) 13:48:54 INFO - [mozharness: 2017-04-25 20:48:54.963472Z] Running download-and-extract step. 13:48:54 INFO - Running pre-action listener: _resource_record_pre_action 13:48:54 INFO - Running main action method: download_and_extract 13:48:54 INFO - mkdir: /builds/slave/test/build/tests 13:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:54 INFO - trying https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 13:48:54 INFO - Downloading https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:48:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 13:48:55 INFO - Downloaded 1165 bytes. 13:48:55 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:48:55 INFO - Using the following test package requirements: 13:48:55 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:48:55 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:48:55 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 13:48:55 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:48:55 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 13:48:55 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:48:55 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:48:55 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 13:48:55 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:48:55 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:48:55 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 13:48:55 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:48:55 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 13:48:55 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:48:55 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 13:48:55 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:48:55 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 13:48:55 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 13:48:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:48:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:48:55 INFO - Fetch https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:48:57 INFO - Expected file size: 51224780 13:48:57 INFO - Obtained file size: 51224780 13:49:13 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:49:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:49:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:49:13 INFO - Fetch https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:49:15 INFO - Expected file size: 51224780 13:49:15 INFO - Obtained file size: 51224780 13:49:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 13:49:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 13:49:30 INFO - Fetch https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 13:49:31 INFO - Expected file size: 14404449 13:49:31 INFO - Obtained file size: 14404449 13:49:31 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:49:31 INFO - trying https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:49:31 INFO - Downloading https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 13:49:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 13:49:33 INFO - Downloaded 59533468 bytes. 13:49:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:49:33 INFO - mkdir: /builds/slave/test/properties 13:49:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:49:33 INFO - Writing to file /builds/slave/test/properties/build_url 13:49:33 INFO - Contents: 13:49:33 INFO - build_url:https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:49:34 INFO - Running post-action listener: _resource_record_post_action 13:49:34 INFO - Running post-action listener: set_extra_try_arguments 13:49:34 INFO - [mozharness: 2017-04-25 20:49:34.341471Z] Finished download-and-extract step (success) 13:49:34 INFO - [mozharness: 2017-04-25 20:49:34.341622Z] Running populate-webroot step. 13:49:34 INFO - Running pre-action listener: _resource_record_pre_action 13:49:34 INFO - Running main action method: populate_webroot 13:49:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:49:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:49:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:49:34 INFO - '--tppagecycles', 13:49:34 INFO - '7'], 13:49:34 INFO - 'tests': ['tsvgm']}}, 13:49:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:49:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:49:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:49:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:49:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:49:34 INFO - 'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:49:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:49:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:49:34 INFO - 'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['damp', 'tps']}, 13:49:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:49:34 INFO - 'tests': ['damp', 'tps']}, 13:49:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['dromaeo_dom']}, 13:49:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:49:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['basic_compositor_video']}, 13:49:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:49:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['a11yr', 13:49:34 INFO - 'ts_paint', 13:49:34 INFO - 'tpaint', 13:49:34 INFO - 'sessionrestore', 13:49:34 INFO - 'sessionrestore_no_auto_restore', 13:49:34 INFO - 'tabpaint']}, 13:49:34 INFO - 'other-e10s': {'tests': ['a11yr', 13:49:34 INFO - 'ts_paint', 13:49:34 INFO - 'tpaint', 13:49:34 INFO - 'sessionrestore', 13:49:34 INFO - 'sessionrestore_no_auto_restore', 13:49:34 INFO - 'tabpaint']}, 13:49:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:49:34 INFO - 'ts_paint', 13:49:34 INFO - 'tpaint', 13:49:34 INFO - 'sessionrestore', 13:49:34 INFO - 'sessionrestore_no_auto_restore', 13:49:34 INFO - 'tabpaint']}, 13:49:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:49:34 INFO - 'ts_paint', 13:49:34 INFO - 'tpaint', 13:49:34 INFO - 'sessionrestore', 13:49:34 INFO - 'sessionrestore_no_auto_restore', 13:49:34 INFO - 'tabpaint']}, 13:49:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['a11yr', 13:49:34 INFO - 'ts_paint', 13:49:34 INFO - 'tpaint', 13:49:34 INFO - 'sessionrestore', 13:49:34 INFO - 'sessionrestore_no_auto_restore', 13:49:34 INFO - 'tabpaint']}, 13:49:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['a11yr', 13:49:34 INFO - 'ts_paint', 13:49:34 INFO - 'tpaint', 13:49:34 INFO - 'sessionrestore', 13:49:34 INFO - 'sessionrestore_no_auto_restore', 13:49:34 INFO - 'tabpaint']}, 13:49:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['tsvgx', 13:49:34 INFO - 'tsvgr_opacity', 13:49:34 INFO - 'tart', 13:49:34 INFO - 'tscrollx', 13:49:34 INFO - 'cart', 13:49:34 INFO - 'tsvg_static']}, 13:49:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:49:34 INFO - 'tsvgr_opacity', 13:49:34 INFO - 'tart', 13:49:34 INFO - 'tscrollx', 13:49:34 INFO - 'cart', 13:49:34 INFO - 'tsvg_static']}, 13:49:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:49:34 INFO - 'talos_options': ['--disable-e10s'], 13:49:34 INFO - 'tests': ['tp5o']}, 13:49:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:49:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:49:34 INFO - 'talos_options': ['--disable-e10s', 13:49:34 INFO - '--xperf_path', 13:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:34 INFO - 'tests': ['tp5n']}, 13:49:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:49:34 INFO - 'talos_options': ['--xperf_path', 13:49:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:49:34 INFO - 'tests': ['tp5n']}}, 13:49:34 INFO - 'talos.zip': {'path': '', 13:49:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:49:34 INFO - Running post-action listener: _resource_record_post_action 13:49:34 INFO - [mozharness: 2017-04-25 20:49:34.360647Z] Finished populate-webroot step (success) 13:49:34 INFO - [mozharness: 2017-04-25 20:49:34.360758Z] Running create-virtualenv step. 13:49:34 INFO - Running pre-action listener: _resource_record_pre_action 13:49:34 INFO - Running main action method: create_virtualenv 13:49:34 INFO - Creating virtualenv /builds/slave/test/build/venv 13:49:34 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:49:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:49:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:49:34 INFO - Using real prefix '/tools/python27' 13:49:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:49:35 INFO - Installing distribute.............................................................................................................................................................................................done. 13:49:38 INFO - Installing pip.................done. 13:49:38 INFO - Return code: 0 13:49:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:49:38 INFO - Reading from file tmpfile_stdout 13:49:38 INFO - Output received: 13:49:38 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:49:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:49: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:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:38 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:49:38 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:49:38 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:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:38 INFO - 'HOME': '/Users/cltbld', 13:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:38 INFO - 'LOGNAME': 'cltbld', 13:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:38 INFO - 'MOZ_NO_REMOTE': '1', 13:49:38 INFO - 'NO_EM_RESTART': '1', 13:49:38 INFO - 'PAGER': '/bin/cat', 13:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:38 INFO - 'PWD': '/builds/slave/test', 13:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:38 INFO - 'SHELL': '/bin/bash', 13:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:49:38 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:38 INFO - 'USER': 'cltbld', 13:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:38 INFO - 'XPC_FLAGS': '0x0', 13:49:38 INFO - 'XPC_SERVICE_NAME': '0', 13:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:38 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:49:38 INFO - Cleaning up... 13:49:38 INFO - Return code: 0 13:49:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:49: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:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:38 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:49:38 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:49:38 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:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:38 INFO - 'HOME': '/Users/cltbld', 13:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:38 INFO - 'LOGNAME': 'cltbld', 13:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:38 INFO - 'MOZ_NO_REMOTE': '1', 13:49:38 INFO - 'NO_EM_RESTART': '1', 13:49:38 INFO - 'PAGER': '/bin/cat', 13:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:38 INFO - 'PWD': '/builds/slave/test', 13:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:38 INFO - 'SHELL': '/bin/bash', 13:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:49:38 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:38 INFO - 'USER': 'cltbld', 13:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:38 INFO - 'XPC_FLAGS': '0x0', 13:49:38 INFO - 'XPC_SERVICE_NAME': '0', 13:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:38 INFO - Downloading/unpacking psutil>=3.1.1 13:49:38 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:49:38 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:49:38 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:49:38 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:49:38 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:49:38 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:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:49:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:42 INFO - Installing collected packages: psutil 13:49:42 INFO - Running setup.py install for psutil 13:49:42 INFO - building 'psutil._psutil_osx' extension 13:49:42 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:49:43 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:49:43 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:49:43 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:49:43 INFO - building 'psutil._psutil_posix' extension 13:49:43 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:49:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:49:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:49:43 INFO - ^ 13:49:43 INFO - 1 warning generated. 13:49:43 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:49:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:49:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:49:43 INFO - Successfully installed psutil 13:49:43 INFO - Cleaning up... 13:49:43 INFO - Return code: 0 13:49:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:49: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:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:49:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:49:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:49:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:44 INFO - 'HOME': '/Users/cltbld', 13:49:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:44 INFO - 'LOGNAME': 'cltbld', 13:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:44 INFO - 'MOZ_NO_REMOTE': '1', 13:49:44 INFO - 'NO_EM_RESTART': '1', 13:49:44 INFO - 'PAGER': '/bin/cat', 13:49:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:44 INFO - 'PWD': '/builds/slave/test', 13:49:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:44 INFO - 'SHELL': '/bin/bash', 13:49:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:49:44 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:49:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:44 INFO - 'USER': 'cltbld', 13:49:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:44 INFO - 'XPC_FLAGS': '0x0', 13:49:44 INFO - 'XPC_SERVICE_NAME': '0', 13:49:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:49:47 INFO - Installing collected packages: mozsystemmonitor 13:49:47 INFO - Running setup.py install for mozsystemmonitor 13:49:47 INFO - Successfully installed mozsystemmonitor 13:49:47 INFO - Cleaning up... 13:49:48 INFO - Return code: 0 13:49:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:49: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:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:49: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==2.5.1'] in /builds/slave/test/build 13:49: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==2.5.1 13:49:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:49:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:48 INFO - 'HOME': '/Users/cltbld', 13:49:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:48 INFO - 'LOGNAME': 'cltbld', 13:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:48 INFO - 'MOZ_NO_REMOTE': '1', 13:49:48 INFO - 'NO_EM_RESTART': '1', 13:49:48 INFO - 'PAGER': '/bin/cat', 13:49:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:48 INFO - 'PWD': '/builds/slave/test', 13:49:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:48 INFO - 'SHELL': '/bin/bash', 13:49:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:49:48 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:49:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:48 INFO - 'USER': 'cltbld', 13:49:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:48 INFO - 'XPC_FLAGS': '0x0', 13:49:48 INFO - 'XPC_SERVICE_NAME': '0', 13:49:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:48 INFO - Downloading/unpacking jsonschema==2.5.1 13:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:50 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:49:50 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:49:50 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:49:50 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:49:50 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:49:50 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:49:51 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:51 INFO - warning: no files found matching '*.txt' 13:49:51 INFO - no previously-included directories found matching 'build' 13:49:51 INFO - no previously-included directories found matching 'dist' 13:49:51 INFO - no previously-included directories found matching '.git*' 13:49:51 INFO - Installing collected packages: jsonschema, functools32 13:49:51 INFO - Running setup.py install for functools32 13:49:51 INFO - warning: no files found matching '*.txt' 13:49:51 INFO - no previously-included directories found matching 'build' 13:49:51 INFO - no previously-included directories found matching 'dist' 13:49:51 INFO - no previously-included directories found matching '.git*' 13:49:51 INFO - Successfully installed jsonschema functools32 13:49:51 INFO - Cleaning up... 13:49:51 INFO - Return code: 0 13:49:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:51 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:49:51 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:49:51 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:49:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:49:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:51 INFO - 'HOME': '/Users/cltbld', 13:49:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:51 INFO - 'LOGNAME': 'cltbld', 13:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:51 INFO - 'MOZ_NO_REMOTE': '1', 13:49:51 INFO - 'NO_EM_RESTART': '1', 13:49:51 INFO - 'PAGER': '/bin/cat', 13:49:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:51 INFO - 'PWD': '/builds/slave/test', 13:49:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:51 INFO - 'SHELL': '/bin/bash', 13:49:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:49:51 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:49:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:51 INFO - 'USER': 'cltbld', 13:49:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:51 INFO - 'XPC_FLAGS': '0x0', 13:49:51 INFO - 'XPC_SERVICE_NAME': '0', 13:49:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:49:52 INFO - Cleaning up... 13:49:52 INFO - Return code: 0 13:49:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:52 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:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 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:49:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:52 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:49:52 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:49:52 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:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:52 INFO - 'HOME': '/Users/cltbld', 13:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:52 INFO - 'LOGNAME': 'cltbld', 13:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:52 INFO - 'MOZ_NO_REMOTE': '1', 13:49:52 INFO - 'NO_EM_RESTART': '1', 13:49:52 INFO - 'PAGER': '/bin/cat', 13:49:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:52 INFO - 'PWD': '/builds/slave/test', 13:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:52 INFO - 'SHELL': '/bin/bash', 13:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:49:52 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:52 INFO - 'USER': 'cltbld', 13:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:52 INFO - 'XPC_FLAGS': '0x0', 13:49:52 INFO - 'XPC_SERVICE_NAME': '0', 13:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:52 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:54 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:54 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:49:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:56 INFO - Downloading docopt-0.6.1.tar.gz 13:49:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:56 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:56 INFO - Running setup.py install for blobuploader 13:49:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:56 INFO - Running setup.py install for requests 13:49:56 INFO - Running setup.py install for docopt 13:49:56 INFO - Successfully installed blobuploader requests docopt 13:49:56 INFO - Cleaning up... 13:49:57 INFO - Return code: 0 13:49:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:57 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:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:57 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:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:57 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:49:57 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:49:57 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:49:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:49:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:57 INFO - 'HOME': '/Users/cltbld', 13:49:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:57 INFO - 'LOGNAME': 'cltbld', 13:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:57 INFO - 'MOZ_NO_REMOTE': '1', 13:49:57 INFO - 'NO_EM_RESTART': '1', 13:49:57 INFO - 'PAGER': '/bin/cat', 13:49:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:57 INFO - 'PWD': '/builds/slave/test', 13:49:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:57 INFO - 'SHELL': '/bin/bash', 13:49:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:49:57 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:49:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:57 INFO - 'USER': 'cltbld', 13:49:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:57 INFO - 'XPC_FLAGS': '0x0', 13:49:57 INFO - 'XPC_SERVICE_NAME': '0', 13:49:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:57 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Hx3Wha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:57 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-aLeMAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:57 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-e2wV3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:57 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-T3obX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:57 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-k6Ukkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:57 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-kgtsoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:57 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Dw55xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-UlNaB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-czPz3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-VTet2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-jOC5SE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-NOZRXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-4xlYzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-VZsjaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-yb1QHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:58 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Q3oKmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:59 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-od_cBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:59 INFO - Running setup.py install for manifestparser 13:49:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:59 INFO - Running setup.py install for mozcrash 13:49:59 INFO - Running setup.py install for mozdebug 13:49:59 INFO - Running setup.py install for mozdevice 13:49:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:49:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:59 INFO - Running setup.py install for mozfile 13:49:59 INFO - Running setup.py install for mozhttpd 13:50:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Running setup.py install for mozinfo 13:50:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Running setup.py install for mozInstall 13:50:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Running setup.py install for mozleak 13:50:00 INFO - Running setup.py install for mozlog 13:50:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Running setup.py install for moznetwork 13:50:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:50:00 INFO - Running setup.py install for mozprocess 13:50:00 INFO - Running setup.py install for mozprofile 13:50:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:50:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:50:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:50:01 INFO - Running setup.py install for mozrunner 13:50:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:50:01 INFO - Running setup.py install for mozscreenshot 13:50:01 INFO - Running setup.py install for moztest 13:50:01 INFO - Running setup.py install for mozversion 13:50:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:50:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:50:01 INFO - Cleaning up... 13:50:01 INFO - Return code: 0 13:50:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:01 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:50:01 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:50:01 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:50:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:50:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:01 INFO - 'HOME': '/Users/cltbld', 13:50:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:01 INFO - 'LOGNAME': 'cltbld', 13:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:01 INFO - 'MOZ_NO_REMOTE': '1', 13:50:01 INFO - 'NO_EM_RESTART': '1', 13:50:01 INFO - 'PAGER': '/bin/cat', 13:50:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:01 INFO - 'PWD': '/builds/slave/test', 13:50:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:01 INFO - 'SHELL': '/bin/bash', 13:50:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:50:01 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:50:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:01 INFO - 'USER': 'cltbld', 13:50:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:01 INFO - 'XPC_FLAGS': '0x0', 13:50:01 INFO - 'XPC_SERVICE_NAME': '0', 13:50:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:50:01 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-rsZp7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-SQ7Lao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-4Rn4HT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-A6OP_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:50:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Ity0wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-3h_Vbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-0ofwhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-hklfpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Ipx6lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:50:02 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:50:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:50:02 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-JOd24c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:50:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-szv6jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:50:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-rBt8CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:50:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-z_TI6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:50:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-HYm7ue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-yT6xqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:50:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-zXneB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:50:03 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:50:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:50:03 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-oySGBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:50:03 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:50:03 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:50:03 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:50:03 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:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:50:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:03 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:50:06 INFO - Downloading blessings-1.6.tar.gz 13:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:50:06 INFO - Installing collected packages: blessings 13:50:06 INFO - Running setup.py install for blessings 13:50:06 INFO - Successfully installed blessings 13:50:06 INFO - Cleaning up... 13:50:06 INFO - Return code: 0 13:50:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:50:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:07 INFO - Reading from file tmpfile_stdout 13:50:07 INFO - Current package versions: 13:50:07 INFO - blessings == 1.6 13:50:07 INFO - blobuploader == 1.2.4 13:50:07 INFO - docopt == 0.6.1 13:50:07 INFO - functools32 == 3.2.3-2 13:50:07 INFO - jsonschema == 2.5.1 13:50:07 INFO - manifestparser == 1.1 13:50:07 INFO - mozInstall == 1.12 13:50:07 INFO - mozcrash == 1.0 13:50:07 INFO - mozdebug == 0.1 13:50:07 INFO - mozdevice == 0.49 13:50:07 INFO - mozfile == 1.2 13:50:07 INFO - mozhttpd == 0.7 13:50:07 INFO - mozinfo == 0.9 13:50:07 INFO - mozleak == 0.1 13:50:07 INFO - mozlog == 3.4 13:50:07 INFO - moznetwork == 0.27 13:50:07 INFO - mozprocess == 0.25 13:50:07 INFO - mozprofile == 0.28 13:50:07 INFO - mozrunner == 6.13 13:50:07 INFO - mozscreenshot == 0.1 13:50:07 INFO - mozsystemmonitor == 0.3 13:50:07 INFO - moztest == 0.8 13:50:07 INFO - mozversion == 1.4 13:50:07 INFO - psutil == 3.1.1 13:50:07 INFO - requests == 1.2.3 13:50:07 INFO - wsgiref == 0.1.2 13:50:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:50:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:07 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:50:07 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:50:07 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:50:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:50:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:07 INFO - 'HOME': '/Users/cltbld', 13:50:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:07 INFO - 'LOGNAME': 'cltbld', 13:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:07 INFO - 'MOZ_NO_REMOTE': '1', 13:50:07 INFO - 'NO_EM_RESTART': '1', 13:50:07 INFO - 'PAGER': '/bin/cat', 13:50:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:07 INFO - 'PWD': '/builds/slave/test', 13:50:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:07 INFO - 'SHELL': '/bin/bash', 13:50:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:50:07 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:50:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:07 INFO - 'USER': 'cltbld', 13:50:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:07 INFO - 'XPC_FLAGS': '0x0', 13:50:07 INFO - 'XPC_SERVICE_NAME': '0', 13:50:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:07 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:50:07 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:50:07 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:50:07 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:50:07 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:50:07 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:50:07 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:50:07 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:50:07 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:50:07 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:50:07 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:50:07 INFO - Cleaning up... 13:50:07 INFO - Return code: 0 13:50:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:50:07 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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:50:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:07 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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:50:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:50:07 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 0x10e827b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e82a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fea4855f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, '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.gLLs9PSvL8/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.rlce0fmAhD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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:50:07 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:50:07 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:50:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:50:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:07 INFO - 'HOME': '/Users/cltbld', 13:50:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:07 INFO - 'LOGNAME': 'cltbld', 13:50:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:07 INFO - 'MOZ_NO_REMOTE': '1', 13:50:07 INFO - 'NO_EM_RESTART': '1', 13:50:07 INFO - 'PAGER': '/bin/cat', 13:50:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:07 INFO - 'PWD': '/builds/slave/test', 13:50:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:07 INFO - 'SHELL': '/bin/bash', 13:50:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:50:07 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:50:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:07 INFO - 'USER': 'cltbld', 13:50:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:07 INFO - 'XPC_FLAGS': '0x0', 13:50:07 INFO - 'XPC_SERVICE_NAME': '0', 13:50:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:50:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:50:07 INFO - Cleaning up... 13:50:07 INFO - Return code: 0 13:50:07 INFO - Running post-action listener: _resource_record_post_action 13:50:07 INFO - Running post-action listener: _start_resource_monitoring 13:50:07 INFO - Starting resource monitoring. 13:50:07 INFO - [mozharness: 2017-04-25 20:50:07.579611Z] Finished create-virtualenv step (success) 13:50:07 INFO - [mozharness: 2017-04-25 20:50:07.580564Z] Running install step. 13:50:07 INFO - Running pre-action listener: _resource_record_pre_action 13:50:07 INFO - Running main action method: install 13:50:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:50:07 INFO - Reading from file tmpfile_stdout 13:50:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:50:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:50:07 INFO - Reading from file tmpfile_stdout 13:50:07 INFO - Output received: 13:50:07 INFO - Usage: mozinstall [options] installer 13:50:07 INFO - Options: 13:50:07 INFO - -h, --help show this help message and exit 13:50:07 INFO - -d DEST, --destination=DEST 13:50:07 INFO - Directory to install application into. [default: 13:50:07 INFO - "/builds/slave/test"] 13:50:07 INFO - --app=APP Application being installed. [default: firefox] 13:50:07 INFO - mkdir: /builds/slave/test/build/application 13:50:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:50:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:50:22 INFO - Reading from file tmpfile_stdout 13:50:22 INFO - Output received: 13:50:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:50:22 INFO - Running post-action listener: _resource_record_post_action 13:50:22 INFO - [mozharness: 2017-04-25 20:50:22.719903Z] Finished install step (success) 13:50:22 INFO - [mozharness: 2017-04-25 20:50:22.720036Z] Running run-tests step. 13:50:22 INFO - Running pre-action listener: _resource_record_pre_action 13:50:22 INFO - Running main action method: run_tests 13:50:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:50:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:50:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:50:22 INFO - 2017-04-25 13:50:22.734 screenresolution[1619:7371] starting screenresolution argv=screenresolution get 13:50:22 INFO - 2017-04-25 13:50:22.737 screenresolution[1619:7371] Display 0: 1600x1200x32@60 13:50:22 INFO - 2017-04-25 13:50:22.742 screenresolution[1620:7373] starting screenresolution argv=screenresolution list 13:50:22 INFO - Available Modes on Display 0 13:50:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:50:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:50:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:50:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:50:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:50:22 INFO - Intel Iris: 13:50:22 INFO - Chipset Model: Intel Iris 13:50:22 INFO - Type: GPU 13:50:22 INFO - Bus: Built-In 13:50:22 INFO - VRAM (Dynamic, Max): 1536 MB 13:50:22 INFO - Vendor: Intel (0x8086) 13:50:22 INFO - Device ID: 0x0a2e 13:50:22 INFO - Revision ID: 0x0009 13:50:22 INFO - Displays: 13:50:22 INFO - Display: 13:50:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:50:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:50:22 INFO - Display Serial Number: 1600x1200 60 13:50:22 INFO - Main Display: Yes 13:50:22 INFO - Mirror: Off 13:50:22 INFO - Online: Yes 13:50:22 INFO - Rotation: Supported 13:50:22 INFO - Return code: 0 13:50:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:50:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:50:22 INFO - Python 2.7.3 13:50:22 INFO - Return code: 0 13:50:22 INFO - grabbing minidump binary from tooltool 13:50:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:50:22 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 0x10e605d30>, '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 0x10e52cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e5fabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:50:22 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:50:22 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:50:22 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:50:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:50:23 INFO - Return code: 0 13:50:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:50:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:50:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:50:23 INFO - ENV: RUST_BACKTRACE is now 1 13:50:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:50:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--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:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0221 --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:50:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gLLs9PSvL8/Render', 13:50:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:50:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:50:23 INFO - 'HOME': '/Users/cltbld', 13:50:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:50:23 INFO - 'LOGNAME': 'cltbld', 13:50:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:50:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:50:23 INFO - 'MOZ_NO_REMOTE': '1', 13:50:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:50:23 INFO - 'NO_EM_RESTART': '1', 13:50:23 INFO - 'PAGER': '/bin/cat', 13:50:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:50:23 INFO - 'PWD': '/builds/slave/test', 13:50:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:50:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:50:23 INFO - 'RUST_BACKTRACE': '1', 13:50:23 INFO - 'SHELL': '/bin/bash', 13:50:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rlce0fmAhD/Listeners', 13:50:23 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 13:50:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:50:23 INFO - 'USER': 'cltbld', 13:50:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:50:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:50:23 INFO - 'XPC_FLAGS': '0x0', 13:50:23 INFO - 'XPC_SERVICE_NAME': '0', 13:50:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:50:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--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:50:23 INFO - mozversion application_buildid: 20170425121527 13:50:23 INFO - mozversion application_changeset: 872f6a669f11224a26f0e71e81bec4e9d723b450 13:50:23 INFO - mozversion application_display_name: Firefox 13:50:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:50:23 INFO - mozversion application_name: Firefox 13:50:23 INFO - mozversion application_remotingname: firefox 13:50:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:50:23 INFO - mozversion application_vendor: Mozilla 13:50:23 INFO - mozversion application_version: 54.0 13:50:23 INFO - mozversion platform_buildid: 20170425121527 13:50:23 INFO - mozversion platform_changeset: 872f6a669f11224a26f0e71e81bec4e9d723b450 13:50:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:50:23 INFO - mozversion platform_version: 54.0 13:50:23 INFO - using testdate: 1493153423 13:50:23 INFO - actual date: 1493153423 13:50:23 INFO - starting webserver on 'localhost:49240' 13:50:23 INFO - SUITE-START | Running 2 tests 13:50:23 INFO - TEST-START | dromaeo_css 13:50:23 INFO - operating with platform_type : mac_ 13:50:23 INFO - Initialising browser for dromaeo_css test... 13:50:23 INFO - TEST-INFO | started process 1630 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpDK_7fW/profile http://localhost:49240/getInfo.html) 13:50:26 INFO - PROCESS | 1630 | 2017-04-25 13:50:26.195 plugin-container[1633:7537] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f4f, name = 'com.apple.tsm.portname' 13:50:26 INFO - PROCESS | 1630 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:50:26 INFO - PROCESS | 1630 | 2017-04-25 13:50:26.195 plugin-container[1633:7537] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 13:50:26 INFO - PROCESS | 1630 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:50:26 INFO - PROCESS | 1630 | 2017-04-25 13:50:26.196 plugin-container[1633:7537] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:50:26 INFO - PROCESS | 1630 | __metrics Screen width/height:1600/1200 13:50:26 INFO - PROCESS | 1630 | colorDepth:24 13:50:26 INFO - PROCESS | 1630 | Browser inner width/height: 1024/689 13:50:26 INFO - PROCESS | 1630 | __metrics 13:50:26 ERROR - PROCESS | 1630 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 13:50:26 INFO - TEST-INFO | 1630: exit 0 13:50:26 INFO - Browser initialized. 13:50:26 INFO - Running cycle 1/1 for dromaeo_css test... 13:50:26 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpDK_7fW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:50:29 INFO - PROCESS | 1634 | 2017-04-25 13:50:29.262 plugin-container[1635:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864b, name = 'com.apple.tsm.portname' 13:50:29 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:50:29 INFO - PROCESS | 1634 | 2017-04-25 13:50:29.262 plugin-container[1635:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 13:50:29 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:50:29 INFO - PROCESS | 1634 | 2017-04-25 13:50:29.262 plugin-container[1635:7673] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:50:39 INFO - PROCESS | 1634 | RSS: Main: 174211072 13:50:39 INFO - PROCESS | 1634 | 13:53:42 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:53:43 INFO - PROCESS | 1634 | RSS: Main: 190136320 13:53:43 INFO - PROCESS | 1634 | 13:56:46 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:56:46 INFO - PROCESS | 1634 | RSS: Main: 202723328 13:56:46 INFO - PROCESS | 1634 | 13:59:48 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:59:49 INFO - PROCESS | 1634 | RSS: Main: 205557760 13:59:49 INFO - PROCESS | 1634 | 14:02:51 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:02:51 INFO - PROCESS | 1634 | RSS: Main: 208580608 14:02:51 INFO - PROCESS | 1634 | 14:05:54 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:05:55 INFO - PROCESS | 1634 | RSS: Main: 211001344 14:05:55 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:08:58 INFO - PROCESS | 1634 | RSS: Main: 209207296 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | __start_tp_report 14:08:58 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 14:08:58 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 14:08:58 INFO - PROCESS | 1634 | |i|pagename|runs| 14:08:58 INFO - PROCESS | 1634 | |0;dojo.html;3124.3751249750057;3648.3797754381753;3658.359787037268;3677.264547090579;3699.5190625218725;6244.469220116284;6251.156093927324;6255.906161407577;6270.874582508359;6283.497320214383;6235.376462353763;6260.7808726694575;6263.686815659222;6285.591436556632;6288.9056664150075;5658.264425624663;5690.089585666295;5703.458171473703;5745.6265342752795;5779.508741756935;5751.856203594923;5772.682502462363;5773.48038676519;5782.913256301159;5799.507041901444;5531.585131115163;5534.889302213974;5701.6864072476;5755.971220143893;5770.538356931435;5662.631928924628;5665.631733937322;5682.232898558683;5705.400932902027;5711.600187986801;5539.030669632798;5657;5666.773329066874;5678.403767604384;5693.943060569382;5192.3249977503065;6096.085587161917;6289.87420251597;6297.527685423565;6318.62088274705;6244.344343843876;6412.23053233615;6421.8073457796345;6430.324815894311;6570.507211959122;6813.454923606099;6833.521653484258;6840.247572766992;6842;6844.4182244509275;5602.551795856321;6296.401841825019;6336.714847831859;6340.144080549113;6361.745530178788;6563.934360656428;6580.572262802998;6625.701843417058;6833.521653484208;6986.7205311787975;6256.404616822681;6385.2656944451055;6416.967915160394;6497.642629655415;6531.248906375733;6127.142200091991;6172.969135154295;6198.597091189058;6740.629265390353;6751.189857217166;6293.37066293367;6299.748010079546;6597;6601.3728695773825;6608.306127856506;6052.303985041776;6428.967855160694;6536.281009088996;6538.8365290868105;6571.671416429255;4362.498312694081;5331.893362132736;5335.733213339317;5360.597955153379;5386.946130538645;4770.666053376231;4781.306710526954;4781.402324709411;4796.06476737033;4801.279808028824;5537.529310008614;5987.742574059496;6334.841628959313;6366.84082897922;6367.872642547123;6547.279799222082;6559.36015996001;6679.799606011828;6714.395704386531;6745;6333.303336632966;6345.619262844244;6347.619142851351;6362.0774987627465;6382.32985536512;6012.30858451275;6029.638221706711;6044.667543285073;6046.3651316612;6054.091886217015;6662.100616416722;6663;6857.314268573302;6871.896921546081;7017.824554386079;6445.774397896051;6702.798916032527;6777.695003724745;6780.96609516969;6787.830304242433;5710.942890571041;6863.759768408082;6948.478864085113;6992.755253566101;6999.335063168991;6321.209848768904;6374.26695929974;6557.836054098495;6624.436922861611;6653.467722582279;6623.834404139935;6705.430038446787;6706.128203333536;6715.630640314829;6735.797926062226;6432.195975503062;6451.645159516272;6477.255115661571;6487.675616219076;6490.448311893542;6255.40573645503;6475.028745688184;6536.8365790855605;6537.640429776408;6540.640264785482;6148.739508400678;6280.277768056732;6290.119383286252;6316.873662526632;6347.619142851444;6360.459360954371;6487.772927947499;6506.479481641552;6520.380563846427;6537.607743535403;6210.658413787285;6232.034034724625;6260.342664020212;6302.086197501429;6380.808575742735 14:08:58 INFO - PROCESS | 1634 | |1;ext.html;777.9338756205722;817.9918200817991;839.5382539603219;970.3935040599621;973.5327043019346;39300.41049384262;39782.801085994564;41281.793591032;41282.38076428856;41433.99999999996;40483.79758101213;40537.391939120935;40666;40782.77651670447;40845.38731919016;8252.339812814991;8387.329013678891;11177.105831533498;11412.31526108432;11634.883651163507;11356.829647555292;11394.54421823126;11400.657980260565;11456.083513318956;11467.254628449165;11417.94291028548;11422.42887855608;11455.885441145607;11470.025047870899;11473.196876218668;11378.772424551546;11396.658100257006;11397.430128493543;11400.657980260565;11452.885471145308;11054.060404865597;11060.22578419511;11106.00045995856;11109;11109.277896936674;35054.82472587646;35269.29461410783;35292.117697057525;35375.1156221094;35427.4685879712;3998.260321840469;4008.579099194601;4029.717919745619;4042.413849991735;4089.754614723126;26279.34301642455;26329.473410531875;26474;27475.17574472749;28259;3173.428782819092;3219.6619354967625;3234.4178047951596;3305.4876494143446;3390.16940849491;367965.1601742001;368798.46802297985;368975.1551242227;369555.15222423984;370087.29912700795;45854.31218531725;45916.77041614837;45942.540574594495;45969.77015114903;46023.76988115038;46831.765841171255;46928;47067.76466117647;47090;47160.52839471561;14761.40954361835;14881;14913.25433728331;14917;14958.252087395804;10897.237193396386;12570.87429125697;12785.105042646925;12790.872091278969;12800.295983720986;9918.652847150315;11018.614348497764;12185.73945846659;12358.011359091252;12428.937855310665;5830.2129212555765;5852.648841069549;5894.440028197314;5908.143319218775;5937.94195989066;1074.5970261152067;1091.9781604367868;1098.19282827122;1155.110564865066;1159.837622732818;27642.861785690944;28472.288192795346;28550.42899142047;28711.13866584006;29036;1090.7600327928;1148.0987424871437;1178.699431644925;1184.585395111704;1243.490169030693;13389.665258368424;13930.721385572435;13953.860461395256;14897;15268.847311526964;511007.44496277283;511567.884321152;513166;513235;513249;42227.36658950118;49825.50174498281;49953.50046499561;50265.49734502608;50456.243156352684;1298.4286913757917;1449.0581122270398;1451.100317802969;1484.95545133644;1490.2325302469237;27969.44061118807;27974.3006424841;28346.149615511567;28954.565681514374;29059.854700726362;40941;41297;41456.79271603622;41650;41901;457706;458886;460591;461173;462061;29352;29526.261843454085;29776.85111574428;29843.10470685883;30254.84872575623;38242.426363605126;39016.60983390243;39068.6093139065;39158;39180.80409598048;27644.447111057263;28095;28136.71863281341;28158.577621336106;29086.563701544917;27952.881884724382;28047;28133.859330703217;28779.712202877705;28800.423991519634;31822.727090916105;32059.679403206603;32635.18412039718;32932.34135317328;32935;26342;27541.86229068842;27932.581011285252;28668.85324586993;29538.852305739194;22014.229501967355;22652;23012.654810177526;23216.3035108947;23258.95334709976 14:08:58 INFO - PROCESS | 1634 | |2;jquery.html;393.2488946112923;408.1449363583293;420.97263677860917;433.92189405906936;443.678062637462;21498.032588533515;22442;22982.77017229827;23061.769382306153;23619;22080.558388832214;22973.310800676005;23112.768872311273;23838.165664201755;23991.880040599815;5320.9467905321035;6325.5255855811;6927.3072692730575;7060.505764596481;7166.784996450115;7032.648367581601;7125.85748285034;7161.534500257492;7164.534305270166;7191.316824901653;6828;7026.262242464544;7042.40139588133;7070.611116388596;7102.68037938294;7011.789646310619;7051.259617740166;7071.646417679121;7375.668094935741;7687.730929417499;7286.635668216621;7612.8477430451085;7636.312731854105;7637.923620763777;7650.73222437212;21109.577808443897;23043.308700739006;27207.591886121525;27959.440811183664;27967.440651187066;2584.9918531772437;2974.3159073413235;3020.7885448018646;3042.558828969787;3090.629124505051;15927.92036039824;16591.641782175262;17326.39357622477;17641.647167056715;17675.292988280453;1806.4219449776076;2141.550274442369;2162.3945295317335;2164.815990640782;2165.4586353411646;159579;187295;190376.0962390386;194042;194904.02547987312;20093.899530502546;21531.354059378245;21664.783352166276;21745.782542174693;21872.781272187392;32577;32997.50503742446;33203.335933281196;33265;33332.50001249983;10401.739956501147;10659.520321585547;10862.619808306672;11184.552617895355;11278.661640150809;7171.49799514029;9255.537223138816;9271.67549135777;9440.24478041755;9453.43279403238;8077.838443231102;9756.268279879037;9813.852792208123;9900.405975641484;9914.256430767722;4190.245755763931;4230.894227644333;4261.252886316595;4268.637165840876;4271.765052922057;888.6045709659139;1087.380193289833;1104.5471356743697;1112.3993043756282;1131.5417256011328;16132.596685082732;21825.12699492034;22085.558288834134;22200.444988875086;22244.110235590397;965.3918031640162;986.7286496213455;991.2020823237364;1011.6560369474267;1150.3558007515817;10422.85348611652;10928.726781830359;11051.502682379152;11742.295462272292;11742.530298787953;511006.4449677802;646408.5359146442;711511;717114;800493;107373.46313268384;171650;176208;179761;186672.06663966866;1342.879140877306;1369.205860600849;1431.3058166789099;1435.777454494555;1438.5109062918448;19779.208831646574;20301.49246268855;20850.165993360097;21029.684554731386;21166.365009049754;66623.33376666172;70792.2301942435;71028.64485677538;71183.93224101746;71337;97640;98283.01716982739;98621;100015.99984000067;100475.49762251142;11290.887091128983;11432.314061156358;11985.820212696992;12482.937585312015;12733.29966851795;13588.864111359155;13747.862521374658;13764.380602873094;13789.931050345085;14059.437622494986;11744;11775.411229438665;11945.641630751092;11975.820362694392;12075.818862717242;11141.442927853737;11223.943880280547;11323.094152467947;11512.19414640967;11532;11885.346305953255;12047.156699030984;12102.213356131822;12175.695607609527;12281.508739650313;12129.575464858688;12161.635150945485;12302.81545776832;12461.626151215478;12558.748825023631;10065.496725163859;11917.821232681343;11963.401829908644;12033.217840840667;12277.281180634896 14:08:58 INFO - PROCESS | 1634 | |3;mootools.html;1491.3885307024118;1558.9243422038785;1615.1439736939426;1625.0737079864477;1626.8129165146004;11076.944615276923;11443.427828608557;11723.944844963951;11741.882581174197;11947.984421324198;11521.423928803548;11678.766424671523;11685.182037257395;11734.119941004437;11736.706582335446;2455.4229756007326;2479.764422379871;2487.6268559716095;2489.6638953741194;2491.0658503061354;2431.3313838694326;2463.6696184060584;2494.8004159667275;2500.112460076674;2511.6483692283095;2352.3648614873973;2369.4194922243987;2370.525894821034;2373.098222675381;2391.6053851114543;2295.2655150351893;2297.6438652008965;2310.5609934112463;2313.7107861517225;2444.4744379958393;2397.9520409591887;2414;2424.078850036992;2424.381782645432;2427.2839512343726;11347.319160850375;11643.24318919276;11656;11673;11773.823392649118;5926.259217597801;6111.908321375183;6112.908306375408;6119.388061193845;6123;3509.0350153707677;3653.488511608377;3678.8528458861615;3696.8336424860945;3768.8680896168503;1070.8714954205468;1236.8515778106596;1285.427984546877;1306.1705816806302;1311.8622544632867;14226.430942762277;14476.42094316226;15349.46276880315;16446.259918303705;16555.83444165555;4685.250359942393;4751.239801631722;4763.963641604416;4852.733099679481;4866.245731911559;12236.449359778831;12252.571160009535;12263.202891812003;12270.38648067593;12272.877271227351;5930;5974.522038236931;6055.031195008777;6063.484603808637;6086.513078953762;5414.3232095988005;5437;5485.204645326485;5513.751881165277;5531.446855314436;3906.746061505993;3994.9201015979515;4033.6369726724733;4060.6548443382053;4099.8975025624595;1048.3343077146067;1049.2550289294534;1052.0478966535297;1061.135174832509;1062.6333914799382;955.8422860227985;965.9855102173473;993.9701808945598;1002.1982414068716;1002.2483137646765;6760.290169532227;6839.692213850389;6958.860822783516;6969.477289203229;7042.577445353295;1001.9549120289458;1025.5231317437278;1041.8280983637767;1045.5974449836715;1058.708855064848;3610.8194590270905;4205.852795152155;4228;4229.196452673982;4343.457067866517;11050.723731906606;11273.492692828679;13534.864651353557;13580.592582222549;14004.43982240699;14362.353694083582;14372.35324410404;14373.496927607484;14379.568612941628;14425.567232983027;8912.465252084767;10232.181425486093;10649.361038337725;10783.352998819939;10882.40146791934;6142.969285153725;7021.929780702128;7128.215896251305;7182.17404998411;7246.384057355184;12676.366181690693;12705.36473176319;12726.936365318114;13000.93499532534;13043.282619455642;12884.098113131991;12903.290319032543;12908.612741617766;13046.739065218453;13091.41088651032;7706.922930770621;9288.303377246868;9505;9507.286953478379;9545.997670244524;10308.896911030793;10372.17022638172;10532.842007370049;10592.099671528007;10598.841017384591;7608.543487390774;8748.65005399777;8835.33734969867;8883.777905552413;9024.052474490083;8773.912260877309;8818.735437936872;8841;8885.289176865965;9021.50381728985;8047.798805029921;8220.958895205486;8330.166983301622;8447.070822209429;8458.703945361884;5977.5217982560425;5977.581569290108;6050.818475445743;6134.846628834315;6163.322034576283;5083.822066227813;6047.455728984412;6163.691815409301;6293.276273228637;6409.4231519163495 14:08:58 INFO - PROCESS | 1634 | |4;prototype.html;378.77841462744294;388.19837036519584;392.5897437178148;401.12754758400473;405.3858404517155;4319.978400107999;4899.559039686427;5233.581313494921;5317.707526086064;5412.648177868436;4528.637708983281;4670.416197975253;4746.477887432379;5237.643060622726;5281.2342210379475;4355.303151495761;4462.786793508669;4582.312653102044;4639.350490931272;4699.78850951708;3777.697784177259;4604.447466304048;4619.284010978304;4643.744594047326;4687.453140463639;3993.4009898515164;4038.970062634024;4191.86819558719;4401.625861801751;4665.230237010889;4401.713888597247;4436.844710435152;4624.560666736655;4669.556392142741;4740;4362.978185109054;4383.356241409471;4412.360207769855;4421.646268298528;4452.888677783081;4550.3618697269285;5240.292560504359;5272.917197706923;5278.9208161877605;5285.814996475105;4593.150267200545;5181;5234.555062819665;5451.427600101972;5495.697736624484;5749.31008279005;5778.59549831512;5778.624389414675;5788.88422231553;5792.464996775858;4222.345536441856;4525;4808.990112076468;4970.254461830718;4976.203807390836;5716.456936591017;5716.999050332351;5834.154047663065;6022.939770602282;6089.969550152221;4360.607545320936;4706.647001474903;4977.228529577921;5148.403994761636;5167.509086636764;4623.751587071539;4954.457562842585;5103.642745007814;5310.628256022042;5349.181278365374;4422.646188304928;4957.429895561984;5074.5179207975925;5176.748114570174;5596.244506991504;5013.568419316629;5657.915131273035;5703.771849125988;5741;5761.510271626875;1659.5270347950775;1804.3504338438152;1829.4420201838568;1830.4142674344082;1854.73106399574;1159.750653609478;1235.3884827010688;1252.8724148266633;1315.0728736240926;1488.2409970914912;4662.254039353687;4678.309971766248;5084.644074914794;5158;5315.883664430436;5628.564715997476;5916.674582897896;5972.910406343908;6039.245094363205;6117.265928088569;4433.778311084498;4629.236176030984;4678.8596342109795;4819.662623616313;5283.362157731116;2918.467804402663;2945.617069780915;2947.042211281342;3143.339898621269;3143.842807859598;5119.59043276537;5367.651102678314;6073.240844894388;6183.752649894044;6202.689865506707;5359.732013399314;5817.923684118367;5907.025340818803;5954.196183515257;5987.730552125077;5294.205869119663;5566.972165139148;5761.740721667535;6148.262208535004;6151.815445536641;5530.364008139116;5692.459216374438;5928.67392293428;5948.226730525004;5980.611260268069;5427.348718153847;5475.890482190413;5501.432091853802;5614.6069775116985;5737.512311453574;5210.687358758487;5707.7716891325545;5828.970855145697;6063.81755557662;6203.689815509116;4383.167198232326;4994;5152.046871328666;5184.403793563789;5235.214717792209;4734.928976065293;5235.528802407802;5346.010987967238;5716.8267164968975;5842.38654941225;4707.976460117678;5255.842324730264;5360.103885725826;5465.1145354852515;5534.146061069587;5231.671906001793;5329.653572517929;5370.087085195448;5734.799282025276;5749.281339832521;4655.837045703384;4871.587239700589;5191.6242195817385;5589.860253493695;5663.5469162467725;5799.042488330897;5839.124131380157;5842.620229685057;5845.473907348359;5854.268216472941;5293.867653308698;5478.506934375766;5639.548836093185;5688.658680479184;5716.571257155647 14:08:58 INFO - PROCESS | 1634 | |5;yui.html;756.2815325440829;761.8438220164867;791.6041979010495;886.716250799744;898.0435835834837;16230.675386492278;17466;17819.732704009417;18045.458636240903;18095;15137.848621513782;16204.270807813647;16535.669286614262;16544.66910661789;16585.66828663426;1004.2518323848725;1018.6485662446444;1026.3687831983314;1032.0298919016138;1032.4321623107262;987.0524296675164;1024.497995981971;1024.774549599087;1032.0917592518574;1037.5590374091018;1100.4387762241274;1103.8951299626522;1103.9448027598628;1105.9612913548028;1106.2643342177482;1088.9183311251647;1096.6161843354762;1098.8516550265692;1099.115212254135;1099.9880110298504;804.5333706450244;806.0931452116369;810.8337790752881;812.1715849833137;812.6708682983401;17488.737668934977;17644.117794110243;17664.293428262856;18100.63798724018;18405.53986150357;15748.606284842856;15761.211939403098;15904.363825446968;15931.64581010604;16159.596010099724;12188;12415.193012454252;12461.314627695474;12464.688382790411;12709.809352859715;3648.835802388899;3992.281389349916;4037.656799172074;4211.368294755781;4221.670173895213;86440;101810.98189018163;103500.48249758703;117067.414662927;123013;11996.880031199576;12005.51977920891;12186.390680465942;12310.630681079581;12509.43707533145;26702.332441688726;26945;27066.72933270642;27074.864625676746;27459.31351716223;8567.357448191411;8574.95712521446;8674.6530138795;8740.8688869667;8783.604737786814;4589.173948689268;4611.538846115362;4696.436427628638;4769.6661233714;4777.713337199779;3297.7196938260518;3693.9261214776093;3761.586225515191;3774.2074164425776;3783.981080094582;587.9617824841372;678.375894177358;679.5073571660605;690.2993461636343;690.7789507357697;691.7440546997542;695.8573492434039;706.5125063706026;707.6921539130494;759.1800855076505;10771.78456430867;10913.181511386678;10945.56217751297;11119.833202501968;11214;686.7939618114546;701.386286998876;716.7455553278511;724.1560605910358;727.5198369076384;5174.482551744871;5229.895402092013;5318.627696061239;5320.414754377015;5326.36083669962;83346.58326708328;97815;106599.46700266605;111792;114949;89459;90986.54506727557;91761.54119229494;92523;94338;85522.5723871389;85749.57125214335;86761.99999999873;87985.5600722005;88488.5575572118;9990.395754329325;10116.393016419039;10160.288779785344;10205.897941020496;10232.693019209435;53627.19559206537;53832.19251711149;54214.18678719743;55169.44830551643;55555.444445555026;67478;68969.65515172391;69474.65262673654;69977.30022699707;71176.86469405926;12451.190672606252;12478.87521124777;12788.424520896397;12944.417501212656;12981.675458113623;13001.609951701465;13346.866531334563;13456.125351852099;13602.727945441233;14098;11308.264962777394;12474.5010199591;12778.105532612628;12882.549110781078;13199.802002969771;12197.512099516274;12202.180138845284;12309.26144431337;12314.322712250912;12339;11166.888331116585;12211.69470763238;12303.630891073282;12661.05042121863;12899.613011609667;8190.50856948585;9250.398724082914;9436.905630943602;9712.805743884941;10007.649732259337;9063.320250981335;10768.623098191525;10800.40597767099;10806.243562950833;10829.566817327219 14:08:58 INFO - PROCESS | 1634 | __end_tp_report 14:08:58 INFO - PROCESS | 1634 | __start_cc_report 14:08:58 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,403 14:08:58 INFO - PROCESS | 1634 | __end_cc_report 14:08:58 INFO - PROCESS | 1634 | __startTimestamp1493154538485__endTimestamp 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | ------- Summary: start ------- 14:08:58 INFO - PROCESS | 1634 | Number of tests: 6 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:6151.02 Median:6321.21 stddev:677.52 (10.7%) stddev-sans-first:636.63 14:08:58 INFO - PROCESS | 1634 | Values: 3124.4 3648.4 3658.4 3677.3 3699.5 6244.5 6251.2 6255.9 6270.9 6283.5 6235.4 6260.8 6263.7 6285.6 6288.9 5658.3 5690.1 5703.5 5745.6 5779.5 5751.9 5772.7 5773.5 5782.9 5799.5 5531.6 5534.9 5701.7 5756.0 5770.5 5662.6 5665.6 5682.2 5705.4 5711.6 5539.0 5657.0 5666.8 5678.4 5693.9 5192.3 6096.1 6289.9 6297.5 6318.6 6244.3 6412.2 6421.8 6430.3 6570.5 6813.5 6833.5 6840.2 6842.0 6844.4 5602.6 6296.4 6336.7 6340.1 6361.7 6563.9 6580.6 6625.7 6833.5 6986.7 6256.4 6385.3 6417.0 6497.6 6531.2 6127.1 6173.0 6198.6 6740.6 6751.2 6293.4 6299.7 6597.0 6601.4 6608.3 6052.3 6429.0 6536.3 6538.8 6571.7 4362.5 5331.9 5335.7 5360.6 5386.9 4770.7 4781.3 4781.4 4796.1 4801.3 5537.5 5987.7 6334.8 6366.8 6367.9 6547.3 6559.4 6679.8 6714.4 6745.0 6333.3 6345.6 6347.6 6362.1 6382.3 6012.3 6029.6 6044.7 6046.4 6054.1 6662.1 6663.0 6857.3 6871.9 7017.8 6445.8 6702.8 6777.7 6781.0 6787.8 5710.9 6863.8 6948.5 6992.8 6999.3 6321.2 6374.3 6557.8 6624.4 6653.5 6623.8 6705.4 6706.1 6715.6 6735.8 6432.2 6451.6 6477.3 6487.7 6490.4 6255.4 6475.0 6536.8 6537.6 6540.6 6148.7 6280.3 6290.1 6316.9 6347.6 6360.5 6487.8 6506.5 6520.4 6537.6 6210.7 6232.0 6260.3 6302.1 6380.8 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:57222.85 Median:29219.28 stddev:120019.44 (410.8%) stddev-sans-first:120281.31 14:08:58 INFO - PROCESS | 1634 | Values: 777.9 818.0 839.5 970.4 973.5 39300.4 39782.8 41281.8 41282.4 41434.0 40483.8 40537.4 40666.0 40782.8 40845.4 8252.3 8387.3 11177.1 11412.3 11634.9 11356.8 11394.5 11400.7 11456.1 11467.3 11417.9 11422.4 11455.9 11470.0 11473.2 11378.8 11396.7 11397.4 11400.7 11452.9 11054.1 11060.2 11106.0 11109.0 11109.3 35054.8 35269.3 35292.1 35375.1 35427.5 3998.3 4008.6 4029.7 4042.4 4089.8 26279.3 26329.5 26474.0 27475.2 28259.0 3173.4 3219.7 3234.4 3305.5 3390.2 367965.2 368798.5 368975.2 369555.2 370087.3 45854.3 45916.8 45942.5 45969.8 46023.8 46831.8 46928.0 47067.8 47090.0 47160.5 14761.4 14881.0 14913.3 14917.0 14958.3 10897.2 12570.9 12785.1 12790.9 12800.3 9918.7 11018.6 12185.7 12358.0 12428.9 5830.2 5852.6 5894.4 5908.1 5937.9 1074.6 1092.0 1098.2 1155.1 1159.8 27642.9 28472.3 28550.4 28711.1 29036.0 1090.8 1148.1 1178.7 1184.6 1243.5 13389.7 13930.7 13953.9 14897.0 15268.8 511007.4 511567.9 513166.0 513235.0 513249.0 42227.4 49825.5 49953.5 50265.5 50456.2 1298.4 1449.1 1451.1 1485.0 1490.2 27969.4 27974.3 28346.1 28954.6 29059.9 40941.0 41297.0 41456.8 41650.0 41901.0 457706.0 458886.0 460591.0 461173.0 462061.0 29352.0 29526.3 29776.9 29843.1 30254.8 38242.4 39016.6 39068.6 39158.0 39180.8 27644.4 28095.0 28136.7 28158.6 29086.6 27952.9 28047.0 28133.9 28779.7 28800.4 31822.7 32059.7 32635.2 32932.3 32935.0 26342.0 27541.9 27932.6 28668.9 29538.9 22014.2 22652.0 23012.7 23216.3 23259.0 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:43186.98 Median:21848.95 stddev:116289.52 (532.2%) stddev-sans-first:116571.35 14:08:58 INFO - PROCESS | 1634 | Values: 393.2 408.1 421.0 433.9 443.7 21498.0 22442.0 22982.8 23061.8 23619.0 22080.6 22973.3 23112.8 23838.2 23991.9 5320.9 6325.5 6927.3 7060.5 7166.8 7032.6 7125.9 7161.5 7164.5 7191.3 6828.0 7026.3 7042.4 7070.6 7102.7 7011.8 7051.3 7071.6 7375.7 7687.7 7286.6 7612.8 7636.3 7637.9 7650.7 21109.6 23043.3 27207.6 27959.4 27967.4 2585.0 2974.3 3020.8 3042.6 3090.6 15927.9 16591.6 17326.4 17641.6 17675.3 1806.4 2141.6 2162.4 2164.8 2165.5 159579.0 187295.0 190376.1 194042.0 194904.0 20093.9 21531.4 21664.8 21745.8 21872.8 32577.0 32997.5 33203.3 33265.0 33332.5 10401.7 10659.5 10862.6 11184.6 11278.7 7171.5 9255.5 9271.7 9440.2 9453.4 8077.8 9756.3 9813.9 9900.4 9914.3 4190.2 4230.9 4261.3 4268.6 4271.8 888.6 1087.4 1104.5 1112.4 1131.5 16132.6 21825.1 22085.6 22200.4 22244.1 965.4 986.7 991.2 1011.7 1150.4 10422.9 10928.7 11051.5 11742.3 11742.5 511006.4 646408.5 711511.0 717114.0 800493.0 107373.5 171650.0 176208.0 179761.0 186672.1 1342.9 1369.2 1431.3 1435.8 1438.5 19779.2 20301.5 20850.2 21029.7 21166.4 66623.3 70792.2 71028.6 71183.9 71337.0 97640.0 98283.0 98621.0 100016.0 100475.5 11290.9 11432.3 11985.8 12482.9 12733.3 13588.9 13747.9 13764.4 13789.9 14059.4 11744.0 11775.4 11945.6 11975.8 12075.8 11141.4 11223.9 11323.1 11512.2 11532.0 11885.3 12047.2 12102.2 12175.7 12281.5 12129.6 12161.6 12302.8 12461.6 12558.7 10065.5 11917.8 11963.4 12033.2 12277.3 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:6920.93 Median:2437.90 stddev:4334.10 (177.8%) stddev-sans-first:4327.06 14:08:58 INFO - PROCESS | 1634 | Values: 1491.4 1558.9 1615.1 1625.1 1626.8 11076.9 11443.4 11723.9 11741.9 11948.0 11521.4 11678.8 11685.2 11734.1 11736.7 2455.4 2479.8 2487.6 2489.7 2491.1 2431.3 2463.7 2494.8 2500.1 2511.6 2352.4 2369.4 2370.5 2373.1 2391.6 2295.3 2297.6 2310.6 2313.7 2444.5 2398.0 2414.0 2424.1 2424.4 2427.3 11347.3 11643.2 11656.0 11673.0 11773.8 5926.3 6111.9 6112.9 6119.4 6123.0 3509.0 3653.5 3678.9 3696.8 3768.9 1070.9 1236.9 1285.4 1306.2 1311.9 14226.4 14476.4 15349.5 16446.3 16555.8 4685.3 4751.2 4764.0 4852.7 4866.2 12236.4 12252.6 12263.2 12270.4 12272.9 5930.0 5974.5 6055.0 6063.5 6086.5 5414.3 5437.0 5485.2 5513.8 5531.4 3906.7 3994.9 4033.6 4060.7 4099.9 1048.3 1049.3 1052.0 1061.1 1062.6 955.8 966.0 994.0 1002.2 1002.2 6760.3 6839.7 6958.9 6969.5 7042.6 1002.0 1025.5 1041.8 1045.6 1058.7 3610.8 4205.9 4228.0 4229.2 4343.5 11050.7 11273.5 13534.9 13580.6 14004.4 14362.4 14372.4 14373.5 14379.6 14425.6 8912.5 10232.2 10649.4 10783.4 10882.4 6143.0 7021.9 7128.2 7182.2 7246.4 12676.4 12705.4 12726.9 13000.9 13043.3 12884.1 12903.3 12908.6 13046.7 13091.4 7706.9 9288.3 9505.0 9507.3 9546.0 10308.9 10372.2 10532.8 10592.1 10598.8 7608.5 8748.7 8835.3 8883.8 9024.1 8773.9 8818.7 8841.0 8885.3 9021.5 8047.8 8221.0 8330.2 8447.1 8458.7 5977.5 5977.6 6050.8 6134.8 6163.3 5083.8 6047.5 6163.7 6293.3 6409.4 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4829.30 Median:5232.63 stddev:1294.15 (24.7%) stddev-sans-first:1253.93 14:08:58 INFO - PROCESS | 1634 | Values: 378.8 388.2 392.6 401.1 405.4 4320.0 4899.6 5233.6 5317.7 5412.6 4528.6 4670.4 4746.5 5237.6 5281.2 4355.3 4462.8 4582.3 4639.4 4699.8 3777.7 4604.4 4619.3 4643.7 4687.5 3993.4 4039.0 4191.9 4401.6 4665.2 4401.7 4436.8 4624.6 4669.6 4740.0 4363.0 4383.4 4412.4 4421.6 4452.9 4550.4 5240.3 5272.9 5278.9 5285.8 4593.2 5181.0 5234.6 5451.4 5495.7 5749.3 5778.6 5778.6 5788.9 5792.5 4222.3 4525.0 4809.0 4970.3 4976.2 5716.5 5717.0 5834.2 6022.9 6090.0 4360.6 4706.6 4977.2 5148.4 5167.5 4623.8 4954.5 5103.6 5310.6 5349.2 4422.6 4957.4 5074.5 5176.7 5596.2 5013.6 5657.9 5703.8 5741.0 5761.5 1659.5 1804.4 1829.4 1830.4 1854.7 1159.8 1235.4 1252.9 1315.1 1488.2 4662.3 4678.3 5084.6 5158.0 5315.9 5628.6 5916.7 5972.9 6039.2 6117.3 4433.8 4629.2 4678.9 4819.7 5283.4 2918.5 2945.6 2947.0 3143.3 3143.8 5119.6 5367.7 6073.2 6183.8 6202.7 5359.7 5817.9 5907.0 5954.2 5987.7 5294.2 5567.0 5761.7 6148.3 6151.8 5530.4 5692.5 5928.7 5948.2 5980.6 5427.3 5475.9 5501.4 5614.6 5737.5 5210.7 5707.8 5829.0 6063.8 6203.7 4383.2 4994.0 5152.0 5184.4 5235.2 4734.9 5235.5 5346.0 5716.8 5842.4 4708.0 5255.8 5360.1 5465.1 5534.1 5231.7 5329.7 5370.1 5734.8 5749.3 4655.8 4871.6 5191.6 5589.9 5663.5 5799.0 5839.1 5842.6 5845.5 5854.3 5293.9 5478.5 5639.5 5688.7 5716.6 14:08:58 INFO - PROCESS | 1634 | 14:08:58 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:21375.99 Median:17932.60 stddev:30399.32 (169.5%) stddev-sans-first:30445.17 14:08:58 INFO - PROCESS | 1634 | Values: 756.3 761.8 791.6 886.7 898.0 16230.7 17466.0 17819.7 18045.5 18095.0 15137.8 16204.3 16535.7 16544.7 16585.7 1004.3 1018.6 1026.4 1032.0 1032.4 987.1 1024.5 1024.8 1032.1 1037.6 1100.4 1103.9 1103.9 1106.0 1106.3 1088.9 1096.6 1098.9 1099.1 1100.0 804.5 806.1 810.8 812.2 812.7 17488.7 17644.1 17664.3 18100.6 18405.5 15748.6 15761.2 15904.4 15931.6 16159.6 12188.0 12415.2 12461.3 12464.7 12709.8 3648.8 3992.3 4037.7 4211.4 4221.7 86440.0 101811.0 103500.5 117067.4 123013.0 11996.9 12005.5 12186.4 12310.6 12509.4 26702.3 26945.0 27066.7 27074.9 27459.3 8567.4 8575.0 8674.7 8740.9 8783.6 4589.2 4611.5 4696.4 4769.7 4777.7 3297.7 3693.9 3761.6 3774.2 3784.0 588.0 678.4 679.5 690.3 690.8 691.7 695.9 706.5 707.7 759.2 10771.8 10913.2 10945.6 11119.8 11214.0 686.8 701.4 716.7 724.2 727.5 5174.5 5229.9 5318.6 5320.4 5326.4 83346.6 97815.0 106599.5 111792.0 114949.0 89459.0 90986.5 91761.5 92523.0 94338.0 85522.6 85749.6 86762.0 87985.6 88488.6 9990.4 10116.4 10160.3 10205.9 10232.7 53627.2 53832.2 54214.2 55169.4 55555.4 67478.0 68969.7 69474.7 69977.3 71176.9 12451.2 12478.9 12788.4 12944.4 12981.7 13001.6 13346.9 13456.1 13602.7 14098.0 11308.3 12474.5 12778.1 12882.5 13199.8 12197.5 12202.2 12309.3 12314.3 12339.0 11166.9 12211.7 12303.6 12661.1 12899.6 8190.5 9250.4 9436.9 9712.8 10007.6 9063.3 10768.6 10800.4 10806.2 10829.6 14:08:58 INFO - PROCESS | 1634 | -------- Summary: end -------- 14:08:58 INFO - PROCESS | 1634 | 14:08:59 INFO - TEST-INFO | 1634: exit 0 14:08:59 INFO - TEST-OK | dromaeo_css | took 1115704ms 14:08:59 INFO - TEST-START | kraken 14:08:59 INFO - operating with platform_type : mac_ 14:08:59 INFO - Initialising browser for kraken test... 14:08:59 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmp5dFuwE/profile http://localhost:49240/getInfo.html) 14:09:01 INFO - PROCESS | 1646 | 2017-04-25 14:09:01.401 plugin-container[1648:10145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x864f, name = 'com.apple.tsm.portname' 14:09:01 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:01 INFO - PROCESS | 1646 | 2017-04-25 14:09:01.402 plugin-container[1648:10145] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c03, name = 'com.apple.CFPasteboardClient' 14:09:01 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:01 INFO - PROCESS | 1646 | 2017-04-25 14:09:01.402 plugin-container[1648:10145] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:09:01 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 14:09:01 INFO - PROCESS | 1646 | colorDepth:24 14:09:01 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 14:09:01 INFO - PROCESS | 1646 | __metrics 14:09:01 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 14:09:02 INFO - TEST-INFO | 1646: exit 0 14:09:02 INFO - Browser initialized. 14:09:02 INFO - Running cycle 1/1 for kraken test... 14:09:02 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmp5dFuwE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:09:04 INFO - PROCESS | 1649 | 2017-04-25 14:09:04.355 plugin-container[1650:10272] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 14:09:04 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:04 INFO - PROCESS | 1649 | 2017-04-25 14:09:04.356 plugin-container[1650:10272] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4517, name = 'com.apple.CFPasteboardClient' 14:09:04 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:09:04 INFO - PROCESS | 1649 | 2017-04-25 14:09:04.356 plugin-container[1650:10272] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:09:14 INFO - PROCESS | 1649 | RSS: Main: 174481408 14:09:14 INFO - PROCESS | 1649 | 14:09:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:09:18 INFO - PROCESS | 1649 | RSS: Main: 187822080 14:09:18 INFO - PROCESS | 1649 | 14:09:20 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:09:21 INFO - PROCESS | 1649 | RSS: Main: 195776512 14:09:21 INFO - PROCESS | 1649 | 14:09:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:09:25 INFO - PROCESS | 1649 | RSS: Main: 199585792 14:09:25 INFO - PROCESS | 1649 | 14:09:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:09:27 INFO - PROCESS | 1649 | RSS: Main: 199979008 14:09:27 INFO - PROCESS | 1649 | 14:09:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:30 INFO - PROCESS | 1649 | RSS: Main: 201277440 14:09:30 INFO - PROCESS | 1649 | 14:09:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:34 INFO - PROCESS | 1649 | RSS: Main: 205197312 14:09:34 INFO - PROCESS | 1649 | 14:09:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:37 INFO - PROCESS | 1649 | RSS: Main: 205160448 14:09:37 INFO - PROCESS | 1649 | 14:09:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:09:41 INFO - PROCESS | 1649 | RSS: Main: 205168640 14:09:41 INFO - PROCESS | 1649 | 14:09:43 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:43 INFO - PROCESS | 1649 | RSS: Main: 204660736 14:09:43 INFO - PROCESS | 1649 | 14:09:45 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:46 INFO - PROCESS | 1649 | RSS: Main: 204636160 14:09:46 INFO - PROCESS | 1649 | 14:09:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:48 INFO - PROCESS | 1649 | RSS: Main: 204656640 14:09:48 INFO - PROCESS | 1649 | 14:09:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:52 INFO - PROCESS | 1649 | RSS: Main: 205299712 14:09:52 INFO - PROCESS | 1649 | 14:09:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:55 INFO - PROCESS | 1649 | RSS: Main: 205840384 14:09:55 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:09:57 INFO - PROCESS | 1649 | RSS: Main: 207179776 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | __start_tp_report 14:09:57 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 14:09:57 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 14:09:57 INFO - PROCESS | 1649 | |i|pagename|runs| 14:09:57 INFO - PROCESS | 1649 | |0;ai-astar;105;119;106;172;175;133;119;120;120;148 14:09:57 INFO - PROCESS | 1649 | |1;audio-beat-detection;154;133;137;145;113;136;140;109;124;114 14:09:57 INFO - PROCESS | 1649 | |2;audio-dft;200;195;193;226;275;210;196;195;196;200 14:09:57 INFO - PROCESS | 1649 | |3;audio-fft;77;60;62;82;78;76;80;82;73;58 14:09:57 INFO - PROCESS | 1649 | |4;audio-oscillator;88;70;83;59;68;77;107;99;97;82 14:09:57 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;88;89;88;89;91;101;89;131;90 14:09:57 INFO - PROCESS | 1649 | |6;imaging-darkroom;148;111;97;97;124;106;150;117;96;148 14:09:57 INFO - PROCESS | 1649 | |7;imaging-desaturate;97;93;91;91;92;88;90;91;90;89 14:09:57 INFO - PROCESS | 1649 | |8;json-parse-financial;65;65;65;66;67;70;69;68;69;68 14:09:57 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;56;56;65;62;67;59;59;58;58;58 14:09:57 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;86;86;80;102;85;81;85;89;90;100 14:09:57 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;149;144;140;136;136;134;138;142;192;138 14:09:57 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;152;158;164;167;163;162;173;163;161;162 14:09:57 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;67;69;75;65;61;77;81;83;81;87 14:09:57 INFO - PROCESS | 1649 | __end_tp_report 14:09:57 INFO - PROCESS | 1649 | __start_cc_report 14:09:57 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,981 14:09:57 INFO - PROCESS | 1649 | __end_cc_report 14:09:57 INFO - PROCESS | 1649 | __startTimestamp1493154597959__endTimestamp 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | ------- Summary: start ------- 14:09:57 INFO - PROCESS | 1649 | Number of tests: 14 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:131.70 Median:126.50 stddev:25.25 (20.0%) stddev-sans-first:24.86 14:09:57 INFO - PROCESS | 1649 | Values: 105.0 119.0 106.0 172.0 175.0 133.0 119.0 120.0 120.0 148.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:136.50 stddev:14.96 (11.0%) stddev-sans-first:13.23 14:09:57 INFO - PROCESS | 1649 | Values: 154.0 133.0 137.0 145.0 113.0 136.0 140.0 109.0 124.0 114.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:208.60 Median:200.00 stddev:25.37 (12.7%) stddev-sans-first:26.72 14:09:57 INFO - PROCESS | 1649 | Values: 200.0 195.0 193.0 226.0 275.0 210.0 196.0 195.0 196.0 200.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:72.80 Median:77.50 stddev:9.28 (12.0%) stddev-sans-first:9.72 14:09:57 INFO - PROCESS | 1649 | Values: 77.0 60.0 62.0 82.0 78.0 76.0 80.0 82.0 73.0 58.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:83.00 Median:82.50 stddev:15.13 (18.3%) stddev-sans-first:15.94 14:09:57 INFO - PROCESS | 1649 | Values: 88.0 70.0 83.0 59.0 68.0 77.0 107.0 99.0 97.0 82.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:89.00 stddev:13.39 (15.0%) stddev-sans-first:14.05 14:09:57 INFO - PROCESS | 1649 | Values: 89.0 88.0 89.0 88.0 89.0 91.0 101.0 89.0 131.0 90.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:119.40 Median:149.00 stddev:22.11 (14.8%) stddev-sans-first:20.89 14:09:57 INFO - PROCESS | 1649 | Values: 148.0 111.0 97.0 97.0 124.0 106.0 150.0 117.0 96.0 148.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:91.20 Median:91.00 stddev:2.49 (2.7%) stddev-sans-first:1.51 14:09:57 INFO - PROCESS | 1649 | Values: 97.0 93.0 91.0 91.0 92.0 88.0 90.0 91.0 90.0 89.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:68.00 stddev:1.87 (2.8%) stddev-sans-first:1.81 14:09:57 INFO - PROCESS | 1649 | Values: 65.0 65.0 65.0 66.0 67.0 70.0 69.0 68.0 69.0 68.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.00 stddev:3.71 (6.3%) stddev-sans-first:3.67 14:09:57 INFO - PROCESS | 1649 | Values: 56.0 56.0 65.0 62.0 67.0 59.0 59.0 58.0 58.0 58.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:85.50 stddev:7.32 (8.6%) stddev-sans-first:7.71 14:09:57 INFO - PROCESS | 1649 | Values: 86.0 86.0 80.0 102.0 85.0 81.0 85.0 89.0 90.0 100.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:141.00 stddev:17.13 (12.1%) stddev-sans-first:18.10 14:09:57 INFO - PROCESS | 1649 | Values: 149.0 144.0 140.0 136.0 136.0 134.0 138.0 142.0 192.0 138.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.50 Median:163.00 stddev:5.44 (3.3%) stddev-sans-first:4.24 14:09:57 INFO - PROCESS | 1649 | Values: 152.0 158.0 164.0 167.0 163.0 162.0 173.0 163.0 161.0 162.0 14:09:57 INFO - PROCESS | 1649 | 14:09:57 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.60 Median:79.00 stddev:8.68 (11.0%) stddev-sans-first:8.76 14:09:57 INFO - PROCESS | 1649 | Values: 67.0 69.0 75.0 65.0 61.0 77.0 81.0 83.0 81.0 87.0 14:09:57 INFO - PROCESS | 1649 | -------- Summary: end -------- 14:09:57 INFO - PROCESS | 1649 | 14:09:58 INFO - TEST-INFO | 1649: exit 0 14:09:58 INFO - TEST-OK | kraken | took 59769ms 14:09:58 INFO - SUITE-END | took 1175s 14:09:59 INFO - Completed test suite (00:19:35) 14:09:59 INFO - javascript benchmark 14:09:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7999.905775414069, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3124.3751249750057, 3648.3797754381753, 3658.359787037268, 3677.264547090579, 3699.5190625218725, 6244.469220116284, 6251.156093927324, 6255.906161407577, 6270.874582508359, 6283.497320214383, 6235.376462353763, 6260.7808726694575, 6263.686815659222, 6285.591436556632, 6288.9056664150075, 5658.264425624663, 5690.089585666295, 5703.458171473703, 5745.6265342752795, 5779.508741756935, 5751.856203594923, 5772.682502462363, 5773.48038676519, 5782.913256301159, 5799.507041901444, 5531.585131115163, 5534.889302213974, 5701.6864072476, 5755.971220143893, 5770.538356931435, 5662.631928924628, 5665.631733937322, 5682.232898558683, 5705.400932902027, 5711.600187986801, 5539.030669632798, 5657.0, 5666.773329066874, 5678.403767604384, 5693.943060569382, 5192.3249977503065, 6096.085587161917, 6289.87420251597, 6297.527685423565, 6318.62088274705, 6244.344343843876, 6412.23053233615, 6421.8073457796345, 6430.324815894311, 6570.507211959122, 6813.454923606099, 6833.521653484258, 6840.247572766992, 6842.0, 6844.4182244509275, 5602.551795856321, 6296.401841825019, 6336.714847831859, 6340.144080549113, 6361.745530178788, 6563.934360656428, 6580.572262802998, 6625.701843417058, 6833.521653484208, 6986.7205311787975, 6256.404616822681, 6385.2656944451055, 6416.967915160394, 6497.642629655415, 6531.248906375733, 6127.142200091991, 6172.969135154295, 6198.597091189058, 6740.629265390353, 6751.189857217166, 6293.37066293367, 6299.748010079546, 6597.0, 6601.3728695773825, 6608.306127856506, 6052.303985041776, 6428.967855160694, 6536.281009088996, 6538.8365290868105, 6571.671416429255, 4362.498312694081, 5331.893362132736, 5335.733213339317, 5360.597955153379, 5386.946130538645, 4770.666053376231, 4781.306710526954, 4781.402324709411, 4796.06476737033, 4801.279808028824, 5537.529310008614, 5987.742574059496, 6334.841628959313, 6366.84082897922, 6367.872642547123, 6547.279799222082, 6559.36015996001, 6679.799606011828, 6714.395704386531, 6745.0, 6333.303336632966, 6345.619262844244, 6347.619142851351, 6362.0774987627465, 6382.32985536512, 6012.30858451275, 6029.638221706711, 6044.667543285073, 6046.3651316612, 6054.091886217015, 6662.100616416722, 6663.0, 6857.314268573302, 6871.896921546081, 7017.824554386079, 6445.774397896051, 6702.798916032527, 6777.695003724745, 6780.96609516969, 6787.830304242433, 5710.942890571041, 6863.759768408082, 6948.478864085113, 6992.755253566101, 6999.335063168991, 6321.209848768904, 6374.26695929974, 6557.836054098495, 6624.436922861611, 6653.467722582279, 6623.834404139935, 6705.430038446787, 6706.128203333536, 6715.630640314829, 6735.797926062226, 6432.195975503062, 6451.645159516272, 6477.255115661571, 6487.675616219076, 6490.448311893542, 6255.40573645503, 6475.028745688184, 6536.8365790855605, 6537.640429776408, 6540.640264785482, 6148.739508400678, 6280.277768056732, 6290.119383286252, 6316.873662526632, 6347.619142851444, 6360.459360954371, 6487.772927947499, 6506.479481641552, 6520.380563846427, 6537.607743535403, 6210.658413787285, 6232.034034724625, 6260.342664020212, 6302.086197501429, 6380.808575742735], "value": 6109.156481337169, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.9338756205722, 817.9918200817991, 839.5382539603219, 970.3935040599621, 973.5327043019346, 39300.41049384262, 39782.801085994564, 41281.793591032, 41282.38076428856, 41433.99999999996, 40483.79758101213, 40537.391939120935, 40666.0, 40782.77651670447, 40845.38731919016, 8252.339812814991, 8387.329013678891, 11177.105831533498, 11412.31526108432, 11634.883651163507, 11356.829647555292, 11394.54421823126, 11400.657980260565, 11456.083513318956, 11467.254628449165, 11417.94291028548, 11422.42887855608, 11455.885441145607, 11470.025047870899, 11473.196876218668, 11378.772424551546, 11396.658100257006, 11397.430128493543, 11400.657980260565, 11452.885471145308, 11054.060404865597, 11060.22578419511, 11106.00045995856, 11109.0, 11109.277896936674, 35054.82472587646, 35269.29461410783, 35292.117697057525, 35375.1156221094, 35427.4685879712, 3998.260321840469, 4008.579099194601, 4029.717919745619, 4042.413849991735, 4089.754614723126, 26279.34301642455, 26329.473410531875, 26474.0, 27475.17574472749, 28259.0, 3173.428782819092, 3219.6619354967625, 3234.4178047951596, 3305.4876494143446, 3390.16940849491, 367965.1601742001, 368798.46802297985, 368975.1551242227, 369555.15222423984, 370087.29912700795, 45854.31218531725, 45916.77041614837, 45942.540574594495, 45969.77015114903, 46023.76988115038, 46831.765841171255, 46928.0, 47067.76466117647, 47090.0, 47160.52839471561, 14761.40954361835, 14881.0, 14913.25433728331, 14917.0, 14958.252087395804, 10897.237193396386, 12570.87429125697, 12785.105042646925, 12790.872091278969, 12800.295983720986, 9918.652847150315, 11018.614348497764, 12185.73945846659, 12358.011359091252, 12428.937855310665, 5830.2129212555765, 5852.648841069549, 5894.440028197314, 5908.143319218775, 5937.94195989066, 1074.5970261152067, 1091.9781604367868, 1098.19282827122, 1155.110564865066, 1159.837622732818, 27642.861785690944, 28472.288192795346, 28550.42899142047, 28711.13866584006, 29036.0, 1090.7600327928, 1148.0987424871437, 1178.699431644925, 1184.585395111704, 1243.490169030693, 13389.665258368424, 13930.721385572435, 13953.860461395256, 14897.0, 15268.847311526964, 511007.44496277283, 511567.884321152, 513166.0, 513235.0, 513249.0, 42227.36658950118, 49825.50174498281, 49953.50046499561, 50265.49734502608, 50456.243156352684, 1298.4286913757917, 1449.0581122270398, 1451.100317802969, 1484.95545133644, 1490.2325302469237, 27969.44061118807, 27974.3006424841, 28346.149615511567, 28954.565681514374, 29059.854700726362, 40941.0, 41297.0, 41456.79271603622, 41650.0, 41901.0, 457706.0, 458886.0, 460591.0, 461173.0, 462061.0, 29352.0, 29526.261843454085, 29776.85111574428, 29843.10470685883, 30254.84872575623, 38242.426363605126, 39016.60983390243, 39068.6093139065, 39158.0, 39180.80409598048, 27644.447111057263, 28095.0, 28136.71863281341, 28158.577621336106, 29086.563701544917, 27952.881884724382, 28047.0, 28133.859330703217, 28779.712202877705, 28800.423991519634, 31822.727090916105, 32059.679403206603, 32635.18412039718, 32932.34135317328, 32935.0, 26342.0, 27541.86229068842, 27932.581011285252, 28668.85324586993, 29538.852305739194, 22014.229501967355, 22652.0, 23012.654810177526, 23216.3035108947, 23258.95334709976], "value": 18694.912723334954, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.2488946112923, 408.1449363583293, 420.97263677860917, 433.92189405906936, 443.678062637462, 21498.032588533515, 22442.0, 22982.77017229827, 23061.769382306153, 23619.0, 22080.558388832214, 22973.310800676005, 23112.768872311273, 23838.165664201755, 23991.880040599815, 5320.9467905321035, 6325.5255855811, 6927.3072692730575, 7060.505764596481, 7166.784996450115, 7032.648367581601, 7125.85748285034, 7161.534500257492, 7164.534305270166, 7191.316824901653, 6828.0, 7026.262242464544, 7042.40139588133, 7070.611116388596, 7102.68037938294, 7011.789646310619, 7051.259617740166, 7071.646417679121, 7375.668094935741, 7687.730929417499, 7286.635668216621, 7612.8477430451085, 7636.312731854105, 7637.923620763777, 7650.73222437212, 21109.577808443897, 23043.308700739006, 27207.591886121525, 27959.440811183664, 27967.440651187066, 2584.9918531772437, 2974.3159073413235, 3020.7885448018646, 3042.558828969787, 3090.629124505051, 15927.92036039824, 16591.641782175262, 17326.39357622477, 17641.647167056715, 17675.292988280453, 1806.4219449776076, 2141.550274442369, 2162.3945295317335, 2164.815990640782, 2165.4586353411646, 159579.0, 187295.0, 190376.0962390386, 194042.0, 194904.02547987312, 20093.899530502546, 21531.354059378245, 21664.783352166276, 21745.782542174693, 21872.781272187392, 32577.0, 32997.50503742446, 33203.335933281196, 33265.0, 33332.50001249983, 10401.739956501147, 10659.520321585547, 10862.619808306672, 11184.552617895355, 11278.661640150809, 7171.49799514029, 9255.537223138816, 9271.67549135777, 9440.24478041755, 9453.43279403238, 8077.838443231102, 9756.268279879037, 9813.852792208123, 9900.405975641484, 9914.256430767722, 4190.245755763931, 4230.894227644333, 4261.252886316595, 4268.637165840876, 4271.765052922057, 888.6045709659139, 1087.380193289833, 1104.5471356743697, 1112.3993043756282, 1131.5417256011328, 16132.596685082732, 21825.12699492034, 22085.558288834134, 22200.444988875086, 22244.110235590397, 965.3918031640162, 986.7286496213455, 991.2020823237364, 1011.6560369474267, 1150.3558007515817, 10422.85348611652, 10928.726781830359, 11051.502682379152, 11742.295462272292, 11742.530298787953, 511006.4449677802, 646408.5359146442, 711511.0, 717114.0, 800493.0, 107373.46313268384, 171650.0, 176208.0, 179761.0, 186672.06663966866, 1342.879140877306, 1369.205860600849, 1431.3058166789099, 1435.777454494555, 1438.5109062918448, 19779.208831646574, 20301.49246268855, 20850.165993360097, 21029.684554731386, 21166.365009049754, 66623.33376666172, 70792.2301942435, 71028.64485677538, 71183.93224101746, 71337.0, 97640.0, 98283.01716982739, 98621.0, 100015.99984000067, 100475.49762251142, 11290.887091128983, 11432.314061156358, 11985.820212696992, 12482.937585312015, 12733.29966851795, 13588.864111359155, 13747.862521374658, 13764.380602873094, 13789.931050345085, 14059.437622494986, 11744.0, 11775.411229438665, 11945.641630751092, 11975.820362694392, 12075.818862717242, 11141.442927853737, 11223.943880280547, 11323.094152467947, 11512.19414640967, 11532.0, 11885.346305953255, 12047.156699030984, 12102.213356131822, 12175.695607609527, 12281.508739650313, 12129.575464858688, 12161.635150945485, 12302.81545776832, 12461.626151215478, 12558.748825023631, 10065.496725163859, 11917.821232681343, 11963.401829908644, 12033.217840840667, 12277.281180634896], "value": 12177.860574438417, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1491.3885307024118, 1558.9243422038785, 1615.1439736939426, 1625.0737079864477, 1626.8129165146004, 11076.944615276923, 11443.427828608557, 11723.944844963951, 11741.882581174197, 11947.984421324198, 11521.423928803548, 11678.766424671523, 11685.182037257395, 11734.119941004437, 11736.706582335446, 2455.4229756007326, 2479.764422379871, 2487.6268559716095, 2489.6638953741194, 2491.0658503061354, 2431.3313838694326, 2463.6696184060584, 2494.8004159667275, 2500.112460076674, 2511.6483692283095, 2352.3648614873973, 2369.4194922243987, 2370.525894821034, 2373.098222675381, 2391.6053851114543, 2295.2655150351893, 2297.6438652008965, 2310.5609934112463, 2313.7107861517225, 2444.4744379958393, 2397.9520409591887, 2414.0, 2424.078850036992, 2424.381782645432, 2427.2839512343726, 11347.319160850375, 11643.24318919276, 11656.0, 11673.0, 11773.823392649118, 5926.259217597801, 6111.908321375183, 6112.908306375408, 6119.388061193845, 6123.0, 3509.0350153707677, 3653.488511608377, 3678.8528458861615, 3696.8336424860945, 3768.8680896168503, 1070.8714954205468, 1236.8515778106596, 1285.427984546877, 1306.1705816806302, 1311.8622544632867, 14226.430942762277, 14476.42094316226, 15349.46276880315, 16446.259918303705, 16555.83444165555, 4685.250359942393, 4751.239801631722, 4763.963641604416, 4852.733099679481, 4866.245731911559, 12236.449359778831, 12252.571160009535, 12263.202891812003, 12270.38648067593, 12272.877271227351, 5930.0, 5974.522038236931, 6055.031195008777, 6063.484603808637, 6086.513078953762, 5414.3232095988005, 5437.0, 5485.204645326485, 5513.751881165277, 5531.446855314436, 3906.746061505993, 3994.9201015979515, 4033.6369726724733, 4060.6548443382053, 4099.8975025624595, 1048.3343077146067, 1049.2550289294534, 1052.0478966535297, 1061.135174832509, 1062.6333914799382, 955.8422860227985, 965.9855102173473, 993.9701808945598, 1002.1982414068716, 1002.2483137646765, 6760.290169532227, 6839.692213850389, 6958.860822783516, 6969.477289203229, 7042.577445353295, 1001.9549120289458, 1025.5231317437278, 1041.8280983637767, 1045.5974449836715, 1058.708855064848, 3610.8194590270905, 4205.852795152155, 4228.0, 4229.196452673982, 4343.457067866517, 11050.723731906606, 11273.492692828679, 13534.864651353557, 13580.592582222549, 14004.43982240699, 14362.353694083582, 14372.35324410404, 14373.496927607484, 14379.568612941628, 14425.567232983027, 8912.465252084767, 10232.181425486093, 10649.361038337725, 10783.352998819939, 10882.40146791934, 6142.969285153725, 7021.929780702128, 7128.215896251305, 7182.17404998411, 7246.384057355184, 12676.366181690693, 12705.36473176319, 12726.936365318114, 13000.93499532534, 13043.282619455642, 12884.098113131991, 12903.290319032543, 12908.612741617766, 13046.739065218453, 13091.41088651032, 7706.922930770621, 9288.303377246868, 9505.0, 9507.286953478379, 9545.997670244524, 10308.896911030793, 10372.17022638172, 10532.842007370049, 10592.099671528007, 10598.841017384591, 7608.543487390774, 8748.65005399777, 8835.33734969867, 8883.777905552413, 9024.052474490083, 8773.912260877309, 8818.735437936872, 8841.0, 8885.289176865965, 9021.50381728985, 8047.798805029921, 8220.958895205486, 8330.166983301622, 8447.070822209429, 8458.703945361884, 5977.5217982560425, 5977.581569290108, 6050.818475445743, 6134.846628834315, 6163.322034576283, 5083.822066227813, 6047.455728984412, 6163.691815409301, 6293.276273228637, 6409.4231519163495], "value": 5274.333027077834, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.77841462744294, 388.19837036519584, 392.5897437178148, 401.12754758400473, 405.3858404517155, 4319.978400107999, 4899.559039686427, 5233.581313494921, 5317.707526086064, 5412.648177868436, 4528.637708983281, 4670.416197975253, 4746.477887432379, 5237.643060622726, 5281.2342210379475, 4355.303151495761, 4462.786793508669, 4582.312653102044, 4639.350490931272, 4699.78850951708, 3777.697784177259, 4604.447466304048, 4619.284010978304, 4643.744594047326, 4687.453140463639, 3993.4009898515164, 4038.970062634024, 4191.86819558719, 4401.625861801751, 4665.230237010889, 4401.713888597247, 4436.844710435152, 4624.560666736655, 4669.556392142741, 4740.0, 4362.978185109054, 4383.356241409471, 4412.360207769855, 4421.646268298528, 4452.888677783081, 4550.3618697269285, 5240.292560504359, 5272.917197706923, 5278.9208161877605, 5285.814996475105, 4593.150267200545, 5181.0, 5234.555062819665, 5451.427600101972, 5495.697736624484, 5749.31008279005, 5778.59549831512, 5778.624389414675, 5788.88422231553, 5792.464996775858, 4222.345536441856, 4525.0, 4808.990112076468, 4970.254461830718, 4976.203807390836, 5716.456936591017, 5716.999050332351, 5834.154047663065, 6022.939770602282, 6089.969550152221, 4360.607545320936, 4706.647001474903, 4977.228529577921, 5148.403994761636, 5167.509086636764, 4623.751587071539, 4954.457562842585, 5103.642745007814, 5310.628256022042, 5349.181278365374, 4422.646188304928, 4957.429895561984, 5074.5179207975925, 5176.748114570174, 5596.244506991504, 5013.568419316629, 5657.915131273035, 5703.771849125988, 5741.0, 5761.510271626875, 1659.5270347950775, 1804.3504338438152, 1829.4420201838568, 1830.4142674344082, 1854.73106399574, 1159.750653609478, 1235.3884827010688, 1252.8724148266633, 1315.0728736240926, 1488.2409970914912, 4662.254039353687, 4678.309971766248, 5084.644074914794, 5158.0, 5315.883664430436, 5628.564715997476, 5916.674582897896, 5972.910406343908, 6039.245094363205, 6117.265928088569, 4433.778311084498, 4629.236176030984, 4678.8596342109795, 4819.662623616313, 5283.362157731116, 2918.467804402663, 2945.617069780915, 2947.042211281342, 3143.339898621269, 3143.842807859598, 5119.59043276537, 5367.651102678314, 6073.240844894388, 6183.752649894044, 6202.689865506707, 5359.732013399314, 5817.923684118367, 5907.025340818803, 5954.196183515257, 5987.730552125077, 5294.205869119663, 5566.972165139148, 5761.740721667535, 6148.262208535004, 6151.815445536641, 5530.364008139116, 5692.459216374438, 5928.67392293428, 5948.226730525004, 5980.611260268069, 5427.348718153847, 5475.890482190413, 5501.432091853802, 5614.6069775116985, 5737.512311453574, 5210.687358758487, 5707.7716891325545, 5828.970855145697, 6063.81755557662, 6203.689815509116, 4383.167198232326, 4994.0, 5152.046871328666, 5184.403793563789, 5235.214717792209, 4734.928976065293, 5235.528802407802, 5346.010987967238, 5716.8267164968975, 5842.38654941225, 4707.976460117678, 5255.842324730264, 5360.103885725826, 5465.1145354852515, 5534.146061069587, 5231.671906001793, 5329.653572517929, 5370.087085195448, 5734.799282025276, 5749.281339832521, 4655.837045703384, 4871.587239700589, 5191.6242195817385, 5589.860253493695, 5663.5469162467725, 5799.042488330897, 5839.124131380157, 5842.620229685057, 5845.473907348359, 5854.268216472941, 5293.867653308698, 5478.506934375766, 5639.548836093185, 5688.658680479184, 5716.571257155647], "value": 4458.212622642151, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.2815325440829, 761.8438220164867, 791.6041979010495, 886.716250799744, 898.0435835834837, 16230.675386492278, 17466.0, 17819.732704009417, 18045.458636240903, 18095.0, 15137.848621513782, 16204.270807813647, 16535.669286614262, 16544.66910661789, 16585.66828663426, 1004.2518323848725, 1018.6485662446444, 1026.3687831983314, 1032.0298919016138, 1032.4321623107262, 987.0524296675164, 1024.497995981971, 1024.774549599087, 1032.0917592518574, 1037.5590374091018, 1100.4387762241274, 1103.8951299626522, 1103.9448027598628, 1105.9612913548028, 1106.2643342177482, 1088.9183311251647, 1096.6161843354762, 1098.8516550265692, 1099.115212254135, 1099.9880110298504, 804.5333706450244, 806.0931452116369, 810.8337790752881, 812.1715849833137, 812.6708682983401, 17488.737668934977, 17644.117794110243, 17664.293428262856, 18100.63798724018, 18405.53986150357, 15748.606284842856, 15761.211939403098, 15904.363825446968, 15931.64581010604, 16159.596010099724, 12188.0, 12415.193012454252, 12461.314627695474, 12464.688382790411, 12709.809352859715, 3648.835802388899, 3992.281389349916, 4037.656799172074, 4211.368294755781, 4221.670173895213, 86440.0, 101810.98189018163, 103500.48249758703, 117067.414662927, 123013.0, 11996.880031199576, 12005.51977920891, 12186.390680465942, 12310.630681079581, 12509.43707533145, 26702.332441688726, 26945.0, 27066.72933270642, 27074.864625676746, 27459.31351716223, 8567.357448191411, 8574.95712521446, 8674.6530138795, 8740.8688869667, 8783.604737786814, 4589.173948689268, 4611.538846115362, 4696.436427628638, 4769.6661233714, 4777.713337199779, 3297.7196938260518, 3693.9261214776093, 3761.586225515191, 3774.2074164425776, 3783.981080094582, 587.9617824841372, 678.375894177358, 679.5073571660605, 690.2993461636343, 690.7789507357697, 691.7440546997542, 695.8573492434039, 706.5125063706026, 707.6921539130494, 759.1800855076505, 10771.78456430867, 10913.181511386678, 10945.56217751297, 11119.833202501968, 11214.0, 686.7939618114546, 701.386286998876, 716.7455553278511, 724.1560605910358, 727.5198369076384, 5174.482551744871, 5229.895402092013, 5318.627696061239, 5320.414754377015, 5326.36083669962, 83346.58326708328, 97815.0, 106599.46700266605, 111792.0, 114949.0, 89459.0, 90986.54506727557, 91761.54119229494, 92523.0, 94338.0, 85522.5723871389, 85749.57125214335, 86761.99999999873, 87985.5600722005, 88488.5575572118, 9990.395754329325, 10116.393016419039, 10160.288779785344, 10205.897941020496, 10232.693019209435, 53627.19559206537, 53832.19251711149, 54214.18678719743, 55169.44830551643, 55555.444445555026, 67478.0, 68969.65515172391, 69474.65262673654, 69977.30022699707, 71176.86469405926, 12451.190672606252, 12478.87521124777, 12788.424520896397, 12944.417501212656, 12981.675458113623, 13001.609951701465, 13346.866531334563, 13456.125351852099, 13602.727945441233, 14098.0, 11308.264962777394, 12474.5010199591, 12778.105532612628, 12882.549110781078, 13199.802002969771, 12197.512099516274, 12202.180138845284, 12309.26144431337, 12314.322712250912, 12339.0, 11166.888331116585, 12211.69470763238, 12303.630891073282, 12661.05042121863, 12899.613011609667, 8190.50856948585, 9250.398724082914, 9436.905630943602, 9712.805743884941, 10007.649732259337, 9063.320250981335, 10768.623098191525, 10800.40597767099, 10806.243562950833, 10829.566817327219], "value": 8014.326350486819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 106.0, 172.0, 175.0, 133.0, 119.0, 120.0, 120.0, 148.0], "value": 131.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 137.0, 145.0, 113.0, 136.0, 140.0, 109.0, 124.0, 114.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 195.0, 193.0, 226.0, 275.0, 210.0, 196.0, 195.0, 196.0, 200.0], "value": 208.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 60.0, 62.0, 82.0, 78.0, 76.0, 80.0, 82.0, 73.0, 58.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 83.0, 59.0, 68.0, 77.0, 107.0, 99.0, 97.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 89.0, 91.0, 101.0, 89.0, 131.0, 90.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 97.0, 97.0, 124.0, 106.0, 150.0, 117.0, 96.0, 148.0], "value": 119.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 93.0, 91.0, 91.0, 92.0, 88.0, 90.0, 91.0, 90.0, 89.0], "value": 91.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 67.0, 70.0, 69.0, 68.0, 69.0, 68.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 65.0, 62.0, 67.0, 59.0, 59.0, 58.0, 58.0, 58.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 80.0, 102.0, 85.0, 81.0, 85.0, 89.0, 90.0, 100.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 144.0, 140.0, 136.0, 136.0, 134.0, 138.0, 142.0, 192.0, 138.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 158.0, 164.0, 167.0, 163.0, 162.0, 173.0, 163.0, 161.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 75.0, 65.0, 61.0, 77.0, 81.0, 83.0, 81.0, 87.0], "value": 74.6, "unit": "score"}]}]} 14:09:59 INFO - Return code: 0 14:09:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:59 ERROR - # TBPL SUCCESS # 14:09:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:59 INFO - 2017-04-25 14:09:59.264 screenresolution[1654:10653] starting screenresolution argv=screenresolution get 14:09:59 INFO - 2017-04-25 14:09:59.266 screenresolution[1654:10653] Display 0: 1600x1200x32@60 14:09:59 INFO - 2017-04-25 14:09:59.272 screenresolution[1655:10656] starting screenresolution argv=screenresolution list 14:09:59 INFO - Available Modes on Display 0 14:09:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:59 INFO - Intel Iris: 14:09:59 INFO - Chipset Model: Intel Iris 14:09:59 INFO - Type: GPU 14:09:59 INFO - Bus: Built-In 14:09:59 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:59 INFO - Vendor: Intel (0x8086) 14:09:59 INFO - Device ID: 0x0a2e 14:09:59 INFO - Revision ID: 0x0009 14:09:59 INFO - Displays: 14:09:59 INFO - Display: 14:09:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:59 INFO - Display Serial Number: 1600x1200 60 14:09:59 INFO - Main Display: Yes 14:09:59 INFO - Mirror: Off 14:09:59 INFO - Online: Yes 14:09:59 INFO - Rotation: Supported 14:09:59 INFO - Return code: 0 14:09:59 INFO - Running post-action listener: _resource_record_post_action 14:09:59 INFO - [mozharness: 2017-04-25 21:09:59.505836Z] Finished run-tests step (success) 14:09:59 INFO - Running post-run listener: _resource_record_post_run 14:09:59 INFO - Total resource usage - Wall time: 1191s; CPU: 55.0%; Read bytes: 39585792; Write bytes: 426397696; Read time: 327; Write time: 1454 14:09:59 INFO - TinderboxPrint: CPU usage
54.6% 14:09:59 INFO - TinderboxPrint: I/O read bytes / time
39,585,792 / 327 14:09:59 INFO - TinderboxPrint: I/O write bytes / time
426,397,696 / 1,454 14:09:59 INFO - TinderboxPrint: CPU idle
2,165.3 (45.4%) 14:09:59 INFO - TinderboxPrint: CPU system
954.5 (20.0%) 14:09:59 INFO - TinderboxPrint: CPU user
1,646.0 (34.5%) 14:09:59 INFO - TinderboxPrint: Swap in / out
162,361,344 / 0 14:09:59 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122968576; Write bytes: 122787840; Read time: 11174; Write time: 282 14:09:59 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 35649536; Write bytes: 299681792; Read time: 301; Write time: 1153 14:09:59 INFO - Running post-run listener: _upload_blobber_files 14:09:59 INFO - Blob upload gear active. 14:09:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:10:00 INFO - (blobuploader) - INFO - Open directory for files ... 14:10:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:10:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:10:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:01 INFO - (blobuploader) - INFO - Done attempting. 14:10:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:10:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:10:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:02 INFO - (blobuploader) - INFO - Done attempting. 14:10:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:10:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:10:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:03 INFO - (blobuploader) - INFO - Done attempting. 14:10:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:10:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:10:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:10:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:10:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:10:05 INFO - (blobuploader) - INFO - Done attempting. 14:10:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:10:05 INFO - Return code: 0 14:10:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:10:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:10:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbc1b5e79058b08d6dc19817e5abcb90e5cee02c057c6fa0a02b3c23230c9c533149195fa9300199fd564f5fb76cb81d9447f4e2620b374140c8812d8256d7e7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/789bfd0bb730b5d6f0c6c0f5199121cf637c623d2a1949f76243d3d75c83b61964ce8b0feea5e1dd0c53601ea5146c9b3cdaadb7ef77738f74143c02ed06f300", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d02f8df00da8e822d519f8ecafce6bff88641a2b0541de10629fa820420d49a9eab352fd50c2ca0ab6f77e7f8cc9994fdcc3a84a5acd9b3519e2fdf23ab3358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef52b6a36578ce34ec515a915e779d4b15a4bce828ed7c48f5912a2100d4144715b85e04a4058b117969712fe98ea7a64867f1940da8fe71bd93062a75e3b962"} 14:10:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:10:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:10:05 INFO - Contents: 14:10:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbc1b5e79058b08d6dc19817e5abcb90e5cee02c057c6fa0a02b3c23230c9c533149195fa9300199fd564f5fb76cb81d9447f4e2620b374140c8812d8256d7e7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/789bfd0bb730b5d6f0c6c0f5199121cf637c623d2a1949f76243d3d75c83b61964ce8b0feea5e1dd0c53601ea5146c9b3cdaadb7ef77738f74143c02ed06f300", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d02f8df00da8e822d519f8ecafce6bff88641a2b0541de10629fa820420d49a9eab352fd50c2ca0ab6f77e7f8cc9994fdcc3a84a5acd9b3519e2fdf23ab3358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef52b6a36578ce34ec515a915e779d4b15a4bce828ed7c48f5912a2100d4144715b85e04a4058b117969712fe98ea7a64867f1940da8fe71bd93062a75e3b962"} 14:10:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:10:05 INFO - Copying logs to upload dir... 14:10:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:10:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.892228 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-04-25 14:10:05.105335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:10:05.109264) ========= 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.gLLs9PSvL8/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.rlce0fmAhD/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbc1b5e79058b08d6dc19817e5abcb90e5cee02c057c6fa0a02b3c23230c9c533149195fa9300199fd564f5fb76cb81d9447f4e2620b374140c8812d8256d7e7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/789bfd0bb730b5d6f0c6c0f5199121cf637c623d2a1949f76243d3d75c83b61964ce8b0feea5e1dd0c53601ea5146c9b3cdaadb7ef77738f74143c02ed06f300", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d02f8df00da8e822d519f8ecafce6bff88641a2b0541de10629fa820420d49a9eab352fd50c2ca0ab6f77e7f8cc9994fdcc3a84a5acd9b3519e2fdf23ab3358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef52b6a36578ce34ec515a915e779d4b15a4bce828ed7c48f5912a2100d4144715b85e04a4058b117969712fe98ea7a64867f1940da8fe71bd93062a75e3b962"} build_url:https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010971 build_url: 'https://queue.taskcluster.net/v1/task/XDh70q34Q4eIJOZCDasBlw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bbc1b5e79058b08d6dc19817e5abcb90e5cee02c057c6fa0a02b3c23230c9c533149195fa9300199fd564f5fb76cb81d9447f4e2620b374140c8812d8256d7e7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/789bfd0bb730b5d6f0c6c0f5199121cf637c623d2a1949f76243d3d75c83b61964ce8b0feea5e1dd0c53601ea5146c9b3cdaadb7ef77738f74143c02ed06f300", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d02f8df00da8e822d519f8ecafce6bff88641a2b0541de10629fa820420d49a9eab352fd50c2ca0ab6f77e7f8cc9994fdcc3a84a5acd9b3519e2fdf23ab3358", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ef52b6a36578ce34ec515a915e779d4b15a4bce828ed7c48f5912a2100d4144715b85e04a4058b117969712fe98ea7a64867f1940da8fe71bd93062a75e3b962"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:10:05.143921) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:10:05.144253) ========= 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.gLLs9PSvL8/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.rlce0fmAhD/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.005069 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:10:05.192597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:10:05.192927) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:10:05.193268) ========= ========= Total master_lag: 4.02 =========