builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0071 starttime: 1487001993.39 results: success (0) buildid: 20170213070540 builduid: 1fc6b61c4883413698beb74ddcd024a0 revision: 55b9181a1979e32d583a85cb6106900301444e69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.392577) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.393118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.393439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.421573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.421986) ========= 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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-02-13 08:06:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.07M=0.001s 2017-02-13 08:06:33 (9.07 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.578212) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.578546) ========= 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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.027507 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:33.627263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 08:06:33.627620) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 55b9181a1979e32d583a85cb6106900301444e69 --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-aurora --rev 55b9181a1979e32d583a85cb6106900301444e69 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.STeE9CHZ3G/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.09RUq8Zf6W/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-02-13 08:06:33,718 truncating revision to first 12 chars 2017-02-13 08:06:33,718 Setting DEBUG logging. 2017-02-13 08:06:33,718 attempt 1/10 2017-02-13 08:06:33,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/55b9181a1979?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-13 08:06:34,818 unpacking tar archive at: mozilla-aurora-55b9181a1979/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-13 08:06:35.023722) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:35.024034) ========= script_repo_revision: 55b9181a1979e32d583a85cb6106900301444e69 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:35.024428) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:35.024700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-13 08:06:35.058033) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-13 08:06:35.058435) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.STeE9CHZ3G/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.09RUq8Zf6W/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:06:35 INFO - MultiFileLogger online at 20170213 08:06:35 in /builds/slave/test 08:06:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:06:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:35 INFO - {'append_to_log': False, 08:06:35 INFO - 'base_work_dir': '/builds/slave/test', 08:06:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:06:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:35 INFO - 'branch': 'Mozilla-Aurora', 08:06:35 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:35 INFO - 'config_files': ('talos/mac_config.py',), 08:06:35 INFO - 'default_actions': ('clobber', 08:06:35 INFO - 'read-buildbot-config', 08:06:35 INFO - 'download-and-extract', 08:06:35 INFO - 'populate-webroot', 08:06:35 INFO - 'create-virtualenv', 08:06:35 INFO - 'install', 08:06:35 INFO - 'run-tests'), 08:06:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:35 INFO - 'download_minidump_stackwalk': True, 08:06:35 INFO - 'download_symbols': 'ondemand', 08:06:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:06:35 INFO - 'tooltool.py': '/tools/tooltool.py', 08:06:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:06:35 INFO - '/tools/misc-python/virtualenv.py')}, 08:06:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:35 INFO - 'installer_path': 'installer.exe', 08:06:35 INFO - 'log_level': 'info', 08:06:35 INFO - 'log_name': 'talos', 08:06:35 INFO - 'log_to_console': True, 08:06:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:06:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:06:35 INFO - 'opt_config_files': (), 08:06:35 INFO - 'pip_index': False, 08:06:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:06:35 INFO - 'cmd': ('bash', 08:06:35 INFO - '-c', 08:06:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:06:35 INFO - 'enabled': True, 08:06:35 INFO - 'halt_on_failure': False, 08:06:35 INFO - 'name': 'check_screen_resolution'},), 08:06:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:06:35 INFO - 'cmd': ('bash', 08:06:35 INFO - '-c', 08:06:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:06:35 INFO - 'enabled': True, 08:06:35 INFO - 'halt_on_failure': False, 08:06:35 INFO - 'name': 'check_screen_resolution'},), 08:06:35 INFO - 'run_cmd_checks_enabled': True, 08:06:35 INFO - 'sps_profile': False, 08:06:35 INFO - 'sps_profile_interval': 0, 08:06:35 INFO - 'suite': 'dromaeojs-e10s', 08:06:35 INFO - 'system_bits': '32', 08:06:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:35 INFO - 'title': 't-yosemite-r7-0071', 08:06:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:35 INFO - 'use_talos_json': True, 08:06:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:35 INFO - 'work_dir': 'build'} 08:06:35 INFO - [mozharness: 2017-02-13 16:06:35.271038Z] Running clobber step. 08:06:35 INFO - Running pre-action listener: _resource_record_pre_action 08:06:35 INFO - Running main action method: clobber 08:06:35 INFO - rmtree: /builds/slave/test/build 08:06:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:37 INFO - Running post-action listener: _resource_record_post_action 08:06:37 INFO - [mozharness: 2017-02-13 16:06:37.827179Z] Finished clobber step (success) 08:06:37 INFO - [mozharness: 2017-02-13 16:06:37.827448Z] Running read-buildbot-config step. 08:06:37 INFO - Running pre-action listener: _resource_record_pre_action 08:06:37 INFO - Running main action method: read_buildbot_config 08:06:37 INFO - Using buildbot properties: 08:06:37 INFO - { 08:06:37 INFO - "project": "", 08:06:37 INFO - "product": "firefox", 08:06:37 INFO - "script_repo_revision": "production", 08:06:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:06:37 INFO - "repository": "", 08:06:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:06:37 INFO - "buildid": "20170213070540", 08:06:37 INFO - "pgo_build": "False", 08:06:37 INFO - "basedir": "/builds/slave/test", 08:06:37 INFO - "buildnumber": 57, 08:06:37 INFO - "slavename": "t-yosemite-r7-0071", 08:06:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:06:37 INFO - "platform": "yosemite_r7", 08:06:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:06:37 INFO - "branch": "mozilla-aurora", 08:06:37 INFO - "repo_path": "releases/mozilla-aurora", 08:06:37 INFO - "revision": "55b9181a1979e32d583a85cb6106900301444e69", 08:06:37 INFO - "stage_platform": "macosx64", 08:06:37 INFO - "builduid": "1fc6b61c4883413698beb74ddcd024a0", 08:06:37 INFO - "slavebuilddir": "test" 08:06:37 INFO - } 08:06:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 08:06:37 INFO - Running post-action listener: _resource_record_post_action 08:06:37 INFO - [mozharness: 2017-02-13 16:06:37.832851Z] Finished read-buildbot-config step (success) 08:06:37 INFO - [mozharness: 2017-02-13 16:06:37.833009Z] Running download-and-extract step. 08:06:37 INFO - Running pre-action listener: _resource_record_pre_action 08:06:37 INFO - Running main action method: download_and_extract 08:06:37 INFO - mkdir: /builds/slave/test/build/tests 08:06:37 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')]} 08:06:37 INFO - trying https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 08:06:37 INFO - Downloading https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:06:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 08:06:39 INFO - Downloaded 1199 bytes. 08:06:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 08:06:39 INFO - Using the following test package requirements: 08:06:39 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:06:39 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 08:06:39 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 08:06:39 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'jsshell-mac.zip'], 08:06:39 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 08:06:39 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 08:06:39 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 08:06:39 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 08:06:39 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 08:06:39 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 08:06:39 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 08:06:39 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:06:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:06:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:06:39 INFO - Fetch https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:06:40 INFO - Expected file size: 16358347 08:06:40 INFO - Obtained file size: 16358347 08:06:46 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:06:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 08:06:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:06:46 INFO - Fetch https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 08:06:47 INFO - Expected file size: 16358347 08:06:47 INFO - Obtained file size: 16358347 08:06:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 08:06:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:06:53 INFO - Fetch https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 08:06:54 INFO - Expected file size: 14403485 08:06:54 INFO - Obtained file size: 14403485 08:06:55 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')]} 08:06:55 INFO - trying https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:06:55 INFO - Downloading https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 08:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 08:06:57 INFO - Downloaded 73961800 bytes. 08:06:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:06:57 INFO - mkdir: /builds/slave/test/properties 08:06:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:57 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:57 INFO - Contents: 08:06:57 INFO - build_url:https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 08:06:57 INFO - Running post-action listener: _resource_record_post_action 08:06:57 INFO - Running post-action listener: set_extra_try_arguments 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.728508Z] Finished download-and-extract step (success) 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.728650Z] Running populate-webroot step. 08:06:57 INFO - Running pre-action listener: _resource_record_pre_action 08:06:57 INFO - Running main action method: populate_webroot 08:06:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:06:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:06:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:06:57 INFO - '--tppagecycles', 08:06:57 INFO - '7'], 08:06:57 INFO - 'tests': ['tsvgm']}}, 08:06:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:06:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:06:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['damp', 'tps']}, 08:06:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'tests': ['damp', 'tps']}, 08:06:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['dromaeo_dom']}, 08:06:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['basic_compositor_video']}, 08:06:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:06:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['a11yr', 08:06:57 INFO - 'ts_paint', 08:06:57 INFO - 'tpaint', 08:06:57 INFO - 'sessionrestore', 08:06:57 INFO - 'sessionrestore_no_auto_restore', 08:06:57 INFO - 'tabpaint']}, 08:06:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tsvgx', 08:06:57 INFO - 'tsvgr_opacity', 08:06:57 INFO - 'tart', 08:06:57 INFO - 'tscrollx', 08:06:57 INFO - 'cart', 08:06:57 INFO - 'tsvg_static']}, 08:06:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:57 INFO - 'tsvgr_opacity', 08:06:57 INFO - 'tart', 08:06:57 INFO - 'tscrollx', 08:06:57 INFO - 'cart', 08:06:57 INFO - 'tsvg_static']}, 08:06:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s'], 08:06:57 INFO - 'tests': ['tp5o']}, 08:06:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:06:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--disable-e10s', 08:06:57 INFO - '--xperf_path', 08:06:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:57 INFO - 'tests': ['tp5n']}, 08:06:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:06:57 INFO - 'talos_options': ['--xperf_path', 08:06:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:57 INFO - 'tests': ['tp5n']}}, 08:06:57 INFO - 'talos.zip': {'path': '', 08:06:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:06:57 INFO - Running post-action listener: _resource_record_post_action 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.747386Z] Finished populate-webroot step (success) 08:06:57 INFO - [mozharness: 2017-02-13 16:06:57.747511Z] Running create-virtualenv step. 08:06:57 INFO - Running pre-action listener: _resource_record_pre_action 08:06:57 INFO - Running main action method: create_virtualenv 08:06:57 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:57 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 08:06:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:06:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:57 INFO - Using real prefix '/tools/python27' 08:06:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:58 INFO - Installing distribute.............................................................................................................................................................................................done. 08:07:01 INFO - Installing pip.................done. 08:07:01 INFO - Return code: 0 08:07:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:07:01 INFO - Reading from file tmpfile_stdout 08:07:01 INFO - Output received: 08:07:01 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) 08:07:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:01 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:01 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 08:07:01 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 08:07:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:01 INFO - 'HOME': '/Users/cltbld', 08:07:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:01 INFO - 'LOGNAME': 'cltbld', 08:07:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:01 INFO - 'MOZ_NO_REMOTE': '1', 08:07:01 INFO - 'NO_EM_RESTART': '1', 08:07:01 INFO - 'PAGER': '/bin/cat', 08:07:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:01 INFO - 'PWD': '/builds/slave/test', 08:07:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:01 INFO - 'SHELL': '/bin/bash', 08:07:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:01 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:01 INFO - 'USER': 'cltbld', 08:07:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:01 INFO - 'XPC_FLAGS': '0x0', 08:07:01 INFO - 'XPC_SERVICE_NAME': '0', 08:07:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:01 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 08:07:01 INFO - Cleaning up... 08:07:02 INFO - Return code: 0 08:07:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:07:02 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')]} 08:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:02 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')]} 08:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:02 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:02 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 08:07:02 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 08:07:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:02 INFO - 'HOME': '/Users/cltbld', 08:07:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:02 INFO - 'LOGNAME': 'cltbld', 08:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:02 INFO - 'MOZ_NO_REMOTE': '1', 08:07:02 INFO - 'NO_EM_RESTART': '1', 08:07:02 INFO - 'PAGER': '/bin/cat', 08:07:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:02 INFO - 'PWD': '/builds/slave/test', 08:07:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:02 INFO - 'SHELL': '/bin/bash', 08:07:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:02 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:02 INFO - 'USER': 'cltbld', 08:07:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:02 INFO - 'XPC_FLAGS': '0x0', 08:07:02 INFO - 'XPC_SERVICE_NAME': '0', 08:07:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:02 INFO - Downloading/unpacking psutil>=3.1.1 08:07:02 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 08:07:02 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 08:07:02 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 08:07:02 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 08:07:02 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 08:07:02 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 08:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:07:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:06 INFO - Installing collected packages: psutil 08:07:06 INFO - Running setup.py install for psutil 08:07:06 INFO - building 'psutil._psutil_osx' extension 08:07:06 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 08:07:07 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 08:07:07 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 08:07:07 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 08:07:07 INFO - building 'psutil._psutil_posix' extension 08:07:07 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 08:07:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:07:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:07:07 INFO - ^ 08:07:07 INFO - 1 warning generated. 08:07:07 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 08:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:07:07 INFO - Successfully installed psutil 08:07:07 INFO - Cleaning up... 08:07:07 INFO - Return code: 0 08:07:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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')]} 08:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:07: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 mozsystemmonitor==0.3 08:07:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:07 INFO - 'HOME': '/Users/cltbld', 08:07:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:07 INFO - 'LOGNAME': 'cltbld', 08:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:07 INFO - 'MOZ_NO_REMOTE': '1', 08:07:07 INFO - 'NO_EM_RESTART': '1', 08:07:07 INFO - 'PAGER': '/bin/cat', 08:07:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:07 INFO - 'PWD': '/builds/slave/test', 08:07:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:07 INFO - 'SHELL': '/bin/bash', 08:07:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:07 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:07 INFO - 'USER': 'cltbld', 08:07:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:07 INFO - 'XPC_FLAGS': '0x0', 08:07:07 INFO - 'XPC_SERVICE_NAME': '0', 08:07:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:07:07 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 08:07:07 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 08:07:07 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 08:07:07 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 08:07:07 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 08:07:07 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 08:07:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:07:10 INFO - Installing collected packages: mozsystemmonitor 08:07:10 INFO - Running setup.py install for mozsystemmonitor 08:07:10 INFO - Successfully installed mozsystemmonitor 08:07:10 INFO - Cleaning up... 08:07:10 INFO - Return code: 0 08:07:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:10 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:10 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 08:07:10 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 08:07:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:10 INFO - 'HOME': '/Users/cltbld', 08:07:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:10 INFO - 'LOGNAME': 'cltbld', 08:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:10 INFO - 'MOZ_NO_REMOTE': '1', 08:07:10 INFO - 'NO_EM_RESTART': '1', 08:07:10 INFO - 'PAGER': '/bin/cat', 08:07:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:10 INFO - 'PWD': '/builds/slave/test', 08:07:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:10 INFO - 'SHELL': '/bin/bash', 08:07:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:10 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:10 INFO - 'USER': 'cltbld', 08:07:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:10 INFO - 'XPC_FLAGS': '0x0', 08:07:10 INFO - 'XPC_SERVICE_NAME': '0', 08:07:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:07:11 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 08:07:11 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 08:07:11 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 08:07:11 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 08:07:11 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 08:07:11 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 08:07:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:07:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:07:13 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 08:07:13 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 08:07:13 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 08:07:13 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 08:07:13 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 08:07:13 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 08:07:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:07:14 INFO - warning: no files found matching '*.txt' 08:07:14 INFO - no previously-included directories found matching 'build' 08:07:14 INFO - no previously-included directories found matching 'dist' 08:07:14 INFO - no previously-included directories found matching '.git*' 08:07:14 INFO - Installing collected packages: jsonschema, functools32 08:07:14 INFO - Running setup.py install for functools32 08:07:14 INFO - warning: no files found matching '*.txt' 08:07:14 INFO - no previously-included directories found matching 'build' 08:07:14 INFO - no previously-included directories found matching 'dist' 08:07:14 INFO - no previously-included directories found matching '.git*' 08:07:14 INFO - Successfully installed jsonschema functools32 08:07:14 INFO - Cleaning up... 08:07:14 INFO - Return code: 0 08:07:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:07:14 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')]} 08:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:14 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')]} 08:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:14 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:14 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 08:07:14 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 08:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:14 INFO - 'HOME': '/Users/cltbld', 08:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:14 INFO - 'LOGNAME': 'cltbld', 08:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:14 INFO - 'MOZ_NO_REMOTE': '1', 08:07:14 INFO - 'NO_EM_RESTART': '1', 08:07:14 INFO - 'PAGER': '/bin/cat', 08:07:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:14 INFO - 'PWD': '/builds/slave/test', 08:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:14 INFO - 'SHELL': '/bin/bash', 08:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:14 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:14 INFO - 'USER': 'cltbld', 08:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:14 INFO - 'XPC_FLAGS': '0x0', 08:07:14 INFO - 'XPC_SERVICE_NAME': '0', 08:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:07:14 INFO - Cleaning up... 08:07:14 INFO - Return code: 0 08:07:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:07:14 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')]} 08:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:14 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')]} 08:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:14 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:14 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 08:07:14 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 08:07:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:14 INFO - 'HOME': '/Users/cltbld', 08:07:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:14 INFO - 'LOGNAME': 'cltbld', 08:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:14 INFO - 'MOZ_NO_REMOTE': '1', 08:07:14 INFO - 'NO_EM_RESTART': '1', 08:07:14 INFO - 'PAGER': '/bin/cat', 08:07:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:14 INFO - 'PWD': '/builds/slave/test', 08:07:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:14 INFO - 'SHELL': '/bin/bash', 08:07:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:14 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:14 INFO - 'USER': 'cltbld', 08:07:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:14 INFO - 'XPC_FLAGS': '0x0', 08:07:14 INFO - 'XPC_SERVICE_NAME': '0', 08:07:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:15 INFO - Downloading/unpacking blobuploader==1.2.4 08:07:15 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 08:07:15 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 08:07:15 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 08:07:15 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 08:07:15 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 08:07:15 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 08:07:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:07:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:07:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:07:17 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 08:07:17 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 08:07:17 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 08:07:17 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 08:07:17 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 08:07:17 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 08:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:07:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:18 INFO - Downloading docopt-0.6.1.tar.gz 08:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:07:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:07:19 INFO - Running setup.py install for blobuploader 08:07:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:07:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:07:19 INFO - Running setup.py install for requests 08:07:19 INFO - Running setup.py install for docopt 08:07:19 INFO - Successfully installed blobuploader requests docopt 08:07:19 INFO - Cleaning up... 08:07:19 INFO - Return code: 0 08:07:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:19 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:19 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 08:07:19 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 08:07:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:19 INFO - 'HOME': '/Users/cltbld', 08:07:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:19 INFO - 'LOGNAME': 'cltbld', 08:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:19 INFO - 'MOZ_NO_REMOTE': '1', 08:07:19 INFO - 'NO_EM_RESTART': '1', 08:07:19 INFO - 'PAGER': '/bin/cat', 08:07:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:19 INFO - 'PWD': '/builds/slave/test', 08:07:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:19 INFO - 'SHELL': '/bin/bash', 08:07:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:19 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:19 INFO - 'USER': 'cltbld', 08:07:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:19 INFO - 'XPC_FLAGS': '0x0', 08:07:19 INFO - 'XPC_SERVICE_NAME': '0', 08:07:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KbTYuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9vJMwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-RDOjcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-QBXI09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-3g45Cf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-jo3TzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-oFL3bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:20 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2kkVzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-CwFq1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7N84r5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-MyMYO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-crrc7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-f8W_Ck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-EZ4OPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-KMbs4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-uD4U0_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:21 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-514dL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:21 INFO - Running setup.py install for manifestparser 08:07:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for mozcrash 08:07:22 INFO - Running setup.py install for mozdebug 08:07:22 INFO - Running setup.py install for mozdevice 08:07:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for mozfile 08:07:22 INFO - Running setup.py install for mozhttpd 08:07:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:07:22 INFO - Running setup.py install for mozinfo 08:07:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Running setup.py install for mozInstall 08:07:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Running setup.py install for mozleak 08:07:23 INFO - Running setup.py install for mozlog 08:07:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Running setup.py install for moznetwork 08:07:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Running setup.py install for mozprocess 08:07:23 INFO - Running setup.py install for mozprofile 08:07:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:07:23 INFO - Running setup.py install for mozrunner 08:07:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:07:24 INFO - Running setup.py install for mozscreenshot 08:07:24 INFO - Running setup.py install for moztest 08:07:24 INFO - Running setup.py install for mozversion 08:07:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:07:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:07:24 INFO - Cleaning up... 08:07:24 INFO - Return code: 0 08:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:24 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')]} 08:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:24 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')]} 08:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:24 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:24 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 08:07:24 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 08:07:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:24 INFO - 'HOME': '/Users/cltbld', 08:07:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:24 INFO - 'LOGNAME': 'cltbld', 08:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:24 INFO - 'MOZ_NO_REMOTE': '1', 08:07:24 INFO - 'NO_EM_RESTART': '1', 08:07:24 INFO - 'PAGER': '/bin/cat', 08:07:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:24 INFO - 'PWD': '/builds/slave/test', 08:07:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:24 INFO - 'SHELL': '/bin/bash', 08:07:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:24 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:24 INFO - 'USER': 'cltbld', 08:07:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:24 INFO - 'XPC_FLAGS': '0x0', 08:07:24 INFO - 'XPC_SERVICE_NAME': '0', 08:07:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-61pgzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:24 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)) 08:07:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:24 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-ah3IBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-JHnXBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-CU4MJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-G6whCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-G8MzMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-fH6lHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-nwqtjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Eo7RdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-9PnQhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:25 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)) 08:07:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:25 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-BvSMcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:26 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)) 08:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-alx2Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-RhY0zZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:26 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)) 08:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-DCQ6jz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:26 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)) 08:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7XZn9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:26 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)) 08:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-TwI4Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:26 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)) 08:07:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:26 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-JczGAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:26 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)) 08:07:26 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)) 08:07:26 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)) 08:07:26 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)) 08:07:26 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)) 08:07:26 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)) 08:07:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:07:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:07:29 INFO - Downloading blessings-1.6.tar.gz 08:07:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:07:29 INFO - Installing collected packages: blessings 08:07:29 INFO - Running setup.py install for blessings 08:07:29 INFO - Successfully installed blessings 08:07:29 INFO - Cleaning up... 08:07:29 INFO - Return code: 0 08:07:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:07:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:29 INFO - Reading from file tmpfile_stdout 08:07:29 INFO - Current package versions: 08:07:29 INFO - blessings == 1.6 08:07:29 INFO - blobuploader == 1.2.4 08:07:29 INFO - docopt == 0.6.1 08:07:29 INFO - functools32 == 3.2.3-2 08:07:29 INFO - jsonschema == 2.5.1 08:07:29 INFO - manifestparser == 1.1 08:07:29 INFO - mozInstall == 1.12 08:07:29 INFO - mozcrash == 1.0 08:07:29 INFO - mozdebug == 0.1 08:07:29 INFO - mozdevice == 0.49 08:07:29 INFO - mozfile == 1.2 08:07:29 INFO - mozhttpd == 0.7 08:07:29 INFO - mozinfo == 0.9 08:07:29 INFO - mozleak == 0.1 08:07:29 INFO - mozlog == 3.4 08:07:29 INFO - moznetwork == 0.27 08:07:29 INFO - mozprocess == 0.24 08:07:29 INFO - mozprofile == 0.28 08:07:29 INFO - mozrunner == 6.13 08:07:29 INFO - mozscreenshot == 0.1 08:07:29 INFO - mozsystemmonitor == 0.3 08:07:29 INFO - moztest == 0.8 08:07:29 INFO - mozversion == 1.4 08:07:29 INFO - psutil == 3.1.1 08:07:29 INFO - requests == 1.2.3 08:07:29 INFO - wsgiref == 0.1.2 08:07:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:29 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 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:29 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 08:07:29 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 08:07:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:29 INFO - 'HOME': '/Users/cltbld', 08:07:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:29 INFO - 'LOGNAME': 'cltbld', 08:07:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:29 INFO - 'MOZ_NO_REMOTE': '1', 08:07:29 INFO - 'NO_EM_RESTART': '1', 08:07:29 INFO - 'PAGER': '/bin/cat', 08:07:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:29 INFO - 'PWD': '/builds/slave/test', 08:07:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:29 INFO - 'SHELL': '/bin/bash', 08:07:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:29 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:29 INFO - 'USER': 'cltbld', 08:07:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:29 INFO - 'XPC_FLAGS': '0x0', 08:07:29 INFO - 'XPC_SERVICE_NAME': '0', 08:07:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 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)) 08:07:30 INFO - Cleaning up... 08:07:30 INFO - Return code: 0 08:07:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:07:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102045b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102048768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3fa5e8210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, '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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 08:07:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:07:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:30 INFO - 'HOME': '/Users/cltbld', 08:07:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:30 INFO - 'LOGNAME': 'cltbld', 08:07:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:30 INFO - 'MOZ_NO_REMOTE': '1', 08:07:30 INFO - 'NO_EM_RESTART': '1', 08:07:30 INFO - 'PAGER': '/bin/cat', 08:07:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:30 INFO - 'PWD': '/builds/slave/test', 08:07:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:30 INFO - 'SHELL': '/bin/bash', 08:07:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:30 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:30 INFO - 'USER': 'cltbld', 08:07:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:30 INFO - 'XPC_FLAGS': '0x0', 08:07:30 INFO - 'XPC_SERVICE_NAME': '0', 08:07:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:07:30 INFO - Cleaning up... 08:07:30 INFO - Return code: 0 08:07:30 INFO - Running post-action listener: _resource_record_post_action 08:07:30 INFO - Running post-action listener: _start_resource_monitoring 08:07:30 INFO - Starting resource monitoring. 08:07:30 INFO - [mozharness: 2017-02-13 16:07:30.481109Z] Finished create-virtualenv step (success) 08:07:30 INFO - [mozharness: 2017-02-13 16:07:30.481922Z] Running install step. 08:07:30 INFO - Running pre-action listener: _resource_record_pre_action 08:07:30 INFO - Running main action method: install 08:07:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:30 INFO - Reading from file tmpfile_stdout 08:07:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:07:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:07:30 INFO - Reading from file tmpfile_stdout 08:07:30 INFO - Output received: 08:07:30 INFO - Usage: mozinstall [options] installer 08:07:30 INFO - Options: 08:07:30 INFO - -h, --help show this help message and exit 08:07:30 INFO - -d DEST, --destination=DEST 08:07:30 INFO - Directory to install application into. [default: 08:07:30 INFO - "/builds/slave/test"] 08:07:30 INFO - --app=APP Application being installed. [default: firefox] 08:07:30 INFO - mkdir: /builds/slave/test/build/application 08:07:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:07:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:07:51 INFO - Reading from file tmpfile_stdout 08:07:51 INFO - Output received: 08:07:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:07:51 INFO - Running post-action listener: _resource_record_post_action 08:07:51 INFO - [mozharness: 2017-02-13 16:07:51.118176Z] Finished install step (success) 08:07:51 INFO - [mozharness: 2017-02-13 16:07:51.118329Z] Running run-tests step. 08:07:51 INFO - Running pre-action listener: _resource_record_pre_action 08:07:51 INFO - Running main action method: run_tests 08:07:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:51 INFO - 2017-02-13 08:07:51.133 screenresolution[1629:8398] starting screenresolution argv=screenresolution get 08:07:51 INFO - 2017-02-13 08:07:51.135 screenresolution[1629:8398] Display 0: 1600x1200x32@60 08:07:51 INFO - 2017-02-13 08:07:51.141 screenresolution[1630:8401] starting screenresolution argv=screenresolution list 08:07:51 INFO - Available Modes on Display 0 08:07:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:51 INFO - Intel Iris: 08:07:51 INFO - Chipset Model: Intel Iris 08:07:51 INFO - Type: GPU 08:07:51 INFO - Bus: Built-In 08:07:51 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:51 INFO - Vendor: Intel (0x8086) 08:07:51 INFO - Device ID: 0x0a2e 08:07:51 INFO - Revision ID: 0x0009 08:07:51 INFO - Displays: 08:07:51 INFO - Display: 08:07:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:51 INFO - Display Serial Number: 1600x1200 60 08:07:51 INFO - Main Display: Yes 08:07:51 INFO - Mirror: Off 08:07:51 INFO - Online: Yes 08:07:51 INFO - Rotation: Supported 08:07:51 INFO - Return code: 0 08:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:51 INFO - Python 2.7.3 08:07:51 INFO - Return code: 0 08:07:51 INFO - grabbing minidump binary from tooltool 08:07: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')]} 08:07:51 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 0x101e23d30>, '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 0x101d4adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101e18be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:51 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 08:07:51 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 08:07:51 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 08:07:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:51 INFO - Return code: 0 08:07:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:07:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:07:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 08:07:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --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 08:07:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.STeE9CHZ3G/Render', 08:07:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:07:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:07:51 INFO - 'HOME': '/Users/cltbld', 08:07:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:07:51 INFO - 'LOGNAME': 'cltbld', 08:07:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:51 INFO - 'MOZ_NO_REMOTE': '1', 08:07:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:51 INFO - 'NO_EM_RESTART': '1', 08:07:51 INFO - 'PAGER': '/bin/cat', 08:07:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:51 INFO - 'PWD': '/builds/slave/test', 08:07:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:07:51 INFO - 'SHELL': '/bin/bash', 08:07:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.09RUq8Zf6W/Listeners', 08:07:51 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 08:07:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:07:51 INFO - 'USER': 'cltbld', 08:07:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:07:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:51 INFO - 'XPC_FLAGS': '0x0', 08:07:51 INFO - 'XPC_SERVICE_NAME': '0', 08:07:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:07:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--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 08:07:51 INFO - mozversion application_buildid: 20170213070540 08:07:51 INFO - mozversion application_changeset: 55b9181a1979e32d583a85cb6106900301444e69 08:07:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:07:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:51 INFO - mozversion application_name: Firefox 08:07:51 INFO - mozversion application_remotingname: firefox-dev 08:07:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:07:51 INFO - mozversion application_vendor: Mozilla 08:07:51 INFO - mozversion application_version: 53.0a2 08:07:51 INFO - mozversion platform_buildid: 20170213070540 08:07:51 INFO - mozversion platform_changeset: 55b9181a1979e32d583a85cb6106900301444e69 08:07:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:07:51 INFO - mozversion platform_version: 53.0a2 08:07:51 INFO - using testdate: 1487002071 08:07:51 INFO - actual date: 1487002071 08:07:51 INFO - starting webserver on 'localhost:49240' 08:07:51 INFO - SUITE-START | Running 2 tests 08:07:51 INFO - TEST-START | dromaeo_css 08:07:51 INFO - operating with platform_type : mac_ 08:07:51 INFO - Initialising browser for dromaeo_css test... 08:07:51 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpejJ8bZ/profile http://localhost:49240/getInfo.html) 08:07:54 INFO - PROCESS | 1640 | 2017-02-13 08:07:54.642 plugin-container[1643:8591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4947, name = 'com.apple.tsm.portname' 08:07:54 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:07:54 INFO - PROCESS | 1640 | 2017-02-13 08:07:54.645 plugin-container[1643:8591] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 08:07:54 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:07:54 INFO - PROCESS | 1640 | 2017-02-13 08:07:54.645 plugin-container[1643:8591] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:07:54 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 08:07:54 INFO - PROCESS | 1640 | colorDepth:24 08:07:54 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 08:07:54 INFO - PROCESS | 1640 | __metrics 08:07:54 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:07:55 INFO - TEST-INFO | 1640: exit 0 08:07:55 INFO - Browser initialized. 08:07:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:55 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpejJ8bZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:58 INFO - PROCESS | 1644 | 2017-02-13 08:07:58.042 plugin-container[1645:8716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 08:07:58 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:07:58 INFO - PROCESS | 1644 | 2017-02-13 08:07:58.043 plugin-container[1645:8716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e17, name = 'com.apple.CFPasteboardClient' 08:07:58 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:07:58 INFO - PROCESS | 1644 | 2017-02-13 08:07:58.043 plugin-container[1645:8716] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:08:07 INFO - PROCESS | 1644 | RSS: Main: 219176960 08:08:07 INFO - PROCESS | 1644 | 08:11:09 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:11:11 INFO - PROCESS | 1644 | RSS: Main: 243273728 08:11:11 INFO - PROCESS | 1644 | 08:12:55 INFO - PROCESS | 1644 | ************************* 08:12:55 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 08:12:55 INFO - PROCESS | 1644 | 08:12:55 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:12:55 INFO - PROCESS | 1644 | Full stack: 08:12:55 INFO - PROCESS | 1644 | ************************* 08:14:14 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:14:14 INFO - PROCESS | 1644 | RSS: Main: 250048512 08:14:14 INFO - PROCESS | 1644 | 08:17:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 08:17:17 INFO - PROCESS | 1644 | RSS: Main: 257343488 08:17:17 INFO - PROCESS | 1644 | 08:20:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 08:20:19 INFO - PROCESS | 1644 | RSS: Main: 253947904 08:20:19 INFO - PROCESS | 1644 | 08:23:22 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 08:23:23 INFO - PROCESS | 1644 | RSS: Main: 257998848 08:23:23 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 08:26:25 INFO - PROCESS | 1644 | RSS: Main: 260284416 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | __start_tp_report 08:26:25 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 08:26:25 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 08:26:25 INFO - PROCESS | 1644 | |i|pagename|runs| 08:26:25 INFO - PROCESS | 1644 | |0;dojo.html;3149.905502834915;3362.798232106074;3366.7811592246503;3392.7455440841936;3393.8472768725405;5668;5715.342735585404;5718.9428105719035;5735.684537350444;5743.9138412923785;5693.060644993581;5747.540196784258;5777.220075289834;5799.710014499279;5800.129980502927;4769.928451073237;5214.165733482634;5229.111051121318;5253.658512196714;5296.285001524783;5298.337707786527;5310.362756469229;5315.707636080014;5318.175682769177;5353.437889021655;5172.922406163911;5181.274621552986;5294;5298.549623282006;5307.177387504924;5189.117849965496;5232.398274198478;5244.527992480657;5281.656692314988;5322.680639161624;5133.230015497668;5208.713520756357;5216.061109000379;5217.087009773312;5296.867578310573;5003.924941125886;5646.858828529279;5681.545476361881;5800.100984347433;5805.071188609802;5455.754491047873;6165.445109940082;6175.104609831549;6210.689465526705;6271.278802937675;6237;6246.812595622138;6260.373962603749;6261.248650161964;6271.090691849657;5802.88394232113;5827.970860145672;5829;5863.325717542494;5865.970670146665;6225.533085018642;6227.09707092469;6250.312465628777;6260.655663938527;6273.278572964076;5565.666060036411;6186.876262474725;6193.628382297076;6198.504119670415;6199.442050215503;6227.314995350508;6277.466415354655;6336.429721325103;6338.112664227012;6340.682965851781;6087;6131.6321020738005;6138.5723274837055;6145.678679083929;6292.559520833589;6221.3778622138325;6272.8118156455375;6283.560150789401;6293.779717709858;6312.905306420407;4919.975400123048;4925.630577706686;4928.753562321869;4930.704157750546;4961.50384961501;4307.806148723315;4311.8490852820005;4360.424451949371;4385.188740083095;4437.8224871004795;4810.278458231223;4878.756062196876;5792.189093526909;5900.7049647518315;5905.763769449174;6238.563300569007;6266.592671476339;6312.24253089623;6321.399467050623;6343.302236753953;4367.388565600819;5692.487676109087;5720.3421606515785;5771.307443106854;5838.970805145947;5168.61235407346;5434.673919564839;5442.83671489848;5452.972735136299;5465.316835395575;5108.438071812097;5323.680579165262;6337.176167098248;6338.366163383809;6350.936490635035;6116.457510225511;6126.487138464006;6139.737467782926;6187.721552530057;6296.401841825019;5229.660072095302;6232.750689972531;6253.093301471352;6283.183186185766;6297.874042519215;5977.970110149596;6086.969565152146;6144.508439324933;6146.323904370426;6165.876682466415;6033.698315084316;6152.630842149485;6201.131841542097;6210.689465526796;6227.159333489921;6088.482478989158;6157.291911430243;6158.815235542941;6164.106204600218;6176.135341052166;6142.662153581596;6156.661383623944;6170.382961703794;6175.876482470236;6192.102145189013;5751.654900705971;5844.035734103995;5911.261092363455;5997.100434934795;6021.217241758719;6120.693965301628;6123.203983482297;6132.6920582337325;6184.134221209124;6197.287311959002;6006.519478441627;6024.9397506026135;6038.184845045863;6045.667488288186;6045.879082418239 08:26:25 INFO - PROCESS | 1644 | |1;ext.html;428.1073960791749;457.9604298242986;489.4518139683555;499.05180157700363;545.351032271597;34353.656463435356;39819.2036159277;42856.785716071456;42877.57122428775;42952.785236073774;42587.3611895821;42998.57001429985;43102.13795724091;43222.35166472498;43250.351244731275;9312.348135630491;9563.139317461428;9569.995150509201;10823.891761082406;11288.887111128866;8736.781580460476;11186.888131118665;11218.719532011683;11228.438578071105;11245.943770281137;11215.439228038606;11239.83140252897;11245.381504017276;11273.154513411486;11278.830817537744;11133.777324453547;11193.104551635932;11199.328040317567;11206.943965280203;11218.382988935606;11153.553857845676;11208.887911120866;11236.943815280953;11240.887591124067;11244.66266012021;30786.692133078832;38156.80921595374;38174.80912595419;38210;38302.42546361807;3871.3031654302213;3915.7063220258597;3934.5868683788362;3963.5243770747406;3983.5618082010956;28295.86816527357;28873;29580.260493487618;29948.251293717614;29987.700122998707;3030.6666266710863;3073.938521229585;3082.475979083561;3088.8455577221275;3089.1813669377634;518837;519386;521386;524306;526673.9999999962;59024.52438689067;59159;59757.402425976055;59839.102413463836;59863.70068149632;46966.356177534304;63044.05433918495;63566.36433635605;63595.68202158959;64183.037254441224;15799.921000394925;16188.595285117966;16222.351105955866;16310.592235194215;16324.020558766511;11380.430978451044;11697.707557310965;12400.069994750249;12554.372281385895;12761.915237204941;14471.85528144726;18540.907295463705;18542.629147416978;18548.165332560067;18644.906775466035;6775.510612034806;7183.353498185188;7615;7954.840903181904;8036.839263214703;843.696269343036;882.580774132282;883.4434306386935;894.9910500895038;912.2610685344891;25276.873615631805;28477.857610712228;30445.695543044287;31509.212269692984;31660.525092123637;956.3496822160997;987.8123156600367;1106.673531308266;1123.1800785426685;1220.993895030519;15478.767818482731;16136.515904522883;16175.757363639555;16184.109873957046;16490.093044882407;647520;649126;653596;654768;655378;64119;64274;64562.031569526494;64990.67504662446;65381.34618653753;1435.3904018606536;1447.3993292783377;1456.919869407193;1478.5047009251805;1478.5268714011413;29681.85159074191;29859.402811943204;30804.22989425282;30920.845395772878;31361.68638313679;54244.72877635586;55032.17451738307;55039.89920201494;55132;55187.72406138104;582517;584323;585481;585495;585938;44366;44519.55480445154;45679;45713.77143114263;45858.62424127282;49349.75325123352;49854.25218621651;49961.500384995685;50033.49966500434;51169;40048.59951400448;40381.1923761529;40815.77552673424;41080;42229.521966731016;36475.81762091172;36748.26503469969;37673.058173544785;41653;41706.582934171485;36377.45433818442;36826;37114.44328335131;37150;37246.06884827901;31860;33264.33471330608;33391.33217335688;33492.66507334895;33791.83104084464;24757.752422476264;24994.37514062163;25110.12114575981;25329.240122796346;25403.87298063498 08:26:25 INFO - PROCESS | 1644 | |2;jquery.html;392.948916640837;393.64375240407423;395.58463613206135;403.3103393197633;423.92369373512776;16925.492235232963;19862.801371986276;19865.40403787887;21203.57592848144;21212.04545795439;16561;20561.588768224665;20959;21023.948802559848;21315;5364.222187782779;5766.913496297559;5779.07534794433;5808.709564521778;5814.127880817869;5501.284832971708;5732;5818.06910894257;5828.562857785683;5829.766809327622;5616;5685.232493613351;5690.57320700947;5698.743556539945;5700.144978253254;5459.235707001023;5681.715914204294;5682.914756278638;5690.630109042899;5708.828735137952;4328.567143285678;5098.980203959223;5102.234664800272;5111;5114.974425127851;15524.223788810627;19532.90233548823;22869.656955145685;24198.153064642654;25188;2206.9088867580454;2519.8740062996776;2612.2555071804636;2628.2640860559072;2660.86695665216;8448.704295349695;9934.304598678096;10112.797744045152;10231.693049208536;10483.842742358795;1792.6056267621102;1818.8181181881705;1828.4971632800953;1858.5911099558075;1860.4511669057524;130570;136205.999999999;140384.29807850896;142092;142161.28919355545;11918.344491052902;11999.460024298927;12044.277343359427;12051.57819476314;12232.266064036186;10810.891891080988;14056.226907520184;15572.610684732972;15606.29771660278;15611.375544978073;7045.436365090883;8337.833243335099;8620.482771033632;8678.132186781271;8858.202761751345;8487.448315859448;8594.785130371665;8597.957010214908;8712.172343627346;8722.86915696265;4660.836870709509;4806.591439727662;4819.036192761461;4830.106430310404;4839.443464001614;1754.5350482122249;2063.319104695447;2097.6119417907735;2099.139352865318;2102.5479521902867;821.5194111444872;824.4929368438487;846.7121178799238;876.3514998900895;889.915458031486;14240.501582444773;19659.901700491406;20665.483362916046;20716.171353145706;20950.37148885536;898.7393655839865;901.8872640919885;915.9679411220575;917.7843206846386;924.4776701163821;10173.84739228912;10672.893271067345;10702.46487675613;10708.08981236588;10710.89289107099;730455;736186;749517;761970;769194;145659;148796.2560187192;149583.75624365642;149758;152504;882.6866462405753;999.2006394884064;1003.172382784206;1023.4371095897227;1024.293237666008;17398.956062636284;17431.912840435718;18066.277348905896;18120.822146560433;18289.99405032736;58767;59545.702271488364;59793.80412391641;60144.699276503336;62714.686426567576;86109;86407.70388444053;89209.55395222982;90966;92466.53766731123;7177.892331614926;7462.738804141829;7584.5070070447455;8177.223163799429;8443.07126216128;9089.772755680897;11898.881011189776;12742.554010609585;12958.611241662766;13063.608091757262;9205.76985575366;9411.247100232102;11073;11090.611828585961;11452.07971967143;10057.642218300436;10137.898621013695;10307.536160872629;10675.199360047873;10931.617393391192;11125.610603628835;11259.605913792979;11431.02836258894;11619.477123529292;11737.002354799595;7451.776446706607;7680.308772210527;7695.653695583824;7698.576578288248;7825;9526.666566670134;10733.463326833784;10963.793982661742;11274.379909105079;11279.774404512027 08:26:25 INFO - PROCESS | 1644 | |3;mootools.html;1344.8453427855798;1401.1663060479011;1435.798988141661;1442.985570144299;1454.0693955868246;6831.385175334219;7095.006699062135;7765.107012693542;7889.64496597653;8036.316913062389;6931.896021559668;7973.760787176379;8256.876146857787;8366.581670916461;8429.367797415203;2307.607706689867;2318.744938056821;2333.603287441139;2336.836421450499;2341.9765802342013;1897;2090.226616152026;2166.1010680567547;2311.687922130516;2328.266596022256;2117.9046942887608;2170.8046275835172;2176.260071575664;2327.8719670418122;2337.5792357375667;2115.132795553823;2340.2745149003863;2347.495288512961;2350.1421980976993;2351.4356554426986;2305.988470057656;2334.32383383523;2358.7641235876276;2381.273711517986;2388.2835149455095;8441.662333506652;8477.406581539295;8484.36367272457;8495.532745698983;8503.362247831375;5091.414487333967;5246.711430871301;5249.9212511811975;5251.711155886424;5256.737163141827;3041.4373340931998;3351.497275408684;3455.153487395579;3481.060113769268;3570.8571657133684;1175.0834349207632;1182.4442512019336;1195.5098409652087;1231.1382032577142;1238.182799352432;10694.946525267402;10739.62411315608;10814.134869210444;10846.999999999922;10881.727956801064;4444.2222611042935;4698.154332220233;4771.06964141989;4781.330613714083;4786.138495070921;9484.857727134098;9575.952120239353;9589.232861371074;9601.951990240004;9654.324197306121;5184.662996905189;5278.762455689503;5279.788808447619;5297.046531624267;5304.787808487617;4656.4877863434995;4806.399200099988;4808.206645903457;4825.565699087099;4852.51474852519;3916;3923.4114882767244;3971.490833483258;3999.340108882002;4025.77858217795;1196.838426812369;1245.6948047728365;1295.3005377096451;1299.2009913902882;1303.4460354349364;758.4425447296233;761.7905076104116;788.731831177391;800.3637108498757;823.197382552007;5536;5547.084731019337;5565.582581306418;5590.329160500766;5697.202391665171;968.4867020479157;986.6004268271362;997.3417544420793;998.6155330197926;1019.5972590826731;3751.9437208441896;3867.9613203867602;3932.8820135395986;3971.424143499234;3977.284088864032;9557.187639050759;9692.854607180898;9883.258755593359;9892.961239069939;10077.848832267522;9854.211663066937;9975.102240798364;9998.300118991601;10038.548265328078;10049.24630652704;7661.272179142972;7948.085970113395;7953.920460795433;7955.2840244378285;7996.80007999793;5648.350439699323;5661.433856614306;5745.741441635053;5805.042168042226;5841.795537156179;9207.907920920705;9230.261579073524;9272.629094836131;9377.812443751223;9380.530973451163;8939.195472407255;9260.027697091708;9357.906420935704;9442.622295108118;9443.244540436886;7142;7198.604076775828;7249.782506524813;7296;7336.7798966031105;7804.102528209329;7869.606519674108;7892.960535197287;7914.366850651819;7915.44591878586;5550.250716153268;7037.190723066913;7197.424206063607;7229.963850180716;7257.310555497219;5907.793227237026;6073.542349836096;7073.858522829618;7082.18554866197;7105.715771369294;5102.36220472441;6062.787802426894;6353.174087368612;6425.710843011982;6486.967565162144;4994.200927851526;5001.049800537886;5004.84985450437;5019.146745053276;5066.214736715815;5015.7492125392855;5038.395392552917;5054.29239906406;5098.490150984871;5137.948620513747 08:26:25 INFO - PROCESS | 1644 | |4;prototype.html;323.4808132946621;332.398358970264;358.8690128103243;365.7403243696974;371.9702423806096;4441.622462090726;5061.291419201315;5329.333833270841;5485.451454854518;5519.641223320481;5123.718195499246;5254.264402983586;5292.894142117156;5316.229146773716;5324.281222035024;4187.843260720731;4188.392683060954;4202.894927626819;4211.68412369072;4217.219814334343;3894.941575876364;4039.1921615676833;4220.620144187023;4239.872803815891;4245.938515371157;3727.77633341999;3737.8317975691025;3761.755485893422;4011.8796436106963;4110.958890411102;3999.2201520703475;4131.421600975866;4134.875953721408;4135.17296540693;4175.832966681329;2976.7469765069995;3391.677245874111;3669.3945498992634;3713.220223753015;3719.0516418313427;4396.120775844844;4836.661433699643;5140.228965655144;5226.320578324793;5227.660202086852;4159.708820382574;4433.623142032931;4603.378543896564;4826.541478559531;4854.538818812242;4975.527324904128;4993.729107434636;5521.917171242394;5701.771929122871;5728.79949201776;3366.410878096348;3931.941020884689;4081.3265811141127;4090.9181816363803;4092.6930480214105;4994.925076123861;5347.732613369316;5794.130880367937;5918.792842250544;5971.462568368867;3695.6489133532273;3789.3558095123894;4131.244221205975;4161.292580261363;4197.265478541304;3175.6030496187977;3859.55615104261;3943.8225279862477;4002.7598344099447;4192.517860446027;4784.880377990578;4788.928166077442;4811.7834697438;4824.614030877591;4872.439669437989;5402.270693456412;5703.720360792561;5739.426057394227;5740.913886291709;5764.884702305931;1238.9442475088642;1239.2254840724547;1249.7000719827176;1358.7893876449166;1369.7123604043063;947.4220725357665;978.002437513732;985.8176237396104;986.2750878104588;992.454150217392;4359.934600980988;4969.453360130383;5033.094043072282;5040.899182016339;5107.9489205107475;5339.652922560022;5539;5546.389897111315;5602.355729091125;5612.298462692163;4448.377227188196;4481.596656300949;4923.79015941365;5035.924461133086;5106.46805958211;2539.4794067216176;2816.816906901045;2900.7824413169096;2924.268932766808;2925.5611658251432;4817.759112044384;5399.974004939049;5493.533049690741;5628.493435590816;5803.419658034163;4603.056373443436;4804.8798780030775;4924.080541923968;5008.6744361616375;5136.303440693666;5363.731813409314;5459.908018396337;5495.279836480968;5833.4749872511675;5942.435468630473;4569.702969306984;4655.743934083658;4811.879703007313;5396.379416367168;5575.860603484945;4741.668083234141;4838.516148385133;5166.641682906141;5223.973880130727;5471.972640136773;5072.898542029213;5665.11939321566;5819.185314055951;5840.678762668094;5865.912011319749;3212.6626704196656;3817.7900215488417;3965.325894597868;3968.1865217630893;3989.640932315989;4786.856394308176;4840.91079507108;5261.552768014609;5483.698396588226;5501.312335958005;4954.439351604233;5486.43381801832;5650.152477128464;5676.5742569308295;5686.744096515584;5608.383077861514;5635.943640563706;5640.492355688008;5677.7069299806835;5680.857978550569;5196.168613021899;5245.606579506476;5515.61390702663;5519.586031047607;5522.889542209214;5164.638475306692;5270.446603106619;5542.0855558832345;5637.689927054052;5643.943560564506;4941.407031156285;5561.805336813192;5562.582806289625;5590.468905453975;5593.965116453469 08:26:25 INFO - PROCESS | 1644 | |5;yui.html;631.744143621833;641.2017038786711;707.3598393453923;726.1032624708486;727.5380133615155;11236.381998990053;13789.310534473274;13915.1650900946;13947.860521394809;13979.30103494825;12359.32023738694;12490.000799935984;12776.68058298543;12876.969842412607;12909.870901290984;826.3430572694707;827.5489858027389;836.8493671139192;838.9538575378351;840.2815592668272;825.6614787936948;837.6691206973242;838.4759525296689;841.5497708725833;842.4818736477054;889.1197714262897;897.4391005621486;900.1898291537635;903.2367649336301;904.8145130248316;875.0811647769816;885.4510203673731;888.564603344363;890.1365675294953;894.4275663575285;658.7463826426861;669.9564528305644;672.2470832667395;672.8586996730693;674.7975607317785;12161.51353945841;12265.877341226562;12372.381380931007;12443.875561244362;12492.125551211418;10074.395536267848;10127.240456965757;10151.543180556893;10537.262391632588;10541.367517948871;9405.811883762355;9501.714948551555;9653.517324133765;9668.371555848918;9722.90277097227;3236.64396916339;3276.8197749123788;3322.302316513535;3384.3738908302043;3397.96602033979;98940;99386.50306748493;101695;101830.9633807327;101915.98084019213;7241.131064272216;7294.207012353547;7310.232425595236;7341.119065712149;7444.627768611548;16212.513624591282;16362.34550617962;16408.425705100264;16523.421680241136;16568.75146872798;6663.633500157538;6672;6680.23177334603;6696.866062678817;6833.453323734089;3859;3964.60353964607;3967.504061992251;3968.40473928913;3970.7021973352116;2749.6425464689864;2861.9856900715363;3195.392875353722;3236.3203727217547;3250.5611742414944;585.519873703559;594.6491569973737;598.9578134046815;608.67131748856;608.7260732670316;690.6305126757261;705.992940070603;710.4848984486206;714.8212946763309;726.9527480713737;8885.955570222108;9193.310501712398;9255.202628696577;9459.290553208537;9571.1864491519;544.1266766839245;545.73531837059;582.1297160744714;582.3303201318517;591.1546488521369;3909.139989202371;4113.547509773923;4388.517263101056;4490.955090449119;4757.310190022427;60314;80629.59685201537;86830.56584717036;96782;101490;63769.36230637727;71525.92711109338;74479;83774;85308.29383412297;65711;70455.94316085262;73784;76494.23505764871;79917;10272.845907311246;10522.31604945676;10533.157347412342;10595.682129536126;10688.839667405151;47888.5211147898;49653;49699.422831871096;50410.243846341604;53095.203571945676;47149.528504714515;64235;67606.66196669181;68537.65731171312;69285;11942.820857687315;11963.521459141537;12188.329641869783;12294.139410241198;12422.503099875903;13271.035454238865;13371.598852034454;13410.530631427853;13436;13915.095518791246;12149.271043737404;12515.56195533152;12665.113442059335;12812.231266124063;12911.031672624778;12720;12778.61664150077;12815.16701414405;12824.29466379358;13221;12160.939195303967;12728.363581821057;12799.87200128024;12924.418401171783;13039.087263891437;9327.347085703936;10401.115905148146;10483.690878504092;10516;10797;9319.580618872302;9949.950250248703;9963.202943764627;9979.45113018791;10060.798784024131 08:26:25 INFO - PROCESS | 1644 | __end_tp_report 08:26:25 INFO - PROCESS | 1644 | __start_cc_report 08:26:25 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,380 08:26:25 INFO - PROCESS | 1644 | __end_cc_report 08:26:25 INFO - PROCESS | 1644 | __startTimestamp1487003185948__endTimestamp 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | ------- Summary: start ------- 08:26:25 INFO - PROCESS | 1644 | Number of tests: 6 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5712.57 Median:5911.26 stddev:662.04 (11.2%) stddev-sans-first:632.81 08:26:25 INFO - PROCESS | 1644 | Values: 3149.9 3362.8 3366.8 3392.7 3393.8 5668.0 5715.3 5718.9 5735.7 5743.9 5693.1 5747.5 5777.2 5799.7 5800.1 4769.9 5214.2 5229.1 5253.7 5296.3 5298.3 5310.4 5315.7 5318.2 5353.4 5172.9 5181.3 5294.0 5298.5 5307.2 5189.1 5232.4 5244.5 5281.7 5322.7 5133.2 5208.7 5216.1 5217.1 5296.9 5003.9 5646.9 5681.5 5800.1 5805.1 5455.8 6165.4 6175.1 6210.7 6271.3 6237.0 6246.8 6260.4 6261.2 6271.1 5802.9 5828.0 5829.0 5863.3 5866.0 6225.5 6227.1 6250.3 6260.7 6273.3 5565.7 6186.9 6193.6 6198.5 6199.4 6227.3 6277.5 6336.4 6338.1 6340.7 6087.0 6131.6 6138.6 6145.7 6292.6 6221.4 6272.8 6283.6 6293.8 6312.9 4920.0 4925.6 4928.8 4930.7 4961.5 4307.8 4311.8 4360.4 4385.2 4437.8 4810.3 4878.8 5792.2 5900.7 5905.8 6238.6 6266.6 6312.2 6321.4 6343.3 4367.4 5692.5 5720.3 5771.3 5839.0 5168.6 5434.7 5442.8 5453.0 5465.3 5108.4 5323.7 6337.2 6338.4 6350.9 6116.5 6126.5 6139.7 6187.7 6296.4 5229.7 6232.8 6253.1 6283.2 6297.9 5978.0 6087.0 6144.5 6146.3 6165.9 6033.7 6152.6 6201.1 6210.7 6227.2 6088.5 6157.3 6158.8 6164.1 6176.1 6142.7 6156.7 6170.4 6175.9 6192.1 5751.7 5844.0 5911.3 5997.1 6021.2 6120.7 6123.2 6132.7 6184.1 6197.3 6006.5 6024.9 6038.2 6045.7 6045.9 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:72593.89 Median:38192.40 stddev:157184.76 (411.6%) stddev-sans-first:157532.32 08:26:25 INFO - PROCESS | 1644 | Values: 428.1 458.0 489.5 499.1 545.4 34353.7 39819.2 42856.8 42877.6 42952.8 42587.4 42998.6 43102.1 43222.4 43250.4 9312.3 9563.1 9570.0 10823.9 11288.9 8736.8 11186.9 11218.7 11228.4 11245.9 11215.4 11239.8 11245.4 11273.2 11278.8 11133.8 11193.1 11199.3 11206.9 11218.4 11153.6 11208.9 11236.9 11240.9 11244.7 30786.7 38156.8 38174.8 38210.0 38302.4 3871.3 3915.7 3934.6 3963.5 3983.6 28295.9 28873.0 29580.3 29948.3 29987.7 3030.7 3073.9 3082.5 3088.8 3089.2 518837.0 519386.0 521386.0 524306.0 526674.0 59024.5 59159.0 59757.4 59839.1 59863.7 46966.4 63044.1 63566.4 63595.7 64183.0 15799.9 16188.6 16222.4 16310.6 16324.0 11380.4 11697.7 12400.1 12554.4 12761.9 14471.9 18540.9 18542.6 18548.2 18644.9 6775.5 7183.4 7615.0 7954.8 8036.8 843.7 882.6 883.4 895.0 912.3 25276.9 28477.9 30445.7 31509.2 31660.5 956.3 987.8 1106.7 1123.2 1221.0 15478.8 16136.5 16175.8 16184.1 16490.1 647520.0 649126.0 653596.0 654768.0 655378.0 64119.0 64274.0 64562.0 64990.7 65381.3 1435.4 1447.4 1456.9 1478.5 1478.5 29681.9 29859.4 30804.2 30920.8 31361.7 54244.7 55032.2 55039.9 55132.0 55187.7 582517.0 584323.0 585481.0 585495.0 585938.0 44366.0 44519.6 45679.0 45713.8 45858.6 49349.8 49854.3 49961.5 50033.5 51169.0 40048.6 40381.2 40815.8 41080.0 42229.5 36475.8 36748.3 37673.1 41653.0 41706.6 36377.5 36826.0 37114.4 37150.0 37246.1 31860.0 33264.3 33391.3 33492.7 33791.8 24757.8 24994.4 25110.1 25329.2 25403.9 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:40581.77 Median:2644.57 stddev:124981.67 (4726.0%) stddev-sans-first:125295.85 08:26:25 INFO - PROCESS | 1644 | Values: 392.9 393.6 395.6 403.3 423.9 16925.5 19862.8 19865.4 21203.6 21212.0 16561.0 20561.6 20959.0 21023.9 21315.0 5364.2 5766.9 5779.1 5808.7 5814.1 5501.3 5732.0 5818.1 5828.6 5829.8 5616.0 5685.2 5690.6 5698.7 5700.1 5459.2 5681.7 5682.9 5690.6 5708.8 4328.6 5099.0 5102.2 5111.0 5115.0 15524.2 19532.9 22869.7 24198.2 25188.0 2206.9 2519.9 2612.3 2628.3 2660.9 8448.7 9934.3 10112.8 10231.7 10483.8 1792.6 1818.8 1828.5 1858.6 1860.5 130570.0 136206.0 140384.3 142092.0 142161.3 11918.3 11999.5 12044.3 12051.6 12232.3 10810.9 14056.2 15572.6 15606.3 15611.4 7045.4 8337.8 8620.5 8678.1 8858.2 8487.4 8594.8 8598.0 8712.2 8722.9 4660.8 4806.6 4819.0 4830.1 4839.4 1754.5 2063.3 2097.6 2099.1 2102.5 821.5 824.5 846.7 876.4 889.9 14240.5 19659.9 20665.5 20716.2 20950.4 898.7 901.9 916.0 917.8 924.5 10173.8 10672.9 10702.5 10708.1 10710.9 730455.0 736186.0 749517.0 761970.0 769194.0 145659.0 148796.3 149583.8 149758.0 152504.0 882.7 999.2 1003.2 1023.4 1024.3 17399.0 17431.9 18066.3 18120.8 18290.0 58767.0 59545.7 59793.8 60144.7 62714.7 86109.0 86407.7 89209.6 90966.0 92466.5 7177.9 7462.7 7584.5 8177.2 8443.1 9089.8 11898.9 12742.6 12958.6 13063.6 9205.8 9411.2 11073.0 11090.6 11452.1 10057.6 10137.9 10307.5 10675.2 10931.6 11125.6 11259.6 11431.0 11619.5 11737.0 7451.8 7680.3 7695.7 7698.6 7825.0 9526.7 10733.5 10963.8 11274.4 11279.8 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5417.96 Median:5267.75 stddev:2941.21 (55.8%) stddev-sans-first:2933.53 08:26:25 INFO - PROCESS | 1644 | Values: 1344.8 1401.2 1435.8 1443.0 1454.1 6831.4 7095.0 7765.1 7889.6 8036.3 6931.9 7973.8 8256.9 8366.6 8429.4 2307.6 2318.7 2333.6 2336.8 2342.0 1897.0 2090.2 2166.1 2311.7 2328.3 2117.9 2170.8 2176.3 2327.9 2337.6 2115.1 2340.3 2347.5 2350.1 2351.4 2306.0 2334.3 2358.8 2381.3 2388.3 8441.7 8477.4 8484.4 8495.5 8503.4 5091.4 5246.7 5249.9 5251.7 5256.7 3041.4 3351.5 3455.2 3481.1 3570.9 1175.1 1182.4 1195.5 1231.1 1238.2 10694.9 10739.6 10814.1 10847.0 10881.7 4444.2 4698.2 4771.1 4781.3 4786.1 9484.9 9576.0 9589.2 9602.0 9654.3 5184.7 5278.8 5279.8 5297.0 5304.8 4656.5 4806.4 4808.2 4825.6 4852.5 3916.0 3923.4 3971.5 3999.3 4025.8 1196.8 1245.7 1295.3 1299.2 1303.4 758.4 761.8 788.7 800.4 823.2 5536.0 5547.1 5565.6 5590.3 5697.2 968.5 986.6 997.3 998.6 1019.6 3751.9 3868.0 3932.9 3971.4 3977.3 9557.2 9692.9 9883.3 9893.0 10077.8 9854.2 9975.1 9998.3 10038.5 10049.2 7661.3 7948.1 7953.9 7955.3 7996.8 5648.4 5661.4 5745.7 5805.0 5841.8 9207.9 9230.3 9272.6 9377.8 9380.5 8939.2 9260.0 9357.9 9442.6 9443.2 7142.0 7198.6 7249.8 7296.0 7336.8 7804.1 7869.6 7893.0 7914.4 7915.4 5550.3 7037.2 7197.4 7230.0 7257.3 5907.8 6073.5 7073.9 7082.2 7105.7 5102.4 6062.8 6353.2 6425.7 6487.0 4994.2 5001.0 5004.8 5019.1 5066.2 5015.7 5038.4 5054.3 5098.5 5137.9 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4493.40 Median:4972.49 stddev:1334.34 (26.8%) stddev-sans-first:1300.86 08:26:25 INFO - PROCESS | 1644 | Values: 323.5 332.4 358.9 365.7 372.0 4441.6 5061.3 5329.3 5485.5 5519.6 5123.7 5254.3 5292.9 5316.2 5324.3 4187.8 4188.4 4202.9 4211.7 4217.2 3894.9 4039.2 4220.6 4239.9 4245.9 3727.8 3737.8 3761.8 4011.9 4111.0 3999.2 4131.4 4134.9 4135.2 4175.8 2976.7 3391.7 3669.4 3713.2 3719.1 4396.1 4836.7 5140.2 5226.3 5227.7 4159.7 4433.6 4603.4 4826.5 4854.5 4975.5 4993.7 5521.9 5701.8 5728.8 3366.4 3931.9 4081.3 4090.9 4092.7 4994.9 5347.7 5794.1 5918.8 5971.5 3695.6 3789.4 4131.2 4161.3 4197.3 3175.6 3859.6 3943.8 4002.8 4192.5 4784.9 4788.9 4811.8 4824.6 4872.4 5402.3 5703.7 5739.4 5740.9 5764.9 1238.9 1239.2 1249.7 1358.8 1369.7 947.4 978.0 985.8 986.3 992.5 4359.9 4969.5 5033.1 5040.9 5107.9 5339.7 5539.0 5546.4 5602.4 5612.3 4448.4 4481.6 4923.8 5035.9 5106.5 2539.5 2816.8 2900.8 2924.3 2925.6 4817.8 5400.0 5493.5 5628.5 5803.4 4603.1 4804.9 4924.1 5008.7 5136.3 5363.7 5459.9 5495.3 5833.5 5942.4 4569.7 4655.7 4811.9 5396.4 5575.9 4741.7 4838.5 5166.6 5224.0 5472.0 5072.9 5665.1 5819.2 5840.7 5865.9 3212.7 3817.8 3965.3 3968.2 3989.6 4786.9 4840.9 5261.6 5483.7 5501.3 4954.4 5486.4 5650.2 5676.6 5686.7 5608.4 5635.9 5640.5 5677.7 5680.9 5196.2 5245.6 5515.6 5519.6 5522.9 5164.6 5270.4 5542.1 5637.7 5643.9 4941.4 5561.8 5562.6 5590.5 5594.0 08:26:25 INFO - PROCESS | 1644 | 08:26:25 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:18400.35 Median:544.93 stddev:26724.95 (4904.3%) stddev-sans-first:26766.62 08:26:25 INFO - PROCESS | 1644 | Values: 631.7 641.2 707.4 726.1 727.5 11236.4 13789.3 13915.2 13947.9 13979.3 12359.3 12490.0 12776.7 12877.0 12909.9 826.3 827.5 836.8 839.0 840.3 825.7 837.7 838.5 841.5 842.5 889.1 897.4 900.2 903.2 904.8 875.1 885.5 888.6 890.1 894.4 658.7 670.0 672.2 672.9 674.8 12161.5 12265.9 12372.4 12443.9 12492.1 10074.4 10127.2 10151.5 10537.3 10541.4 9405.8 9501.7 9653.5 9668.4 9722.9 3236.6 3276.8 3322.3 3384.4 3398.0 98940.0 99386.5 101695.0 101831.0 101916.0 7241.1 7294.2 7310.2 7341.1 7444.6 16212.5 16362.3 16408.4 16523.4 16568.8 6663.6 6672.0 6680.2 6696.9 6833.5 3859.0 3964.6 3967.5 3968.4 3970.7 2749.6 2862.0 3195.4 3236.3 3250.6 585.5 594.6 599.0 608.7 608.7 690.6 706.0 710.5 714.8 727.0 8886.0 9193.3 9255.2 9459.3 9571.2 544.1 545.7 582.1 582.3 591.2 3909.1 4113.5 4388.5 4491.0 4757.3 60314.0 80629.6 86830.6 96782.0 101490.0 63769.4 71525.9 74479.0 83774.0 85308.3 65711.0 70455.9 73784.0 76494.2 79917.0 10272.8 10522.3 10533.2 10595.7 10688.8 47888.5 49653.0 49699.4 50410.2 53095.2 47149.5 64235.0 67606.7 68537.7 69285.0 11942.8 11963.5 12188.3 12294.1 12422.5 13271.0 13371.6 13410.5 13436.0 13915.1 12149.3 12515.6 12665.1 12812.2 12911.0 12720.0 12778.6 12815.2 12824.3 13221.0 12160.9 12728.4 12799.9 12924.4 13039.1 9327.3 10401.1 10483.7 10516.0 10797.0 9319.6 9950.0 9963.2 9979.5 10060.8 08:26:25 INFO - PROCESS | 1644 | -------- Summary: end -------- 08:26:25 INFO - PROCESS | 1644 | 08:26:26 INFO - TEST-INFO | 1644: exit 0 08:26:26 INFO - TEST-OK | dromaeo_css | took 1114878ms 08:26:26 INFO - TEST-START | kraken 08:26:26 INFO - operating with platform_type : mac_ 08:26:26 INFO - Initialising browser for kraken test... 08:26:26 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpJ_GUvw/profile http://localhost:49240/getInfo.html) 08:26:29 INFO - PROCESS | 1653 | 2017-02-13 08:26:29.248 plugin-container[1654:10894] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 08:26:29 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:26:29 INFO - PROCESS | 1653 | 2017-02-13 08:26:29.251 plugin-container[1654:10894] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 08:26:29 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:26:29 INFO - PROCESS | 1653 | 2017-02-13 08:26:29.251 plugin-container[1654:10894] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:26:29 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 08:26:29 INFO - PROCESS | 1653 | colorDepth:24 08:26:29 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 08:26:29 INFO - PROCESS | 1653 | __metrics 08:26:29 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 08:26:30 INFO - TEST-INFO | 1653: exit 0 08:26:30 INFO - Browser initialized. 08:26:30 INFO - Running cycle 1/1 for kraken test... 08:26:30 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpJ_GUvw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:26:32 INFO - PROCESS | 1655 | 2017-02-13 08:26:32.719 plugin-container[1656:11026] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 08:26:32 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:26:32 INFO - PROCESS | 1655 | 2017-02-13 08:26:32.720 plugin-container[1656:11026] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c1f, name = 'com.apple.CFPasteboardClient' 08:26:32 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:26:32 INFO - PROCESS | 1655 | 2017-02-13 08:26:32.720 plugin-container[1656:11026] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:26:42 INFO - PROCESS | 1655 | RSS: Main: 219041792 08:26:42 INFO - PROCESS | 1655 | 08:26:45 INFO - PROCESS | 1655 | 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) 08:26:46 INFO - PROCESS | 1655 | RSS: Main: 233119744 08:26:46 INFO - PROCESS | 1655 | 08:26:49 INFO - PROCESS | 1655 | 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) 08:26:49 INFO - PROCESS | 1655 | RSS: Main: 241176576 08:26:49 INFO - PROCESS | 1655 | 08:26:53 INFO - PROCESS | 1655 | 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) 08:26:53 INFO - PROCESS | 1655 | RSS: Main: 244838400 08:26:53 INFO - PROCESS | 1655 | 08:26:55 INFO - PROCESS | 1655 | 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) 08:26:56 INFO - PROCESS | 1655 | RSS: Main: 245751808 08:26:56 INFO - PROCESS | 1655 | 08:26:58 INFO - PROCESS | 1655 | 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) 08:26:58 INFO - PROCESS | 1655 | RSS: Main: 246513664 08:26:58 INFO - PROCESS | 1655 | 08:27:01 INFO - PROCESS | 1655 | 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) 08:27:02 INFO - PROCESS | 1655 | RSS: Main: 250531840 08:27:02 INFO - PROCESS | 1655 | 08:27:04 INFO - PROCESS | 1655 | 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) 08:27:05 INFO - PROCESS | 1655 | RSS: Main: 250568704 08:27:05 INFO - PROCESS | 1655 | 08:27:08 INFO - PROCESS | 1655 | 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) 08:27:09 INFO - PROCESS | 1655 | RSS: Main: 249860096 08:27:09 INFO - PROCESS | 1655 | 08:27:10 INFO - PROCESS | 1655 | 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) 08:27:11 INFO - PROCESS | 1655 | RSS: Main: 249081856 08:27:11 INFO - PROCESS | 1655 | 08:27:13 INFO - PROCESS | 1655 | 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) 08:27:14 INFO - PROCESS | 1655 | RSS: Main: 249200640 08:27:14 INFO - PROCESS | 1655 | 08:27:16 INFO - PROCESS | 1655 | 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) 08:27:16 INFO - PROCESS | 1655 | RSS: Main: 249184256 08:27:16 INFO - PROCESS | 1655 | 08:27:19 INFO - PROCESS | 1655 | 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) 08:27:20 INFO - PROCESS | 1655 | RSS: Main: 249090048 08:27:20 INFO - PROCESS | 1655 | 08:27:23 INFO - PROCESS | 1655 | 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) 08:27:23 INFO - PROCESS | 1655 | RSS: Main: 249466880 08:27:23 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | 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) 08:27:25 INFO - PROCESS | 1655 | RSS: Main: 251179008 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | __start_tp_report 08:27:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 08:27:25 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 08:27:25 INFO - PROCESS | 1655 | |i|pagename|runs| 08:27:25 INFO - PROCESS | 1655 | |0;ai-astar;85;170;177;136;117;118;118;116;118;118 08:27:25 INFO - PROCESS | 1655 | |1;audio-beat-detection;136;142;129;145;115;96;124;146;136;113 08:27:25 INFO - PROCESS | 1655 | |2;audio-dft;194;203;234;207;194;197;194;194;196;195 08:27:25 INFO - PROCESS | 1655 | |3;audio-fft;82;58;60;87;63;51;73;53;62;54 08:27:25 INFO - PROCESS | 1655 | |4;audio-oscillator;77;71;84;72;69;71;81;69;72;80 08:27:25 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;90;88;92;88;89;86;91;90;90;77 08:27:25 INFO - PROCESS | 1655 | |6;imaging-darkroom;96;96;96;98;106;96;97;96;97;96 08:27:25 INFO - PROCESS | 1655 | |7;imaging-desaturate;92;96;94;114;119;93;124;93;147;151 08:27:25 INFO - PROCESS | 1655 | |8;json-parse-financial;57;57;56;59;64;60;62;59;59;57 08:27:25 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;68;78;73;80;78;68;68;69;70;70 08:27:25 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;83;84;88;88;74;97;75;86;83;94 08:27:25 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;149;167;138;139;138;136;142;145;191;169 08:27:25 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;171;166;180;234;158;153;165;152;146;176 08:27:25 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;66;66;66;61;59;74;85;63;62 08:27:25 INFO - PROCESS | 1655 | __end_tp_report 08:27:25 INFO - PROCESS | 1655 | __start_cc_report 08:27:25 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,930 08:27:25 INFO - PROCESS | 1655 | __end_cc_report 08:27:25 INFO - PROCESS | 1655 | __startTimestamp1487003245940__endTimestamp 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | ------- Summary: start ------- 08:27:25 INFO - PROCESS | 1655 | Number of tests: 14 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:127.30 Median:127.00 stddev:27.36 (21.5%) stddev-sans-first:24.37 08:27:25 INFO - PROCESS | 1655 | Values: 85.0 170.0 177.0 136.0 117.0 118.0 118.0 116.0 118.0 118.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:139.00 stddev:16.23 (11.7%) stddev-sans-first:16.97 08:27:25 INFO - PROCESS | 1655 | Values: 136.0 142.0 129.0 145.0 115.0 96.0 124.0 146.0 136.0 113.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:200.80 Median:196.50 stddev:12.48 (6.4%) stddev-sans-first:12.99 08:27:25 INFO - PROCESS | 1655 | Values: 194.0 203.0 234.0 207.0 194.0 197.0 194.0 194.0 196.0 195.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:64.30 Median:62.50 stddev:12.38 (19.8%) stddev-sans-first:11.36 08:27:25 INFO - PROCESS | 1655 | Values: 82.0 58.0 60.0 87.0 63.0 51.0 73.0 53.0 62.0 54.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:74.60 Median:74.50 stddev:5.44 (7.3%) stddev-sans-first:5.70 08:27:25 INFO - PROCESS | 1655 | Values: 77.0 71.0 84.0 72.0 69.0 71.0 81.0 69.0 72.0 80.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:88.10 Median:90.00 stddev:4.25 (4.7%) stddev-sans-first:4.46 08:27:25 INFO - PROCESS | 1655 | Values: 90.0 88.0 92.0 88.0 89.0 86.0 91.0 90.0 90.0 77.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:96.00 stddev:3.10 (3.2%) stddev-sans-first:3.24 08:27:25 INFO - PROCESS | 1655 | Values: 96.0 96.0 96.0 98.0 106.0 96.0 97.0 96.0 97.0 96.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:112.30 Median:92.50 stddev:22.72 (24.6%) stddev-sans-first:22.88 08:27:25 INFO - PROCESS | 1655 | Values: 92.0 96.0 94.0 114.0 119.0 93.0 124.0 93.0 147.0 151.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:2.49 (4.2%) stddev-sans-first:2.54 08:27:25 INFO - PROCESS | 1655 | Values: 57.0 57.0 56.0 59.0 64.0 60.0 62.0 59.0 59.0 57.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:71.50 stddev:4.73 (6.6%) stddev-sans-first:4.77 08:27:25 INFO - PROCESS | 1655 | Values: 68.0 78.0 73.0 80.0 78.0 68.0 68.0 69.0 70.0 70.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:87.00 stddev:7.25 (8.3%) stddev-sans-first:7.65 08:27:25 INFO - PROCESS | 1655 | Values: 83.0 84.0 88.0 88.0 74.0 97.0 75.0 86.0 83.0 94.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:151.40 Median:147.00 stddev:18.28 (12.4%) stddev-sans-first:19.36 08:27:25 INFO - PROCESS | 1655 | Values: 149.0 167.0 138.0 139.0 138.0 136.0 142.0 145.0 191.0 169.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:168.50 stddev:24.96 (14.8%) stddev-sans-first:26.47 08:27:25 INFO - PROCESS | 1655 | Values: 171.0 166.0 180.0 234.0 158.0 153.0 165.0 152.0 146.0 176.0 08:27:25 INFO - PROCESS | 1655 | 08:27:25 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:7.58 (11.5%) stddev-sans-first:8.04 08:27:25 INFO - PROCESS | 1655 | Values: 67.0 66.0 66.0 66.0 61.0 59.0 74.0 85.0 63.0 62.0 08:27:25 INFO - PROCESS | 1655 | -------- Summary: end -------- 08:27:25 INFO - PROCESS | 1655 | 08:27:26 INFO - TEST-INFO | 1655: exit 0 08:27:26 INFO - TEST-OK | kraken | took 60197ms 08:27:26 INFO - SUITE-END | took 1175s 08:27:27 INFO - Completed test suite (00:19:35) 08:27:27 INFO - javascript benchmark 08:27:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7187.236775956328, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.905502834915, 3362.798232106074, 3366.7811592246503, 3392.7455440841936, 3393.8472768725405, 5668.0, 5715.342735585404, 5718.9428105719035, 5735.684537350444, 5743.9138412923785, 5693.060644993581, 5747.540196784258, 5777.220075289834, 5799.710014499279, 5800.129980502927, 4769.928451073237, 5214.165733482634, 5229.111051121318, 5253.658512196714, 5296.285001524783, 5298.337707786527, 5310.362756469229, 5315.707636080014, 5318.175682769177, 5353.437889021655, 5172.922406163911, 5181.274621552986, 5294.0, 5298.549623282006, 5307.177387504924, 5189.117849965496, 5232.398274198478, 5244.527992480657, 5281.656692314988, 5322.680639161624, 5133.230015497668, 5208.713520756357, 5216.061109000379, 5217.087009773312, 5296.867578310573, 5003.924941125886, 5646.858828529279, 5681.545476361881, 5800.100984347433, 5805.071188609802, 5455.754491047873, 6165.445109940082, 6175.104609831549, 6210.689465526705, 6271.278802937675, 6237.0, 6246.812595622138, 6260.373962603749, 6261.248650161964, 6271.090691849657, 5802.88394232113, 5827.970860145672, 5829.0, 5863.325717542494, 5865.970670146665, 6225.533085018642, 6227.09707092469, 6250.312465628777, 6260.655663938527, 6273.278572964076, 5565.666060036411, 6186.876262474725, 6193.628382297076, 6198.504119670415, 6199.442050215503, 6227.314995350508, 6277.466415354655, 6336.429721325103, 6338.112664227012, 6340.682965851781, 6087.0, 6131.6321020738005, 6138.5723274837055, 6145.678679083929, 6292.559520833589, 6221.3778622138325, 6272.8118156455375, 6283.560150789401, 6293.779717709858, 6312.905306420407, 4919.975400123048, 4925.630577706686, 4928.753562321869, 4930.704157750546, 4961.50384961501, 4307.806148723315, 4311.8490852820005, 4360.424451949371, 4385.188740083095, 4437.8224871004795, 4810.278458231223, 4878.756062196876, 5792.189093526909, 5900.7049647518315, 5905.763769449174, 6238.563300569007, 6266.592671476339, 6312.24253089623, 6321.399467050623, 6343.302236753953, 4367.388565600819, 5692.487676109087, 5720.3421606515785, 5771.307443106854, 5838.970805145947, 5168.61235407346, 5434.673919564839, 5442.83671489848, 5452.972735136299, 5465.316835395575, 5108.438071812097, 5323.680579165262, 6337.176167098248, 6338.366163383809, 6350.936490635035, 6116.457510225511, 6126.487138464006, 6139.737467782926, 6187.721552530057, 6296.401841825019, 5229.660072095302, 6232.750689972531, 6253.093301471352, 6283.183186185766, 6297.874042519215, 5977.970110149596, 6086.969565152146, 6144.508439324933, 6146.323904370426, 6165.876682466415, 6033.698315084316, 6152.630842149485, 6201.131841542097, 6210.689465526796, 6227.159333489921, 6088.482478989158, 6157.291911430243, 6158.815235542941, 6164.106204600218, 6176.135341052166, 6142.662153581596, 6156.661383623944, 6170.382961703794, 6175.876482470236, 6192.102145189013, 5751.654900705971, 5844.035734103995, 5911.261092363455, 5997.100434934795, 6021.217241758719, 6120.693965301628, 6123.203983482297, 6132.6920582337325, 6184.134221209124, 6197.287311959002, 6006.519478441627, 6024.9397506026135, 6038.184845045863, 6045.667488288186, 6045.879082418239], "value": 5671.348202097922, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.1073960791749, 457.9604298242986, 489.4518139683555, 499.05180157700363, 545.351032271597, 34353.656463435356, 39819.2036159277, 42856.785716071456, 42877.57122428775, 42952.785236073774, 42587.3611895821, 42998.57001429985, 43102.13795724091, 43222.35166472498, 43250.351244731275, 9312.348135630491, 9563.139317461428, 9569.995150509201, 10823.891761082406, 11288.887111128866, 8736.781580460476, 11186.888131118665, 11218.719532011683, 11228.438578071105, 11245.943770281137, 11215.439228038606, 11239.83140252897, 11245.381504017276, 11273.154513411486, 11278.830817537744, 11133.777324453547, 11193.104551635932, 11199.328040317567, 11206.943965280203, 11218.382988935606, 11153.553857845676, 11208.887911120866, 11236.943815280953, 11240.887591124067, 11244.66266012021, 30786.692133078832, 38156.80921595374, 38174.80912595419, 38210.0, 38302.42546361807, 3871.3031654302213, 3915.7063220258597, 3934.5868683788362, 3963.5243770747406, 3983.5618082010956, 28295.86816527357, 28873.0, 29580.260493487618, 29948.251293717614, 29987.700122998707, 3030.6666266710863, 3073.938521229585, 3082.475979083561, 3088.8455577221275, 3089.1813669377634, 518837.0, 519386.0, 521386.0, 524306.0, 526673.9999999962, 59024.52438689067, 59159.0, 59757.402425976055, 59839.102413463836, 59863.70068149632, 46966.356177534304, 63044.05433918495, 63566.36433635605, 63595.68202158959, 64183.037254441224, 15799.921000394925, 16188.595285117966, 16222.351105955866, 16310.592235194215, 16324.020558766511, 11380.430978451044, 11697.707557310965, 12400.069994750249, 12554.372281385895, 12761.915237204941, 14471.85528144726, 18540.907295463705, 18542.629147416978, 18548.165332560067, 18644.906775466035, 6775.510612034806, 7183.353498185188, 7615.0, 7954.840903181904, 8036.839263214703, 843.696269343036, 882.580774132282, 883.4434306386935, 894.9910500895038, 912.2610685344891, 25276.873615631805, 28477.857610712228, 30445.695543044287, 31509.212269692984, 31660.525092123637, 956.3496822160997, 987.8123156600367, 1106.673531308266, 1123.1800785426685, 1220.993895030519, 15478.767818482731, 16136.515904522883, 16175.757363639555, 16184.109873957046, 16490.093044882407, 647520.0, 649126.0, 653596.0, 654768.0, 655378.0, 64119.0, 64274.0, 64562.031569526494, 64990.67504662446, 65381.34618653753, 1435.3904018606536, 1447.3993292783377, 1456.919869407193, 1478.5047009251805, 1478.5268714011413, 29681.85159074191, 29859.402811943204, 30804.22989425282, 30920.845395772878, 31361.68638313679, 54244.72877635586, 55032.17451738307, 55039.89920201494, 55132.0, 55187.72406138104, 582517.0, 584323.0, 585481.0, 585495.0, 585938.0, 44366.0, 44519.55480445154, 45679.0, 45713.77143114263, 45858.62424127282, 49349.75325123352, 49854.25218621651, 49961.500384995685, 50033.49966500434, 51169.0, 40048.59951400448, 40381.1923761529, 40815.77552673424, 41080.0, 42229.521966731016, 36475.81762091172, 36748.26503469969, 37673.058173544785, 41653.0, 41706.582934171485, 36377.45433818442, 36826.0, 37114.44328335131, 37150.0, 37246.06884827901, 31860.0, 33264.33471330608, 33391.33217335688, 33492.66507334895, 33791.83104084464, 24757.752422476264, 24994.37514062163, 25110.12114575981, 25329.240122796346, 25403.87298063498], "value": 20733.496693406738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.948916640837, 393.64375240407423, 395.58463613206135, 403.3103393197633, 423.92369373512776, 16925.492235232963, 19862.801371986276, 19865.40403787887, 21203.57592848144, 21212.04545795439, 16561.0, 20561.588768224665, 20959.0, 21023.948802559848, 21315.0, 5364.222187782779, 5766.913496297559, 5779.07534794433, 5808.709564521778, 5814.127880817869, 5501.284832971708, 5732.0, 5818.06910894257, 5828.562857785683, 5829.766809327622, 5616.0, 5685.232493613351, 5690.57320700947, 5698.743556539945, 5700.144978253254, 5459.235707001023, 5681.715914204294, 5682.914756278638, 5690.630109042899, 5708.828735137952, 4328.567143285678, 5098.980203959223, 5102.234664800272, 5111.0, 5114.974425127851, 15524.223788810627, 19532.90233548823, 22869.656955145685, 24198.153064642654, 25188.0, 2206.9088867580454, 2519.8740062996776, 2612.2555071804636, 2628.2640860559072, 2660.86695665216, 8448.704295349695, 9934.304598678096, 10112.797744045152, 10231.693049208536, 10483.842742358795, 1792.6056267621102, 1818.8181181881705, 1828.4971632800953, 1858.5911099558075, 1860.4511669057524, 130570.0, 136205.999999999, 140384.29807850896, 142092.0, 142161.28919355545, 11918.344491052902, 11999.460024298927, 12044.277343359427, 12051.57819476314, 12232.266064036186, 10810.891891080988, 14056.226907520184, 15572.610684732972, 15606.29771660278, 15611.375544978073, 7045.436365090883, 8337.833243335099, 8620.482771033632, 8678.132186781271, 8858.202761751345, 8487.448315859448, 8594.785130371665, 8597.957010214908, 8712.172343627346, 8722.86915696265, 4660.836870709509, 4806.591439727662, 4819.036192761461, 4830.106430310404, 4839.443464001614, 1754.5350482122249, 2063.319104695447, 2097.6119417907735, 2099.139352865318, 2102.5479521902867, 821.5194111444872, 824.4929368438487, 846.7121178799238, 876.3514998900895, 889.915458031486, 14240.501582444773, 19659.901700491406, 20665.483362916046, 20716.171353145706, 20950.37148885536, 898.7393655839865, 901.8872640919885, 915.9679411220575, 917.7843206846386, 924.4776701163821, 10173.84739228912, 10672.893271067345, 10702.46487675613, 10708.08981236588, 10710.89289107099, 730455.0, 736186.0, 749517.0, 761970.0, 769194.0, 145659.0, 148796.2560187192, 149583.75624365642, 149758.0, 152504.0, 882.6866462405753, 999.2006394884064, 1003.172382784206, 1023.4371095897227, 1024.293237666008, 17398.956062636284, 17431.912840435718, 18066.277348905896, 18120.822146560433, 18289.99405032736, 58767.0, 59545.702271488364, 59793.80412391641, 60144.699276503336, 62714.686426567576, 86109.0, 86407.70388444053, 89209.55395222982, 90966.0, 92466.53766731123, 7177.892331614926, 7462.738804141829, 7584.5070070447455, 8177.223163799429, 8443.07126216128, 9089.772755680897, 11898.881011189776, 12742.554010609585, 12958.611241662766, 13063.608091757262, 9205.76985575366, 9411.247100232102, 11073.0, 11090.611828585961, 11452.07971967143, 10057.642218300436, 10137.898621013695, 10307.536160872629, 10675.199360047873, 10931.617393391192, 11125.610603628835, 11259.605913792979, 11431.02836258894, 11619.477123529292, 11737.002354799595, 7451.776446706607, 7680.308772210527, 7695.653695583824, 7698.576578288248, 7825.0, 9526.666566670134, 10733.463326833784, 10963.793982661742, 11274.379909105079, 11279.774404512027], "value": 9583.64933074786, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1344.8453427855798, 1401.1663060479011, 1435.798988141661, 1442.985570144299, 1454.0693955868246, 6831.385175334219, 7095.006699062135, 7765.107012693542, 7889.64496597653, 8036.316913062389, 6931.896021559668, 7973.760787176379, 8256.876146857787, 8366.581670916461, 8429.367797415203, 2307.607706689867, 2318.744938056821, 2333.603287441139, 2336.836421450499, 2341.9765802342013, 1897.0, 2090.226616152026, 2166.1010680567547, 2311.687922130516, 2328.266596022256, 2117.9046942887608, 2170.8046275835172, 2176.260071575664, 2327.8719670418122, 2337.5792357375667, 2115.132795553823, 2340.2745149003863, 2347.495288512961, 2350.1421980976993, 2351.4356554426986, 2305.988470057656, 2334.32383383523, 2358.7641235876276, 2381.273711517986, 2388.2835149455095, 8441.662333506652, 8477.406581539295, 8484.36367272457, 8495.532745698983, 8503.362247831375, 5091.414487333967, 5246.711430871301, 5249.9212511811975, 5251.711155886424, 5256.737163141827, 3041.4373340931998, 3351.497275408684, 3455.153487395579, 3481.060113769268, 3570.8571657133684, 1175.0834349207632, 1182.4442512019336, 1195.5098409652087, 1231.1382032577142, 1238.182799352432, 10694.946525267402, 10739.62411315608, 10814.134869210444, 10846.999999999922, 10881.727956801064, 4444.2222611042935, 4698.154332220233, 4771.06964141989, 4781.330613714083, 4786.138495070921, 9484.857727134098, 9575.952120239353, 9589.232861371074, 9601.951990240004, 9654.324197306121, 5184.662996905189, 5278.762455689503, 5279.788808447619, 5297.046531624267, 5304.787808487617, 4656.4877863434995, 4806.399200099988, 4808.206645903457, 4825.565699087099, 4852.51474852519, 3916.0, 3923.4114882767244, 3971.490833483258, 3999.340108882002, 4025.77858217795, 1196.838426812369, 1245.6948047728365, 1295.3005377096451, 1299.2009913902882, 1303.4460354349364, 758.4425447296233, 761.7905076104116, 788.731831177391, 800.3637108498757, 823.197382552007, 5536.0, 5547.084731019337, 5565.582581306418, 5590.329160500766, 5697.202391665171, 968.4867020479157, 986.6004268271362, 997.3417544420793, 998.6155330197926, 1019.5972590826731, 3751.9437208441896, 3867.9613203867602, 3932.8820135395986, 3971.424143499234, 3977.284088864032, 9557.187639050759, 9692.854607180898, 9883.258755593359, 9892.961239069939, 10077.848832267522, 9854.211663066937, 9975.102240798364, 9998.300118991601, 10038.548265328078, 10049.24630652704, 7661.272179142972, 7948.085970113395, 7953.920460795433, 7955.2840244378285, 7996.80007999793, 5648.350439699323, 5661.433856614306, 5745.741441635053, 5805.042168042226, 5841.795537156179, 9207.907920920705, 9230.261579073524, 9272.629094836131, 9377.812443751223, 9380.530973451163, 8939.195472407255, 9260.027697091708, 9357.906420935704, 9442.622295108118, 9443.244540436886, 7142.0, 7198.604076775828, 7249.782506524813, 7296.0, 7336.7798966031105, 7804.102528209329, 7869.606519674108, 7892.960535197287, 7914.366850651819, 7915.44591878586, 5550.250716153268, 7037.190723066913, 7197.424206063607, 7229.963850180716, 7257.310555497219, 5907.793227237026, 6073.542349836096, 7073.858522829618, 7082.18554866197, 7105.715771369294, 5102.36220472441, 6062.787802426894, 6353.174087368612, 6425.710843011982, 6486.967565162144, 4994.200927851526, 5001.049800537886, 5004.84985450437, 5019.146745053276, 5066.214736715815, 5015.7492125392855, 5038.395392552917, 5054.29239906406, 5098.490150984871, 5137.948620513747], "value": 4404.450481316853, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.4808132946621, 332.398358970264, 358.8690128103243, 365.7403243696974, 371.9702423806096, 4441.622462090726, 5061.291419201315, 5329.333833270841, 5485.451454854518, 5519.641223320481, 5123.718195499246, 5254.264402983586, 5292.894142117156, 5316.229146773716, 5324.281222035024, 4187.843260720731, 4188.392683060954, 4202.894927626819, 4211.68412369072, 4217.219814334343, 3894.941575876364, 4039.1921615676833, 4220.620144187023, 4239.872803815891, 4245.938515371157, 3727.77633341999, 3737.8317975691025, 3761.755485893422, 4011.8796436106963, 4110.958890411102, 3999.2201520703475, 4131.421600975866, 4134.875953721408, 4135.17296540693, 4175.832966681329, 2976.7469765069995, 3391.677245874111, 3669.3945498992634, 3713.220223753015, 3719.0516418313427, 4396.120775844844, 4836.661433699643, 5140.228965655144, 5226.320578324793, 5227.660202086852, 4159.708820382574, 4433.623142032931, 4603.378543896564, 4826.541478559531, 4854.538818812242, 4975.527324904128, 4993.729107434636, 5521.917171242394, 5701.771929122871, 5728.79949201776, 3366.410878096348, 3931.941020884689, 4081.3265811141127, 4090.9181816363803, 4092.6930480214105, 4994.925076123861, 5347.732613369316, 5794.130880367937, 5918.792842250544, 5971.462568368867, 3695.6489133532273, 3789.3558095123894, 4131.244221205975, 4161.292580261363, 4197.265478541304, 3175.6030496187977, 3859.55615104261, 3943.8225279862477, 4002.7598344099447, 4192.517860446027, 4784.880377990578, 4788.928166077442, 4811.7834697438, 4824.614030877591, 4872.439669437989, 5402.270693456412, 5703.720360792561, 5739.426057394227, 5740.913886291709, 5764.884702305931, 1238.9442475088642, 1239.2254840724547, 1249.7000719827176, 1358.7893876449166, 1369.7123604043063, 947.4220725357665, 978.002437513732, 985.8176237396104, 986.2750878104588, 992.454150217392, 4359.934600980988, 4969.453360130383, 5033.094043072282, 5040.899182016339, 5107.9489205107475, 5339.652922560022, 5539.0, 5546.389897111315, 5602.355729091125, 5612.298462692163, 4448.377227188196, 4481.596656300949, 4923.79015941365, 5035.924461133086, 5106.46805958211, 2539.4794067216176, 2816.816906901045, 2900.7824413169096, 2924.268932766808, 2925.5611658251432, 4817.759112044384, 5399.974004939049, 5493.533049690741, 5628.493435590816, 5803.419658034163, 4603.056373443436, 4804.8798780030775, 4924.080541923968, 5008.6744361616375, 5136.303440693666, 5363.731813409314, 5459.908018396337, 5495.279836480968, 5833.4749872511675, 5942.435468630473, 4569.702969306984, 4655.743934083658, 4811.879703007313, 5396.379416367168, 5575.860603484945, 4741.668083234141, 4838.516148385133, 5166.641682906141, 5223.973880130727, 5471.972640136773, 5072.898542029213, 5665.11939321566, 5819.185314055951, 5840.678762668094, 5865.912011319749, 3212.6626704196656, 3817.7900215488417, 3965.325894597868, 3968.1865217630893, 3989.640932315989, 4786.856394308176, 4840.91079507108, 5261.552768014609, 5483.698396588226, 5501.312335958005, 4954.439351604233, 5486.43381801832, 5650.152477128464, 5676.5742569308295, 5686.744096515584, 5608.383077861514, 5635.943640563706, 5640.492355688008, 5677.7069299806835, 5680.857978550569, 5196.168613021899, 5245.606579506476, 5515.61390702663, 5519.586031047607, 5522.889542209214, 5164.638475306692, 5270.446603106619, 5542.0855558832345, 5637.689927054052, 5643.943560564506, 4941.407031156285, 5561.805336813192, 5562.582806289625, 5590.468905453975, 5593.965116453469], "value": 4084.972013207056, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.744143621833, 641.2017038786711, 707.3598393453923, 726.1032624708486, 727.5380133615155, 11236.381998990053, 13789.310534473274, 13915.1650900946, 13947.860521394809, 13979.30103494825, 12359.32023738694, 12490.000799935984, 12776.68058298543, 12876.969842412607, 12909.870901290984, 826.3430572694707, 827.5489858027389, 836.8493671139192, 838.9538575378351, 840.2815592668272, 825.6614787936948, 837.6691206973242, 838.4759525296689, 841.5497708725833, 842.4818736477054, 889.1197714262897, 897.4391005621486, 900.1898291537635, 903.2367649336301, 904.8145130248316, 875.0811647769816, 885.4510203673731, 888.564603344363, 890.1365675294953, 894.4275663575285, 658.7463826426861, 669.9564528305644, 672.2470832667395, 672.8586996730693, 674.7975607317785, 12161.51353945841, 12265.877341226562, 12372.381380931007, 12443.875561244362, 12492.125551211418, 10074.395536267848, 10127.240456965757, 10151.543180556893, 10537.262391632588, 10541.367517948871, 9405.811883762355, 9501.714948551555, 9653.517324133765, 9668.371555848918, 9722.90277097227, 3236.64396916339, 3276.8197749123788, 3322.302316513535, 3384.3738908302043, 3397.96602033979, 98940.0, 99386.50306748493, 101695.0, 101830.9633807327, 101915.98084019213, 7241.131064272216, 7294.207012353547, 7310.232425595236, 7341.119065712149, 7444.627768611548, 16212.513624591282, 16362.34550617962, 16408.425705100264, 16523.421680241136, 16568.75146872798, 6663.633500157538, 6672.0, 6680.23177334603, 6696.866062678817, 6833.453323734089, 3859.0, 3964.60353964607, 3967.504061992251, 3968.40473928913, 3970.7021973352116, 2749.6425464689864, 2861.9856900715363, 3195.392875353722, 3236.3203727217547, 3250.5611742414944, 585.519873703559, 594.6491569973737, 598.9578134046815, 608.67131748856, 608.7260732670316, 690.6305126757261, 705.992940070603, 710.4848984486206, 714.8212946763309, 726.9527480713737, 8885.955570222108, 9193.310501712398, 9255.202628696577, 9459.290553208537, 9571.1864491519, 544.1266766839245, 545.73531837059, 582.1297160744714, 582.3303201318517, 591.1546488521369, 3909.139989202371, 4113.547509773923, 4388.517263101056, 4490.955090449119, 4757.310190022427, 60314.0, 80629.59685201537, 86830.56584717036, 96782.0, 101490.0, 63769.36230637727, 71525.92711109338, 74479.0, 83774.0, 85308.29383412297, 65711.0, 70455.94316085262, 73784.0, 76494.23505764871, 79917.0, 10272.845907311246, 10522.31604945676, 10533.157347412342, 10595.682129536126, 10688.839667405151, 47888.5211147898, 49653.0, 49699.422831871096, 50410.243846341604, 53095.203571945676, 47149.528504714515, 64235.0, 67606.66196669181, 68537.65731171312, 69285.0, 11942.820857687315, 11963.521459141537, 12188.329641869783, 12294.139410241198, 12422.503099875903, 13271.035454238865, 13371.598852034454, 13410.530631427853, 13436.0, 13915.095518791246, 12149.271043737404, 12515.56195533152, 12665.113442059335, 12812.231266124063, 12911.031672624778, 12720.0, 12778.61664150077, 12815.16701414405, 12824.29466379358, 13221.0, 12160.939195303967, 12728.363581821057, 12799.87200128024, 12924.418401171783, 13039.087263891437, 9327.347085703936, 10401.115905148146, 10483.690878504092, 10516.0, 10797.0, 9319.580618872302, 9949.950250248703, 9963.202943764627, 9979.45113018791, 10060.798784024131], "value": 6797.544181066647, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1497.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 170.0, 177.0, 136.0, 117.0, 118.0, 118.0, 116.0, 118.0, 118.0], "value": 127.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 142.0, 129.0, 145.0, 115.0, 96.0, 124.0, 146.0, 136.0, 113.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 203.0, 234.0, 207.0, 194.0, 197.0, 194.0, 194.0, 196.0, 195.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 87.0, 63.0, 51.0, 73.0, 53.0, 62.0, 54.0], "value": 64.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 71.0, 84.0, 72.0, 69.0, 71.0, 81.0, 69.0, 72.0, 80.0], "value": 74.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 92.0, 88.0, 89.0, 86.0, 91.0, 90.0, 90.0, 77.0], "value": 88.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 98.0, 106.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 96.0, 94.0, 114.0, 119.0, 93.0, 124.0, 93.0, 147.0, 151.0], "value": 112.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 59.0, 64.0, 60.0, 62.0, 59.0, 59.0, 57.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 78.0, 73.0, 80.0, 78.0, 68.0, 68.0, 69.0, 70.0, 70.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 88.0, 88.0, 74.0, 97.0, 75.0, 86.0, 83.0, 94.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 167.0, 138.0, 139.0, 138.0, 136.0, 142.0, 145.0, 191.0, 169.0], "value": 151.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 166.0, 180.0, 234.0, 158.0, 153.0, 165.0, 152.0, 146.0, 176.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 61.0, 59.0, 74.0, 85.0, 63.0, 62.0], "value": 66.9, "unit": "score"}]}]} 08:27:27 INFO - Return code: 0 08:27:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:27:27 ERROR - # TBPL SUCCESS # 08:27:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:27:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:27:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:27:27 INFO - 2017-02-13 08:27:27.282 screenresolution[1660:11411] starting screenresolution argv=screenresolution get 08:27:27 INFO - 2017-02-13 08:27:27.284 screenresolution[1660:11411] Display 0: 1600x1200x32@60 08:27:27 INFO - 2017-02-13 08:27:27.290 screenresolution[1661:11414] starting screenresolution argv=screenresolution list 08:27:27 INFO - Available Modes on Display 0 08:27:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:27:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:27:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:27:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:27:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:27:27 INFO - Intel Iris: 08:27:27 INFO - Chipset Model: Intel Iris 08:27:27 INFO - Type: GPU 08:27:27 INFO - Bus: Built-In 08:27:27 INFO - VRAM (Dynamic, Max): 1536 MB 08:27:27 INFO - Vendor: Intel (0x8086) 08:27:27 INFO - Device ID: 0x0a2e 08:27:27 INFO - Revision ID: 0x0009 08:27:27 INFO - Displays: 08:27:27 INFO - Display: 08:27:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:27:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:27:27 INFO - Display Serial Number: 1600x1200 60 08:27:27 INFO - Main Display: Yes 08:27:27 INFO - Mirror: Off 08:27:27 INFO - Online: Yes 08:27:27 INFO - Rotation: Supported 08:27:27 INFO - Return code: 0 08:27:27 INFO - Running post-action listener: _resource_record_post_action 08:27:27 INFO - [mozharness: 2017-02-13 16:27:27.528856Z] Finished run-tests step (success) 08:27:27 INFO - Running post-run listener: _resource_record_post_run 08:27:27 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 34693632; Write bytes: 516377600; Read time: 321; Write time: 1894 08:27:27 INFO - TinderboxPrint: CPU usage
54.3% 08:27:27 INFO - TinderboxPrint: I/O read bytes / time
34,693,632 / 321 08:27:27 INFO - TinderboxPrint: I/O write bytes / time
516,377,600 / 1,894 08:27:27 INFO - TinderboxPrint: CPU idle
2,186.9 (45.7%) 08:27:27 INFO - TinderboxPrint: CPU system
959.6 (20.1%) 08:27:27 INFO - TinderboxPrint: CPU user
1,639.3 (34.3%) 08:27:27 INFO - TinderboxPrint: Swap in / out
239,165,440 / 0 08:27:27 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201396736; Write bytes: 201313792; Read time: 15412; Write time: 446 08:27:27 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 32858624; Write bytes: 300967424; Read time: 302; Write time: 1398 08:27:28 INFO - Running post-run listener: _upload_blobber_files 08:27:28 INFO - Blob upload gear active. 08:27:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:27:28 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 08:27:28 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:27:28 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:27:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:27:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:27:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:27:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:29 INFO - (blobuploader) - INFO - Done attempting. 08:27:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:27:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:30 INFO - (blobuploader) - INFO - Done attempting. 08:27:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:27:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:31 INFO - (blobuploader) - INFO - Done attempting. 08:27:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:27:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:27:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:27:33 INFO - (blobuploader) - INFO - Done attempting. 08:27:33 INFO - (blobuploader) - INFO - Iteration through files over. 08:27:33 INFO - Return code: 0 08:27:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:27:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:27:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebe6e828909db780d1c8d340b8953db3007eb15026bf027828a6b90255ea8ab9349a66ed30f3e7cf652cf46d09b818bd2bf22a0e1b8314b7411412b09f58003", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42af9ce22350d71de3bd23362721926619075146e48f6c52a7a4022b4b2a2c7c17a531caebcc208d36c31cbcafb32506a07c55f8a05d8e08cad6ca7f2b76b4cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db5819eef2222caab5f332ade2930269b08510e2c776ff7bb273838432f632a7df3c2d9bfccdfee687b4c257488ac3359611fdde2c1331d0ae0a1622916f7c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4db463e7ce5862da361ccac7014b570f6c255a98eef1ba95f48fdf6d86a867aac8077e4c64bd71bec43fc189b06001315063e38de384cab05ee23c891912a4"} 08:27:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:27:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:27:33 INFO - Contents: 08:27:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebe6e828909db780d1c8d340b8953db3007eb15026bf027828a6b90255ea8ab9349a66ed30f3e7cf652cf46d09b818bd2bf22a0e1b8314b7411412b09f58003", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42af9ce22350d71de3bd23362721926619075146e48f6c52a7a4022b4b2a2c7c17a531caebcc208d36c31cbcafb32506a07c55f8a05d8e08cad6ca7f2b76b4cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db5819eef2222caab5f332ade2930269b08510e2c776ff7bb273838432f632a7df3c2d9bfccdfee687b4c257488ac3359611fdde2c1331d0ae0a1622916f7c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4db463e7ce5862da361ccac7014b570f6c255a98eef1ba95f48fdf6d86a867aac8077e4c64bd71bec43fc189b06001315063e38de384cab05ee23c891912a4"} 08:27:33 INFO - Running post-run listener: copy_logs_to_upload_dir 08:27:33 INFO - Copying logs to upload dir... 08:27:33 INFO - mkdir: /builds/slave/test/build/upload/logs 08:27:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.506851 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-02-13 08:27:33.606337) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:33.609815) ========= 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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-Aurora/sha512/5ebe6e828909db780d1c8d340b8953db3007eb15026bf027828a6b90255ea8ab9349a66ed30f3e7cf652cf46d09b818bd2bf22a0e1b8314b7411412b09f58003", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42af9ce22350d71de3bd23362721926619075146e48f6c52a7a4022b4b2a2c7c17a531caebcc208d36c31cbcafb32506a07c55f8a05d8e08cad6ca7f2b76b4cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db5819eef2222caab5f332ade2930269b08510e2c776ff7bb273838432f632a7df3c2d9bfccdfee687b4c257488ac3359611fdde2c1331d0ae0a1622916f7c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4db463e7ce5862da361ccac7014b570f6c255a98eef1ba95f48fdf6d86a867aac8077e4c64bd71bec43fc189b06001315063e38de384cab05ee23c891912a4"} build_url:https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/TM6U8PYZSlCcXzjxIjDM9g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ebe6e828909db780d1c8d340b8953db3007eb15026bf027828a6b90255ea8ab9349a66ed30f3e7cf652cf46d09b818bd2bf22a0e1b8314b7411412b09f58003", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/42af9ce22350d71de3bd23362721926619075146e48f6c52a7a4022b4b2a2c7c17a531caebcc208d36c31cbcafb32506a07c55f8a05d8e08cad6ca7f2b76b4cd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/db5819eef2222caab5f332ade2930269b08510e2c776ff7bb273838432f632a7df3c2d9bfccdfee687b4c257488ac3359611fdde2c1331d0ae0a1622916f7c72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a4db463e7ce5862da361ccac7014b570f6c255a98eef1ba95f48fdf6d86a867aac8077e4c64bd71bec43fc189b06001315063e38de384cab05ee23c891912a4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:33.645431) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:33.645757) ========= 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.STeE9CHZ3G/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.09RUq8Zf6W/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005102 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-13 08:27:33.694544) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 08:27:33.694900) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-13 08:27:33.695228) ========= ========= Total master_lag: 0.18 =========