builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0159 starttime: 1494026677.1 results: success (0) buildid: 20170505144815 builduid: 534d4e2531a840b9bff989ea0995e526 revision: c273884ffe6bb255399bb15fbad6eb0b66be49eb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.096736) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.097380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.097670) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.123008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.123346) ========= 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.nT6t82vVgB/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.m6kolk1y4l/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-05-05 16:24:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.65M=0.001s 2017-05-05 16:24:37 (9.65 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154754 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.302396) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.302762) ========= 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.nT6t82vVgB/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.m6kolk1y4l/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.020882 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:37.351605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 16:24:37.351977) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c273884ffe6bb255399bb15fbad6eb0b66be49eb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c273884ffe6bb255399bb15fbad6eb0b66be49eb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nT6t82vVgB/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.m6kolk1y4l/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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-05-05 16:24:37,427 truncating revision to first 12 chars 2017-05-05 16:24:37,427 Setting DEBUG logging. 2017-05-05 16:24:37,427 attempt 1/10 2017-05-05 16:24:37,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c273884ffe6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 16:24:38,224 unpacking tar archive at: mozilla-central-c273884ffe6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.056980 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 16:24:38.432534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:38.432848) ========= script_repo_revision: c273884ffe6bb255399bb15fbad6eb0b66be49eb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:38.433210) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:38.433474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 16:24:38.453794) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-05 16:24:38.454129) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nT6t82vVgB/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.m6kolk1y4l/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:24:38 INFO - MultiFileLogger online at 20170505 16:24:38 in /builds/slave/test 16:24:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:24:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:24:38 INFO - {'append_to_log': False, 16:24:38 INFO - 'base_work_dir': '/builds/slave/test', 16:24:38 INFO - 'blob_upload_branch': 'Firefox', 16:24:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:24:38 INFO - 'branch': 'Firefox', 16:24:38 INFO - 'buildbot_json_path': 'buildprops.json', 16:24:38 INFO - 'config_files': ('talos/mac_config.py',), 16:24:38 INFO - 'default_actions': ('clobber', 16:24:38 INFO - 'read-buildbot-config', 16:24:38 INFO - 'download-and-extract', 16:24:38 INFO - 'populate-webroot', 16:24:38 INFO - 'create-virtualenv', 16:24:38 INFO - 'install', 16:24:38 INFO - 'run-tests'), 16:24:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:24:38 INFO - 'download_minidump_stackwalk': True, 16:24:38 INFO - 'download_symbols': 'ondemand', 16:24:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:24:38 INFO - 'tooltool.py': '/tools/tooltool.py', 16:24:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:24:38 INFO - '/tools/misc-python/virtualenv.py')}, 16:24:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:24:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:24:38 INFO - 'gecko_profile': False, 16:24:38 INFO - 'gecko_profile_interval': 0, 16:24:38 INFO - 'installer_path': 'installer.exe', 16:24:38 INFO - 'log_level': 'info', 16:24:38 INFO - 'log_name': 'talos', 16:24:38 INFO - 'log_to_console': True, 16:24:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:24:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:24:38 INFO - 'opt_config_files': (), 16:24:38 INFO - 'pip_index': False, 16:24:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:24:38 INFO - 'cmd': ('bash', 16:24:38 INFO - '-c', 16:24:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:24:38 INFO - 'enabled': True, 16:24:38 INFO - 'halt_on_failure': False, 16:24:38 INFO - 'name': 'check_screen_resolution'},), 16:24:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:24:38 INFO - 'cmd': ('bash', 16:24:38 INFO - '-c', 16:24:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:24:38 INFO - 'enabled': True, 16:24:38 INFO - 'halt_on_failure': False, 16:24:38 INFO - 'name': 'check_screen_resolution'},), 16:24:38 INFO - 'run_cmd_checks_enabled': True, 16:24:38 INFO - 'suite': 'dromaeojs', 16:24:38 INFO - 'system_bits': '32', 16:24:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:24:38 INFO - 'title': 't-yosemite-r7-0159', 16:24:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:24:38 INFO - 'use_talos_json': True, 16:24:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:24:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:24:38 INFO - 'work_dir': 'build'} 16:24:38 INFO - [mozharness: 2017-05-05 23:24:38.654209Z] Running clobber step. 16:24:38 INFO - Running pre-action listener: _resource_record_pre_action 16:24:38 INFO - Running main action method: clobber 16:24:38 INFO - rmtree: /builds/slave/test/build 16:24:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:24:40 INFO - Running post-action listener: _resource_record_post_action 16:24:40 INFO - [mozharness: 2017-05-05 23:24:40.790758Z] Finished clobber step (success) 16:24:40 INFO - [mozharness: 2017-05-05 23:24:40.790893Z] Running read-buildbot-config step. 16:24:40 INFO - Running pre-action listener: _resource_record_pre_action 16:24:40 INFO - Running main action method: read_buildbot_config 16:24:40 INFO - Using buildbot properties: 16:24:40 INFO - { 16:24:40 INFO - "project": "", 16:24:40 INFO - "product": "firefox", 16:24:40 INFO - "script_repo_revision": "production", 16:24:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 16:24:40 INFO - "repository": "", 16:24:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 16:24:40 INFO - "buildid": "20170505144815", 16:24:40 INFO - "pgo_build": "False", 16:24:40 INFO - "basedir": "/builds/slave/test", 16:24:40 INFO - "buildnumber": 24, 16:24:40 INFO - "slavename": "t-yosemite-r7-0159", 16:24:40 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:24:40 INFO - "platform": "yosemite_r7", 16:24:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:24:40 INFO - "branch": "mozilla-central", 16:24:40 INFO - "repo_path": "mozilla-central", 16:24:40 INFO - "revision": "c273884ffe6bb255399bb15fbad6eb0b66be49eb", 16:24:40 INFO - "stage_platform": "macosx64", 16:24:40 INFO - "builduid": "534d4e2531a840b9bff989ea0995e526", 16:24:40 INFO - "slavebuilddir": "test" 16:24:40 INFO - } 16:24:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 16:24:40 INFO - Running post-action listener: _resource_record_post_action 16:24:40 INFO - [mozharness: 2017-05-05 23:24:40.794219Z] Finished read-buildbot-config step (success) 16:24:40 INFO - [mozharness: 2017-05-05 23:24:40.794357Z] Running download-and-extract step. 16:24:40 INFO - Running pre-action listener: _resource_record_pre_action 16:24:40 INFO - Running main action method: download_and_extract 16:24:40 INFO - mkdir: /builds/slave/test/build/tests 16:24:40 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')]} 16:24:40 INFO - trying https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 16:24:40 INFO - Downloading https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 16:24:42 INFO - Downloaded 1325 bytes. 16:24:42 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 16:24:42 INFO - Using the following test package requirements: 16:24:42 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 16:24:42 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:24:42 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 16:24:42 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 16:24:42 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'jsshell-mac.zip'], 16:24:42 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 16:24:42 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 16:24:42 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 16:24:42 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 16:24:42 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 16:24:42 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 16:24:42 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 16:24:42 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:24:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:24:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:24:42 INFO - Fetch https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:24:43 INFO - Content-Length response header: 52706526 16:24:43 INFO - Bytes received: 52706526 16:25:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:25:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 16:25:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:25:00 INFO - Fetch https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 16:25:01 INFO - Content-Length response header: 52706526 16:25:01 INFO - Bytes received: 52706526 16:25:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 16:25:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:25:17 INFO - Fetch https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 16:25:18 INFO - Content-Length response header: 14408697 16:25:18 INFO - Bytes received: 14408697 16:25:18 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')]} 16:25:18 INFO - trying https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:25:18 INFO - Downloading https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 16:25:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 16:25:20 INFO - Downloaded 70882007 bytes. 16:25:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:25:20 INFO - mkdir: /builds/slave/test/properties 16:25:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:25:20 INFO - Writing to file /builds/slave/test/properties/build_url 16:25:20 INFO - Contents: 16:25:20 INFO - build_url:https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 16:25:20 INFO - Running post-action listener: _resource_record_post_action 16:25:20 INFO - Running post-action listener: set_extra_try_arguments 16:25:20 INFO - [mozharness: 2017-05-05 23:25:20.976442Z] Finished download-and-extract step (success) 16:25:20 INFO - [mozharness: 2017-05-05 23:25:20.976595Z] Running populate-webroot step. 16:25:20 INFO - Running pre-action listener: _resource_record_pre_action 16:25:20 INFO - Running main action method: populate_webroot 16:25:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:25:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:25:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:25:20 INFO - '--tppagecycles', 16:25:20 INFO - '7'], 16:25:20 INFO - 'tests': ['tsvgm']}}, 16:25:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:25:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:25:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:25:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:25:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:25:20 INFO - 'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:25:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:25:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:25:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:25:20 INFO - 'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['damp', 'tps']}, 16:25:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:25:20 INFO - 'tests': ['damp', 'tps']}, 16:25:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['dromaeo_dom']}, 16:25:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:25:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:25:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:25:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['a11yr', 16:25:20 INFO - 'ts_paint', 16:25:20 INFO - 'tpaint', 16:25:20 INFO - 'sessionrestore', 16:25:20 INFO - 'sessionrestore_no_auto_restore', 16:25:20 INFO - 'tabpaint']}, 16:25:20 INFO - 'other-e10s': {'tests': ['a11yr', 16:25:20 INFO - 'ts_paint', 16:25:20 INFO - 'tpaint', 16:25:20 INFO - 'sessionrestore', 16:25:20 INFO - 'sessionrestore_no_auto_restore', 16:25:20 INFO - 'tabpaint']}, 16:25:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:25:20 INFO - 'ts_paint', 16:25:20 INFO - 'tpaint', 16:25:20 INFO - 'sessionrestore', 16:25:20 INFO - 'sessionrestore_no_auto_restore', 16:25:20 INFO - 'tabpaint']}, 16:25:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:25:20 INFO - 'ts_paint', 16:25:20 INFO - 'tpaint', 16:25:20 INFO - 'sessionrestore', 16:25:20 INFO - 'sessionrestore_no_auto_restore', 16:25:20 INFO - 'tabpaint']}, 16:25:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['a11yr', 16:25:20 INFO - 'ts_paint', 16:25:20 INFO - 'tpaint', 16:25:20 INFO - 'sessionrestore', 16:25:20 INFO - 'sessionrestore_no_auto_restore', 16:25:20 INFO - 'tabpaint']}, 16:25:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['a11yr', 16:25:20 INFO - 'ts_paint', 16:25:20 INFO - 'tpaint', 16:25:20 INFO - 'sessionrestore', 16:25:20 INFO - 'sessionrestore_no_auto_restore', 16:25:20 INFO - 'tabpaint']}, 16:25:20 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:25:20 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:25:20 INFO - 'bloom_basic_ref']}, 16:25:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['tsvgx', 16:25:20 INFO - 'tsvgr_opacity', 16:25:20 INFO - 'tart', 16:25:20 INFO - 'tscrollx', 16:25:20 INFO - 'cart', 16:25:20 INFO - 'tsvg_static']}, 16:25:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:25:20 INFO - 'tsvgr_opacity', 16:25:20 INFO - 'tart', 16:25:20 INFO - 'tscrollx', 16:25:20 INFO - 'cart', 16:25:20 INFO - 'tsvg_static']}, 16:25:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:25:20 INFO - 'talos_options': ['--disable-e10s'], 16:25:20 INFO - 'tests': ['tp5o']}, 16:25:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:25:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:25:20 INFO - 'talos_options': ['--disable-e10s', 16:25:20 INFO - '--xperf_path', 16:25:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:25:20 INFO - 'tests': ['tp5n']}, 16:25:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:25:20 INFO - 'talos_options': ['--xperf_path', 16:25:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:25:20 INFO - 'tests': ['tp5n']}}, 16:25:20 INFO - 'talos.zip': {'path': '', 16:25:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:25:20 INFO - Running post-action listener: _resource_record_post_action 16:25:20 INFO - [mozharness: 2017-05-05 23:25:20.995861Z] Finished populate-webroot step (success) 16:25:20 INFO - [mozharness: 2017-05-05 23:25:20.996004Z] Running create-virtualenv step. 16:25:20 INFO - Running pre-action listener: _resource_record_pre_action 16:25:20 INFO - Running main action method: create_virtualenv 16:25:20 INFO - Creating virtualenv /builds/slave/test/build/venv 16:25:20 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 16:25:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:25:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:25:21 INFO - Using real prefix '/tools/python27' 16:25:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:25:21 INFO - Installing distribute.............................................................................................................................................................................................done. 16:25:24 INFO - Installing pip.................done. 16:25:24 INFO - Return code: 0 16:25:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:25:24 INFO - Reading from file tmpfile_stdout 16:25:24 INFO - Output received: 16:25:24 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) 16:25:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:24 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 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:24 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 16:25:24 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 16:25:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:24 INFO - 'HOME': '/Users/cltbld', 16:25:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:24 INFO - 'LOGNAME': 'cltbld', 16:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:24 INFO - 'MOZ_NO_REMOTE': '1', 16:25:24 INFO - 'NO_EM_RESTART': '1', 16:25:24 INFO - 'PAGER': '/bin/cat', 16:25:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:24 INFO - 'PWD': '/builds/slave/test', 16:25:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:24 INFO - 'SHELL': '/bin/bash', 16:25:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:24 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:24 INFO - 'USER': 'cltbld', 16:25:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:24 INFO - 'XPC_FLAGS': '0x0', 16:25:24 INFO - 'XPC_SERVICE_NAME': '0', 16:25:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:25 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 16:25:25 INFO - Cleaning up... 16:25:25 INFO - Return code: 0 16:25:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:25 INFO - 'HOME': '/Users/cltbld', 16:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:25 INFO - 'LOGNAME': 'cltbld', 16:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:25 INFO - 'MOZ_NO_REMOTE': '1', 16:25:25 INFO - 'NO_EM_RESTART': '1', 16:25:25 INFO - 'PAGER': '/bin/cat', 16:25:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:25 INFO - 'PWD': '/builds/slave/test', 16:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:25 INFO - 'SHELL': '/bin/bash', 16:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:25 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:25 INFO - 'USER': 'cltbld', 16:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:25 INFO - 'XPC_FLAGS': '0x0', 16:25:25 INFO - 'XPC_SERVICE_NAME': '0', 16:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:25 INFO - Downloading/unpacking psutil>=3.1.1 16:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:25:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:27 INFO - Installing collected packages: psutil 16:25:27 INFO - Running setup.py install for psutil 16:25:27 INFO - building 'psutil._psutil_osx' extension 16:25:27 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 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 INFO - building 'psutil._psutil_posix' extension 16:25:28 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 16:25:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:25:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:25:28 INFO - ^ 16:25:28 INFO - 1 warning generated. 16:25:28 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 16:25:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:25:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:25:28 INFO - Successfully installed psutil 16:25:28 INFO - Cleaning up... 16:25:28 INFO - Return code: 0 16:25:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:25:28 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')]} 16:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:28 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')]} 16:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:28 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 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:28 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 16:25:28 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 16:25:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:28 INFO - 'HOME': '/Users/cltbld', 16:25:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:28 INFO - 'LOGNAME': 'cltbld', 16:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:28 INFO - 'MOZ_NO_REMOTE': '1', 16:25:28 INFO - 'NO_EM_RESTART': '1', 16:25:28 INFO - 'PAGER': '/bin/cat', 16:25:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:28 INFO - 'PWD': '/builds/slave/test', 16:25:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:28 INFO - 'SHELL': '/bin/bash', 16:25:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:28 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:28 INFO - 'USER': 'cltbld', 16:25:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:28 INFO - 'XPC_FLAGS': '0x0', 16:25:28 INFO - 'XPC_SERVICE_NAME': '0', 16:25:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 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 16:25:28 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 16:25:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:25:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:25:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:25:30 INFO - Installing collected packages: mozsystemmonitor 16:25:30 INFO - Running setup.py install for mozsystemmonitor 16:25:30 INFO - Successfully installed mozsystemmonitor 16:25:30 INFO - Cleaning up... 16:25:30 INFO - Return code: 0 16:25:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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')]} 16:25:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25: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==2.5.1'] in /builds/slave/test/build 16:25: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==2.5.1 16:25:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:30 INFO - 'HOME': '/Users/cltbld', 16:25:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:30 INFO - 'LOGNAME': 'cltbld', 16:25:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:30 INFO - 'MOZ_NO_REMOTE': '1', 16:25:30 INFO - 'NO_EM_RESTART': '1', 16:25:30 INFO - 'PAGER': '/bin/cat', 16:25:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:30 INFO - 'PWD': '/builds/slave/test', 16:25:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:30 INFO - 'SHELL': '/bin/bash', 16:25:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:30 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:30 INFO - 'USER': 'cltbld', 16:25:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:30 INFO - 'XPC_FLAGS': '0x0', 16:25:30 INFO - 'XPC_SERVICE_NAME': '0', 16:25:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:30 INFO - Downloading/unpacking jsonschema==2.5.1 16:25:30 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 16:25:30 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 16:25:30 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 16:25:30 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 16:25:30 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 16:25:30 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 16:25:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:25:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:32 INFO - Downloading functools32-3.2.3-2.tar.gz 16:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:25:32 INFO - warning: no files found matching '*.txt' 16:25:32 INFO - no previously-included directories found matching 'build' 16:25:32 INFO - no previously-included directories found matching 'dist' 16:25:32 INFO - no previously-included directories found matching '.git*' 16:25:32 INFO - Installing collected packages: jsonschema, functools32 16:25:32 INFO - Running setup.py install for functools32 16:25:32 INFO - warning: no files found matching '*.txt' 16:25:32 INFO - no previously-included directories found matching 'build' 16:25:32 INFO - no previously-included directories found matching 'dist' 16:25:32 INFO - no previously-included directories found matching '.git*' 16:25:32 INFO - Successfully installed jsonschema functools32 16:25:32 INFO - Cleaning up... 16:25:32 INFO - Return code: 0 16:25:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:25:32 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')]} 16:25:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:32 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')]} 16:25:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:25:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:33 INFO - 'HOME': '/Users/cltbld', 16:25:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:33 INFO - 'LOGNAME': 'cltbld', 16:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:33 INFO - 'MOZ_NO_REMOTE': '1', 16:25:33 INFO - 'NO_EM_RESTART': '1', 16:25:33 INFO - 'PAGER': '/bin/cat', 16:25:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:33 INFO - 'PWD': '/builds/slave/test', 16:25:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:33 INFO - 'SHELL': '/bin/bash', 16:25:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:33 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:33 INFO - 'USER': 'cltbld', 16:25:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:33 INFO - 'XPC_FLAGS': '0x0', 16:25:33 INFO - 'XPC_SERVICE_NAME': '0', 16:25:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:25:33 INFO - Cleaning up... 16:25:33 INFO - Return code: 0 16:25:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:25:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:34 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 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:34 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 16:25:34 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 16:25:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:34 INFO - 'HOME': '/Users/cltbld', 16:25:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:34 INFO - 'LOGNAME': 'cltbld', 16:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:34 INFO - 'MOZ_NO_REMOTE': '1', 16:25:34 INFO - 'NO_EM_RESTART': '1', 16:25:34 INFO - 'PAGER': '/bin/cat', 16:25:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:34 INFO - 'PWD': '/builds/slave/test', 16:25:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:34 INFO - 'SHELL': '/bin/bash', 16:25:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:34 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:34 INFO - 'USER': 'cltbld', 16:25:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:34 INFO - 'XPC_FLAGS': '0x0', 16:25:34 INFO - 'XPC_SERVICE_NAME': '0', 16:25:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:34 INFO - Downloading/unpacking blobuploader==1.2.4 16:25:34 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 16:25:34 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 16:25:34 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 16:25:34 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 16:25:34 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 16:25:34 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 16:25:36 INFO - Downloading blobuploader-1.2.4.tar.gz 16:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:25:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:25:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:37 INFO - Downloading docopt-0.6.1.tar.gz 16:25:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:25:37 INFO - Installing collected packages: blobuploader, requests, docopt 16:25:37 INFO - Running setup.py install for blobuploader 16:25:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:25:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:25:37 INFO - Running setup.py install for requests 16:25:38 INFO - Running setup.py install for docopt 16:25:38 INFO - Successfully installed blobuploader requests docopt 16:25:38 INFO - Cleaning up... 16:25:38 INFO - Return code: 0 16:25:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:25:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:25:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:38 INFO - 'HOME': '/Users/cltbld', 16:25:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:38 INFO - 'LOGNAME': 'cltbld', 16:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:38 INFO - 'MOZ_NO_REMOTE': '1', 16:25:38 INFO - 'NO_EM_RESTART': '1', 16:25:38 INFO - 'PAGER': '/bin/cat', 16:25:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:38 INFO - 'PWD': '/builds/slave/test', 16:25:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:38 INFO - 'SHELL': '/bin/bash', 16:25:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:38 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:38 INFO - 'USER': 'cltbld', 16:25:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:38 INFO - 'XPC_FLAGS': '0x0', 16:25:38 INFO - 'XPC_SERVICE_NAME': '0', 16:25:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:38 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-l05oVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:38 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-nkQuFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:38 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-wTF3fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:38 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ljmtol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:38 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Upz3Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-A_yHfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-YuOFKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-q0ETjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ezUfLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-lutBn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-RxuVCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-yJpHiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-kOj3cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-lzEFhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:39 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ZTCFH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:40 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-uBicjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:40 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Q1_NmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:25:40 INFO - Running setup.py install for manifestparser 16:25:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:25:40 INFO - Running setup.py install for mozcrash 16:25:40 INFO - Running setup.py install for mozdebug 16:25:40 INFO - Running setup.py install for mozdevice 16:25:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:25:40 INFO - Running setup.py install for mozfile 16:25:40 INFO - Running setup.py install for mozhttpd 16:25:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Running setup.py install for mozinfo 16:25:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Running setup.py install for mozInstall 16:25:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Running setup.py install for mozleak 16:25:41 INFO - Running setup.py install for mozlog 16:25:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Running setup.py install for moznetwork 16:25:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:25:41 INFO - Running setup.py install for mozprocess 16:25:42 INFO - Running setup.py install for mozprofile 16:25:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:25:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:25:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:25:42 INFO - Running setup.py install for mozrunner 16:25:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:25:42 INFO - Running setup.py install for mozscreenshot 16:25:42 INFO - Running setup.py install for moztest 16:25:42 INFO - Running setup.py install for mozversion 16:25:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:25:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:25:42 INFO - Cleaning up... 16:25:42 INFO - Return code: 0 16:25:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:42 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 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:42 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 16:25:42 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 16:25:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:42 INFO - 'HOME': '/Users/cltbld', 16:25:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:42 INFO - 'LOGNAME': 'cltbld', 16:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:42 INFO - 'MOZ_NO_REMOTE': '1', 16:25:42 INFO - 'NO_EM_RESTART': '1', 16:25:42 INFO - 'PAGER': '/bin/cat', 16:25:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:42 INFO - 'PWD': '/builds/slave/test', 16:25:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:42 INFO - 'SHELL': '/bin/bash', 16:25:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:42 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:42 INFO - 'USER': 'cltbld', 16:25:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:42 INFO - 'XPC_FLAGS': '0x0', 16:25:42 INFO - 'XPC_SERVICE_NAME': '0', 16:25:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-GBwfqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-4zhFHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ClnhAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-okVjWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Yfqch6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:43 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)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-kwBraB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:43 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)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-rzFefS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:43 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)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-EbH9vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:43 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)) 16:25:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:43 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-S5uc_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-rSTKHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-kwW2uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Untvx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6_sUqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-nqk2GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-t18hRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:44 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)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-oADJrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:44 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)) 16:25:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:44 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-fkb6XM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:44 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)) 16:25:44 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)) 16:25:44 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)) 16:25:44 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)) 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:25:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:46 INFO - Downloading blessings-1.6.tar.gz 16:25:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:25:46 INFO - Installing collected packages: blessings 16:25:46 INFO - Running setup.py install for blessings 16:25:46 INFO - Successfully installed blessings 16:25:46 INFO - Cleaning up... 16:25:46 INFO - Return code: 0 16:25:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:25:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:46 INFO - Reading from file tmpfile_stdout 16:25:46 INFO - Current package versions: 16:25:46 INFO - blessings == 1.6 16:25:46 INFO - blobuploader == 1.2.4 16:25:46 INFO - docopt == 0.6.1 16:25:46 INFO - functools32 == 3.2.3-2 16:25:46 INFO - jsonschema == 2.5.1 16:25:46 INFO - manifestparser == 1.1 16:25:46 INFO - mozInstall == 1.12 16:25:46 INFO - mozcrash == 1.0 16:25:46 INFO - mozdebug == 0.1 16:25:46 INFO - mozdevice == 0.50 16:25:46 INFO - mozfile == 1.2 16:25:46 INFO - mozhttpd == 0.7 16:25:46 INFO - mozinfo == 0.9 16:25:46 INFO - mozleak == 0.1 16:25:46 INFO - mozlog == 3.4 16:25:46 INFO - moznetwork == 0.27 16:25:46 INFO - mozprocess == 0.25 16:25:46 INFO - mozprofile == 0.28 16:25:46 INFO - mozrunner == 6.13 16:25:46 INFO - mozscreenshot == 0.1 16:25:46 INFO - mozsystemmonitor == 0.3 16:25:46 INFO - moztest == 0.8 16:25:46 INFO - mozversion == 1.4 16:25:46 INFO - psutil == 3.1.1 16:25:46 INFO - requests == 1.2.3 16:25:46 INFO - wsgiref == 0.1.2 16:25:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:25:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:46 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 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:46 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 16:25:46 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 16:25:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:46 INFO - 'HOME': '/Users/cltbld', 16:25:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:46 INFO - 'LOGNAME': 'cltbld', 16:25:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:46 INFO - 'MOZ_NO_REMOTE': '1', 16:25:46 INFO - 'NO_EM_RESTART': '1', 16:25:46 INFO - 'PAGER': '/bin/cat', 16:25:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:46 INFO - 'PWD': '/builds/slave/test', 16:25:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:46 INFO - 'SHELL': '/bin/bash', 16:25:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:46 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:46 INFO - 'USER': 'cltbld', 16:25:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:46 INFO - 'XPC_FLAGS': '0x0', 16:25:46 INFO - 'XPC_SERVICE_NAME': '0', 16:25:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 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)) 16:25:47 INFO - Cleaning up... 16:25:47 INFO - Return code: 0 16:25:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:25:47 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')]} 16:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:47 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')]} 16:25:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:25:47 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 0x10f754b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f757768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb87ada81b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, '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.nT6t82vVgB/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.m6kolk1y4l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 16:25:47 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 16:25:47 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 16:25:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:25:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:25:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:25:47 INFO - 'HOME': '/Users/cltbld', 16:25:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:25:47 INFO - 'LOGNAME': 'cltbld', 16:25:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:47 INFO - 'MOZ_NO_REMOTE': '1', 16:25:47 INFO - 'NO_EM_RESTART': '1', 16:25:47 INFO - 'PAGER': '/bin/cat', 16:25:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:25:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:47 INFO - 'PWD': '/builds/slave/test', 16:25:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:25:47 INFO - 'SHELL': '/bin/bash', 16:25:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:25:47 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:25:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:25:47 INFO - 'USER': 'cltbld', 16:25:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:25:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:25:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:47 INFO - 'XPC_FLAGS': '0x0', 16:25:47 INFO - 'XPC_SERVICE_NAME': '0', 16:25:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:25:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:25:47 INFO - Cleaning up... 16:25:47 INFO - Return code: 0 16:25:47 INFO - Running post-action listener: _resource_record_post_action 16:25:47 INFO - Running post-action listener: _start_resource_monitoring 16:25:47 INFO - Starting resource monitoring. 16:25:47 INFO - [mozharness: 2017-05-05 23:25:47.406111Z] Finished create-virtualenv step (success) 16:25:47 INFO - [mozharness: 2017-05-05 23:25:47.407097Z] Running install step. 16:25:47 INFO - Running pre-action listener: _resource_record_pre_action 16:25:47 INFO - Running main action method: install 16:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:47 INFO - Reading from file tmpfile_stdout 16:25:47 INFO - Detecting whether we're running mozinstall >=1.0... 16:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:25:47 INFO - Reading from file tmpfile_stdout 16:25:47 INFO - Output received: 16:25:47 INFO - Usage: mozinstall [options] installer 16:25:47 INFO - Options: 16:25:47 INFO - -h, --help show this help message and exit 16:25:47 INFO - -d DEST, --destination=DEST 16:25:47 INFO - Directory to install application into. [default: 16:25:47 INFO - "/builds/slave/test"] 16:25:47 INFO - --app=APP Application being installed. [default: firefox] 16:25:47 INFO - mkdir: /builds/slave/test/build/application 16:25:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:25:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:26:07 INFO - Reading from file tmpfile_stdout 16:26:07 INFO - Output received: 16:26:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:26:07 INFO - Running post-action listener: _resource_record_post_action 16:26:07 INFO - [mozharness: 2017-05-05 23:26:07.621456Z] Finished install step (success) 16:26:07 INFO - [mozharness: 2017-05-05 23:26:07.621601Z] Running run-tests step. 16:26:07 INFO - Running pre-action listener: _resource_record_pre_action 16:26:07 INFO - Running main action method: run_tests 16:26:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:26:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:26:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:26:07 INFO - 2017-05-05 16:26:07.636 screenresolution[1895:10588] starting screenresolution argv=screenresolution get 16:26:07 INFO - 2017-05-05 16:26:07.638 screenresolution[1895:10588] Display 0: 1600x1200x32@60 16:26:07 INFO - 2017-05-05 16:26:07.644 screenresolution[1896:10591] starting screenresolution argv=screenresolution list 16:26:07 INFO - Available Modes on Display 0 16:26:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:26:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:26:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:26:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:26:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:26:07 INFO - Intel Iris: 16:26:07 INFO - Chipset Model: Intel Iris 16:26:07 INFO - Type: GPU 16:26:07 INFO - Bus: Built-In 16:26:07 INFO - VRAM (Dynamic, Max): 1536 MB 16:26:07 INFO - Vendor: Intel (0x8086) 16:26:07 INFO - Device ID: 0x0a2e 16:26:07 INFO - Revision ID: 0x0009 16:26:07 INFO - Displays: 16:26:07 INFO - Display: 16:26:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:26:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:26:07 INFO - Display Serial Number: 1600x1200 60 16:26:07 INFO - Main Display: Yes 16:26:07 INFO - Mirror: Off 16:26:07 INFO - Online: Yes 16:26:07 INFO - Rotation: Supported 16:26:07 INFO - Return code: 0 16:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:26:07 INFO - Python 2.7.3 16:26:07 INFO - Return code: 0 16:26:07 INFO - grabbing minidump binary from tooltool 16:26: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')]} 16:26:07 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 0x10f532d30>, '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 0x10f458db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f527be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:26:07 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 16:26:07 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 16:26:07 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 16:26:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:26:08 INFO - Return code: 0 16:26:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:26:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:26:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:26:08 INFO - ENV: RUST_BACKTRACE is now 1 16:26:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:26:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nT6t82vVgB/Render', 16:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:26:08 INFO - 'HOME': '/Users/cltbld', 16:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:26:08 INFO - 'LOGNAME': 'cltbld', 16:26:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:26:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:26:08 INFO - 'MOZ_NO_REMOTE': '1', 16:26:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:26:08 INFO - 'NO_EM_RESTART': '1', 16:26:08 INFO - 'PAGER': '/bin/cat', 16:26:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:26:08 INFO - 'PWD': '/builds/slave/test', 16:26:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:26:08 INFO - 'RUST_BACKTRACE': '1', 16:26:08 INFO - 'SHELL': '/bin/bash', 16:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m6kolk1y4l/Listeners', 16:26:08 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 16:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:26:08 INFO - 'USER': 'cltbld', 16:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:26:08 INFO - 'XPC_FLAGS': '0x0', 16:26:08 INFO - 'XPC_SERVICE_NAME': '0', 16:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:26:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:26:08 INFO - mozversion application_buildid: 20170505144815 16:26:08 INFO - mozversion application_changeset: c273884ffe6bb255399bb15fbad6eb0b66be49eb 16:26:08 INFO - mozversion application_display_name: Nightly 16:26:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:26:08 INFO - mozversion application_name: Firefox 16:26:08 INFO - mozversion application_remotingname: firefox 16:26:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:26:08 INFO - mozversion application_vendor: Mozilla 16:26:08 INFO - mozversion application_version: 55.0a1 16:26:08 INFO - mozversion platform_buildid: 20170505144815 16:26:08 INFO - mozversion platform_changeset: c273884ffe6bb255399bb15fbad6eb0b66be49eb 16:26:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:26:08 INFO - mozversion platform_version: 55.0a1 16:26:08 INFO - using testdate: 1494026768 16:26:08 INFO - actual date: 1494026768 16:26:08 INFO - starting webserver on 'localhost:49713' 16:26:08 INFO - SUITE-START | Running 2 tests 16:26:08 INFO - TEST-START | dromaeo_css 16:26:08 INFO - operating with platform_type : mac_ 16:26:08 INFO - Initialising browser for dromaeo_css test... 16:26:08 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpcJPFQh/profile http://localhost:49713/getInfo.html) 16:26:11 INFO - PID 1906 | __metrics Screen width/height:1600/1200 16:26:11 INFO - PID 1906 | colorDepth:24 16:26:11 INFO - PID 1906 | Browser inner width/height: 1024/691 16:26:11 INFO - PID 1906 | __metrics 16:26:11 INFO - PID 1906 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:26:11 INFO - PID 1906 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:26:12 INFO - TEST-INFO | 1906: exit 0 16:26:12 INFO - Browser initialized. 16:26:12 INFO - Running cycle 1/1 for dromaeo_css test... 16:26:12 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpcJPFQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:26:24 INFO - PID 1908 | RSS: Main: 240648192 16:26:24 INFO - PID 1908 | 16:29:29 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49713/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49713/tests/dromaeo/cssquery-ext.html) 16:29:31 INFO - PID 1908 | RSS: Main: 430882816 16:29:31 INFO - PID 1908 | 16:32:33 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49713/tests/dromaeo/cssquery-ext.html (next: http://localhost:49713/tests/dromaeo/cssquery-jquery.html) 16:32:34 INFO - PID 1908 | RSS: Main: 365547520 16:32:34 INFO - PID 1908 | 16:35:36 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49713/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49713/tests/dromaeo/cssquery-mootools.html) 16:35:37 INFO - PID 1908 | RSS: Main: 332414976 16:35:37 INFO - PID 1908 | 16:38:39 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49713/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49713/tests/dromaeo/cssquery-prototype.html) 16:38:40 INFO - PID 1908 | RSS: Main: 322998272 16:38:40 INFO - PID 1908 | 16:41:43 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49713/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49713/tests/dromaeo/cssquery-yui.html) 16:41:44 INFO - PID 1908 | RSS: Main: 328171520 16:41:44 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | Cycle 1(1): loaded http://localhost:49713/tests/dromaeo/cssquery-yui.html (next: http://localhost:49713/tests/dromaeo/cssquery-dojo.html) 16:44:46 INFO - PID 1908 | RSS: Main: 371634176 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | __start_tp_report 16:44:46 INFO - PID 1908 | _x_x_mozilla_page_load 16:44:46 INFO - PID 1908 | _x_x_mozilla_page_load_details 16:44:46 INFO - PID 1908 | |i|pagename|runs| 16:44:46 INFO - PID 1908 | |0;dojo.html;3010.3226773975853;3517.7537572369943;3526.7002304804105;3553.1117220694828;3580.8030558319297;6024.9397506024925;6148.6472975945335;6178.876422471548;6208.596441231322;6218.595791273569;5071.7210553419545;6132.712130452599;6147.801178770142;6163.2912215095275;6237.03325984472;5223.294855194538;5251.949610077981;5352.411234764192;5372.382176049756;5403.2705584746145;5403.486668766461;5468.453154684519;5490.505854473096;5493.917591236134;5562.3881373048935;5292.708901010443;5382.4886635769535;5392.352917649868;5417.377001644822;5450.99999999998;4460.4870439899505;5287.444818294062;5353.116735738598;5357.303550538444;5367.490088441592;5266.8419947401635;5299.470052994709;5327.973360133214;5334.91997620036;5339.119045357511;6149.631022138686;6154.476869466101;6164;6219.2847822500535;6243.781467648656;6581.638009909453;6599.439047680953;6617.966910165466;6619.536632435731;6633.767818126343;6592.340765923417;6675.532712710112;6693.0964319816685;6694;6720.1599800025;5123.538881500683;5227.693076730855;6202.472789812917;6244.344343843922;6308.495320374359;6859.17689877208;6875.449964002868;6878.105846240057;6880.380765731108;6888.862222755617;6341.4292713656;6406.391392817675;6413.102165696806;6464.127342808754;6500.609963402211;6666.733330666816;6668.466522678174;6668.499862510331;6675.299093595103;6676.9666151668935;6334.683265836689;6424.26120996082;6528.934710652833;6596.96701516499;6597.967010164918;6499.447546958561;6577.835554111186;6621.569597976116;6625.668716564152;6630.336966303331;5277.788888444419;5278.97360513195;5283.973580132075;5293.0472514946905;5336.573074154058;4592.127495775792;4673.112108699336;4686.250199968057;4693.436787585443;4716.622670186377;6146.094710639716;6192.133101365813;6193.907091393633;6205.255369355616;6209.6895155242055;5321;5681.886362272731;6528.37980391862;6711.463082953352;6719;6252.124702541648;6304.054391841169;6317.020861766434;6318.368163183645;6350.745970161234;5896.587238893237;5902.527797776168;5904.970475147683;5927.1405646181065;5974.910376344358;6668;6765.492588055817;6874.243833178346;6905.378515933389;6914.412274956484;6552.3447655234095;6571.277159512354;6579.769708060195;6579.967100164468;6581.638009909309;6715.395614394728;6863.142107236596;6928.896066559107;6931.93068069333;6939.757108501179;6529.053287273224;6552.017197420425;6555.246146693001;6584.637844918576;6591.835204119935;6460.741570337133;6573.244076931214;6679.899801502884;6705.329467053256;6718;6327.3356297589935;6341.239051313872;6355.586886852339;6429.7749578764515;6498.0252962056065;6452.193475815523;6462.7414903405215;6490.026496025634;6512.185976752906;6514.088027676224;6366.076918846648;6389.52078594098;6393.776217832539;6399.104125422352;6402.839929001812;6314.368563143649;6501.382368674968;6504.739810407531;6506.284308726131;6510.316416776171;6289.811305660837;6306.337834527309;6323.715432805627;6326.114343991753;6348.746050158126 16:44:46 INFO - PID 1908 | |1;ext.html;754.7999780058282;799.5642374905676;810.1048341582551;1108.0858291909171;1124.8931351521603;25831;32544.02367928963;36299.092522686944;36338;36362;38068.23863522728;38362.424563631495;38421.61578384216;38428.61571384285;38438.84683459501;5875.412458754112;8205.507669539817;8409.075001749803;8417.83164336713;8418.621162047692;5902;8204.958975205116;8344.833103337929;8350.749477515654;8351.582420878962;7150.570965742072;8418.452800567944;8436.746897593051;8436.789080272982;8487.278581320596;5904.380040095814;8338.082810890797;8380.580970951429;8397.118302578263;8405.663773449085;5961.552883533709;6748.426383757386;8207.179282071806;8240.175982401772;8251.689526932469;36581.63418365809;36921.63078369209;36922.892313230645;37000.629993699986;37064;3596.4065929121925;3623.655752703515;3628.8548458061646;3636.799976001319;3640.5813331466957;30170.547441788392;30175.094747157622;30189.69810301891;30215;30230.09309720712;3100.891468798581;3173.714365707074;3185.761067919915;3188.3145123798263;3199.280161963563;290634.54682726454;297040;297799;297864.99999999785;298890;48474.515254847705;48477.27284090741;48478;48490.75754621275;48555.02889942181;50899.74550127226;50902.23646645303;50905.74547127241;50984.47046588608;51023.234651480256;13873.306334683226;13953.720925581432;13955.511557095453;13970.441182352592;13982.650433739034;9871.555779989918;9883.604655813831;11446;11475.426228688531;11500.482478288497;10178.694639160836;11610.245334053428;11718.23831450953;11758.58844940423;11778.823317650242;4586.243269860503;5331.173668081376;5338.54622357104;5359.517643412111;5385.5960802939935;1016.8474728790593;1018.8930162332997;1035.6277931740324;1049.2550289294534;1064.6433444795925;22685.546289074126;23824.880875595856;23962.88018559896;23990.04039838422;24000.759992400202;960.313375936209;1082.9874067746525;1140.2873204247346;1156.4680247086267;1161.924474909128;10405.53175107122;12035.759284814254;12124.939375303067;12133.878661213452;12144;300119;300230;300608;300680;300832;51899.702507437614;51932.48067519352;51936.74031629818;52161.47838521566;52271.95456090857;1511.5012046024785;1523.573399448134;1555.2534783304077;1567.9843201567837;1582.968340633204;23228.651570226797;23255.76744232536;23374.883125584944;23399.649005265273;23450.17924372707;31975.040748777574;36047.27905441824;37124.62875371212;37244.25511489809;37433.62566374301;279377;279396;279922;280339;280400;27837.860810695816;32935.50596741099;32958.835205823816;32974.010779676646;33016.50475242825;34573.65426345704;38383.61616383801;42619;42741.78629106835;42788.57211427846;28038;28776;28975.7102428973;29917.70082299149;30328.5450718235;23799.286021419386;25284.241472755846;29741.5538766923;29743.10770676883;29804.403911922072;26583.734162658126;35727.82136089407;35949.46075808813;35983.64016359803;35985.28029439449;28444.146675599764;29045.12864614065;29141.41717165687;29928.25179370446;30104.69895301019;22353;23237.003455094145;23301.18445854387;23337.649935250643;23610.055597776583 16:44:46 INFO - PID 1908 | |2;jquery.html;427.95078565964883;437.65206660704746;440.86917057746876;446.42411289436626;455.8928651766834;18784;20589.27937522187;21035.58252766917;21288.4677883053;21300.360989170313;21840;22110.447238818997;22397.888010559964;22701.432464188405;23492.76507234927;6005.759769609211;6269.341719119495;6276.874462510747;6279.937200628004;6308.085327627514;5840.853978650546;6151.5386346024225;6215.5338349623735;6220.7822726204595;6235.064740288947;5930.288365396159;6194.132821405007;6203.968980155093;6214.689265536727;6242.4069713377385;6087.604305720114;6145.692715364258;6176.413240742122;6179.320274769794;6182.350853160398;5264.842054738364;5389.191621256843;5447.346318441772;5472;5477.20580515823;27623.861880690467;27948.580771288245;27971.160865173875;28129.593520323902;28308;2163.0698799516204;2165.675148727688;2206.6800313954386;2230.2751605728204;2233.542123864604;15122.848771512254;15313.540593782092;16563.757718171186;17407.73888391675;17642.823571764377;1915.1573307744686;2121.713568668241;2175.9564808703894;2177.7604463509;2178.4444966533433;141178;141979;142441.8633720495;152321;162354.9999999988;11810.76378472443;12340.629781106582;12386.380680965916;12387.75224495505;12463.813042804366;16600.4189853357;16623.750643740354;16632.50102496927;16634;16669.91665041691;8734.432261903083;8933.731988040368;8962.924449066024;9002.459852408745;9064.864027039599;8495.660173592987;8512.489250644981;8546.829063418822;8694.695685650971;8696.13038696138;6378;7590.1650818409935;7724.266194711493;7769.650365733555;7780.299773020455;2133.2426988419197;2146.399008277685;2147.7207962965026;2147.76374598794;2323.210108563063;802.9036515618163;880.6433394475248;934.6261495401758;943.3820847345;953.5779121032638;19175.712364314546;19461;19773.912434816222;20335.831154613268;20337.898310508353;773.2963003666637;835.6949713354703;988.421773262635;996.1681995533665;999.8100360931545;9821.754456138511;10505;10516.737081573021;10576.526940163334;10600.310979786444;537303;541433.2928335412;543885;545193;560766.6888301173;130191;131463;134558.32720836528;134829.32585337208;134886;1172.2263306217856;1179.4161889864401;1197.26368283505;1197.9820302695466;1200.8078707406598;16690.49928502147;17093.658126837643;17504.299828006737;17879;17901.37345192912;54098;54423.18365224604;54492.727536362065;54967.725161373935;55333;74216;75809;76071.61964190143;77019;77750;8395.412321137706;8621.051684314594;8701.564921753761;8774;8851;12653.493860245488;13433.798493022809;13728.107673001223;13925.234112123526;14028.368723407268;11710.531578736754;11740.58907938218;11795.174337796616;11952.34262115592;12026.75946481083;9389.812203756022;9557.330986830855;11068.778624427627;11072.944635276772;11103.555857765921;11796.174267801514;11940.164188506722;11949.64151075469;11978.161528692908;12092;8541.829163416822;8760.342974276828;8779.517126557845;8973.685920992733;8999.730008099768;11824.76350473003;11993.34036627994;12166.087543434101;12258.632241032783;12264.202826816228 16:44:46 INFO - PID 1908 | |3;mootools.html;1201.345266829578;1235.8455193100863;1444.1118711992128;1465.8827293816491;1483.777433384992;9752.561134748936;10222.233332500064;11394.25937314074;11682.649520514398;11718.707032324197;11244;11337.489812958416;11344.43277836109;11344.716382090432;11354.432278386068;2485.5401750676137;2531.2785856031037;2533.2526904563106;2535.5943049112147;2537.606670966003;2113;2183.2140429445385;2195.978040219601;2476.4923190745853;2573.2537564106387;2029.502771820906;2507.53610582042;2530.6963164420295;2532.1643857526974;2536.251805717318;2481.900723971039;2519.5590771614984;2526.1158594491963;2526.5831137862233;2526.772590466867;2453;2454.631805229212;2481.466484705797;2495.800335973118;2504.4365017871014;11502.252353596989;11609.941950290278;11610.013148882355;11629.709257268636;11630.767384652345;6426.453751431134;6666.666666666696;6684.431823295025;6684.83287917801;6690.431313338323;3913.882583522499;4082.2447847148073;4218.704690671654;4232.661387089025;4237.724547904377;1214.1440284599337;1224.357212463455;1241.3669028795289;1258.584667059868;1261.400834603565;16546.83453165465;16550.089745064015;16601.50195494137;16605.916970415314;16614.501564953072;5732.197492351074;5921;5940.6435613863305;6027.78902738402;6091.604045737013;13724.725505489834;13734.587962361145;13751.793723094162;13759;13770.449182032606;6694.196696396463;6808.489363297773;6813.318668133246;6817.5909445433435;6819.147606549182;5238.947610523922;6160.568760186744;6170.074488826622;6221.440070393686;6227.719752611143;4173.123644034726;4273.6281363842745;4610.838620648261;4683.812647494062;4709.152352576501;1392.5543825975792;1440.8343040550262;1442.3725679329525;1458.6061763323844;1461.093273278382;785.8251913389405;794.7059587952494;809.8906647602616;819.7253919936769;850.3154960257052;6134.693265336716;6270.9372906271265;6452.419282264619;6562.573432726857;6681.966590167018;866.547709415688;895.5253715530779;933.7712260496222;934.313279739391;937.9906200937903;3769.151940813295;4321.135772845443;4404.889877753082;4535.569120933506;4560.931586026212;14977.550673479813;15039.924800376148;15197.468088616846;15204.923975380274;15258.542243732705;14548.927255363868;14738.852611473962;15188.936774425683;15191.240437978056;15240;8286.668533258602;8608.880845490046;8613.741587752378;8630.050694423733;8640.913590864136;5755.7697692093525;5941.7623295067715;6636.938089905592;6796.082528858541;6905.723771049303;13121.73756524845;13124.934375328063;13174.47302107905;13476.921846252473;13635;13544.187348759106;13666;13740.587782366545;13746.93126534361;14000.719985600435;8738.956305218688;9122.908770912207;9202.769930751785;9227;9379.437233765995;9547;9858.30991830565;9862.358946668444;10498.422586757802;10645.520951557044;8910.153535414125;8925.866112008196;8954.597043133204;8991.370604057915;9030.819383612159;8654.524001179996;8792.252658524098;8862.33532485079;8894.68868589622;9034.819303614022;7988.6405111768945;8104.756857294291;8104.959475202586;8116.797080073045;8128.187181281824;4834.540718631724;5733.226014487991;5805.8548536286935;5857.7949771757785;5921.289445266596;5562.082256427644;5815.709214539341;5923.141144533933;5943.613665111754;6034.547408944434 16:44:46 INFO - PID 1908 | |4;prototype.html;345.85819813876316;394.3296396126585;399.5213654928254;402.03912648769426;405.82346679194535;4837.516248375161;5833.5041521470675;5868.3838196989345;5882.235309409776;5911.349751527328;4793.664443488957;5299.629025968184;5668.433156684329;5711.600657838825;5845.210896528978;3654.9817250913707;3796.652832506778;4303.2469317869245;4429.734215947045;4448.733076015434;4441.244988351988;4455.554444555535;4461.7992190351515;4467.285234362503;4480.619147372461;3607.935658980594;4062.756234625932;4423.557644235583;4439.689221754478;4460.732356058631;3669.5229620149344;4048.1701251243717;4250.723702959298;4263.912702260935;4269.380939763748;3666.7249956253386;3676.9264614707554;3685.760425572329;3688.8564544990872;3694.9445758313645;5375.3012108425655;5485.985092757813;5702.6293290935955;5703.5152012079025;5729.914051289234;4582.404287442644;4883.99878025004;5020.874478138039;5041.8487445376695;5062.493750624908;6150.938490615082;6188.566800323979;6193.4425901669065;6230.906536401958;6253.781117660906;4116.732412393185;4147.900806286337;4165.166966606691;4192.434021407102;4195.370694395834;6245.219347581552;6416.326285740023;6430.260520040161;6506.349365063503;6631.972044333136;4103.342706028679;4108.116754897652;4111.251504512293;4117.423560701504;4125.711200216017;4201.264778663722;4286.421333119989;4321.373400856858;4327.744953963378;4334.761588112684;4968.403791544965;5010.473900240495;5018.347614810052;5061.544460998528;5069.518395752398;6162.7226774795245;6164.352742961924;6166.691665416712;6168.228971378578;6180.752769889244;1334.813126162338;1465.7874608181753;1467.1710483576744;1470.9411623535152;1475.6458449971929;911.7447114807865;916.5783739479781;937.9953100234592;961.2598299309632;981.7398389426808;5676.829695109153;5962.433568810956;5974.970125149433;5988.341282458926;6026.186464827192;6227.88251994315;6355.428011478989;6357.904631430532;6375.171227740457;6377.585456945284;5859.630712340421;5884.735186916513;5910.202122713465;5936.5844390892225;5995.760169593254;3085.706857848501;3311.9006429807146;3331.60020797501;3358.5465962094804;3364.411228035084;4719.5044520325555;6581.967090164614;6591.110200123018;6669.4330981866115;6703.564268322543;5580.581456390787;6353.5870168438905;6620.205575330991;6654.234763002317;6677.3656502632175;6013.977623803964;6310.5898116622275;6537.757826013042;6681.265060843303;6700.798976030727;5662.207290979349;5901.793437229848;6465.967670161619;6479.254885688206;6481.5138864584405;5676.34722006958;6036.879262414815;6345.460635846005;6388.105665206967;6390.712417941297;6641.26946035926;6670.83322916931;6722.025306330457;6725.327467253432;6745.123133992746;4239.915201695887;4240.427542281753;4258.382534532538;4282.122164956114;4283.571642835692;5271.627767504715;6376.936230637634;6454.709538070704;6497.480201583957;6502.837429064311;6171.352008039271;6226.003839385677;6266.749330026748;6272.6236425814595;6273.3099359071375;6027.487663548647;6092.817215483543;6165.660888651168;6235.657038862906;6244.219472565929;6077.665728384981;6099.255335099312;6109.84725381869;6137.961708954096;6163.181861351002;4912.336834527293;5072.594192464668;5373.817760092773;5441.075017246998;5890.734916928663;6017.247844019497;6082.787102451393;6097.725602347994;6107.206063211754;6175.5677102602385 16:44:46 INFO - PID 1908 | |5;yui.html;833.6457005772553;849.1296421168302;850.7150104714921;866.0906048648917;885.0795173020059;15859.84140158598;15868.206589670528;16315.918420407896;16327.91836040818;16351.509454716363;13172.736545269088;15073.321700523502;15328.693426131471;15544.53366399007;15545.37818487262;996.6860438961722;1002.0630710285869;1005.964791232307;1006.1498034161123;1008.3798463944695;986.7631768375574;990.8711867457221;990.9554070066828;993.1905497019906;995.6166875752851;1026.36365453419;1050.5115121468516;1052.947352632369;1067.8985496377832;1070.2829104499965;1058.4866339825178;1059.6079450603288;1060.8567843341166;1061.8088744026072;1063.3407287481734;780.1808101493466;781.7928249014016;782.182619162976;782.2646712090674;783.7217787685347;16161.595960100974;16423.589410264718;16587.253573589216;16887.493375198763;17154.656906861917;17270;17298.91350543252;17487;17728;17748.023858687768;13890.305484725824;14009.439622415091;14066.296685165804;14446.638834029129;14561.563153105319;3588.2105936693883;3605.4231322988458;3605.603383627799;3610.151614370621;3614.5843228028853;89363.99999999935;99323.55749761207;108176.91823081748;121330.18004729936;122976.79343862763;9835;10832.862549432197;11496.88503114958;13839.930800346136;13881.236531990837;23832.642510362013;24842;25096.37259068538;26016;26061.60907586388;7804.804879877935;7901.565413902291;7953.761387158394;7999.640016199285;8037.959810200911;3891.669208117342;3945.0926286954164;3951.68386529077;3952.130531283113;3954.387070004154;4232.513260975027;4282.828686852491;4331.263685173528;4349.499807522112;4356.6514678825615;927.6150397585062;934.8364036293622;947.725159703692;957.9329446938787;959.69289827256;644.3492073006297;652.3541693723274;659.980200593983;661.6592454885738;692.9778576599475;9778.608855645694;9959.55182016811;9965.302428830057;11948.641540753792;12024.939875300568;594.7234535940722;638.5211091681239;660.577230572434;672.1228796420718;686.087503620194;5429.239906413105;5544.69504177266;5545.9722701387045;5596.720163991784;5672.4894759471845;92678;100523.49738251262;100579;102286;102968.48515757373;79575.60212198902;87867.56066219628;87973;88338.55830720805;89546.55226723825;76854;79472.20527794649;80176;81014;81805;11683.941580292045;12145.635630931087;12219.205751626116;12249.387530623611;12263.816042759545;37711.68009119668;38299.80850095732;38354;38390.808045959595;38620;52509;52569.47430525646;52761;70493.90121975522;71498;16617.667646646758;16783.328666853187;16892.831071689125;16960.491185264462;17241.310347585957;18329.3584724534;18356.72464913054;18591;18635.068246587347;18762;16589.58526036859;16951.66096678084;17121.68953414159;17145.742813857552;17249.0513021785;16406.933549319256;16907.408240711517;16978.151092445576;17320;17423.56441088932;16036.67926641484;16495.34018639241;16903.492895212672;17064.91467542704;17095.316187352368;11402.258853174517;11532.769344613229;11951.521939122686;12160.939195303967;12188.329641869783;12448.62654120378;13162.868371316164;13325.733485330045;13529.729405412034;13789.586312410644 16:44:46 INFO - PID 1908 | __end_tp_report 16:44:46 INFO - PID 1908 | __start_cc_report 16:44:46 INFO - PID 1908 | _x_x_mozilla_cycle_collect,1967 16:44:46 INFO - PID 1908 | __end_cc_report 16:44:46 INFO - PID 1908 | __startTimestamp1494027886764__endTimestamp 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | ------- Summary: start ------- 16:44:46 INFO - PID 1908 | Number of tests: 6 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | [#0] dojo.html Cycles:165 Average:6080.71 Median:6334.68 stddev:748.61 (11.8%) stddev-sans-first:711.11 16:44:46 INFO - PID 1908 | Values: 3010.3 3517.8 3526.7 3553.1 3580.8 6024.9 6148.6 6178.9 6208.6 6218.6 5071.7 6132.7 6147.8 6163.3 6237.0 5223.3 5251.9 5352.4 5372.4 5403.3 5403.5 5468.5 5490.5 5493.9 5562.4 5292.7 5382.5 5392.4 5417.4 5451.0 4460.5 5287.4 5353.1 5357.3 5367.5 5266.8 5299.5 5328.0 5334.9 5339.1 6149.6 6154.5 6164.0 6219.3 6243.8 6581.6 6599.4 6618.0 6619.5 6633.8 6592.3 6675.5 6693.1 6694.0 6720.2 5123.5 5227.7 6202.5 6244.3 6308.5 6859.2 6875.4 6878.1 6880.4 6888.9 6341.4 6406.4 6413.1 6464.1 6500.6 6666.7 6668.5 6668.5 6675.3 6677.0 6334.7 6424.3 6528.9 6597.0 6598.0 6499.4 6577.8 6621.6 6625.7 6630.3 5277.8 5279.0 5284.0 5293.0 5336.6 4592.1 4673.1 4686.3 4693.4 4716.6 6146.1 6192.1 6193.9 6205.3 6209.7 5321.0 5681.9 6528.4 6711.5 6719.0 6252.1 6304.1 6317.0 6318.4 6350.7 5896.6 5902.5 5905.0 5927.1 5974.9 6668.0 6765.5 6874.2 6905.4 6914.4 6552.3 6571.3 6579.8 6580.0 6581.6 6715.4 6863.1 6928.9 6931.9 6939.8 6529.1 6552.0 6555.2 6584.6 6591.8 6460.7 6573.2 6679.9 6705.3 6718.0 6327.3 6341.2 6355.6 6429.8 6498.0 6452.2 6462.7 6490.0 6512.2 6514.1 6366.1 6389.5 6393.8 6399.1 6402.8 6314.4 6501.4 6504.7 6506.3 6510.3 6289.8 6306.3 6323.7 6326.1 6348.7 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | [#1] ext.html Cycles:180 Average:43600.59 Median:17581.68 stddev:76739.94 (436.5%) stddev-sans-first:76887.79 16:44:46 INFO - PID 1908 | Values: 754.8 799.6 810.1 1108.1 1124.9 25831.0 32544.0 36299.1 36338.0 36362.0 38068.2 38362.4 38421.6 38428.6 38438.8 5875.4 8205.5 8409.1 8417.8 8418.6 5902.0 8205.0 8344.8 8350.7 8351.6 7150.6 8418.5 8436.7 8436.8 8487.3 5904.4 8338.1 8380.6 8397.1 8405.7 5961.6 6748.4 8207.2 8240.2 8251.7 36581.6 36921.6 36922.9 37000.6 37064.0 3596.4 3623.7 3628.9 3636.8 3640.6 30170.5 30175.1 30189.7 30215.0 30230.1 3100.9 3173.7 3185.8 3188.3 3199.3 290634.5 297040.0 297799.0 297865.0 298890.0 48474.5 48477.3 48478.0 48490.8 48555.0 50899.7 50902.2 50905.7 50984.5 51023.2 13873.3 13953.7 13955.5 13970.4 13982.7 9871.6 9883.6 11446.0 11475.4 11500.5 10178.7 11610.2 11718.2 11758.6 11778.8 4586.2 5331.2 5338.5 5359.5 5385.6 1016.8 1018.9 1035.6 1049.3 1064.6 22685.5 23824.9 23962.9 23990.0 24000.8 960.3 1083.0 1140.3 1156.5 1161.9 10405.5 12035.8 12124.9 12133.9 12144.0 300119.0 300230.0 300608.0 300680.0 300832.0 51899.7 51932.5 51936.7 52161.5 52272.0 1511.5 1523.6 1555.3 1568.0 1583.0 23228.7 23255.8 23374.9 23399.6 23450.2 31975.0 36047.3 37124.6 37244.3 37433.6 279377.0 279396.0 279922.0 280339.0 280400.0 27837.9 32935.5 32958.8 32974.0 33016.5 34573.7 38383.6 42619.0 42741.8 42788.6 28038.0 28776.0 28975.7 29917.7 30328.5 23799.3 25284.2 29741.6 29743.1 29804.4 26583.7 35727.8 35949.5 35983.6 35985.3 28444.1 29045.1 29141.4 29928.3 30104.7 22353.0 23237.0 23301.2 23337.6 23610.1 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | [#2] jquery.html Cycles:180 Average:35117.43 Median:12907.99 stddev:92527.93 (716.8%) stddev-sans-first:92750.83 16:44:46 INFO - PID 1908 | Values: 428.0 437.7 440.9 446.4 455.9 18784.0 20589.3 21035.6 21288.5 21300.4 21840.0 22110.4 22397.9 22701.4 23492.8 6005.8 6269.3 6276.9 6279.9 6308.1 5840.9 6151.5 6215.5 6220.8 6235.1 5930.3 6194.1 6204.0 6214.7 6242.4 6087.6 6145.7 6176.4 6179.3 6182.4 5264.8 5389.2 5447.3 5472.0 5477.2 27623.9 27948.6 27971.2 28129.6 28308.0 2163.1 2165.7 2206.7 2230.3 2233.5 15122.8 15313.5 16563.8 17407.7 17642.8 1915.2 2121.7 2176.0 2177.8 2178.4 141178.0 141979.0 142441.9 152321.0 162355.0 11810.8 12340.6 12386.4 12387.8 12463.8 16600.4 16623.8 16632.5 16634.0 16669.9 8734.4 8933.7 8962.9 9002.5 9064.9 8495.7 8512.5 8546.8 8694.7 8696.1 6378.0 7590.2 7724.3 7769.7 7780.3 2133.2 2146.4 2147.7 2147.8 2323.2 802.9 880.6 934.6 943.4 953.6 19175.7 19461.0 19773.9 20335.8 20337.9 773.3 835.7 988.4 996.2 999.8 9821.8 10505.0 10516.7 10576.5 10600.3 537303.0 541433.3 543885.0 545193.0 560766.7 130191.0 131463.0 134558.3 134829.3 134886.0 1172.2 1179.4 1197.3 1198.0 1200.8 16690.5 17093.7 17504.3 17879.0 17901.4 54098.0 54423.2 54492.7 54967.7 55333.0 74216.0 75809.0 76071.6 77019.0 77750.0 8395.4 8621.1 8701.6 8774.0 8851.0 12653.5 13433.8 13728.1 13925.2 14028.4 11710.5 11740.6 11795.2 11952.3 12026.8 9389.8 9557.3 11068.8 11072.9 11103.6 11796.2 11940.2 11949.6 11978.2 12092.0 8541.8 8760.3 8779.5 8973.7 8999.7 11824.8 11993.3 12166.1 12258.6 12264.2 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | [#3] mootools.html Cycles:180 Average:7102.64 Median:4225.68 stddev:4537.14 (107.4%) stddev-sans-first:4528.19 16:44:46 INFO - PID 1908 | Values: 1201.3 1235.8 1444.1 1465.9 1483.8 9752.6 10222.2 11394.3 11682.6 11718.7 11244.0 11337.5 11344.4 11344.7 11354.4 2485.5 2531.3 2533.3 2535.6 2537.6 2113.0 2183.2 2196.0 2476.5 2573.3 2029.5 2507.5 2530.7 2532.2 2536.3 2481.9 2519.6 2526.1 2526.6 2526.8 2453.0 2454.6 2481.5 2495.8 2504.4 11502.3 11609.9 11610.0 11629.7 11630.8 6426.5 6666.7 6684.4 6684.8 6690.4 3913.9 4082.2 4218.7 4232.7 4237.7 1214.1 1224.4 1241.4 1258.6 1261.4 16546.8 16550.1 16601.5 16605.9 16614.5 5732.2 5921.0 5940.6 6027.8 6091.6 13724.7 13734.6 13751.8 13759.0 13770.4 6694.2 6808.5 6813.3 6817.6 6819.1 5238.9 6160.6 6170.1 6221.4 6227.7 4173.1 4273.6 4610.8 4683.8 4709.2 1392.6 1440.8 1442.4 1458.6 1461.1 785.8 794.7 809.9 819.7 850.3 6134.7 6270.9 6452.4 6562.6 6682.0 866.5 895.5 933.8 934.3 938.0 3769.2 4321.1 4404.9 4535.6 4560.9 14977.6 15039.9 15197.5 15204.9 15258.5 14548.9 14738.9 15188.9 15191.2 15240.0 8286.7 8608.9 8613.7 8630.1 8640.9 5755.8 5941.8 6636.9 6796.1 6905.7 13121.7 13124.9 13174.5 13476.9 13635.0 13544.2 13666.0 13740.6 13746.9 14000.7 8739.0 9122.9 9202.8 9227.0 9379.4 9547.0 9858.3 9862.4 10498.4 10645.5 8910.2 8925.9 8954.6 8991.4 9030.8 8654.5 8792.3 8862.3 8894.7 9034.8 7988.6 8104.8 8105.0 8116.8 8128.2 4834.5 5733.2 5805.9 5857.8 5921.3 5562.1 5815.7 5923.1 5943.6 6034.5 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | [#4] prototype.html Cycles:180 Average:5040.38 Median:5839.36 stddev:1582.94 (27.1%) stddev-sans-first:1547.67 16:44:46 INFO - PID 1908 | Values: 345.9 394.3 399.5 402.0 405.8 4837.5 5833.5 5868.4 5882.2 5911.3 4793.7 5299.6 5668.4 5711.6 5845.2 3655.0 3796.7 4303.2 4429.7 4448.7 4441.2 4455.6 4461.8 4467.3 4480.6 3607.9 4062.8 4423.6 4439.7 4460.7 3669.5 4048.2 4250.7 4263.9 4269.4 3666.7 3676.9 3685.8 3688.9 3694.9 5375.3 5486.0 5702.6 5703.5 5729.9 4582.4 4884.0 5020.9 5041.8 5062.5 6150.9 6188.6 6193.4 6230.9 6253.8 4116.7 4147.9 4165.2 4192.4 4195.4 6245.2 6416.3 6430.3 6506.3 6632.0 4103.3 4108.1 4111.3 4117.4 4125.7 4201.3 4286.4 4321.4 4327.7 4334.8 4968.4 5010.5 5018.3 5061.5 5069.5 6162.7 6164.4 6166.7 6168.2 6180.8 1334.8 1465.8 1467.2 1470.9 1475.6 911.7 916.6 938.0 961.3 981.7 5676.8 5962.4 5975.0 5988.3 6026.2 6227.9 6355.4 6357.9 6375.2 6377.6 5859.6 5884.7 5910.2 5936.6 5995.8 3085.7 3311.9 3331.6 3358.5 3364.4 4719.5 6582.0 6591.1 6669.4 6703.6 5580.6 6353.6 6620.2 6654.2 6677.4 6014.0 6310.6 6537.8 6681.3 6700.8 5662.2 5901.8 6466.0 6479.3 6481.5 5676.3 6036.9 6345.5 6388.1 6390.7 6641.3 6670.8 6722.0 6725.3 6745.1 4239.9 4240.4 4258.4 4282.1 4283.6 5271.6 6376.9 6454.7 6497.5 6502.8 6171.4 6226.0 6266.7 6272.6 6273.3 6027.5 6092.8 6165.7 6235.7 6244.2 6077.7 6099.3 6109.8 6138.0 6163.2 4912.3 5072.6 5373.8 5441.1 5890.7 6017.2 6082.8 6097.7 6107.2 6175.6 16:44:46 INFO - PID 1908 | 16:44:46 INFO - PID 1908 | [#5] yui.html Cycles:180 Average:21023.69 Median:18698.53 stddev:28586.06 (152.9%) stddev-sans-first:28626.05 16:44:46 INFO - PID 1908 | Values: 833.6 849.1 850.7 866.1 885.1 15859.8 15868.2 16315.9 16327.9 16351.5 13172.7 15073.3 15328.7 15544.5 15545.4 996.7 1002.1 1006.0 1006.1 1008.4 986.8 990.9 991.0 993.2 995.6 1026.4 1050.5 1052.9 1067.9 1070.3 1058.5 1059.6 1060.9 1061.8 1063.3 780.2 781.8 782.2 782.3 783.7 16161.6 16423.6 16587.3 16887.5 17154.7 17270.0 17298.9 17487.0 17728.0 17748.0 13890.3 14009.4 14066.3 14446.6 14561.6 3588.2 3605.4 3605.6 3610.2 3614.6 89364.0 99323.6 108176.9 121330.2 122976.8 9835.0 10832.9 11496.9 13839.9 13881.2 23832.6 24842.0 25096.4 26016.0 26061.6 7804.8 7901.6 7953.8 7999.6 8038.0 3891.7 3945.1 3951.7 3952.1 3954.4 4232.5 4282.8 4331.3 4349.5 4356.7 927.6 934.8 947.7 957.9 959.7 644.3 652.4 660.0 661.7 693.0 9778.6 9959.6 9965.3 11948.6 12024.9 594.7 638.5 660.6 672.1 686.1 5429.2 5544.7 5546.0 5596.7 5672.5 92678.0 100523.5 100579.0 102286.0 102968.5 79575.6 87867.6 87973.0 88338.6 89546.6 76854.0 79472.2 80176.0 81014.0 81805.0 11683.9 12145.6 12219.2 12249.4 12263.8 37711.7 38299.8 38354.0 38390.8 38620.0 52509.0 52569.5 52761.0 70493.9 71498.0 16617.7 16783.3 16892.8 16960.5 17241.3 18329.4 18356.7 18591.0 18635.1 18762.0 16589.6 16951.7 17121.7 17145.7 17249.1 16406.9 16907.4 16978.2 17320.0 17423.6 16036.7 16495.3 16903.5 17064.9 17095.3 11402.3 11532.8 11951.5 12160.9 12188.3 12448.6 13162.9 13325.7 13529.7 13789.6 16:44:46 INFO - PID 1908 | -------- Summary: end -------- 16:44:46 INFO - PID 1908 | 16:44:47 INFO - TEST-INFO | 1908: exit 0 16:44:47 INFO - TEST-OK | dromaeo_css | took 1119196ms 16:44:47 INFO - TEST-START | kraken 16:44:47 INFO - operating with platform_type : mac_ 16:44:47 INFO - Initialising browser for kraken test... 16:44:47 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpf1nBa_/profile http://localhost:49713/getInfo.html) 16:44:49 INFO - PID 1914 | __metrics Screen width/height:1600/1200 16:44:49 INFO - PID 1914 | colorDepth:24 16:44:49 INFO - PID 1914 | Browser inner width/height: 1024/691 16:44:49 INFO - PID 1914 | __metrics 16:44:50 INFO - PID 1914 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:44:50 INFO - PID 1914 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:44:51 INFO - TEST-INFO | 1914: exit 0 16:44:51 INFO - Browser initialized. 16:44:51 INFO - Running cycle 1/1 for kraken test... 16:44:51 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpf1nBa_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:45:03 INFO - PID 1915 | RSS: Main: 239226880 16:45:03 INFO - PID 1915 | 16:45:06 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49713/tests/kraken/driver.html?testName=audio-beat-detection) 16:45:07 INFO - PID 1915 | RSS: Main: 307892224 16:45:07 INFO - PID 1915 | 16:45:09 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49713/tests/kraken/driver.html?testName=audio-dft) 16:45:10 INFO - PID 1915 | RSS: Main: 290185216 16:45:10 INFO - PID 1915 | 16:45:13 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49713/tests/kraken/driver.html?testName=audio-fft) 16:45:14 INFO - PID 1915 | RSS: Main: 381468672 16:45:14 INFO - PID 1915 | 16:45:16 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49713/tests/kraken/driver.html?testName=audio-oscillator) 16:45:17 INFO - PID 1915 | RSS: Main: 286343168 16:45:17 INFO - PID 1915 | 16:45:19 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49713/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:45:19 INFO - PID 1915 | RSS: Main: 287576064 16:45:19 INFO - PID 1915 | 16:45:22 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49713/tests/kraken/driver.html?testName=imaging-darkroom) 16:45:23 INFO - PID 1915 | RSS: Main: 350302208 16:45:23 INFO - PID 1915 | 16:45:26 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49713/tests/kraken/driver.html?testName=imaging-desaturate) 16:45:27 INFO - PID 1915 | RSS: Main: 373088256 16:45:27 INFO - PID 1915 | 16:45:30 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49713/tests/kraken/driver.html?testName=json-parse-financial) 16:45:30 INFO - PID 1915 | RSS: Main: 364544000 16:45:30 INFO - PID 1915 | 16:45:32 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49713/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:45:32 INFO - PID 1915 | RSS: Main: 310755328 16:45:32 INFO - PID 1915 | 16:45:34 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:45:35 INFO - PID 1915 | RSS: Main: 332017664 16:45:35 INFO - PID 1915 | 16:45:37 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:45:38 INFO - PID 1915 | RSS: Main: 315629568 16:45:38 INFO - PID 1915 | 16:45:40 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:45:41 INFO - PID 1915 | RSS: Main: 352186368 16:45:41 INFO - PID 1915 | 16:45:44 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:45:45 INFO - PID 1915 | RSS: Main: 344485888 16:45:45 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49713/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49713/tests/kraken/driver.html?testName=ai-astar) 16:45:47 INFO - PID 1915 | RSS: Main: 387055616 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | __start_tp_report 16:45:47 INFO - PID 1915 | _x_x_mozilla_page_load 16:45:47 INFO - PID 1915 | _x_x_mozilla_page_load_details 16:45:47 INFO - PID 1915 | |i|pagename|runs| 16:45:47 INFO - PID 1915 | |0;ai-astar;112;111;112;112;110;112;110;106;102;110 16:45:47 INFO - PID 1915 | |1;audio-beat-detection;170;112;111;150;114;124;142;128;157;138 16:45:47 INFO - PID 1915 | |2;audio-dft;185;183;183;188;189;185;185;189;184;185 16:45:47 INFO - PID 1915 | |3;audio-fft;80;58;57;87;66;85;81;81;80;58 16:45:47 INFO - PID 1915 | |4;audio-oscillator;94;70;114;97;98;69;88;69;68;91 16:45:47 INFO - PID 1915 | |5;imaging-gaussian-blur;88;89;88;89;77;134;135;88;88;89 16:45:47 INFO - PID 1915 | |6;imaging-darkroom;96;96;101;147;129;96;110;149;95;95 16:45:47 INFO - PID 1915 | |7;imaging-desaturate;84;84;84;84;86;86;84;85;86;84 16:45:47 INFO - PID 1915 | |8;json-parse-financial;50;50;47;50;49;48;49;49;50;49 16:45:47 INFO - PID 1915 | |9;json-stringify-tinderbox;54;53;63;58;61;64;59;56;57;57 16:45:47 INFO - PID 1915 | |10;stanford-crypto-aes;81;84;80;82;80;79;71;99;92;100 16:45:47 INFO - PID 1915 | |11;stanford-crypto-ccm;142;149;140;137;135;136;132;138;174;155 16:45:47 INFO - PID 1915 | |12;stanford-crypto-pbkdf2;183;198;173;180;184;191;183;194;219;214 16:45:47 INFO - PID 1915 | |13;stanford-crypto-sha256-iterative;68;68;67;67;71;71;72;106;73;57 16:45:47 INFO - PID 1915 | __end_tp_report 16:45:47 INFO - PID 1915 | __start_cc_report 16:45:47 INFO - PID 1915 | _x_x_mozilla_cycle_collect,2153 16:45:47 INFO - PID 1915 | __end_cc_report 16:45:47 INFO - PID 1915 | __startTimestamp1494027947558__endTimestamp 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | ------- Summary: start ------- 16:45:47 INFO - PID 1915 | Number of tests: 14 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:3.27 (2.9%) stddev-sans-first:3.36 16:45:47 INFO - PID 1915 | Values: 112.0 111.0 112.0 112.0 110.0 112.0 110.0 106.0 102.0 110.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:140.00 stddev:20.29 (14.5%) stddev-sans-first:17.01 16:45:47 INFO - PID 1915 | Values: 170.0 112.0 111.0 150.0 114.0 124.0 142.0 128.0 157.0 138.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#2] audio-dft Cycles:10 Average:185.60 Median:185.00 stddev:2.27 (1.2%) stddev-sans-first:2.40 16:45:47 INFO - PID 1915 | Values: 185.0 183.0 183.0 188.0 189.0 185.0 185.0 189.0 184.0 185.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#3] audio-fft Cycles:10 Average:73.30 Median:80.50 stddev:12.11 (15.0%) stddev-sans-first:12.60 16:45:47 INFO - PID 1915 | Values: 80.0 58.0 57.0 87.0 66.0 85.0 81.0 81.0 80.0 58.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:89.50 stddev:15.98 (17.9%) stddev-sans-first:16.68 16:45:47 INFO - PID 1915 | Values: 94.0 70.0 114.0 97.0 98.0 69.0 88.0 69.0 68.0 91.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:96.50 Median:88.00 stddev:20.35 (23.1%) stddev-sans-first:21.35 16:45:47 INFO - PID 1915 | Values: 88.0 89.0 88.0 89.0 77.0 134.0 135.0 88.0 88.0 89.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#6] imaging-darkroom Cycles:10 Average:111.40 Median:95.00 stddev:21.99 (23.1%) stddev-sans-first:22.60 16:45:47 INFO - PID 1915 | Values: 96.0 96.0 101.0 147.0 129.0 96.0 110.0 149.0 95.0 95.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:84.50 stddev:0.95 (1.1%) stddev-sans-first:0.97 16:45:47 INFO - PID 1915 | Values: 84.0 84.0 84.0 84.0 86.0 86.0 84.0 85.0 86.0 84.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:49.50 stddev:0.99 (2.0%) stddev-sans-first:1.00 16:45:47 INFO - PID 1915 | Values: 50.0 50.0 47.0 50.0 49.0 48.0 49.0 49.0 50.0 49.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.50 stddev:3.61 (6.2%) stddev-sans-first:3.50 16:45:47 INFO - PID 1915 | Values: 54.0 53.0 63.0 58.0 61.0 64.0 59.0 56.0 57.0 57.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.50 stddev:9.30 (11.4%) stddev-sans-first:9.76 16:45:47 INFO - PID 1915 | Values: 81.0 84.0 80.0 82.0 80.0 79.0 71.0 99.0 92.0 100.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:141.00 stddev:12.65 (9.0%) stddev-sans-first:13.40 16:45:47 INFO - PID 1915 | Values: 142.0 149.0 140.0 137.0 135.0 136.0 132.0 138.0 174.0 155.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.90 Median:192.50 stddev:14.85 (7.7%) stddev-sans-first:15.40 16:45:47 INFO - PID 1915 | Values: 183.0 198.0 173.0 180.0 184.0 191.0 183.0 194.0 219.0 214.0 16:45:47 INFO - PID 1915 | 16:45:47 INFO - PID 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:69.50 stddev:12.76 (18.4%) stddev-sans-first:13.45 16:45:47 INFO - PID 1915 | Values: 68.0 68.0 67.0 67.0 71.0 71.0 72.0 106.0 73.0 57.0 16:45:47 INFO - PID 1915 | -------- Summary: end -------- 16:45:47 INFO - PID 1915 | 16:45:48 INFO - TEST-INFO | 1915: exit 0 16:45:48 INFO - TEST-OK | kraken | took 61343ms 16:45:48 INFO - SUITE-END | took 1180s 16:45:49 INFO - Completed test suite (00:19:41) 16:45:49 INFO - javascript benchmark 16:45:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7716.941917298828, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3010.3226773975853, 3517.7537572369943, 3526.7002304804105, 3553.1117220694828, 3580.8030558319297, 6024.9397506024925, 6148.6472975945335, 6178.876422471548, 6208.596441231322, 6218.595791273569, 5071.7210553419545, 6132.712130452599, 6147.801178770142, 6163.2912215095275, 6237.03325984472, 5223.294855194538, 5251.949610077981, 5352.411234764192, 5372.382176049756, 5403.2705584746145, 5403.486668766461, 5468.453154684519, 5490.505854473096, 5493.917591236134, 5562.3881373048935, 5292.708901010443, 5382.4886635769535, 5392.352917649868, 5417.377001644822, 5450.99999999998, 4460.4870439899505, 5287.444818294062, 5353.116735738598, 5357.303550538444, 5367.490088441592, 5266.8419947401635, 5299.470052994709, 5327.973360133214, 5334.91997620036, 5339.119045357511, 6149.631022138686, 6154.476869466101, 6164.0, 6219.2847822500535, 6243.781467648656, 6581.638009909453, 6599.439047680953, 6617.966910165466, 6619.536632435731, 6633.767818126343, 6592.340765923417, 6675.532712710112, 6693.0964319816685, 6694.0, 6720.1599800025, 5123.538881500683, 5227.693076730855, 6202.472789812917, 6244.344343843922, 6308.495320374359, 6859.17689877208, 6875.449964002868, 6878.105846240057, 6880.380765731108, 6888.862222755617, 6341.4292713656, 6406.391392817675, 6413.102165696806, 6464.127342808754, 6500.609963402211, 6666.733330666816, 6668.466522678174, 6668.499862510331, 6675.299093595103, 6676.9666151668935, 6334.683265836689, 6424.26120996082, 6528.934710652833, 6596.96701516499, 6597.967010164918, 6499.447546958561, 6577.835554111186, 6621.569597976116, 6625.668716564152, 6630.336966303331, 5277.788888444419, 5278.97360513195, 5283.973580132075, 5293.0472514946905, 5336.573074154058, 4592.127495775792, 4673.112108699336, 4686.250199968057, 4693.436787585443, 4716.622670186377, 6146.094710639716, 6192.133101365813, 6193.907091393633, 6205.255369355616, 6209.6895155242055, 5321.0, 5681.886362272731, 6528.37980391862, 6711.463082953352, 6719.0, 6252.124702541648, 6304.054391841169, 6317.020861766434, 6318.368163183645, 6350.745970161234, 5896.587238893237, 5902.527797776168, 5904.970475147683, 5927.1405646181065, 5974.910376344358, 6668.0, 6765.492588055817, 6874.243833178346, 6905.378515933389, 6914.412274956484, 6552.3447655234095, 6571.277159512354, 6579.769708060195, 6579.967100164468, 6581.638009909309, 6715.395614394728, 6863.142107236596, 6928.896066559107, 6931.93068069333, 6939.757108501179, 6529.053287273224, 6552.017197420425, 6555.246146693001, 6584.637844918576, 6591.835204119935, 6460.741570337133, 6573.244076931214, 6679.899801502884, 6705.329467053256, 6718.0, 6327.3356297589935, 6341.239051313872, 6355.586886852339, 6429.7749578764515, 6498.0252962056065, 6452.193475815523, 6462.7414903405215, 6490.026496025634, 6512.185976752906, 6514.088027676224, 6366.076918846648, 6389.52078594098, 6393.776217832539, 6399.104125422352, 6402.839929001812, 6314.368563143649, 6501.382368674968, 6504.739810407531, 6506.284308726131, 6510.316416776171, 6289.811305660837, 6306.337834527309, 6323.715432805627, 6326.114343991753, 6348.746050158126], "value": 6029.154144974585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.7999780058282, 799.5642374905676, 810.1048341582551, 1108.0858291909171, 1124.8931351521603, 25831.0, 32544.02367928963, 36299.092522686944, 36338.0, 36362.0, 38068.23863522728, 38362.424563631495, 38421.61578384216, 38428.61571384285, 38438.84683459501, 5875.412458754112, 8205.507669539817, 8409.075001749803, 8417.83164336713, 8418.621162047692, 5902.0, 8204.958975205116, 8344.833103337929, 8350.749477515654, 8351.582420878962, 7150.570965742072, 8418.452800567944, 8436.746897593051, 8436.789080272982, 8487.278581320596, 5904.380040095814, 8338.082810890797, 8380.580970951429, 8397.118302578263, 8405.663773449085, 5961.552883533709, 6748.426383757386, 8207.179282071806, 8240.175982401772, 8251.689526932469, 36581.63418365809, 36921.63078369209, 36922.892313230645, 37000.629993699986, 37064.0, 3596.4065929121925, 3623.655752703515, 3628.8548458061646, 3636.799976001319, 3640.5813331466957, 30170.547441788392, 30175.094747157622, 30189.69810301891, 30215.0, 30230.09309720712, 3100.891468798581, 3173.714365707074, 3185.761067919915, 3188.3145123798263, 3199.280161963563, 290634.54682726454, 297040.0, 297799.0, 297864.99999999785, 298890.0, 48474.515254847705, 48477.27284090741, 48478.0, 48490.75754621275, 48555.02889942181, 50899.74550127226, 50902.23646645303, 50905.74547127241, 50984.47046588608, 51023.234651480256, 13873.306334683226, 13953.720925581432, 13955.511557095453, 13970.441182352592, 13982.650433739034, 9871.555779989918, 9883.604655813831, 11446.0, 11475.426228688531, 11500.482478288497, 10178.694639160836, 11610.245334053428, 11718.23831450953, 11758.58844940423, 11778.823317650242, 4586.243269860503, 5331.173668081376, 5338.54622357104, 5359.517643412111, 5385.5960802939935, 1016.8474728790593, 1018.8930162332997, 1035.6277931740324, 1049.2550289294534, 1064.6433444795925, 22685.546289074126, 23824.880875595856, 23962.88018559896, 23990.04039838422, 24000.759992400202, 960.313375936209, 1082.9874067746525, 1140.2873204247346, 1156.4680247086267, 1161.924474909128, 10405.53175107122, 12035.759284814254, 12124.939375303067, 12133.878661213452, 12144.0, 300119.0, 300230.0, 300608.0, 300680.0, 300832.0, 51899.702507437614, 51932.48067519352, 51936.74031629818, 52161.47838521566, 52271.95456090857, 1511.5012046024785, 1523.573399448134, 1555.2534783304077, 1567.9843201567837, 1582.968340633204, 23228.651570226797, 23255.76744232536, 23374.883125584944, 23399.649005265273, 23450.17924372707, 31975.040748777574, 36047.27905441824, 37124.62875371212, 37244.25511489809, 37433.62566374301, 279377.0, 279396.0, 279922.0, 280339.0, 280400.0, 27837.860810695816, 32935.50596741099, 32958.835205823816, 32974.010779676646, 33016.50475242825, 34573.65426345704, 38383.61616383801, 42619.0, 42741.78629106835, 42788.57211427846, 28038.0, 28776.0, 28975.7102428973, 29917.70082299149, 30328.5450718235, 23799.286021419386, 25284.241472755846, 29741.5538766923, 29743.10770676883, 29804.403911922072, 26583.734162658126, 35727.82136089407, 35949.46075808813, 35983.64016359803, 35985.28029439449, 28444.146675599764, 29045.12864614065, 29141.41717165687, 29928.25179370446, 30104.69895301019, 22353.0, 23237.003455094145, 23301.18445854387, 23337.649935250643, 23610.055597776583], "value": 16798.851157540452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.95078565964883, 437.65206660704746, 440.86917057746876, 446.42411289436626, 455.8928651766834, 18784.0, 20589.27937522187, 21035.58252766917, 21288.4677883053, 21300.360989170313, 21840.0, 22110.447238818997, 22397.888010559964, 22701.432464188405, 23492.76507234927, 6005.759769609211, 6269.341719119495, 6276.874462510747, 6279.937200628004, 6308.085327627514, 5840.853978650546, 6151.5386346024225, 6215.5338349623735, 6220.7822726204595, 6235.064740288947, 5930.288365396159, 6194.132821405007, 6203.968980155093, 6214.689265536727, 6242.4069713377385, 6087.604305720114, 6145.692715364258, 6176.413240742122, 6179.320274769794, 6182.350853160398, 5264.842054738364, 5389.191621256843, 5447.346318441772, 5472.0, 5477.20580515823, 27623.861880690467, 27948.580771288245, 27971.160865173875, 28129.593520323902, 28308.0, 2163.0698799516204, 2165.675148727688, 2206.6800313954386, 2230.2751605728204, 2233.542123864604, 15122.848771512254, 15313.540593782092, 16563.757718171186, 17407.73888391675, 17642.823571764377, 1915.1573307744686, 2121.713568668241, 2175.9564808703894, 2177.7604463509, 2178.4444966533433, 141178.0, 141979.0, 142441.8633720495, 152321.0, 162354.9999999988, 11810.76378472443, 12340.629781106582, 12386.380680965916, 12387.75224495505, 12463.813042804366, 16600.4189853357, 16623.750643740354, 16632.50102496927, 16634.0, 16669.91665041691, 8734.432261903083, 8933.731988040368, 8962.924449066024, 9002.459852408745, 9064.864027039599, 8495.660173592987, 8512.489250644981, 8546.829063418822, 8694.695685650971, 8696.13038696138, 6378.0, 7590.1650818409935, 7724.266194711493, 7769.650365733555, 7780.299773020455, 2133.2426988419197, 2146.399008277685, 2147.7207962965026, 2147.76374598794, 2323.210108563063, 802.9036515618163, 880.6433394475248, 934.6261495401758, 943.3820847345, 953.5779121032638, 19175.712364314546, 19461.0, 19773.912434816222, 20335.831154613268, 20337.898310508353, 773.2963003666637, 835.6949713354703, 988.421773262635, 996.1681995533665, 999.8100360931545, 9821.754456138511, 10505.0, 10516.737081573021, 10576.526940163334, 10600.310979786444, 537303.0, 541433.2928335412, 543885.0, 545193.0, 560766.6888301173, 130191.0, 131463.0, 134558.32720836528, 134829.32585337208, 134886.0, 1172.2263306217856, 1179.4161889864401, 1197.26368283505, 1197.9820302695466, 1200.8078707406598, 16690.49928502147, 17093.658126837643, 17504.299828006737, 17879.0, 17901.37345192912, 54098.0, 54423.18365224604, 54492.727536362065, 54967.725161373935, 55333.0, 74216.0, 75809.0, 76071.61964190143, 77019.0, 77750.0, 8395.412321137706, 8621.051684314594, 8701.564921753761, 8774.0, 8851.0, 12653.493860245488, 13433.798493022809, 13728.107673001223, 13925.234112123526, 14028.368723407268, 11710.531578736754, 11740.58907938218, 11795.174337796616, 11952.34262115592, 12026.75946481083, 9389.812203756022, 9557.330986830855, 11068.778624427627, 11072.944635276772, 11103.555857765921, 11796.174267801514, 11940.164188506722, 11949.64151075469, 11978.161528692908, 12092.0, 8541.829163416822, 8760.342974276828, 8779.517126557845, 8973.685920992733, 8999.730008099768, 11824.76350473003, 11993.34036627994, 12166.087543434101, 12258.632241032783, 12264.202826816228], "value": 10266.516778398201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.345266829578, 1235.8455193100863, 1444.1118711992128, 1465.8827293816491, 1483.777433384992, 9752.561134748936, 10222.233332500064, 11394.25937314074, 11682.649520514398, 11718.707032324197, 11244.0, 11337.489812958416, 11344.43277836109, 11344.716382090432, 11354.432278386068, 2485.5401750676137, 2531.2785856031037, 2533.2526904563106, 2535.5943049112147, 2537.606670966003, 2113.0, 2183.2140429445385, 2195.978040219601, 2476.4923190745853, 2573.2537564106387, 2029.502771820906, 2507.53610582042, 2530.6963164420295, 2532.1643857526974, 2536.251805717318, 2481.900723971039, 2519.5590771614984, 2526.1158594491963, 2526.5831137862233, 2526.772590466867, 2453.0, 2454.631805229212, 2481.466484705797, 2495.800335973118, 2504.4365017871014, 11502.252353596989, 11609.941950290278, 11610.013148882355, 11629.709257268636, 11630.767384652345, 6426.453751431134, 6666.666666666696, 6684.431823295025, 6684.83287917801, 6690.431313338323, 3913.882583522499, 4082.2447847148073, 4218.704690671654, 4232.661387089025, 4237.724547904377, 1214.1440284599337, 1224.357212463455, 1241.3669028795289, 1258.584667059868, 1261.400834603565, 16546.83453165465, 16550.089745064015, 16601.50195494137, 16605.916970415314, 16614.501564953072, 5732.197492351074, 5921.0, 5940.6435613863305, 6027.78902738402, 6091.604045737013, 13724.725505489834, 13734.587962361145, 13751.793723094162, 13759.0, 13770.449182032606, 6694.196696396463, 6808.489363297773, 6813.318668133246, 6817.5909445433435, 6819.147606549182, 5238.947610523922, 6160.568760186744, 6170.074488826622, 6221.440070393686, 6227.719752611143, 4173.123644034726, 4273.6281363842745, 4610.838620648261, 4683.812647494062, 4709.152352576501, 1392.5543825975792, 1440.8343040550262, 1442.3725679329525, 1458.6061763323844, 1461.093273278382, 785.8251913389405, 794.7059587952494, 809.8906647602616, 819.7253919936769, 850.3154960257052, 6134.693265336716, 6270.9372906271265, 6452.419282264619, 6562.573432726857, 6681.966590167018, 866.547709415688, 895.5253715530779, 933.7712260496222, 934.313279739391, 937.9906200937903, 3769.151940813295, 4321.135772845443, 4404.889877753082, 4535.569120933506, 4560.931586026212, 14977.550673479813, 15039.924800376148, 15197.468088616846, 15204.923975380274, 15258.542243732705, 14548.927255363868, 14738.852611473962, 15188.936774425683, 15191.240437978056, 15240.0, 8286.668533258602, 8608.880845490046, 8613.741587752378, 8630.050694423733, 8640.913590864136, 5755.7697692093525, 5941.7623295067715, 6636.938089905592, 6796.082528858541, 6905.723771049303, 13121.73756524845, 13124.934375328063, 13174.47302107905, 13476.921846252473, 13635.0, 13544.187348759106, 13666.0, 13740.587782366545, 13746.93126534361, 14000.719985600435, 8738.956305218688, 9122.908770912207, 9202.769930751785, 9227.0, 9379.437233765995, 9547.0, 9858.30991830565, 9862.358946668444, 10498.422586757802, 10645.520951557044, 8910.153535414125, 8925.866112008196, 8954.597043133204, 8991.370604057915, 9030.819383612159, 8654.524001179996, 8792.252658524098, 8862.33532485079, 8894.68868589622, 9034.819303614022, 7988.6405111768945, 8104.756857294291, 8104.959475202586, 8116.797080073045, 8128.187181281824, 4834.540718631724, 5733.226014487991, 5805.8548536286935, 5857.7949771757785, 5921.289445266596, 5562.082256427644, 5815.709214539341, 5923.141144533933, 5943.613665111754, 6034.547408944434], "value": 5371.643286985156, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.85819813876316, 394.3296396126585, 399.5213654928254, 402.03912648769426, 405.82346679194535, 4837.516248375161, 5833.5041521470675, 5868.3838196989345, 5882.235309409776, 5911.349751527328, 4793.664443488957, 5299.629025968184, 5668.433156684329, 5711.600657838825, 5845.210896528978, 3654.9817250913707, 3796.652832506778, 4303.2469317869245, 4429.734215947045, 4448.733076015434, 4441.244988351988, 4455.554444555535, 4461.7992190351515, 4467.285234362503, 4480.619147372461, 3607.935658980594, 4062.756234625932, 4423.557644235583, 4439.689221754478, 4460.732356058631, 3669.5229620149344, 4048.1701251243717, 4250.723702959298, 4263.912702260935, 4269.380939763748, 3666.7249956253386, 3676.9264614707554, 3685.760425572329, 3688.8564544990872, 3694.9445758313645, 5375.3012108425655, 5485.985092757813, 5702.6293290935955, 5703.5152012079025, 5729.914051289234, 4582.404287442644, 4883.99878025004, 5020.874478138039, 5041.8487445376695, 5062.493750624908, 6150.938490615082, 6188.566800323979, 6193.4425901669065, 6230.906536401958, 6253.781117660906, 4116.732412393185, 4147.900806286337, 4165.166966606691, 4192.434021407102, 4195.370694395834, 6245.219347581552, 6416.326285740023, 6430.260520040161, 6506.349365063503, 6631.972044333136, 4103.342706028679, 4108.116754897652, 4111.251504512293, 4117.423560701504, 4125.711200216017, 4201.264778663722, 4286.421333119989, 4321.373400856858, 4327.744953963378, 4334.761588112684, 4968.403791544965, 5010.473900240495, 5018.347614810052, 5061.544460998528, 5069.518395752398, 6162.7226774795245, 6164.352742961924, 6166.691665416712, 6168.228971378578, 6180.752769889244, 1334.813126162338, 1465.7874608181753, 1467.1710483576744, 1470.9411623535152, 1475.6458449971929, 911.7447114807865, 916.5783739479781, 937.9953100234592, 961.2598299309632, 981.7398389426808, 5676.829695109153, 5962.433568810956, 5974.970125149433, 5988.341282458926, 6026.186464827192, 6227.88251994315, 6355.428011478989, 6357.904631430532, 6375.171227740457, 6377.585456945284, 5859.630712340421, 5884.735186916513, 5910.202122713465, 5936.5844390892225, 5995.760169593254, 3085.706857848501, 3311.9006429807146, 3331.60020797501, 3358.5465962094804, 3364.411228035084, 4719.5044520325555, 6581.967090164614, 6591.110200123018, 6669.4330981866115, 6703.564268322543, 5580.581456390787, 6353.5870168438905, 6620.205575330991, 6654.234763002317, 6677.3656502632175, 6013.977623803964, 6310.5898116622275, 6537.757826013042, 6681.265060843303, 6700.798976030727, 5662.207290979349, 5901.793437229848, 6465.967670161619, 6479.254885688206, 6481.5138864584405, 5676.34722006958, 6036.879262414815, 6345.460635846005, 6388.105665206967, 6390.712417941297, 6641.26946035926, 6670.83322916931, 6722.025306330457, 6725.327467253432, 6745.123133992746, 4239.915201695887, 4240.427542281753, 4258.382534532538, 4282.122164956114, 4283.571642835692, 5271.627767504715, 6376.936230637634, 6454.709538070704, 6497.480201583957, 6502.837429064311, 6171.352008039271, 6226.003839385677, 6266.749330026748, 6272.6236425814595, 6273.3099359071375, 6027.487663548647, 6092.817215483543, 6165.660888651168, 6235.657038862906, 6244.219472565929, 6077.665728384981, 6099.255335099312, 6109.84725381869, 6137.961708954096, 6163.181861351002, 4912.336834527293, 5072.594192464668, 5373.817760092773, 5441.075017246998, 5890.734916928663, 6017.247844019497, 6082.787102451393, 6097.725602347994, 6107.206063211754, 6175.5677102602385], "value": 4545.327987694918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.6457005772553, 849.1296421168302, 850.7150104714921, 866.0906048648917, 885.0795173020059, 15859.84140158598, 15868.206589670528, 16315.918420407896, 16327.91836040818, 16351.509454716363, 13172.736545269088, 15073.321700523502, 15328.693426131471, 15544.53366399007, 15545.37818487262, 996.6860438961722, 1002.0630710285869, 1005.964791232307, 1006.1498034161123, 1008.3798463944695, 986.7631768375574, 990.8711867457221, 990.9554070066828, 993.1905497019906, 995.6166875752851, 1026.36365453419, 1050.5115121468516, 1052.947352632369, 1067.8985496377832, 1070.2829104499965, 1058.4866339825178, 1059.6079450603288, 1060.8567843341166, 1061.8088744026072, 1063.3407287481734, 780.1808101493466, 781.7928249014016, 782.182619162976, 782.2646712090674, 783.7217787685347, 16161.595960100974, 16423.589410264718, 16587.253573589216, 16887.493375198763, 17154.656906861917, 17270.0, 17298.91350543252, 17487.0, 17728.0, 17748.023858687768, 13890.305484725824, 14009.439622415091, 14066.296685165804, 14446.638834029129, 14561.563153105319, 3588.2105936693883, 3605.4231322988458, 3605.603383627799, 3610.151614370621, 3614.5843228028853, 89363.99999999935, 99323.55749761207, 108176.91823081748, 121330.18004729936, 122976.79343862763, 9835.0, 10832.862549432197, 11496.88503114958, 13839.930800346136, 13881.236531990837, 23832.642510362013, 24842.0, 25096.37259068538, 26016.0, 26061.60907586388, 7804.804879877935, 7901.565413902291, 7953.761387158394, 7999.640016199285, 8037.959810200911, 3891.669208117342, 3945.0926286954164, 3951.68386529077, 3952.130531283113, 3954.387070004154, 4232.513260975027, 4282.828686852491, 4331.263685173528, 4349.499807522112, 4356.6514678825615, 927.6150397585062, 934.8364036293622, 947.725159703692, 957.9329446938787, 959.69289827256, 644.3492073006297, 652.3541693723274, 659.980200593983, 661.6592454885738, 692.9778576599475, 9778.608855645694, 9959.55182016811, 9965.302428830057, 11948.641540753792, 12024.939875300568, 594.7234535940722, 638.5211091681239, 660.577230572434, 672.1228796420718, 686.087503620194, 5429.239906413105, 5544.69504177266, 5545.9722701387045, 5596.720163991784, 5672.4894759471845, 92678.0, 100523.49738251262, 100579.0, 102286.0, 102968.48515757373, 79575.60212198902, 87867.56066219628, 87973.0, 88338.55830720805, 89546.55226723825, 76854.0, 79472.20527794649, 80176.0, 81014.0, 81805.0, 11683.941580292045, 12145.635630931087, 12219.205751626116, 12249.387530623611, 12263.816042759545, 37711.68009119668, 38299.80850095732, 38354.0, 38390.808045959595, 38620.0, 52509.0, 52569.47430525646, 52761.0, 70493.90121975522, 71498.0, 16617.667646646758, 16783.328666853187, 16892.831071689125, 16960.491185264462, 17241.310347585957, 18329.3584724534, 18356.72464913054, 18591.0, 18635.068246587347, 18762.0, 16589.58526036859, 16951.66096678084, 17121.68953414159, 17145.742813857552, 17249.0513021785, 16406.933549319256, 16907.408240711517, 16978.151092445576, 17320.0, 17423.56441088932, 16036.67926641484, 16495.34018639241, 16903.492895212672, 17064.91467542704, 17095.316187352368, 11402.258853174517, 11532.769344613229, 11951.521939122686, 12160.939195303967, 12188.329641869783, 12448.62654120378, 13162.868371316164, 13325.733485330045, 13529.729405412034, 13789.586312410644], "value": 8317.8059810267, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 112.0, 112.0, 110.0, 112.0, 110.0, 106.0, 102.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 112.0, 111.0, 150.0, 114.0, 124.0, 142.0, 128.0, 157.0, 138.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 183.0, 188.0, 189.0, 185.0, 185.0, 189.0, 184.0, 185.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 57.0, 87.0, 66.0, 85.0, 81.0, 81.0, 80.0, 58.0], "value": 73.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 70.0, 114.0, 97.0, 98.0, 69.0, 88.0, 69.0, 68.0, 91.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 89.0, 77.0, 134.0, 135.0, 88.0, 88.0, 89.0], "value": 96.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 101.0, 147.0, 129.0, 96.0, 110.0, 149.0, 95.0, 95.0], "value": 111.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 86.0, 86.0, 84.0, 85.0, 86.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 47.0, 50.0, 49.0, 48.0, 49.0, 49.0, 50.0, 49.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 63.0, 58.0, 61.0, 64.0, 59.0, 56.0, 57.0, 57.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 80.0, 82.0, 80.0, 79.0, 71.0, 99.0, 92.0, 100.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 149.0, 140.0, 137.0, 135.0, 136.0, 132.0, 138.0, 174.0, 155.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 198.0, 173.0, 180.0, 184.0, 191.0, 183.0, 194.0, 219.0, 214.0], "value": 191.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 67.0, 71.0, 71.0, 72.0, 106.0, 73.0, 57.0], "value": 72.0, "unit": "score"}]}]} 16:45:49 INFO - Return code: 0 16:45:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:45:49 INFO - # TBPL SUCCESS # 16:45:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:45:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:45:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:45:49 INFO - 2017-05-05 16:45:49.388 screenresolution[1920:12670] starting screenresolution argv=screenresolution get 16:45:49 INFO - 2017-05-05 16:45:49.391 screenresolution[1920:12670] Display 0: 1600x1200x32@60 16:45:49 INFO - 2017-05-05 16:45:49.397 screenresolution[1921:12673] starting screenresolution argv=screenresolution list 16:45:49 INFO - Available Modes on Display 0 16:45:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:45:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:45:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:45:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:45:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:45:49 INFO - Intel Iris: 16:45:49 INFO - Chipset Model: Intel Iris 16:45:49 INFO - Type: GPU 16:45:49 INFO - Bus: Built-In 16:45:49 INFO - VRAM (Dynamic, Max): 1536 MB 16:45:49 INFO - Vendor: Intel (0x8086) 16:45:49 INFO - Device ID: 0x0a2e 16:45:49 INFO - Revision ID: 0x0009 16:45:49 INFO - Displays: 16:45:49 INFO - Display: 16:45:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:45:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:45:49 INFO - Display Serial Number: 1600x1200 60 16:45:49 INFO - Main Display: Yes 16:45:49 INFO - Mirror: Off 16:45:49 INFO - Online: Yes 16:45:49 INFO - Rotation: Supported 16:45:49 INFO - Return code: 0 16:45:49 INFO - Running post-action listener: _resource_record_post_action 16:45:49 INFO - [mozharness: 2017-05-05 23:45:49.633807Z] Finished run-tests step (success) 16:45:49 INFO - Running post-run listener: _resource_record_post_run 16:45:49 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 2523136; Write bytes: 506846720; Read time: 13; Write time: 1710 16:45:49 INFO - TinderboxPrint: CPU usage
53.2% 16:45:49 INFO - TinderboxPrint: I/O read bytes / time
2,523,136 / 13 16:45:49 INFO - TinderboxPrint: I/O write bytes / time
506,846,720 / 1,710 16:45:49 INFO - TinderboxPrint: CPU idle
2,249.6 (46.8%) 16:45:49 INFO - TinderboxPrint: CPU system
954.9 (19.9%) 16:45:49 INFO - TinderboxPrint: CPU user
1,601.1 (33.3%) 16:45:49 INFO - TinderboxPrint: Swap in / out
210,829,312 / 0 16:45:49 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207636992; Write bytes: 203390976; Read time: 16002; Write time: 391 16:45:49 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 139264; Write bytes: 296295936; Read time: 5; Write time: 1288 16:45:50 INFO - Running post-run listener: _upload_blobber_files 16:45:50 INFO - Blob upload gear active. 16:45:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:45:50 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 16:45:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:45:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:45:50 INFO - (blobuploader) - INFO - Open directory for files ... 16:45:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:45:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:45:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:51 INFO - (blobuploader) - INFO - Done attempting. 16:45:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:45:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:45:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:52 INFO - (blobuploader) - INFO - Done attempting. 16:45:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:45:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:45:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:53 INFO - (blobuploader) - INFO - Done attempting. 16:45:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:45:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:55 INFO - (blobuploader) - INFO - Done attempting. 16:45:55 INFO - (blobuploader) - INFO - Iteration through files over. 16:45:55 INFO - Return code: 0 16:45:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:45:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:45:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2422d2046c80f353db05201e63e8faf0185db0795e58b562ca9d62582dc98176a044332028950abe4bc7cc4b62f0295df177bacd3f1eb814324b178570cd8b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83deb16ddd3776c7365df725381c500e05b795599da824f87c10b1030aca9093c5fa23edf2a66ed800760ed0adaf053b2ce3242c0af551eed10605fad01a1b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba8eab2246214add37f7210991e770e33bad78feeaa746323bb0480fdff7c4e8b7b38bb7a5e9fa22703ecb6a37a99eff38fecc58fad50b925ecafc336823b9e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/030738d56caa9d632a3365e9da051bf0c75d0ba8936c508eea3bb88345b6f6fb1cafd3ddaf2b43eb1c48da85bb5354e5abaca03f4c1886e90e70a177b794375d"} 16:45:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:45:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:45:55 INFO - Contents: 16:45:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2422d2046c80f353db05201e63e8faf0185db0795e58b562ca9d62582dc98176a044332028950abe4bc7cc4b62f0295df177bacd3f1eb814324b178570cd8b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83deb16ddd3776c7365df725381c500e05b795599da824f87c10b1030aca9093c5fa23edf2a66ed800760ed0adaf053b2ce3242c0af551eed10605fad01a1b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba8eab2246214add37f7210991e770e33bad78feeaa746323bb0480fdff7c4e8b7b38bb7a5e9fa22703ecb6a37a99eff38fecc58fad50b925ecafc336823b9e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/030738d56caa9d632a3365e9da051bf0c75d0ba8936c508eea3bb88345b6f6fb1cafd3ddaf2b43eb1c48da85bb5354e5abaca03f4c1886e90e70a177b794375d"} 16:45:55 INFO - Running post-run listener: copy_logs_to_upload_dir 16:45:55 INFO - Copying logs to upload dir... 16:45:55 INFO - mkdir: /builds/slave/test/build/upload/logs 16:45:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.147403 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-05 16:45:55.644061) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 16:45:55.647262) ========= 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.nT6t82vVgB/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.m6kolk1y4l/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2422d2046c80f353db05201e63e8faf0185db0795e58b562ca9d62582dc98176a044332028950abe4bc7cc4b62f0295df177bacd3f1eb814324b178570cd8b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83deb16ddd3776c7365df725381c500e05b795599da824f87c10b1030aca9093c5fa23edf2a66ed800760ed0adaf053b2ce3242c0af551eed10605fad01a1b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba8eab2246214add37f7210991e770e33bad78feeaa746323bb0480fdff7c4e8b7b38bb7a5e9fa22703ecb6a37a99eff38fecc58fad50b925ecafc336823b9e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/030738d56caa9d632a3365e9da051bf0c75d0ba8936c508eea3bb88345b6f6fb1cafd3ddaf2b43eb1c48da85bb5354e5abaca03f4c1886e90e70a177b794375d"} build_url:https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010984 build_url: 'https://queue.taskcluster.net/v1/task/DN9Zc1nBSuGBF6_nFJXX6A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2422d2046c80f353db05201e63e8faf0185db0795e58b562ca9d62582dc98176a044332028950abe4bc7cc4b62f0295df177bacd3f1eb814324b178570cd8b48", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/83deb16ddd3776c7365df725381c500e05b795599da824f87c10b1030aca9093c5fa23edf2a66ed800760ed0adaf053b2ce3242c0af551eed10605fad01a1b8d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ba8eab2246214add37f7210991e770e33bad78feeaa746323bb0480fdff7c4e8b7b38bb7a5e9fa22703ecb6a37a99eff38fecc58fad50b925ecafc336823b9e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/030738d56caa9d632a3365e9da051bf0c75d0ba8936c508eea3bb88345b6f6fb1cafd3ddaf2b43eb1c48da85bb5354e5abaca03f4c1886e90e70a177b794375d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 16:45:55.682517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:45:55.682908) ========= 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.nT6t82vVgB/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.m6kolk1y4l/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.005099 ========= master_lag: 0.19 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 16:45:55.882925) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 16:45:55.883232) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 16:45:55.922398) ========= ========= Total master_lag: 0.34 =========