builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0145 starttime: 1493374586.53 results: success (0) buildid: 20170428013726 builduid: a69431d51a794d4080081319f03ec8c9 revision: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.533401) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.533868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.534170) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.560244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.560638) ========= 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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-28 03:16:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 73.0M=0s 2017-04-28 03:16:26 (73.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109252 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.697017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.697351) ========= 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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.022275 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:26.747884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 03:16:26.748546) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b --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 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-28 03:16:26,834 truncating revision to first 12 chars 2017-04-28 03:16:26,834 Setting DEBUG logging. 2017-04-28 03:16:26,834 attempt 1/10 2017-04-28 03:16:26,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f2b930cd028?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-28 03:16:27,859 unpacking tar archive at: mozilla-central-8f2b930cd028/testing/mozharness/ program finished with exit code 0 elapsedTime=1.276106 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-28 03:16:28.050848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:28.051177) ========= script_repo_revision: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:28.051587) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:28.051861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-28 03:16:28.073248) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-28 03:16:28.073594) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:16:28 INFO - MultiFileLogger online at 20170428 03:16:28 in /builds/slave/test 03:16:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:16:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:16:28 INFO - {'append_to_log': False, 03:16:28 INFO - 'base_work_dir': '/builds/slave/test', 03:16:28 INFO - 'blob_upload_branch': 'Firefox', 03:16:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:16:28 INFO - 'branch': 'Firefox', 03:16:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:16:28 INFO - 'config_files': ('talos/mac_config.py',), 03:16:28 INFO - 'default_actions': ('clobber', 03:16:28 INFO - 'read-buildbot-config', 03:16:28 INFO - 'download-and-extract', 03:16:28 INFO - 'populate-webroot', 03:16:28 INFO - 'create-virtualenv', 03:16:28 INFO - 'install', 03:16:28 INFO - 'run-tests'), 03:16:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:16:28 INFO - 'download_minidump_stackwalk': True, 03:16:28 INFO - 'download_symbols': 'ondemand', 03:16:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:16:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:16:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:16:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:16:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:16:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:16:28 INFO - 'gecko_profile': False, 03:16:28 INFO - 'gecko_profile_interval': 0, 03:16:28 INFO - 'installer_path': 'installer.exe', 03:16:28 INFO - 'log_level': 'info', 03:16:28 INFO - 'log_name': 'talos', 03:16:28 INFO - 'log_to_console': True, 03:16:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:16:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:16:28 INFO - 'opt_config_files': (), 03:16:28 INFO - 'pip_index': False, 03:16:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:16:28 INFO - 'cmd': ('bash', 03:16:28 INFO - '-c', 03:16:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:16:28 INFO - 'enabled': True, 03:16:28 INFO - 'halt_on_failure': False, 03:16:28 INFO - 'name': 'check_screen_resolution'},), 03:16:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:16:28 INFO - 'cmd': ('bash', 03:16:28 INFO - '-c', 03:16:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:16:28 INFO - 'enabled': True, 03:16:28 INFO - 'halt_on_failure': False, 03:16:28 INFO - 'name': 'check_screen_resolution'},), 03:16:28 INFO - 'run_cmd_checks_enabled': True, 03:16:28 INFO - 'suite': 'dromaeojs-e10s', 03:16:28 INFO - 'system_bits': '32', 03:16:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:16:28 INFO - 'title': 't-yosemite-r7-0145', 03:16:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:16:28 INFO - 'use_talos_json': True, 03:16:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:16:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:16:28 INFO - 'work_dir': 'build'} 03:16:28 INFO - [mozharness: 2017-04-28 10:16:28.282704Z] Running clobber step. 03:16:28 INFO - Running pre-action listener: _resource_record_pre_action 03:16:28 INFO - Running main action method: clobber 03:16:28 INFO - rmtree: /builds/slave/test/build 03:16:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:16:31 INFO - Running post-action listener: _resource_record_post_action 03:16:31 INFO - [mozharness: 2017-04-28 10:16:31.433872Z] Finished clobber step (success) 03:16:31 INFO - [mozharness: 2017-04-28 10:16:31.434057Z] Running read-buildbot-config step. 03:16:31 INFO - Running pre-action listener: _resource_record_pre_action 03:16:31 INFO - Running main action method: read_buildbot_config 03:16:31 INFO - Using buildbot properties: 03:16:31 INFO - { 03:16:31 INFO - "project": "", 03:16:31 INFO - "product": "firefox", 03:16:31 INFO - "script_repo_revision": "production", 03:16:31 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:16:31 INFO - "repository": "", 03:16:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:16:31 INFO - "buildid": "20170428013726", 03:16:31 INFO - "pgo_build": "False", 03:16:31 INFO - "basedir": "/builds/slave/test", 03:16:31 INFO - "buildnumber": 47, 03:16:31 INFO - "slavename": "t-yosemite-r7-0145", 03:16:31 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:16:31 INFO - "platform": "yosemite_r7", 03:16:31 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:16:31 INFO - "branch": "mozilla-central", 03:16:31 INFO - "repo_path": "mozilla-central", 03:16:31 INFO - "revision": "8f2b930cd02842fa1ca884be447a5bbff4ba1b9b", 03:16:31 INFO - "stage_platform": "macosx64", 03:16:31 INFO - "builduid": "a69431d51a794d4080081319f03ec8c9", 03:16:31 INFO - "slavebuilddir": "test" 03:16:31 INFO - } 03:16:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:16:31 INFO - Running post-action listener: _resource_record_post_action 03:16:31 INFO - [mozharness: 2017-04-28 10:16:31.439878Z] Finished read-buildbot-config step (success) 03:16:31 INFO - [mozharness: 2017-04-28 10:16:31.440038Z] Running download-and-extract step. 03:16:31 INFO - Running pre-action listener: _resource_record_pre_action 03:16:31 INFO - Running main action method: download_and_extract 03:16:31 INFO - mkdir: /builds/slave/test/build/tests 03:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:16:31 INFO - trying https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:16:31 INFO - Downloading https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/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 03:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/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 03:16:32 INFO - Downloaded 1325 bytes. 03:16:32 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:16:32 INFO - Using the following test package requirements: 03:16:32 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 03:16:32 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:16:32 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:16:32 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:16:32 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'jsshell-mac.zip'], 03:16:32 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:16:32 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:16:32 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:16:32 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:16:32 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:16:32 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:16:32 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:16:32 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:16:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:16:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:16:32 INFO - Fetch https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:16:34 INFO - Content-Length response header: 52698547 03:16:34 INFO - Bytes received: 52698547 03:16:50 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 03:16:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:16:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:16:50 INFO - Fetch https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:16:52 INFO - Content-Length response header: 52698547 03:16:52 INFO - Bytes received: 52698547 03:17:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:17:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:17:07 INFO - Fetch https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:17:09 INFO - Content-Length response header: 14408809 03:17:09 INFO - Bytes received: 14408809 03:17:09 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')]} 03:17:09 INFO - trying https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:17:09 INFO - Downloading https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/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 03:17:11 INFO - Downloaded 71220116 bytes. 03:17:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:17:11 INFO - mkdir: /builds/slave/test/properties 03:17:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:17:11 INFO - Writing to file /builds/slave/test/properties/build_url 03:17:11 INFO - Contents: 03:17:11 INFO - build_url:https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:17:12 INFO - Running post-action listener: _resource_record_post_action 03:17:12 INFO - Running post-action listener: set_extra_try_arguments 03:17:12 INFO - [mozharness: 2017-04-28 10:17:12.136386Z] Finished download-and-extract step (success) 03:17:12 INFO - [mozharness: 2017-04-28 10:17:12.136506Z] Running populate-webroot step. 03:17:12 INFO - Running pre-action listener: _resource_record_pre_action 03:17:12 INFO - Running main action method: populate_webroot 03:17:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:17:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:17:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:17:12 INFO - '--tppagecycles', 03:17:12 INFO - '7'], 03:17:12 INFO - 'tests': ['tsvgm']}}, 03:17:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:17:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:17:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:17:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:17:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:17:12 INFO - 'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:17:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:17:12 INFO - 'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['damp', 'tps']}, 03:17:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:17:12 INFO - 'tests': ['damp', 'tps']}, 03:17:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['dromaeo_dom']}, 03:17:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:17:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:17:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:17:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['a11yr', 03:17:12 INFO - 'ts_paint', 03:17:12 INFO - 'tpaint', 03:17:12 INFO - 'sessionrestore', 03:17:12 INFO - 'sessionrestore_no_auto_restore', 03:17:12 INFO - 'tabpaint']}, 03:17:12 INFO - 'other-e10s': {'tests': ['a11yr', 03:17:12 INFO - 'ts_paint', 03:17:12 INFO - 'tpaint', 03:17:12 INFO - 'sessionrestore', 03:17:12 INFO - 'sessionrestore_no_auto_restore', 03:17:12 INFO - 'tabpaint']}, 03:17:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:17:12 INFO - 'ts_paint', 03:17:12 INFO - 'tpaint', 03:17:12 INFO - 'sessionrestore', 03:17:12 INFO - 'sessionrestore_no_auto_restore', 03:17:12 INFO - 'tabpaint']}, 03:17:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:17:12 INFO - 'ts_paint', 03:17:12 INFO - 'tpaint', 03:17:12 INFO - 'sessionrestore', 03:17:12 INFO - 'sessionrestore_no_auto_restore', 03:17:12 INFO - 'tabpaint']}, 03:17:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['a11yr', 03:17:12 INFO - 'ts_paint', 03:17:12 INFO - 'tpaint', 03:17:12 INFO - 'sessionrestore', 03:17:12 INFO - 'sessionrestore_no_auto_restore', 03:17:12 INFO - 'tabpaint']}, 03:17:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['a11yr', 03:17:12 INFO - 'ts_paint', 03:17:12 INFO - 'tpaint', 03:17:12 INFO - 'sessionrestore', 03:17:12 INFO - 'sessionrestore_no_auto_restore', 03:17:12 INFO - 'tabpaint']}, 03:17:12 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:17:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:17:12 INFO - 'bloom_basic_ref']}, 03:17:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['tsvgx', 03:17:12 INFO - 'tsvgr_opacity', 03:17:12 INFO - 'tart', 03:17:12 INFO - 'tscrollx', 03:17:12 INFO - 'cart', 03:17:12 INFO - 'tsvg_static']}, 03:17:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:17:12 INFO - 'tsvgr_opacity', 03:17:12 INFO - 'tart', 03:17:12 INFO - 'tscrollx', 03:17:12 INFO - 'cart', 03:17:12 INFO - 'tsvg_static']}, 03:17:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:17:12 INFO - 'talos_options': ['--disable-e10s'], 03:17:12 INFO - 'tests': ['tp5o']}, 03:17:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:17:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:17:12 INFO - 'talos_options': ['--disable-e10s', 03:17:12 INFO - '--xperf_path', 03:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:12 INFO - 'tests': ['tp5n']}, 03:17:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:17:12 INFO - 'talos_options': ['--xperf_path', 03:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:17:12 INFO - 'tests': ['tp5n']}}, 03:17:12 INFO - 'talos.zip': {'path': '', 03:17:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:17:12 INFO - Running post-action listener: _resource_record_post_action 03:17:12 INFO - [mozharness: 2017-04-28 10:17:12.155501Z] Finished populate-webroot step (success) 03:17:12 INFO - [mozharness: 2017-04-28 10:17:12.155576Z] Running create-virtualenv step. 03:17:12 INFO - Running pre-action listener: _resource_record_pre_action 03:17:12 INFO - Running main action method: create_virtualenv 03:17:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:17:12 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 03:17:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:17:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:17:12 INFO - Using real prefix '/tools/python27' 03:17:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:17:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:17:15 INFO - Installing pip.................done. 03:17:15 INFO - Return code: 0 03:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:17:16 INFO - Reading from file tmpfile_stdout 03:17:16 INFO - Output received: 03:17:16 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) 03:17:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:17:16 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')]} 03:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:16 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')]} 03:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:16 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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:16 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 03:17:16 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 03:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:16 INFO - 'HOME': '/Users/cltbld', 03:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:16 INFO - 'LOGNAME': 'cltbld', 03:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:16 INFO - 'MOZ_NO_REMOTE': '1', 03:17:16 INFO - 'NO_EM_RESTART': '1', 03:17:16 INFO - 'PAGER': '/bin/cat', 03:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:16 INFO - 'PWD': '/builds/slave/test', 03:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:16 INFO - 'SHELL': '/bin/bash', 03:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:16 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:16 INFO - 'USER': 'cltbld', 03:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:16 INFO - 'XPC_FLAGS': '0x0', 03:17:16 INFO - 'XPC_SERVICE_NAME': '0', 03:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:16 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 03:17:16 INFO - Cleaning up... 03:17:16 INFO - Return code: 0 03:17:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:17:16 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')]} 03:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:16 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')]} 03:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:16 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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:16 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 03:17:16 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 03:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:16 INFO - 'HOME': '/Users/cltbld', 03:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:16 INFO - 'LOGNAME': 'cltbld', 03:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:16 INFO - 'MOZ_NO_REMOTE': '1', 03:17:16 INFO - 'NO_EM_RESTART': '1', 03:17:16 INFO - 'PAGER': '/bin/cat', 03:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:16 INFO - 'PWD': '/builds/slave/test', 03:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:16 INFO - 'SHELL': '/bin/bash', 03:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:16 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:16 INFO - 'USER': 'cltbld', 03:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:16 INFO - 'XPC_FLAGS': '0x0', 03:17:16 INFO - 'XPC_SERVICE_NAME': '0', 03:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:16 INFO - Downloading/unpacking psutil>=3.1.1 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:16 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 03:17:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:17:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:20 INFO - Installing collected packages: psutil 03:17:20 INFO - Running setup.py install for psutil 03:17:20 INFO - building 'psutil._psutil_osx' extension 03:17:20 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 03:17:20 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 03:17:20 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 03:17:20 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 03:17:20 INFO - building 'psutil._psutil_posix' extension 03:17:20 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 03:17:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:17:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:17:20 INFO - ^ 03:17:20 INFO - 1 warning generated. 03:17:20 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 03:17:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:17:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:17:21 INFO - Successfully installed psutil 03:17:21 INFO - Cleaning up... 03:17:21 INFO - Return code: 0 03:17:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:17:21 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')]} 03:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:21 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')]} 03:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:21 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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:21 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 03:17:21 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 03:17:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:21 INFO - 'HOME': '/Users/cltbld', 03:17:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:21 INFO - 'LOGNAME': 'cltbld', 03:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:21 INFO - 'MOZ_NO_REMOTE': '1', 03:17:21 INFO - 'NO_EM_RESTART': '1', 03:17:21 INFO - 'PAGER': '/bin/cat', 03:17:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:21 INFO - 'PWD': '/builds/slave/test', 03:17:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:21 INFO - 'SHELL': '/bin/bash', 03:17:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:21 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:21 INFO - 'USER': 'cltbld', 03:17:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:21 INFO - 'XPC_FLAGS': '0x0', 03:17:21 INFO - 'XPC_SERVICE_NAME': '0', 03:17:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:17:21 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 03:17:21 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 03:17:21 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 03:17:21 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 03:17:21 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 03:17:21 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 03:17:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:17:24 INFO - Installing collected packages: mozsystemmonitor 03:17:24 INFO - Running setup.py install for mozsystemmonitor 03:17:24 INFO - Successfully installed mozsystemmonitor 03:17:24 INFO - Cleaning up... 03:17:24 INFO - Return code: 0 03:17:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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', '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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:17: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 jsonschema==2.5.1 03:17:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:25 INFO - 'HOME': '/Users/cltbld', 03:17:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:25 INFO - 'LOGNAME': 'cltbld', 03:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:25 INFO - 'MOZ_NO_REMOTE': '1', 03:17:25 INFO - 'NO_EM_RESTART': '1', 03:17:25 INFO - 'PAGER': '/bin/cat', 03:17:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:25 INFO - 'PWD': '/builds/slave/test', 03:17:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:25 INFO - 'SHELL': '/bin/bash', 03:17:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:25 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:25 INFO - 'USER': 'cltbld', 03:17:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:25 INFO - 'XPC_FLAGS': '0x0', 03:17:25 INFO - 'XPC_SERVICE_NAME': '0', 03:17:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:25 INFO - Downloading/unpacking jsonschema==2.5.1 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:17:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:17:29 INFO - warning: no files found matching '*.txt' 03:17:29 INFO - no previously-included directories found matching 'build' 03:17:29 INFO - no previously-included directories found matching 'dist' 03:17:29 INFO - no previously-included directories found matching '.git*' 03:17:29 INFO - Installing collected packages: jsonschema, functools32 03:17:29 INFO - Running setup.py install for functools32 03:17:29 INFO - warning: no files found matching '*.txt' 03:17:29 INFO - no previously-included directories found matching 'build' 03:17:29 INFO - no previously-included directories found matching 'dist' 03:17:29 INFO - no previously-included directories found matching '.git*' 03:17:29 INFO - Successfully installed jsonschema functools32 03:17:29 INFO - Cleaning up... 03:17:29 INFO - Return code: 0 03:17:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:29 INFO - 'HOME': '/Users/cltbld', 03:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:29 INFO - 'LOGNAME': 'cltbld', 03:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:29 INFO - 'MOZ_NO_REMOTE': '1', 03:17:29 INFO - 'NO_EM_RESTART': '1', 03:17:29 INFO - 'PAGER': '/bin/cat', 03:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:29 INFO - 'PWD': '/builds/slave/test', 03:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:29 INFO - 'SHELL': '/bin/bash', 03:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:29 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:29 INFO - 'USER': 'cltbld', 03:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:29 INFO - 'XPC_FLAGS': '0x0', 03:17:29 INFO - 'XPC_SERVICE_NAME': '0', 03:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:17:29 INFO - Cleaning up... 03:17:29 INFO - Return code: 0 03:17:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:29 INFO - 'HOME': '/Users/cltbld', 03:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:29 INFO - 'LOGNAME': 'cltbld', 03:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:29 INFO - 'MOZ_NO_REMOTE': '1', 03:17:29 INFO - 'NO_EM_RESTART': '1', 03:17:29 INFO - 'PAGER': '/bin/cat', 03:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:29 INFO - 'PWD': '/builds/slave/test', 03:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:29 INFO - 'SHELL': '/bin/bash', 03:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:29 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:29 INFO - 'USER': 'cltbld', 03:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:29 INFO - 'XPC_FLAGS': '0x0', 03:17:29 INFO - 'XPC_SERVICE_NAME': '0', 03:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:32 INFO - Downloading blobuploader-1.2.4.tar.gz 03:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:17:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17: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 03:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:17:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:17:33 INFO - Downloading docopt-0.6.1.tar.gz 03:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:17:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:17:33 INFO - Running setup.py install for blobuploader 03:17:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:17:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:17:33 INFO - Running setup.py install for requests 03:17:34 INFO - Running setup.py install for docopt 03:17:34 INFO - Successfully installed blobuploader requests docopt 03:17:34 INFO - Cleaning up... 03:17:34 INFO - Return code: 0 03:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17: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')]} 03:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17: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')]} 03:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:34 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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:34 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 03:17:34 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 03:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:34 INFO - 'HOME': '/Users/cltbld', 03:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:34 INFO - 'LOGNAME': 'cltbld', 03:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:34 INFO - 'MOZ_NO_REMOTE': '1', 03:17:34 INFO - 'NO_EM_RESTART': '1', 03:17:34 INFO - 'PAGER': '/bin/cat', 03:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:34 INFO - 'PWD': '/builds/slave/test', 03:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:34 INFO - 'SHELL': '/bin/bash', 03:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:34 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:34 INFO - 'USER': 'cltbld', 03:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:34 INFO - 'XPC_FLAGS': '0x0', 03:17:34 INFO - 'XPC_SERVICE_NAME': '0', 03:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:34 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-7RPdoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-zPOpz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-tr798T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-E_hFjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-YN9B8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-vT6GOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-AKUH1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-e8rK9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-aYvIqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-gzsRsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:35 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-XCJtha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-lTbxTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-wLcqvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-itodUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-aJlvXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-1F3unB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:36 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-iyRLTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:17:36 INFO - Running setup.py install for manifestparser 03:17:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:17:36 INFO - Running setup.py install for mozcrash 03:17:36 INFO - Running setup.py install for mozdebug 03:17:37 INFO - Running setup.py install for mozdevice 03:17:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:17:37 INFO - Running setup.py install for mozfile 03:17:37 INFO - Running setup.py install for mozhttpd 03:17:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:17:37 INFO - Running setup.py install for mozinfo 03:17:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:17:37 INFO - Running setup.py install for mozInstall 03:17:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:17:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:17:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:17:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:17:37 INFO - Running setup.py install for mozleak 03:17:37 INFO - Running setup.py install for mozlog 03:17:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:17:38 INFO - Running setup.py install for moznetwork 03:17:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:17:38 INFO - Running setup.py install for mozprocess 03:17:38 INFO - Running setup.py install for mozprofile 03:17:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:17:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:17:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:17:38 INFO - Running setup.py install for mozrunner 03:17:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:17:38 INFO - Running setup.py install for mozscreenshot 03:17:38 INFO - Running setup.py install for moztest 03:17:39 INFO - Running setup.py install for mozversion 03:17:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:17:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:17:39 INFO - Cleaning up... 03:17:39 INFO - Return code: 0 03:17:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:39 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')]} 03:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 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')]} 03:17:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:39 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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:39 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 03:17:39 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 03:17:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:39 INFO - 'HOME': '/Users/cltbld', 03:17:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:39 INFO - 'LOGNAME': 'cltbld', 03:17:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:39 INFO - 'MOZ_NO_REMOTE': '1', 03:17:39 INFO - 'NO_EM_RESTART': '1', 03:17:39 INFO - 'PAGER': '/bin/cat', 03:17:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:39 INFO - 'PWD': '/builds/slave/test', 03:17:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:39 INFO - 'SHELL': '/bin/bash', 03:17:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:39 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:39 INFO - 'USER': 'cltbld', 03:17:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:39 INFO - 'XPC_FLAGS': '0x0', 03:17:39 INFO - 'XPC_SERVICE_NAME': '0', 03:17:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:17:39 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-lE783b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:17:39 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)) 03:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:17:39 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-7t8NR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:17:39 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)) 03:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:17:39 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-KDwtBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:17:39 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)) 03:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:17:39 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-TGqbEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:17:39 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)) 03:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:17:39 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-gVT3Sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-JTFttb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-2xGKBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-qD9jco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-IawBUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-19UuoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-IG9FoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-C3xZT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-zJhMNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-YQHQmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:17:40 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)) 03:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:40 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-Fmkj91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:17:41 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)) 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:17:41 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-5u00bA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:17:41 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)) 03:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:17:41 INFO - Running setup.py (path:/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/pip-lkYW8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:17:41 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)) 03:17:41 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)) 03:17:41 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)) 03:17:41 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)) 03:17:41 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)) 03:17:41 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)) 03:17:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:17:41 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 03:17:41 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 03:17:41 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 03:17:41 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 03:17:41 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 03:17:41 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 03:17:43 INFO - Downloading blessings-1.6.tar.gz 03:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:17:44 INFO - Installing collected packages: blessings 03:17:44 INFO - Running setup.py install for blessings 03:17:44 INFO - Successfully installed blessings 03:17:44 INFO - Cleaning up... 03:17:44 INFO - Return code: 0 03:17:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:17:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:44 INFO - Reading from file tmpfile_stdout 03:17:44 INFO - Current package versions: 03:17:44 INFO - blessings == 1.6 03:17:44 INFO - blobuploader == 1.2.4 03:17:44 INFO - docopt == 0.6.1 03:17:44 INFO - functools32 == 3.2.3-2 03:17:44 INFO - jsonschema == 2.5.1 03:17:44 INFO - manifestparser == 1.1 03:17:44 INFO - mozInstall == 1.12 03:17:44 INFO - mozcrash == 1.0 03:17:44 INFO - mozdebug == 0.1 03:17:44 INFO - mozdevice == 0.50 03:17:44 INFO - mozfile == 1.2 03:17:44 INFO - mozhttpd == 0.7 03:17:44 INFO - mozinfo == 0.9 03:17:44 INFO - mozleak == 0.1 03:17:44 INFO - mozlog == 3.4 03:17:44 INFO - moznetwork == 0.27 03:17:44 INFO - mozprocess == 0.25 03:17:44 INFO - mozprofile == 0.28 03:17:44 INFO - mozrunner == 6.13 03:17:44 INFO - mozscreenshot == 0.1 03:17:44 INFO - mozsystemmonitor == 0.3 03:17:44 INFO - moztest == 0.8 03:17:44 INFO - mozversion == 1.4 03:17:44 INFO - psutil == 3.1.1 03:17:44 INFO - requests == 1.2.3 03:17:44 INFO - wsgiref == 0.1.2 03:17:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 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 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:44 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 03:17:44 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 03:17:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:44 INFO - 'HOME': '/Users/cltbld', 03:17:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:44 INFO - 'LOGNAME': 'cltbld', 03:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:44 INFO - 'MOZ_NO_REMOTE': '1', 03:17:44 INFO - 'NO_EM_RESTART': '1', 03:17:44 INFO - 'PAGER': '/bin/cat', 03:17:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:44 INFO - 'PWD': '/builds/slave/test', 03:17:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:44 INFO - 'SHELL': '/bin/bash', 03:17:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:44 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:44 INFO - 'USER': 'cltbld', 03:17:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:44 INFO - 'XPC_FLAGS': '0x0', 03:17:44 INFO - 'XPC_SERVICE_NAME': '0', 03:17:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 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)) 03:17:44 INFO - Cleaning up... 03:17:44 INFO - Return code: 0 03:17:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:17:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:17:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e9a3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92fa49fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, '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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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 03:17:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:17:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:17:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:17:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:17:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:17:44 INFO - 'HOME': '/Users/cltbld', 03:17:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:17:44 INFO - 'LOGNAME': 'cltbld', 03:17:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:17:44 INFO - 'MOZ_NO_REMOTE': '1', 03:17:44 INFO - 'NO_EM_RESTART': '1', 03:17:44 INFO - 'PAGER': '/bin/cat', 03:17:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:17:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:17:44 INFO - 'PWD': '/builds/slave/test', 03:17:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:17:44 INFO - 'SHELL': '/bin/bash', 03:17:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:17:44 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:17:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:17:44 INFO - 'USER': 'cltbld', 03:17:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:17:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:17:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:17:44 INFO - 'XPC_FLAGS': '0x0', 03:17:44 INFO - 'XPC_SERVICE_NAME': '0', 03:17:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:17:45 INFO - Cleaning up... 03:17:45 INFO - Return code: 0 03:17:45 INFO - Running post-action listener: _resource_record_post_action 03:17:45 INFO - Running post-action listener: _start_resource_monitoring 03:17:45 INFO - Starting resource monitoring. 03:17:45 INFO - [mozharness: 2017-04-28 10:17:45.146171Z] Finished create-virtualenv step (success) 03:17:45 INFO - [mozharness: 2017-04-28 10:17:45.147182Z] Running install step. 03:17:45 INFO - Running pre-action listener: _resource_record_pre_action 03:17:45 INFO - Running main action method: install 03:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:17:45 INFO - Reading from file tmpfile_stdout 03:17:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:17:45 INFO - Reading from file tmpfile_stdout 03:17:45 INFO - Output received: 03:17:45 INFO - Usage: mozinstall [options] installer 03:17:45 INFO - Options: 03:17:45 INFO - -h, --help show this help message and exit 03:17:45 INFO - -d DEST, --destination=DEST 03:17:45 INFO - Directory to install application into. [default: 03:17:45 INFO - "/builds/slave/test"] 03:17:45 INFO - --app=APP Application being installed. [default: firefox] 03:17:45 INFO - mkdir: /builds/slave/test/build/application 03:17:45 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'] 03:17:45 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 03:18:05 INFO - Reading from file tmpfile_stdout 03:18:05 INFO - Output received: 03:18:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:18:05 INFO - Running post-action listener: _resource_record_post_action 03:18:05 INFO - [mozharness: 2017-04-28 10:18:05.064869Z] Finished install step (success) 03:18:05 INFO - [mozharness: 2017-04-28 10:18:05.064999Z] Running run-tests step. 03:18:05 INFO - Running pre-action listener: _resource_record_pre_action 03:18:05 INFO - Running main action method: run_tests 03:18:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:18:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:18:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:18:05 INFO - 2017-04-28 03:18:05.079 screenresolution[1897:18168] starting screenresolution argv=screenresolution get 03:18:05 INFO - 2017-04-28 03:18:05.082 screenresolution[1897:18168] Display 0: 1600x1200x32@60 03:18:05 INFO - 2017-04-28 03:18:05.088 screenresolution[1898:18171] starting screenresolution argv=screenresolution list 03:18:05 INFO - Available Modes on Display 0 03:18:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:18:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:18:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:18:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:18:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:18:05 INFO - Intel Iris: 03:18:05 INFO - Chipset Model: Intel Iris 03:18:05 INFO - Type: GPU 03:18:05 INFO - Bus: Built-In 03:18:05 INFO - VRAM (Dynamic, Max): 1536 MB 03:18:05 INFO - Vendor: Intel (0x8086) 03:18:05 INFO - Device ID: 0x0a2e 03:18:05 INFO - Revision ID: 0x0009 03:18:05 INFO - Displays: 03:18:05 INFO - Display: 03:18:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:18:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:18:05 INFO - Display Serial Number: 1600x1200 60 03:18:05 INFO - Main Display: Yes 03:18:05 INFO - Mirror: Off 03:18:05 INFO - Online: Yes 03:18:05 INFO - Rotation: Supported 03:18:05 INFO - Return code: 0 03:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:05 INFO - Python 2.7.3 03:18:05 INFO - Return code: 0 03:18:05 INFO - grabbing minidump binary from tooltool 03:18:05 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')]} 03:18:05 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 0x10e77ed30>, '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 0x10e6a4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e773be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:05 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 03:18:05 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 03:18:05 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 03:18:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:05 INFO - Return code: 0 03:18:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:18:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:05 INFO - ENV: RUST_BACKTRACE is now 1 03:18:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:18:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:18:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0145 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:18:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Qs08CiQg8q/Render', 03:18:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:18:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:18:05 INFO - 'HOME': '/Users/cltbld', 03:18:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:18:05 INFO - 'LOGNAME': 'cltbld', 03:18:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:18:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:05 INFO - 'MOZ_NO_REMOTE': '1', 03:18:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:05 INFO - 'NO_EM_RESTART': '1', 03:18:05 INFO - 'PAGER': '/bin/cat', 03:18:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:18:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:05 INFO - 'PWD': '/builds/slave/test', 03:18:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:18:05 INFO - 'RUST_BACKTRACE': '1', 03:18:05 INFO - 'SHELL': '/bin/bash', 03:18:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.l6WlZrv8Hn/Listeners', 03:18:05 INFO - 'TMPDIR': '/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/', 03:18:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:18:05 INFO - 'USER': 'cltbld', 03:18:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:18:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:18:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:05 INFO - 'XPC_FLAGS': '0x0', 03:18:05 INFO - 'XPC_SERVICE_NAME': '0', 03:18:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:18:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0145', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:18:05 INFO - mozversion application_buildid: 20170428013726 03:18:05 INFO - mozversion application_changeset: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b 03:18:05 INFO - mozversion application_display_name: Nightly 03:18:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:05 INFO - mozversion application_name: Firefox 03:18:05 INFO - mozversion application_remotingname: firefox 03:18:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:18:05 INFO - mozversion application_vendor: Mozilla 03:18:05 INFO - mozversion application_version: 55.0a1 03:18:05 INFO - mozversion platform_buildid: 20170428013726 03:18:05 INFO - mozversion platform_changeset: 8f2b930cd02842fa1ca884be447a5bbff4ba1b9b 03:18:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:18:05 INFO - mozversion platform_version: 55.0a1 03:18:05 INFO - using testdate: 1493374685 03:18:05 INFO - actual date: 1493374685 03:18:05 INFO - starting webserver on 'localhost:56059' 03:18:05 INFO - SUITE-START | Running 2 tests 03:18:05 INFO - TEST-START | dromaeo_css 03:18:05 INFO - operating with platform_type : mac_ 03:18:05 INFO - Initialising browser for dromaeo_css test... 03:18:05 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmp105oZl/profile http://localhost:56059/getInfo.html) 03:18:08 INFO - PID 1908 | 2017-04-28 03:18:08.330 plugin-container[1910:18344] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b47, name = 'com.apple.tsm.portname' 03:18:08 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:18:08 INFO - PID 1908 | 2017-04-28 03:18:08.333 plugin-container[1910:18344] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 03:18:08 INFO - PID 1908 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:18:08 INFO - PID 1908 | 2017-04-28 03:18:08.333 plugin-container[1910:18344] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:18:08 INFO - PID 1908 | __metrics Screen width/height:1600/1200 03:18:08 INFO - PID 1908 | colorDepth:24 03:18:08 INFO - PID 1908 | Browser inner width/height: 1024/689 03:18:08 INFO - PID 1908 | __metrics 03:18:08 ERROR - PID 1908 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 03:18:09 INFO - TEST-INFO | 1908: exit 0 03:18:09 INFO - Browser initialized. 03:18:09 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:09 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmp105oZl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:18:11 INFO - PID 1911 | 2017-04-28 03:18:11.665 plugin-container[1912:18470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 03:18:11 INFO - PID 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:18:11 INFO - PID 1911 | 2017-04-28 03:18:11.666 plugin-container[1912:18470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x972b, name = 'com.apple.CFPasteboardClient' 03:18:11 INFO - PID 1911 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:18:11 INFO - PID 1911 | 2017-04-28 03:18:11.666 plugin-container[1912:18470] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:18:21 INFO - PID 1911 | RSS: Main: 251318272 03:18:21 INFO - PID 1911 | 03:21:25 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:56059/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56059/tests/dromaeo/cssquery-ext.html) 03:21:27 INFO - PID 1911 | RSS: Main: 253038592 03:21:27 INFO - PID 1911 | 03:23:10 INFO - PID 1911 | ************************* 03:23:10 INFO - PID 1911 | A coding exception was thrown and uncaught in a Task. 03:23:10 INFO - PID 1911 | 03:23:10 ERROR - PID 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:23:10 INFO - PID 1911 | Full stack: 03:23:10 INFO - PID 1911 | ************************* 03:23:10 INFO - PID 1911 | ************************* 03:23:10 INFO - PID 1911 | A coding exception was thrown and uncaught in a Task. 03:23:10 INFO - PID 1911 | 03:23:10 ERROR - PID 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:23:10 INFO - PID 1911 | Full stack: 03:23:10 INFO - PID 1911 | ************************* 03:23:10 INFO - PID 1911 | ************************* 03:23:10 INFO - PID 1911 | A coding exception was thrown and uncaught in a Task. 03:23:10 INFO - PID 1911 | 03:23:10 ERROR - PID 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:23:10 INFO - PID 1911 | Full stack: 03:23:10 INFO - PID 1911 | ************************* 03:23:10 INFO - PID 1911 | ************************* 03:23:10 INFO - PID 1911 | A coding exception was thrown and uncaught in a Task. 03:23:10 INFO - PID 1911 | 03:23:10 ERROR - PID 1911 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:23:10 INFO - PID 1911 | Full stack: 03:23:10 INFO - PID 1911 | ************************* 03:24:29 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:56059/tests/dromaeo/cssquery-ext.html (next: http://localhost:56059/tests/dromaeo/cssquery-jquery.html) 03:24:29 INFO - PID 1911 | RSS: Main: 258486272 03:24:29 INFO - PID 1911 | 03:27:31 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:56059/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56059/tests/dromaeo/cssquery-mootools.html) 03:27:32 INFO - PID 1911 | RSS: Main: 267440128 03:27:32 INFO - PID 1911 | 03:30:33 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:56059/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56059/tests/dromaeo/cssquery-prototype.html) 03:30:34 INFO - PID 1911 | RSS: Main: 259813376 03:30:34 INFO - PID 1911 | 03:33:37 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:56059/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56059/tests/dromaeo/cssquery-yui.html) 03:33:38 INFO - PID 1911 | RSS: Main: 269688832 03:33:38 INFO - PID 1911 | 03:36:39 INFO - PID 1911 | Cycle 1(1): loaded http://localhost:56059/tests/dromaeo/cssquery-yui.html (next: http://localhost:56059/tests/dromaeo/cssquery-dojo.html) 03:36:40 INFO - PID 1911 | RSS: Main: 264433664 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | __start_tp_report 03:36:40 INFO - PID 1911 | _x_x_mozilla_page_load 03:36:40 INFO - PID 1911 | _x_x_mozilla_page_load_details 03:36:40 INFO - PID 1911 | |i|pagename|runs| 03:36:40 INFO - PID 1911 | |0;dojo.html;3535.6464353564647;3556.217632120933;3579.7291961353735;3584.784912905225;3590.5870824855133;4690.460597031338;4729.432468103823;4933.654644174909;6025.276966763994;6204.627722336663;6124.716609781009;6128.442013630949;6129.022607377561;6166.4450199482035;6222.097795819604;4913.729744864031;5229.3201883755055;5420.024395608789;5424.918626220609;5508.504234618904;4578.267477203648;5464.153056276284;5549;5550.361708403525;5557.194206840006;5305.071612467841;5382.085045542267;5398.24424580559;5404.891902161974;5430.266913966623;4396.956030439718;5397.892042159174;5477.561795056386;5478.150886612581;5526.834194974117;5397.7031263280505;5422.43064478232;5434.7826086956475;5436.075867102562;5467.9453205467835;6027.8794424111275;6214.65819379934;6255.468285195764;6265.937340626581;6271.529635277327;5497.505224529811;6316.273628532732;6418;6655.534112612119;6669.566478178951;6639.269680335159;6710.5302628816;6720.5295629305965;6730.091437655903;6732.124823772878;6215.34738852423;6275.02737075754;6286.214223222143;6299.244090709144;6313.652749098844;6621.768238111643;6721.932780672229;6784.660766961632;6880.724771009103;6909.896351554731;6458.870822583522;6553.148090748172;6584.078229047937;6584.86830263392;6587.341265873471;6757.966210168917;6759.628220447923;6763;6763.830904227335;6767.796966091025;6329.68351582419;6435.935640643534;6478.805635830932;6672.432843208285;6697.6986035628515;6559.7376104955265;6616.702248398834;6653.434458071021;6656.70044847983;6663.333666633394;5259.631825772236;5271.314729085271;5274.736263186825;5284.630075894651;5325.813596524103;4675.836345727883;4692.436907571113;4711.089795469752;4713.34013238147;4740.597049250783;5594.440555944454;5863.0325996211;6241.781537646251;6278.811635650938;6292.653904035322;6768.120144381199;6790.185177778698;6799.1161149051295;6802.081718967975;6806.149231346082;6345.206849143857;6349.936500635027;6357.554971152067;6374.872502550016;6375.968120159369;5670.688112153789;5792.681402522901;5798.217240672455;5802.448767367094;5832.941670583325;6940.444764418733;6943.930560694328;6955.895661565181;6974.302569743188;7011.053507776589;6492.0261960706275;6495.123158373748;6530.053142294246;6778.4577233822165;6801.557898736566;6830.248672645906;6934.410575101173;6935.479839011993;6940.826479338057;6951.826204344932;5554.91667624994;6611.966940165461;6640.435562977201;6645.302243264581;6668.399844013868;5550.5282051026115;6547.443467305332;6648.7340506379205;6679.265280819009;6724.562903411458;6531.444827189552;6535.150430444012;6537.05212744159;6539.21529416454;6559.4752419807255;6539.673016349258;6540.37866402691;6552.803415897531;6555.4100130986535;6561;5988.730507127277;6266.373362663697;6275.811725648238;6308.842278943063;6321.462675672619;6458.838529036811;6464.321246269074;6516.446102081376;6532.281449040697;6537.542372034102;6319.431251187415;6331.430171284606;6335.271443784024;6338.429541341301;6345.048242763438 03:36:40 INFO - PID 1911 | |1;ext.html;718.2458418660407;765.6592816196795;826.3719573124424;1201.207203245858;1260.4643026713645;36403.81798091009;37970.81014594927;37970.81014594927;37998.81000595;38275;38060.80969595155;38423.615763842354;38425.61574384255;38557.61442385575;38575.84272471823;7922.881156782653;8250.381221408388;8487.830243395128;8488.957555212215;8495.660173593049;8502.914970850305;8592.441491303076;8597.18326758957;8599.183077607617;8626.3098952084;8561.614727337284;8603.440776349516;8628.741137765877;8638.09300023498;8640.65437382504;8574.142585741438;8592.14078592142;8592.656293748243;8601.526916019617;8627.266682332009;8295.253427191521;8390.790230244293;8393.454425462325;8403;8412.32701383894;36511;36595.90212293636;36679;36707;36744.71393501241;3595.8022308773006;3608.639136086397;3632.7093832493338;3647.106458917582;3652.8721494747556;30204.24489387783;30228.546571801442;30350.54474182889;30355.696443035507;30375;3117.5011998080427;3156.8737250509953;3177.2215807127172;3177.396294704022;3195.1373129255203;243680.78159609088;247567;279109;295342;295573;46462.07075858464;46749.76625116853;46779.298310525366;46792.76603617028;46826.531734682896;49233.50766492361;49388.259176112384;49442;49455.75272123616;49587;13425.798613020812;13518.107464954914;13558.661033474242;13559.59321220365;13583.592492225249;10925.562977480971;10928.562857485611;10952.233343665866;10970.451477426097;10971.451427428756;13104.868951310556;13115.868841311465;13180.802287965687;13323.800142997863;13364;5102.668326558762;5873.941260587425;5905.261842269716;5955.553333500005;5971.104334349795;986.2997271936862;996.1781530237583;1013.6553571785481;1019.0879163148941;1052.3633201912885;20469.89765051195;21705.782942170375;21961.560768784533;23389.479683820497;24262;1096.8628921384827;1097.0948967102172;1131.5247596009697;1135.1429670598645;1135.7898788724112;11016.441854896562;12256.220495063664;12334;12361.76836550628;12414.565490207799;298177;299006;299165;299651;299857;52436;52634.94730105376;53053.46946530485;53267.73366133145;53274.46725532773;1470.3897882378908;1506.246876561719;1510.8489151084805;1519.187234829383;1522.862942335173;22628;22724.97737601845;23833.404164896016;23932;23958.88020559886;36914;36920.26159476849;36939.44590831194;37026;37107.44338834973;200955.99522002882;201243;201366;201568.9921550383;201641;26788.732112679405;32952.681892724024;34030.48954265638;34182;34341.969740907814;43018.78490607527;43143.78428107839;44664.33003504885;44853.32720009137;44983.32525012193;28904.7109528902;30176.698233018265;30188;30881.845590771904;31108.911188108308;28013.159605211877;29825.403491930472;30528.236794080327;30559.08322750321;31091.533626995162;35434.468482973294;36252.81873590615;36816.0298359718;37061.073473163386;37170.62829371672;29889.402211956072;30262.09213723592;30960.0711978641;31042.37915241637;31114.666400019636;20222.292219772236;21357.78642213558;22643;24032.63951040771;24681.753182467946 03:36:40 INFO - PID 1911 | |2;jquery.html;431.0025257143421;431.70859669722927;434.6088520331702;438.05817492391367;462.2073144557082;17641.82358176418;19248.807511924893;20718.689219661697;21367.824769637664;21587.46031349213;20857.895710521425;21821.454463638416;22490.32529024128;22611.886940565317;22688.319350419515;6011.609245399046;6197.101420294055;6252.3747625237565;6272.1219029335925;6286.842828929291;5961.89182711512;5978.8505287367725;6025.517958563326;6066.848328791793;6118.4799292060225;6035.7283922223605;6098.878022439549;6101.35935726749;6101.877962440749;6118.938810611904;5942.702864856761;6005.849853753647;6051.727672254759;6054.51563874889;6061.696915154224;5173.870653233699;5355.116405793039;5377.274068000809;5389.51494365509;5389.541888939445;26150.6077408839;26260.949562017497;26351.94592216309;26602.73397266022;26778.330541736417;2257.1761307122947;2274.8748818814956;2301.5166814968875;2302.3323236261463;2304.2396009316885;17783;17994.280228790834;18180.81929058744;18331.99174045427;18386.90806545972;1914.444811004807;2161.178752074202;2204.063273108938;2205.8897055147177;2210.6794514795424;115949.84050159475;141427.29286353604;141518;142568;143400;12021.879781202077;12461.252324860538;12511.3744312784;12532.686682833002;12614.243145411305;15955.521334359988;16004.439844605384;16050.117243551716;16054.036757794336;16065.919670401807;8661.956690216635;8944.68693595721;8969.551522423983;9086.22767064807;9113.453192808453;8551;8585.527795971282;8595.613197406006;8707.869381959275;8726.258268047288;7303.014093097364;7337.19290878003;7610.277023682741;7731.4974526656715;7765.495242809312;2230.8103811175906;2230.832687548408;2235.608768465512;2246.3148739634566;2253.39158427227;986.2800155886243;992.3648864726437;1002.7894142230214;1033.1579762493543;1036.9222308326905;16878.74681879773;20660.17359305641;21192.258270960752;21305.147794088374;21449.785502145092;1020.2603112743202;1033.1019357015723;1048.3185929146116;1053.3521884041259;1070.0797314309686;9370.95314523423;9699.903000970042;10792.838107428395;10806.675799726021;10883.78232435347;497805.0219497831;512486;523143;523900.0439982434;524553;131632.3418382921;131801;133449.33275333562;135732.32133839466;137933;1195.5994741761433;1215.7143071378218;1241.7268200995766;1245.3337464456472;1245.9003279737599;21457.03443345022;22557.210497632503;22689.319320420414;22717.659235111158;22721.545569088856;53832.923341532165;56154.15768763553;56416;58027;58250.4174958245;70307.64846175736;74208.62895685487;74494.62752686202;74719.62640186981;74754.62622686852;7676.424268179797;8806.691765788166;8877.20105190536;9077.409968352036;9227.03116172819;14113.929430352782;14234.644133896321;14287.357068931715;14571.489997850025;14646.926765366105;12064.939675301568;12100.273983561014;12145;12169.148159628741;12342.691432714253;11372.772544548898;11601;11619.477123529292;11815.291082535075;11838.526458941546;12350.320732359807;12425.813612795635;12461.626151215478;12592.307423091817;12874;8979.640814367613;8980.46117232968;8984.820303594022;9003.504807235666;9303.488308142847;11980.460879260629;12000.939995299968;12074.335911524951;12158.878411215775;12245 03:36:40 INFO - PID 1911 | |3;mootools.html;1369.8424831017787;1405.1217988757028;1405.7048019915817;1461.7953486511883;1473.344361759017;11424.371659558721;11769.529218831236;11770.941145294271;11910.702232444182;12008.21946573472;9933.602655893756;11662;11831.70420739482;11848;11890.702732431671;2484.5652010898066;2522.6342180383926;2530.101813856082;2530.9746902531015;2541.796656267494;2444.8899799509063;2505.7870081043134;2514.3211332940095;2519.407939134302;2520.7101183363875;2200.0319859261954;2488.962665560009;2500.2999160235163;2510.63595778612;2533.3160046787357;2444.608862581987;2472.6043832986725;2500.9749902500926;2503.9107988025266;2507.9874600627063;2390.4143484846322;2467.1858286765323;2472.7898128659085;2513.5852584323566;2518.3955850595908;11726.824097638542;11808.822867656992;11841.40792960357;11853.822192667118;11887.881121188764;6571;6781.6609169541325;6839.247682754893;6846.828829279308;6852.965735171342;4045.5347635022054;4359.673024523174;4413.16149931512;4435.334699795057;4439.245328294198;1149.6953307373553;1239.6838806104477;1249.9625011249677;1319.9934000330034;1320.0495643137021;11201.495932683049;16249.350025998945;16914;16960.3215871365;16962.745558816503;5097.311862898461;5176.430592634807;5553.08374118266;5724;5731.996900542388;11986.101042421853;12002.559692836916;12017;12064.457099430547;12072.456739446747;6622.205335359788;6662.700178491979;6671.566348187353;6685.164354455693;6712;6077.36187700294;6181.690915454299;6276.592021518587;6301.369863013662;6304.495640348761;4271.850485233002;4386.978065109718;4408.911821763547;4425.800838962255;4429.003474218275;1273.2615083251692;1275.2603489975793;1287.9678008049873;1288.1948782011243;1313.7175507265983;784.4548039112761;793.6349478896404;813.129950952487;819.7253919936769;847.2925107535154;5869.765209391662;7163.67763450646;7445.739399121113;7504.399648028145;7511.136219334737;920.7467946314683;924.5793164110314;943.4150826487485;946.2477330522114;969.5249327829313;3903.1413089120347;4233.618974292329;4333.285007973649;4391.736495810262;4506;14683.19242441676;15187;15238.466653667068;15272.389104435699;15273.541793746206;12466.376681165906;14652.780208296885;15252.0086194397;15277;15314.310856011507;7469.626518674045;7540.698372065166;8527.957360213284;8684.261837743736;8793;6299.590526615755;7137.429005679637;7148.606021825902;7159;7182.1941230268185;12312.445939932904;12790.296533690736;13138;13153.473861045451;13178.891377379574;13113.868861311646;13172.538961136313;13285.867141328463;13425.26161061112;13684.973626978215;7624.665683505254;9178.449293042439;9552.235821134154;9559.713208603753;9561.760955976157;9349.579268932779;10704.732381690208;10975.341479511255;10984.286021408583;11004.669859904216;9069.274458043208;9232.95383523105;9242.72271831846;9320.95339523298;9393;9097.90902090997;9198.356115072149;9217.124373184537;9273.026332235018;9311;8236.588170591567;8388.328933685169;8411;8425.747227583182;8427.367947404091;6014;6015.097735339734;6100.420460056288;6208.782692605918;6265.154204182377;6029.306629737636;6163.907541386972;6239.625622462667;6318.020706790455;6374.26695929974 03:36:40 INFO - PID 1911 | |4;prototype.html;341.6071517754582;399.9140184860258;400.3014739279957;409.9385092236164;411.1796965054716;5768.855778605537;6087.086936959458;6133.386661333864;6224.564280500367;6262.874742505147;4752.5485078917445;5652.293463317085;6113.7860174893885;6181.443670069692;6182.289036760774;4340.131973605276;4463.575960283776;4465.263231566803;4471.575200355961;4475.149721552894;3716.5725941516666;3894.883153505385;4449.710768800034;4461.375407442961;4474.963891429408;3587.318409502186;3958.772780438059;4428.535003824601;4440.3801756963385;4464.419625448703;3872.3029854626157;3890.4164375343926;4382.737035777832;4395.670324725626;4435.889102772457;3508.8245437778373;3584.8207589620674;3747.2880152770886;3759.548854137521;3777.508923839883;4847.321375007502;5161.4322424533275;5993.910091348634;6005.459508644243;6027.216461859974;4740.478547359788;4839.523945196714;5238;5279.392869819982;5286.6035047371215;6512.5766825156215;6524.9233876410335;6561.967190164019;6605.108310378086;6670.93329066708;4140;4285.785710714452;4295.303355174719;4304.655627549789;4338.652907767371;5891;6842.794716158523;6870.110719552164;6975.511714179958;7011.404030657401;3783.697304215711;4211.915761684749;4262.062346283813;4360.563943605614;4362.781860906942;3895.2988462077096;3943.4873466449176;4416.580424859633;4434.645228381722;4439.489458712224;4403.339499075164;5065.442801291855;5259.395169555473;5287.101192797234;5290.92063619046;6677.966610166918;6690.765823196262;6703.396694297439;6704.296048914891;6713.731450742013;1499.7225513280077;1512.2589930933764;1512.3270144785686;1513.5610672904954;1513.9091654500764;830.8629076202479;835.5529791561607;952.9952350238204;971.9173870220969;994.4530508220449;5145.948540514547;5987.5808693391045;6318.494520438354;6355.3644635536075;6442.710078046499;5982.581219314607;6034.306054803666;6685.899711504331;6940.757073502504;6981.441484681213;6294.276158241769;6331.461825744863;6352.396522330371;6366.554341196164;6391.680415979183;3053;3143.679213981139;3158.7157155856085;3623.836927338276;3653.5433070866143;5683;6273.560850740404;6624.668766561653;7151.713931442684;7197.640117994079;7016.5790052597;7082.822929426702;7097;7125.572465652078;7136.3220494052985;6225.875482490324;6532;7206.387457066208;7207.9639601801655;7219.278072192738;5995.9700201500455;6897.55165914214;7014.5440546364325;7028.824279393056;7031.367176954099;5405.837824865261;6469.611823290617;6601.613661131216;6675.998600210008;6772.64547090574;7040.3663670269925;7158.997740316256;7192.388646965067;7198.280171982759;7219.530730502711;4346.47842258931;4348.586884245991;4360.716553424018;4382.846600368972;4391.5388884166705;5961.701914904151;6090.208272924491;6318.968405157945;6705.362990515893;6774;6053.515718742578;6603.504737144637;6655.933440665532;6663.900041499284;6669.333066693292;6429.58207716497;6447.742090316522;6580.934190658224;6651.268360480247;6678.398944094861;5662.8301150965535;6445.774397896051;6499.870002600016;6542.775456344865;6546.509011824228;5358;5519.779208831602;6610.338966103352;6695.196576410862;6772.898406524005;6493.383128602775;6496.058071579689;6527.955527115829;6530.346965303432;6549.967250163719 03:36:40 INFO - PID 1911 | |5;yui.html;817.8650522663761;832.396512528417;843.8017065989492;857.7905153733234;869.1178453869322;14339.784903226433;14920.179390133566;16165.919170404146;16908.746368804477;16945.406910758127;16844;17069.231884565193;17253.741193882102;17589.560260993483;17654.117294135274;893.63361021981;950.424992879305;973.0852998181704;1003.0120331473493;1004.6985904228738;995.512199022481;1023.2632504596678;1025.0876719719456;1026.7587117027492;1030.4435604773414;975.65851951817;1080.6703955293633;1087.1465899269076;1090.6891535912266;1091.4597274349208;1055.9208059395537;1068.0707784227693;1072.254782925867;1079.3793568697952;1081.762012357284;779.8206412525094;784.8077221080815;793.4326956226269;794.745681381958;796.5618909599697;15824.920875395665;16063.839361606351;16255.943363681441;17046.829531704647;17158.914205429017;14687.339069741887;16958.40645577411;16982.490525284262;17309;17363;11958.820617690742;12190.329531875743;13180.275084870329;14269.429222831075;14345.354459049368;3236.3527294541186;3258.0388785308155;3258.169166862435;3261.1031966209243;3265.510173473974;126059.62016347208;127033.36483317617;127810;129972.35013824965;132684.99999999904;13299;13320.000999925045;13401;13411;13449.386073671221;24996.625050624254;25405.745942540707;25609.231723047964;25908.35229119287;25973.870130649226;7638.618069096634;8021.759347219476;8048.637811298506;8089.352851771844;8103.513789172668;4001.6198461146146;4094;4096.795160241976;4098.8360465581045;4102.774347410921;4274.8030551445645;4311.417958575552;4449.043455657049;4452.799624016927;4465.1962646723905;916.2578311567652;938.5776400619749;939.3096074385321;952.0955092661999;955.4649396338073;587.5886879184502;626.7994241842566;635.3424205946823;656.4649810404505;689.4897775645986;10873.021428071512;10957.56169753201;12158.027357811354;12172.695682607828;12306.569270075504;660.920689517261;661.9503537234726;673.2526895146384;685.0751485494543;685.6194811879355;5447.319085114361;5513.2005859150195;5591.776328946797;5592.273004509388;5736.627119237236;95018.52490737502;104775.47612262043;107106.8959138482;107138;111506.44246778876;93233.60149597761;93328.53335733413;93657;94146.52926735459;95444;66226.99999999904;86715.13284867197;87310.56344718362;87995;88976.22047559012;11005.504752286006;11527.596534121265;11670.533178672758;11718.70703232426;12024.33866137371;40550.1889962205;41217;41412.792936035126;41454.341826327814;42499.575004249564;73247.26752732405;76422.61788691022;78484.8091015434;79151.60424197842;79804.201957982;15843.366265349257;15866.68266634684;16246.431374901822;16319.59201019984;16650.916745416194;15022.924885375503;18629;18638.53403664919;18681.532961675523;18795.24819007279;14672;16843.41048063312;17139.05735184527;17232.74150887763;17425.128743563026;16564.585885352964;16569.08870012161;17174.91412542929;17290.567735806704;17328.220230089424;16175.838241617434;16919.577010574834;17149.314027438762;17481.912590437474;17486.650266994842;9182.724518264462;11676.766464670489;11856.76286474283;12037.277763333877;12084.214526055779;12749;13436.328183590585;14137.575872723835;14318.284085795876;14429.63925901819 03:36:40 INFO - PID 1911 | __end_tp_report 03:36:40 INFO - PID 1911 | __start_cc_report 03:36:40 INFO - PID 1911 | _x_x_mozilla_cycle_collect,431 03:36:40 INFO - PID 1911 | __end_cc_report 03:36:40 INFO - PID 1911 | __startTimestamp1493375800155__endTimestamp 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | ------- Summary: start ------- 03:36:40 INFO - PID 1911 | Number of tests: 6 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | [#0] dojo.html Cycles:165 Average:6090.89 Median:6335.27 stddev:766.78 (12.1%) stddev-sans-first:742.47 03:36:40 INFO - PID 1911 | Values: 3535.6 3556.2 3579.7 3584.8 3590.6 4690.5 4729.4 4933.7 6025.3 6204.6 6124.7 6128.4 6129.0 6166.4 6222.1 4913.7 5229.3 5420.0 5424.9 5508.5 4578.3 5464.2 5549.0 5550.4 5557.2 5305.1 5382.1 5398.2 5404.9 5430.3 4397.0 5397.9 5477.6 5478.2 5526.8 5397.7 5422.4 5434.8 5436.1 5467.9 6027.9 6214.7 6255.5 6265.9 6271.5 5497.5 6316.3 6418.0 6655.5 6669.6 6639.3 6710.5 6720.5 6730.1 6732.1 6215.3 6275.0 6286.2 6299.2 6313.7 6621.8 6721.9 6784.7 6880.7 6909.9 6458.9 6553.1 6584.1 6584.9 6587.3 6758.0 6759.6 6763.0 6763.8 6767.8 6329.7 6435.9 6478.8 6672.4 6697.7 6559.7 6616.7 6653.4 6656.7 6663.3 5259.6 5271.3 5274.7 5284.6 5325.8 4675.8 4692.4 4711.1 4713.3 4740.6 5594.4 5863.0 6241.8 6278.8 6292.7 6768.1 6790.2 6799.1 6802.1 6806.1 6345.2 6349.9 6357.6 6374.9 6376.0 5670.7 5792.7 5798.2 5802.4 5832.9 6940.4 6943.9 6955.9 6974.3 7011.1 6492.0 6495.1 6530.1 6778.5 6801.6 6830.2 6934.4 6935.5 6940.8 6951.8 5554.9 6612.0 6640.4 6645.3 6668.4 5550.5 6547.4 6648.7 6679.3 6724.6 6531.4 6535.2 6537.1 6539.2 6559.5 6539.7 6540.4 6552.8 6555.4 6561.0 5988.7 6266.4 6275.8 6308.8 6321.5 6458.8 6464.3 6516.4 6532.3 6537.5 6319.4 6331.4 6335.3 6338.4 6345.0 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | [#1] ext.html Cycles:180 Average:41215.40 Median:18073.91 stddev:68339.36 (378.1%) stddev-sans-first:68463.42 03:36:40 INFO - PID 1911 | Values: 718.2 765.7 826.4 1201.2 1260.5 36403.8 37970.8 37970.8 37998.8 38275.0 38060.8 38423.6 38425.6 38557.6 38575.8 7922.9 8250.4 8487.8 8489.0 8495.7 8502.9 8592.4 8597.2 8599.2 8626.3 8561.6 8603.4 8628.7 8638.1 8640.7 8574.1 8592.1 8592.7 8601.5 8627.3 8295.3 8390.8 8393.5 8403.0 8412.3 36511.0 36595.9 36679.0 36707.0 36744.7 3595.8 3608.6 3632.7 3647.1 3652.9 30204.2 30228.5 30350.5 30355.7 30375.0 3117.5 3156.9 3177.2 3177.4 3195.1 243680.8 247567.0 279109.0 295342.0 295573.0 46462.1 46749.8 46779.3 46792.8 46826.5 49233.5 49388.3 49442.0 49455.8 49587.0 13425.8 13518.1 13558.7 13559.6 13583.6 10925.6 10928.6 10952.2 10970.5 10971.5 13104.9 13115.9 13180.8 13323.8 13364.0 5102.7 5873.9 5905.3 5955.6 5971.1 986.3 996.2 1013.7 1019.1 1052.4 20469.9 21705.8 21961.6 23389.5 24262.0 1096.9 1097.1 1131.5 1135.1 1135.8 11016.4 12256.2 12334.0 12361.8 12414.6 298177.0 299006.0 299165.0 299651.0 299857.0 52436.0 52634.9 53053.5 53267.7 53274.5 1470.4 1506.2 1510.8 1519.2 1522.9 22628.0 22725.0 23833.4 23932.0 23958.9 36914.0 36920.3 36939.4 37026.0 37107.4 200956.0 201243.0 201366.0 201569.0 201641.0 26788.7 32952.7 34030.5 34182.0 34342.0 43018.8 43143.8 44664.3 44853.3 44983.3 28904.7 30176.7 30188.0 30881.8 31108.9 28013.2 29825.4 30528.2 30559.1 31091.5 35434.5 36252.8 36816.0 37061.1 37170.6 29889.4 30262.1 30960.1 31042.4 31114.7 20222.3 21357.8 22643.0 24032.6 24681.8 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | [#2] jquery.html Cycles:180 Average:34215.83 Median:12407.19 stddev:87615.98 (706.2%) stddev-sans-first:87825.04 03:36:40 INFO - PID 1911 | Values: 431.0 431.7 434.6 438.1 462.2 17641.8 19248.8 20718.7 21367.8 21587.5 20857.9 21821.5 22490.3 22611.9 22688.3 6011.6 6197.1 6252.4 6272.1 6286.8 5961.9 5978.9 6025.5 6066.8 6118.5 6035.7 6098.9 6101.4 6101.9 6118.9 5942.7 6005.8 6051.7 6054.5 6061.7 5173.9 5355.1 5377.3 5389.5 5389.5 26150.6 26260.9 26351.9 26602.7 26778.3 2257.2 2274.9 2301.5 2302.3 2304.2 17783.0 17994.3 18180.8 18332.0 18386.9 1914.4 2161.2 2204.1 2205.9 2210.7 115949.8 141427.3 141518.0 142568.0 143400.0 12021.9 12461.3 12511.4 12532.7 12614.2 15955.5 16004.4 16050.1 16054.0 16065.9 8662.0 8944.7 8969.6 9086.2 9113.5 8551.0 8585.5 8595.6 8707.9 8726.3 7303.0 7337.2 7610.3 7731.5 7765.5 2230.8 2230.8 2235.6 2246.3 2253.4 986.3 992.4 1002.8 1033.2 1036.9 16878.7 20660.2 21192.3 21305.1 21449.8 1020.3 1033.1 1048.3 1053.4 1070.1 9371.0 9699.9 10792.8 10806.7 10883.8 497805.0 512486.0 523143.0 523900.0 524553.0 131632.3 131801.0 133449.3 135732.3 137933.0 1195.6 1215.7 1241.7 1245.3 1245.9 21457.0 22557.2 22689.3 22717.7 22721.5 53832.9 56154.2 56416.0 58027.0 58250.4 70307.6 74208.6 74494.6 74719.6 74754.6 7676.4 8806.7 8877.2 9077.4 9227.0 14113.9 14234.6 14287.4 14571.5 14646.9 12064.9 12100.3 12145.0 12169.1 12342.7 11372.8 11601.0 11619.5 11815.3 11838.5 12350.3 12425.8 12461.6 12592.3 12874.0 8979.6 8980.5 8984.8 9003.5 9303.5 11980.5 12000.9 12074.3 12158.9 12245.0 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | [#3] mootools.html Cycles:180 Average:7115.38 Median:4252.73 stddev:4433.59 (104.3%) stddev-sans-first:4425.00 03:36:40 INFO - PID 1911 | Values: 1369.8 1405.1 1405.7 1461.8 1473.3 11424.4 11769.5 11770.9 11910.7 12008.2 9933.6 11662.0 11831.7 11848.0 11890.7 2484.6 2522.6 2530.1 2531.0 2541.8 2444.9 2505.8 2514.3 2519.4 2520.7 2200.0 2489.0 2500.3 2510.6 2533.3 2444.6 2472.6 2501.0 2503.9 2508.0 2390.4 2467.2 2472.8 2513.6 2518.4 11726.8 11808.8 11841.4 11853.8 11887.9 6571.0 6781.7 6839.2 6846.8 6853.0 4045.5 4359.7 4413.2 4435.3 4439.2 1149.7 1239.7 1250.0 1320.0 1320.0 11201.5 16249.4 16914.0 16960.3 16962.7 5097.3 5176.4 5553.1 5724.0 5732.0 11986.1 12002.6 12017.0 12064.5 12072.5 6622.2 6662.7 6671.6 6685.2 6712.0 6077.4 6181.7 6276.6 6301.4 6304.5 4271.9 4387.0 4408.9 4425.8 4429.0 1273.3 1275.3 1288.0 1288.2 1313.7 784.5 793.6 813.1 819.7 847.3 5869.8 7163.7 7445.7 7504.4 7511.1 920.7 924.6 943.4 946.2 969.5 3903.1 4233.6 4333.3 4391.7 4506.0 14683.2 15187.0 15238.5 15272.4 15273.5 12466.4 14652.8 15252.0 15277.0 15314.3 7469.6 7540.7 8528.0 8684.3 8793.0 6299.6 7137.4 7148.6 7159.0 7182.2 12312.4 12790.3 13138.0 13153.5 13178.9 13113.9 13172.5 13285.9 13425.3 13685.0 7624.7 9178.4 9552.2 9559.7 9561.8 9349.6 10704.7 10975.3 10984.3 11004.7 9069.3 9233.0 9242.7 9321.0 9393.0 9097.9 9198.4 9217.1 9273.0 9311.0 8236.6 8388.3 8411.0 8425.7 8427.4 6014.0 6015.1 6100.4 6208.8 6265.2 6029.3 6163.9 6239.6 6318.0 6374.3 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | [#4] prototype.html Cycles:180 Average:5273.10 Median:6070.30 stddev:1736.59 (28.6%) stddev-sans-first:1701.55 03:36:40 INFO - PID 1911 | Values: 341.6 399.9 400.3 409.9 411.2 5768.9 6087.1 6133.4 6224.6 6262.9 4752.5 5652.3 6113.8 6181.4 6182.3 4340.1 4463.6 4465.3 4471.6 4475.1 3716.6 3894.9 4449.7 4461.4 4475.0 3587.3 3958.8 4428.5 4440.4 4464.4 3872.3 3890.4 4382.7 4395.7 4435.9 3508.8 3584.8 3747.3 3759.5 3777.5 4847.3 5161.4 5993.9 6005.5 6027.2 4740.5 4839.5 5238.0 5279.4 5286.6 6512.6 6524.9 6562.0 6605.1 6670.9 4140.0 4285.8 4295.3 4304.7 4338.7 5891.0 6842.8 6870.1 6975.5 7011.4 3783.7 4211.9 4262.1 4360.6 4362.8 3895.3 3943.5 4416.6 4434.6 4439.5 4403.3 5065.4 5259.4 5287.1 5290.9 6678.0 6690.8 6703.4 6704.3 6713.7 1499.7 1512.3 1512.3 1513.6 1513.9 830.9 835.6 953.0 971.9 994.5 5145.9 5987.6 6318.5 6355.4 6442.7 5982.6 6034.3 6685.9 6940.8 6981.4 6294.3 6331.5 6352.4 6366.6 6391.7 3053.0 3143.7 3158.7 3623.8 3653.5 5683.0 6273.6 6624.7 7151.7 7197.6 7016.6 7082.8 7097.0 7125.6 7136.3 6225.9 6532.0 7206.4 7208.0 7219.3 5996.0 6897.6 7014.5 7028.8 7031.4 5405.8 6469.6 6601.6 6676.0 6772.6 7040.4 7159.0 7192.4 7198.3 7219.5 4346.5 4348.6 4360.7 4382.8 4391.5 5961.7 6090.2 6319.0 6705.4 6774.0 6053.5 6603.5 6655.9 6663.9 6669.3 6429.6 6447.7 6580.9 6651.3 6678.4 5662.8 6445.8 6499.9 6542.8 6546.5 5358.0 5519.8 6610.3 6695.2 6772.9 6493.4 6496.1 6528.0 6530.3 6550.0 03:36:40 INFO - PID 1911 | 03:36:40 INFO - PID 1911 | [#5] yui.html Cycles:180 Average:22640.93 Median:17484.28 stddev:32181.49 (184.1%) stddev-sans-first:32230.05 03:36:40 INFO - PID 1911 | Values: 817.9 832.4 843.8 857.8 869.1 14339.8 14920.2 16165.9 16908.7 16945.4 16844.0 17069.2 17253.7 17589.6 17654.1 893.6 950.4 973.1 1003.0 1004.7 995.5 1023.3 1025.1 1026.8 1030.4 975.7 1080.7 1087.1 1090.7 1091.5 1055.9 1068.1 1072.3 1079.4 1081.8 779.8 784.8 793.4 794.7 796.6 15824.9 16063.8 16255.9 17046.8 17158.9 14687.3 16958.4 16982.5 17309.0 17363.0 11958.8 12190.3 13180.3 14269.4 14345.4 3236.4 3258.0 3258.2 3261.1 3265.5 126059.6 127033.4 127810.0 129972.4 132685.0 13299.0 13320.0 13401.0 13411.0 13449.4 24996.6 25405.7 25609.2 25908.4 25973.9 7638.6 8021.8 8048.6 8089.4 8103.5 4001.6 4094.0 4096.8 4098.8 4102.8 4274.8 4311.4 4449.0 4452.8 4465.2 916.3 938.6 939.3 952.1 955.5 587.6 626.8 635.3 656.5 689.5 10873.0 10957.6 12158.0 12172.7 12306.6 660.9 662.0 673.3 685.1 685.6 5447.3 5513.2 5591.8 5592.3 5736.6 95018.5 104775.5 107106.9 107138.0 111506.4 93233.6 93328.5 93657.0 94146.5 95444.0 66227.0 86715.1 87310.6 87995.0 88976.2 11005.5 11527.6 11670.5 11718.7 12024.3 40550.2 41217.0 41412.8 41454.3 42499.6 73247.3 76422.6 78484.8 79151.6 79804.2 15843.4 15866.7 16246.4 16319.6 16650.9 15022.9 18629.0 18638.5 18681.5 18795.2 14672.0 16843.4 17139.1 17232.7 17425.1 16564.6 16569.1 17174.9 17290.6 17328.2 16175.8 16919.6 17149.3 17481.9 17486.7 9182.7 11676.8 11856.8 12037.3 12084.2 12749.0 13436.3 14137.6 14318.3 14429.6 03:36:40 INFO - PID 1911 | -------- Summary: end -------- 03:36:40 INFO - PID 1911 | 03:36:40 INFO - TEST-INFO | 1911: exit 0 03:36:40 INFO - TEST-OK | dromaeo_css | took 1115126ms 03:36:40 INFO - TEST-START | kraken 03:36:40 INFO - operating with platform_type : mac_ 03:36:40 INFO - Initialising browser for kraken test... 03:36:40 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmp6KFyBl/profile http://localhost:56059/getInfo.html) 03:36:43 INFO - PID 1939 | 2017-04-28 03:36:43.238 plugin-container[1940:20689] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 03:36:43 INFO - PID 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:43 INFO - PID 1939 | 2017-04-28 03:36:43.244 plugin-container[1940:20689] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 03:36:43 INFO - PID 1939 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:43 INFO - PID 1939 | 2017-04-28 03:36:43.244 plugin-container[1940:20689] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:36:43 INFO - PID 1939 | __metrics Screen width/height:1600/1200 03:36:43 INFO - PID 1939 | colorDepth:24 03:36:43 INFO - PID 1939 | Browser inner width/height: 1024/689 03:36:43 INFO - PID 1939 | __metrics 03:36:43 ERROR - PID 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 03:36:44 INFO - TEST-INFO | 1939: exit 0 03:36:44 INFO - Browser initialized. 03:36:44 INFO - Running cycle 1/1 for kraken test... 03:36:44 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/tmp6KFyBl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:36:46 INFO - PID 1941 | 2017-04-28 03:36:46.740 plugin-container[1942:20810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954f, name = 'com.apple.tsm.portname' 03:36:46 INFO - PID 1941 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:46 INFO - PID 1941 | 2017-04-28 03:36:46.740 plugin-container[1942:20810] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 03:36:46 INFO - PID 1941 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:36:46 INFO - PID 1941 | 2017-04-28 03:36:46.741 plugin-container[1942:20810] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:36:56 INFO - PID 1941 | RSS: Main: 251338752 03:36:56 INFO - PID 1941 | 03:36:59 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56059/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:00 INFO - PID 1941 | RSS: Main: 259629056 03:37:00 INFO - PID 1941 | 03:37:03 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56059/tests/kraken/driver.html?testName=audio-dft) 03:37:04 INFO - PID 1941 | RSS: Main: 266686464 03:37:04 INFO - PID 1941 | 03:37:07 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56059/tests/kraken/driver.html?testName=audio-fft) 03:37:08 INFO - PID 1941 | RSS: Main: 261980160 03:37:08 INFO - PID 1941 | 03:37:10 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56059/tests/kraken/driver.html?testName=audio-oscillator) 03:37:10 INFO - PID 1941 | RSS: Main: 263868416 03:37:10 INFO - PID 1941 | 03:37:12 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56059/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:13 INFO - PID 1941 | RSS: Main: 264622080 03:37:13 INFO - PID 1941 | 03:37:16 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56059/tests/kraken/driver.html?testName=imaging-darkroom) 03:37:16 INFO - PID 1941 | RSS: Main: 269656064 03:37:16 INFO - PID 1941 | 03:37:19 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56059/tests/kraken/driver.html?testName=imaging-desaturate) 03:37:20 INFO - PID 1941 | RSS: Main: 270532608 03:37:20 INFO - PID 1941 | 03:37:23 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56059/tests/kraken/driver.html?testName=json-parse-financial) 03:37:24 INFO - PID 1941 | RSS: Main: 270397440 03:37:24 INFO - PID 1941 | 03:37:25 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56059/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:37:26 INFO - PID 1941 | RSS: Main: 269967360 03:37:26 INFO - PID 1941 | 03:37:27 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:37:28 INFO - PID 1941 | RSS: Main: 270299136 03:37:28 INFO - PID 1941 | 03:37:30 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:37:31 INFO - PID 1941 | RSS: Main: 269721600 03:37:31 INFO - PID 1941 | 03:37:34 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:37:34 INFO - PID 1941 | RSS: Main: 270032896 03:37:34 INFO - PID 1941 | 03:37:38 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:37:38 INFO - PID 1941 | RSS: Main: 270098432 03:37:38 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | Cycle 1(1): loaded http://localhost:56059/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56059/tests/kraken/driver.html?testName=ai-astar) 03:37:40 INFO - PID 1941 | RSS: Main: 271638528 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | __start_tp_report 03:37:40 INFO - PID 1941 | _x_x_mozilla_page_load 03:37:40 INFO - PID 1941 | _x_x_mozilla_page_load_details 03:37:40 INFO - PID 1941 | |i|pagename|runs| 03:37:40 INFO - PID 1941 | |0;ai-astar;105;165;98;167;167;166;108;164;164;115 03:37:40 INFO - PID 1941 | |1;audio-beat-detection;142;96;151;159;136;104;105;144;142;141 03:37:40 INFO - PID 1941 | |2;audio-dft;194;212;219;236;258;287;218;203;195;199 03:37:40 INFO - PID 1941 | |3;audio-fft;79;60;59;85;62;58;57;58;77;60 03:37:40 INFO - PID 1941 | |4;audio-oscillator;91;70;85;105;103;105;90;71;78;90 03:37:40 INFO - PID 1941 | |5;imaging-gaussian-blur;88;89;88;88;90;108;94;88;90;91 03:37:40 INFO - PID 1941 | |6;imaging-darkroom;99;97;97;97;100;96;97;104;100;96 03:37:40 INFO - PID 1941 | |7;imaging-desaturate;91;95;89;91;94;91;93;95;93;147 03:37:40 INFO - PID 1941 | |8;json-parse-financial;51;50;49;50;51;52;52;50;53;51 03:37:40 INFO - PID 1941 | |9;json-stringify-tinderbox;64;57;62;64;59;62;60;59;60;59 03:37:40 INFO - PID 1941 | |10;stanford-crypto-aes;83;87;83;84;83;80;84;83;84;81 03:37:40 INFO - PID 1941 | |11;stanford-crypto-ccm;150;139;135;137;138;145;150;155;212;154 03:37:40 INFO - PID 1941 | |12;stanford-crypto-pbkdf2;243;186;186;191;183;182;234;190;185;184 03:37:40 INFO - PID 1941 | |13;stanford-crypto-sha256-iterative;65;85;88;69;71;67;68;63;68;79 03:37:40 INFO - PID 1941 | __end_tp_report 03:37:40 INFO - PID 1941 | __start_cc_report 03:37:40 INFO - PID 1941 | _x_x_mozilla_cycle_collect,995 03:37:40 INFO - PID 1941 | __end_cc_report 03:37:40 INFO - PID 1941 | __startTimestamp1493375860714__endTimestamp 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | ------- Summary: start ------- 03:37:40 INFO - PID 1941 | Number of tests: 14 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#0] ai-astar Cycles:10 Average:141.90 Median:165.50 stddev:30.76 (18.6%) stddev-sans-first:29.58 03:37:40 INFO - PID 1941 | Values: 105.0 165.0 98.0 167.0 167.0 166.0 108.0 164.0 164.0 115.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:143.00 stddev:21.96 (15.4%) stddev-sans-first:22.99 03:37:40 INFO - PID 1941 | Values: 142.0 96.0 151.0 159.0 136.0 104.0 105.0 144.0 142.0 141.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#2] audio-dft Cycles:10 Average:222.10 Median:218.50 stddev:30.27 (13.9%) stddev-sans-first:30.35 03:37:40 INFO - PID 1941 | Values: 194.0 212.0 219.0 236.0 258.0 287.0 218.0 203.0 195.0 199.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#3] audio-fft Cycles:10 Average:65.50 Median:61.00 stddev:10.51 (17.2%) stddev-sans-first:9.95 03:37:40 INFO - PID 1941 | Values: 79.0 60.0 59.0 85.0 62.0 58.0 57.0 58.0 77.0 60.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#4] audio-oscillator Cycles:10 Average:88.80 Median:81.50 stddev:13.06 (16.0%) stddev-sans-first:13.83 03:37:40 INFO - PID 1941 | Values: 91.0 70.0 85.0 105.0 103.0 105.0 90.0 71.0 78.0 90.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:89.50 stddev:6.13 (6.9%) stddev-sans-first:6.38 03:37:40 INFO - PID 1941 | Values: 88.0 89.0 88.0 88.0 90.0 108.0 94.0 88.0 90.0 91.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:97.00 stddev:2.50 (2.6%) stddev-sans-first:2.64 03:37:40 INFO - PID 1941 | Values: 99.0 97.0 97.0 97.0 100.0 96.0 97.0 104.0 100.0 96.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:93.00 stddev:17.36 (18.7%) stddev-sans-first:18.23 03:37:40 INFO - PID 1941 | Values: 91.0 95.0 89.0 91.0 94.0 91.0 93.0 95.0 93.0 147.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#8] json-parse-financial Cycles:10 Average:50.90 Median:51.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 03:37:40 INFO - PID 1941 | Values: 51.0 50.0 49.0 50.0 51.0 52.0 52.0 50.0 53.0 51.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:61.00 stddev:2.32 (3.8%) stddev-sans-first:2.11 03:37:40 INFO - PID 1941 | Values: 64.0 57.0 62.0 64.0 59.0 62.0 60.0 59.0 60.0 59.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.87 (2.2%) stddev-sans-first:1.99 03:37:40 INFO - PID 1941 | Values: 83.0 87.0 83.0 84.0 83.0 80.0 84.0 83.0 84.0 81.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:150.00 stddev:22.48 (15.0%) stddev-sans-first:23.83 03:37:40 INFO - PID 1941 | Values: 150.0 139.0 135.0 137.0 138.0 145.0 150.0 155.0 212.0 154.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.40 Median:188.00 stddev:22.47 (11.9%) stddev-sans-first:16.32 03:37:40 INFO - PID 1941 | Values: 243.0 186.0 186.0 191.0 183.0 182.0 234.0 190.0 185.0 184.0 03:37:40 INFO - PID 1941 | 03:37:40 INFO - PID 1941 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:70.00 stddev:8.63 (12.3%) stddev-sans-first:8.74 03:37:40 INFO - PID 1941 | Values: 65.0 85.0 88.0 69.0 71.0 67.0 68.0 63.0 68.0 79.0 03:37:40 INFO - PID 1941 | -------- Summary: end -------- 03:37:40 INFO - PID 1941 | 03:37:41 INFO - TEST-INFO | 1941: exit 0 03:37:41 INFO - TEST-OK | kraken | took 60951ms 03:37:41 INFO - SUITE-END | took 1176s 03:37:41 INFO - Completed test suite (00:19:36) 03:37:41 INFO - javascript benchmark 03:37:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7852.060321857181, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3535.6464353564647, 3556.217632120933, 3579.7291961353735, 3584.784912905225, 3590.5870824855133, 4690.460597031338, 4729.432468103823, 4933.654644174909, 6025.276966763994, 6204.627722336663, 6124.716609781009, 6128.442013630949, 6129.022607377561, 6166.4450199482035, 6222.097795819604, 4913.729744864031, 5229.3201883755055, 5420.024395608789, 5424.918626220609, 5508.504234618904, 4578.267477203648, 5464.153056276284, 5549.0, 5550.361708403525, 5557.194206840006, 5305.071612467841, 5382.085045542267, 5398.24424580559, 5404.891902161974, 5430.266913966623, 4396.956030439718, 5397.892042159174, 5477.561795056386, 5478.150886612581, 5526.834194974117, 5397.7031263280505, 5422.43064478232, 5434.7826086956475, 5436.075867102562, 5467.9453205467835, 6027.8794424111275, 6214.65819379934, 6255.468285195764, 6265.937340626581, 6271.529635277327, 5497.505224529811, 6316.273628532732, 6418.0, 6655.534112612119, 6669.566478178951, 6639.269680335159, 6710.5302628816, 6720.5295629305965, 6730.091437655903, 6732.124823772878, 6215.34738852423, 6275.02737075754, 6286.214223222143, 6299.244090709144, 6313.652749098844, 6621.768238111643, 6721.932780672229, 6784.660766961632, 6880.724771009103, 6909.896351554731, 6458.870822583522, 6553.148090748172, 6584.078229047937, 6584.86830263392, 6587.341265873471, 6757.966210168917, 6759.628220447923, 6763.0, 6763.830904227335, 6767.796966091025, 6329.68351582419, 6435.935640643534, 6478.805635830932, 6672.432843208285, 6697.6986035628515, 6559.7376104955265, 6616.702248398834, 6653.434458071021, 6656.70044847983, 6663.333666633394, 5259.631825772236, 5271.314729085271, 5274.736263186825, 5284.630075894651, 5325.813596524103, 4675.836345727883, 4692.436907571113, 4711.089795469752, 4713.34013238147, 4740.597049250783, 5594.440555944454, 5863.0325996211, 6241.781537646251, 6278.811635650938, 6292.653904035322, 6768.120144381199, 6790.185177778698, 6799.1161149051295, 6802.081718967975, 6806.149231346082, 6345.206849143857, 6349.936500635027, 6357.554971152067, 6374.872502550016, 6375.968120159369, 5670.688112153789, 5792.681402522901, 5798.217240672455, 5802.448767367094, 5832.941670583325, 6940.444764418733, 6943.930560694328, 6955.895661565181, 6974.302569743188, 7011.053507776589, 6492.0261960706275, 6495.123158373748, 6530.053142294246, 6778.4577233822165, 6801.557898736566, 6830.248672645906, 6934.410575101173, 6935.479839011993, 6940.826479338057, 6951.826204344932, 5554.91667624994, 6611.966940165461, 6640.435562977201, 6645.302243264581, 6668.399844013868, 5550.5282051026115, 6547.443467305332, 6648.7340506379205, 6679.265280819009, 6724.562903411458, 6531.444827189552, 6535.150430444012, 6537.05212744159, 6539.21529416454, 6559.4752419807255, 6539.673016349258, 6540.37866402691, 6552.803415897531, 6555.4100130986535, 6561.0, 5988.730507127277, 6266.373362663697, 6275.811725648238, 6308.842278943063, 6321.462675672619, 6458.838529036811, 6464.321246269074, 6516.446102081376, 6532.281449040697, 6537.542372034102, 6319.431251187415, 6331.430171284606, 6335.271443784024, 6338.429541341301, 6345.048242763438], "value": 6039.612761228356, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.2458418660407, 765.6592816196795, 826.3719573124424, 1201.207203245858, 1260.4643026713645, 36403.81798091009, 37970.81014594927, 37970.81014594927, 37998.81000595, 38275.0, 38060.80969595155, 38423.615763842354, 38425.61574384255, 38557.61442385575, 38575.84272471823, 7922.881156782653, 8250.381221408388, 8487.830243395128, 8488.957555212215, 8495.660173593049, 8502.914970850305, 8592.441491303076, 8597.18326758957, 8599.183077607617, 8626.3098952084, 8561.614727337284, 8603.440776349516, 8628.741137765877, 8638.09300023498, 8640.65437382504, 8574.142585741438, 8592.14078592142, 8592.656293748243, 8601.526916019617, 8627.266682332009, 8295.253427191521, 8390.790230244293, 8393.454425462325, 8403.0, 8412.32701383894, 36511.0, 36595.90212293636, 36679.0, 36707.0, 36744.71393501241, 3595.8022308773006, 3608.639136086397, 3632.7093832493338, 3647.106458917582, 3652.8721494747556, 30204.24489387783, 30228.546571801442, 30350.54474182889, 30355.696443035507, 30375.0, 3117.5011998080427, 3156.8737250509953, 3177.2215807127172, 3177.396294704022, 3195.1373129255203, 243680.78159609088, 247567.0, 279109.0, 295342.0, 295573.0, 46462.07075858464, 46749.76625116853, 46779.298310525366, 46792.76603617028, 46826.531734682896, 49233.50766492361, 49388.259176112384, 49442.0, 49455.75272123616, 49587.0, 13425.798613020812, 13518.107464954914, 13558.661033474242, 13559.59321220365, 13583.592492225249, 10925.562977480971, 10928.562857485611, 10952.233343665866, 10970.451477426097, 10971.451427428756, 13104.868951310556, 13115.868841311465, 13180.802287965687, 13323.800142997863, 13364.0, 5102.668326558762, 5873.941260587425, 5905.261842269716, 5955.553333500005, 5971.104334349795, 986.2997271936862, 996.1781530237583, 1013.6553571785481, 1019.0879163148941, 1052.3633201912885, 20469.89765051195, 21705.782942170375, 21961.560768784533, 23389.479683820497, 24262.0, 1096.8628921384827, 1097.0948967102172, 1131.5247596009697, 1135.1429670598645, 1135.7898788724112, 11016.441854896562, 12256.220495063664, 12334.0, 12361.76836550628, 12414.565490207799, 298177.0, 299006.0, 299165.0, 299651.0, 299857.0, 52436.0, 52634.94730105376, 53053.46946530485, 53267.73366133145, 53274.46725532773, 1470.3897882378908, 1506.246876561719, 1510.8489151084805, 1519.187234829383, 1522.862942335173, 22628.0, 22724.97737601845, 23833.404164896016, 23932.0, 23958.88020559886, 36914.0, 36920.26159476849, 36939.44590831194, 37026.0, 37107.44338834973, 200955.99522002882, 201243.0, 201366.0, 201568.9921550383, 201641.0, 26788.732112679405, 32952.681892724024, 34030.48954265638, 34182.0, 34341.969740907814, 43018.78490607527, 43143.78428107839, 44664.33003504885, 44853.32720009137, 44983.32525012193, 28904.7109528902, 30176.698233018265, 30188.0, 30881.845590771904, 31108.911188108308, 28013.159605211877, 29825.403491930472, 30528.236794080327, 30559.08322750321, 31091.533626995162, 35434.468482973294, 36252.81873590615, 36816.0298359718, 37061.073473163386, 37170.62829371672, 29889.402211956072, 30262.09213723592, 30960.0711978641, 31042.37915241637, 31114.666400019636, 20222.292219772236, 21357.78642213558, 22643.0, 24032.63951040771, 24681.753182467946], "value": 17078.263743639232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [431.0025257143421, 431.70859669722927, 434.6088520331702, 438.05817492391367, 462.2073144557082, 17641.82358176418, 19248.807511924893, 20718.689219661697, 21367.824769637664, 21587.46031349213, 20857.895710521425, 21821.454463638416, 22490.32529024128, 22611.886940565317, 22688.319350419515, 6011.609245399046, 6197.101420294055, 6252.3747625237565, 6272.1219029335925, 6286.842828929291, 5961.89182711512, 5978.8505287367725, 6025.517958563326, 6066.848328791793, 6118.4799292060225, 6035.7283922223605, 6098.878022439549, 6101.35935726749, 6101.877962440749, 6118.938810611904, 5942.702864856761, 6005.849853753647, 6051.727672254759, 6054.51563874889, 6061.696915154224, 5173.870653233699, 5355.116405793039, 5377.274068000809, 5389.51494365509, 5389.541888939445, 26150.6077408839, 26260.949562017497, 26351.94592216309, 26602.73397266022, 26778.330541736417, 2257.1761307122947, 2274.8748818814956, 2301.5166814968875, 2302.3323236261463, 2304.2396009316885, 17783.0, 17994.280228790834, 18180.81929058744, 18331.99174045427, 18386.90806545972, 1914.444811004807, 2161.178752074202, 2204.063273108938, 2205.8897055147177, 2210.6794514795424, 115949.84050159475, 141427.29286353604, 141518.0, 142568.0, 143400.0, 12021.879781202077, 12461.252324860538, 12511.3744312784, 12532.686682833002, 12614.243145411305, 15955.521334359988, 16004.439844605384, 16050.117243551716, 16054.036757794336, 16065.919670401807, 8661.956690216635, 8944.68693595721, 8969.551522423983, 9086.22767064807, 9113.453192808453, 8551.0, 8585.527795971282, 8595.613197406006, 8707.869381959275, 8726.258268047288, 7303.014093097364, 7337.19290878003, 7610.277023682741, 7731.4974526656715, 7765.495242809312, 2230.8103811175906, 2230.832687548408, 2235.608768465512, 2246.3148739634566, 2253.39158427227, 986.2800155886243, 992.3648864726437, 1002.7894142230214, 1033.1579762493543, 1036.9222308326905, 16878.74681879773, 20660.17359305641, 21192.258270960752, 21305.147794088374, 21449.785502145092, 1020.2603112743202, 1033.1019357015723, 1048.3185929146116, 1053.3521884041259, 1070.0797314309686, 9370.95314523423, 9699.903000970042, 10792.838107428395, 10806.675799726021, 10883.78232435347, 497805.0219497831, 512486.0, 523143.0, 523900.0439982434, 524553.0, 131632.3418382921, 131801.0, 133449.33275333562, 135732.32133839466, 137933.0, 1195.5994741761433, 1215.7143071378218, 1241.7268200995766, 1245.3337464456472, 1245.9003279737599, 21457.03443345022, 22557.210497632503, 22689.319320420414, 22717.659235111158, 22721.545569088856, 53832.923341532165, 56154.15768763553, 56416.0, 58027.0, 58250.4174958245, 70307.64846175736, 74208.62895685487, 74494.62752686202, 74719.62640186981, 74754.62622686852, 7676.424268179797, 8806.691765788166, 8877.20105190536, 9077.409968352036, 9227.03116172819, 14113.929430352782, 14234.644133896321, 14287.357068931715, 14571.489997850025, 14646.926765366105, 12064.939675301568, 12100.273983561014, 12145.0, 12169.148159628741, 12342.691432714253, 11372.772544548898, 11601.0, 11619.477123529292, 11815.291082535075, 11838.526458941546, 12350.320732359807, 12425.813612795635, 12461.626151215478, 12592.307423091817, 12874.0, 8979.640814367613, 8980.46117232968, 8984.820303594022, 9003.504807235666, 9303.488308142847, 11980.460879260629, 12000.939995299968, 12074.335911524951, 12158.878411215775, 12245.0], "value": 10466.427261483846, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.8424831017787, 1405.1217988757028, 1405.7048019915817, 1461.7953486511883, 1473.344361759017, 11424.371659558721, 11769.529218831236, 11770.941145294271, 11910.702232444182, 12008.21946573472, 9933.602655893756, 11662.0, 11831.70420739482, 11848.0, 11890.702732431671, 2484.5652010898066, 2522.6342180383926, 2530.101813856082, 2530.9746902531015, 2541.796656267494, 2444.8899799509063, 2505.7870081043134, 2514.3211332940095, 2519.407939134302, 2520.7101183363875, 2200.0319859261954, 2488.962665560009, 2500.2999160235163, 2510.63595778612, 2533.3160046787357, 2444.608862581987, 2472.6043832986725, 2500.9749902500926, 2503.9107988025266, 2507.9874600627063, 2390.4143484846322, 2467.1858286765323, 2472.7898128659085, 2513.5852584323566, 2518.3955850595908, 11726.824097638542, 11808.822867656992, 11841.40792960357, 11853.822192667118, 11887.881121188764, 6571.0, 6781.6609169541325, 6839.247682754893, 6846.828829279308, 6852.965735171342, 4045.5347635022054, 4359.673024523174, 4413.16149931512, 4435.334699795057, 4439.245328294198, 1149.6953307373553, 1239.6838806104477, 1249.9625011249677, 1319.9934000330034, 1320.0495643137021, 11201.495932683049, 16249.350025998945, 16914.0, 16960.3215871365, 16962.745558816503, 5097.311862898461, 5176.430592634807, 5553.08374118266, 5724.0, 5731.996900542388, 11986.101042421853, 12002.559692836916, 12017.0, 12064.457099430547, 12072.456739446747, 6622.205335359788, 6662.700178491979, 6671.566348187353, 6685.164354455693, 6712.0, 6077.36187700294, 6181.690915454299, 6276.592021518587, 6301.369863013662, 6304.495640348761, 4271.850485233002, 4386.978065109718, 4408.911821763547, 4425.800838962255, 4429.003474218275, 1273.2615083251692, 1275.2603489975793, 1287.9678008049873, 1288.1948782011243, 1313.7175507265983, 784.4548039112761, 793.6349478896404, 813.129950952487, 819.7253919936769, 847.2925107535154, 5869.765209391662, 7163.67763450646, 7445.739399121113, 7504.399648028145, 7511.136219334737, 920.7467946314683, 924.5793164110314, 943.4150826487485, 946.2477330522114, 969.5249327829313, 3903.1413089120347, 4233.618974292329, 4333.285007973649, 4391.736495810262, 4506.0, 14683.19242441676, 15187.0, 15238.466653667068, 15272.389104435699, 15273.541793746206, 12466.376681165906, 14652.780208296885, 15252.0086194397, 15277.0, 15314.310856011507, 7469.626518674045, 7540.698372065166, 8527.957360213284, 8684.261837743736, 8793.0, 6299.590526615755, 7137.429005679637, 7148.606021825902, 7159.0, 7182.1941230268185, 12312.445939932904, 12790.296533690736, 13138.0, 13153.473861045451, 13178.891377379574, 13113.868861311646, 13172.538961136313, 13285.867141328463, 13425.26161061112, 13684.973626978215, 7624.665683505254, 9178.449293042439, 9552.235821134154, 9559.713208603753, 9561.760955976157, 9349.579268932779, 10704.732381690208, 10975.341479511255, 10984.286021408583, 11004.669859904216, 9069.274458043208, 9232.95383523105, 9242.72271831846, 9320.95339523298, 9393.0, 9097.90902090997, 9198.356115072149, 9217.124373184537, 9273.026332235018, 9311.0, 8236.588170591567, 8388.328933685169, 8411.0, 8425.747227583182, 8427.367947404091, 6014.0, 6015.097735339734, 6100.420460056288, 6208.782692605918, 6265.154204182377, 6029.306629737636, 6163.907541386972, 6239.625622462667, 6318.020706790455, 6374.26695929974], "value": 5413.664157477418, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6071517754582, 399.9140184860258, 400.3014739279957, 409.9385092236164, 411.1796965054716, 5768.855778605537, 6087.086936959458, 6133.386661333864, 6224.564280500367, 6262.874742505147, 4752.5485078917445, 5652.293463317085, 6113.7860174893885, 6181.443670069692, 6182.289036760774, 4340.131973605276, 4463.575960283776, 4465.263231566803, 4471.575200355961, 4475.149721552894, 3716.5725941516666, 3894.883153505385, 4449.710768800034, 4461.375407442961, 4474.963891429408, 3587.318409502186, 3958.772780438059, 4428.535003824601, 4440.3801756963385, 4464.419625448703, 3872.3029854626157, 3890.4164375343926, 4382.737035777832, 4395.670324725626, 4435.889102772457, 3508.8245437778373, 3584.8207589620674, 3747.2880152770886, 3759.548854137521, 3777.508923839883, 4847.321375007502, 5161.4322424533275, 5993.910091348634, 6005.459508644243, 6027.216461859974, 4740.478547359788, 4839.523945196714, 5238.0, 5279.392869819982, 5286.6035047371215, 6512.5766825156215, 6524.9233876410335, 6561.967190164019, 6605.108310378086, 6670.93329066708, 4140.0, 4285.785710714452, 4295.303355174719, 4304.655627549789, 4338.652907767371, 5891.0, 6842.794716158523, 6870.110719552164, 6975.511714179958, 7011.404030657401, 3783.697304215711, 4211.915761684749, 4262.062346283813, 4360.563943605614, 4362.781860906942, 3895.2988462077096, 3943.4873466449176, 4416.580424859633, 4434.645228381722, 4439.489458712224, 4403.339499075164, 5065.442801291855, 5259.395169555473, 5287.101192797234, 5290.92063619046, 6677.966610166918, 6690.765823196262, 6703.396694297439, 6704.296048914891, 6713.731450742013, 1499.7225513280077, 1512.2589930933764, 1512.3270144785686, 1513.5610672904954, 1513.9091654500764, 830.8629076202479, 835.5529791561607, 952.9952350238204, 971.9173870220969, 994.4530508220449, 5145.948540514547, 5987.5808693391045, 6318.494520438354, 6355.3644635536075, 6442.710078046499, 5982.581219314607, 6034.306054803666, 6685.899711504331, 6940.757073502504, 6981.441484681213, 6294.276158241769, 6331.461825744863, 6352.396522330371, 6366.554341196164, 6391.680415979183, 3053.0, 3143.679213981139, 3158.7157155856085, 3623.836927338276, 3653.5433070866143, 5683.0, 6273.560850740404, 6624.668766561653, 7151.713931442684, 7197.640117994079, 7016.5790052597, 7082.822929426702, 7097.0, 7125.572465652078, 7136.3220494052985, 6225.875482490324, 6532.0, 7206.387457066208, 7207.9639601801655, 7219.278072192738, 5995.9700201500455, 6897.55165914214, 7014.5440546364325, 7028.824279393056, 7031.367176954099, 5405.837824865261, 6469.611823290617, 6601.613661131216, 6675.998600210008, 6772.64547090574, 7040.3663670269925, 7158.997740316256, 7192.388646965067, 7198.280171982759, 7219.530730502711, 4346.47842258931, 4348.586884245991, 4360.716553424018, 4382.846600368972, 4391.5388884166705, 5961.701914904151, 6090.208272924491, 6318.968405157945, 6705.362990515893, 6774.0, 6053.515718742578, 6603.504737144637, 6655.933440665532, 6663.900041499284, 6669.333066693292, 6429.58207716497, 6447.742090316522, 6580.934190658224, 6651.268360480247, 6678.398944094861, 5662.8301150965535, 6445.774397896051, 6499.870002600016, 6542.775456344865, 6546.509011824228, 5358.0, 5519.779208831602, 6610.338966103352, 6695.196576410862, 6772.898406524005, 6493.383128602775, 6496.058071579689, 6527.955527115829, 6530.346965303432, 6549.967250163719], "value": 4724.320447830282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.8650522663761, 832.396512528417, 843.8017065989492, 857.7905153733234, 869.1178453869322, 14339.784903226433, 14920.179390133566, 16165.919170404146, 16908.746368804477, 16945.406910758127, 16844.0, 17069.231884565193, 17253.741193882102, 17589.560260993483, 17654.117294135274, 893.63361021981, 950.424992879305, 973.0852998181704, 1003.0120331473493, 1004.6985904228738, 995.512199022481, 1023.2632504596678, 1025.0876719719456, 1026.7587117027492, 1030.4435604773414, 975.65851951817, 1080.6703955293633, 1087.1465899269076, 1090.6891535912266, 1091.4597274349208, 1055.9208059395537, 1068.0707784227693, 1072.254782925867, 1079.3793568697952, 1081.762012357284, 779.8206412525094, 784.8077221080815, 793.4326956226269, 794.745681381958, 796.5618909599697, 15824.920875395665, 16063.839361606351, 16255.943363681441, 17046.829531704647, 17158.914205429017, 14687.339069741887, 16958.40645577411, 16982.490525284262, 17309.0, 17363.0, 11958.820617690742, 12190.329531875743, 13180.275084870329, 14269.429222831075, 14345.354459049368, 3236.3527294541186, 3258.0388785308155, 3258.169166862435, 3261.1031966209243, 3265.510173473974, 126059.62016347208, 127033.36483317617, 127810.0, 129972.35013824965, 132684.99999999904, 13299.0, 13320.000999925045, 13401.0, 13411.0, 13449.386073671221, 24996.625050624254, 25405.745942540707, 25609.231723047964, 25908.35229119287, 25973.870130649226, 7638.618069096634, 8021.759347219476, 8048.637811298506, 8089.352851771844, 8103.513789172668, 4001.6198461146146, 4094.0, 4096.795160241976, 4098.8360465581045, 4102.774347410921, 4274.8030551445645, 4311.417958575552, 4449.043455657049, 4452.799624016927, 4465.1962646723905, 916.2578311567652, 938.5776400619749, 939.3096074385321, 952.0955092661999, 955.4649396338073, 587.5886879184502, 626.7994241842566, 635.3424205946823, 656.4649810404505, 689.4897775645986, 10873.021428071512, 10957.56169753201, 12158.027357811354, 12172.695682607828, 12306.569270075504, 660.920689517261, 661.9503537234726, 673.2526895146384, 685.0751485494543, 685.6194811879355, 5447.319085114361, 5513.2005859150195, 5591.776328946797, 5592.273004509388, 5736.627119237236, 95018.52490737502, 104775.47612262043, 107106.8959138482, 107138.0, 111506.44246778876, 93233.60149597761, 93328.53335733413, 93657.0, 94146.52926735459, 95444.0, 66226.99999999904, 86715.13284867197, 87310.56344718362, 87995.0, 88976.22047559012, 11005.504752286006, 11527.596534121265, 11670.533178672758, 11718.70703232426, 12024.33866137371, 40550.1889962205, 41217.0, 41412.792936035126, 41454.341826327814, 42499.575004249564, 73247.26752732405, 76422.61788691022, 78484.8091015434, 79151.60424197842, 79804.201957982, 15843.366265349257, 15866.68266634684, 16246.431374901822, 16319.59201019984, 16650.916745416194, 15022.924885375503, 18629.0, 18638.53403664919, 18681.532961675523, 18795.24819007279, 14672.0, 16843.41048063312, 17139.05735184527, 17232.74150887763, 17425.128743563026, 16564.585885352964, 16569.08870012161, 17174.91412542929, 17290.567735806704, 17328.220230089424, 16175.838241617434, 16919.577010574834, 17149.314027438762, 17481.912590437474, 17486.650266994842, 9182.724518264462, 11676.766464670489, 11856.76286474283, 12037.277763333877, 12084.214526055779, 12749.0, 13436.328183590585, 14137.575872723835, 14318.284085795876, 14429.63925901819], "value": 8487.690855967998, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 165.0, 98.0, 167.0, 167.0, 166.0, 108.0, 164.0, 164.0, 115.0], "value": 141.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 96.0, 151.0, 159.0, 136.0, 104.0, 105.0, 144.0, 142.0, 141.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 212.0, 219.0, 236.0, 258.0, 287.0, 218.0, 203.0, 195.0, 199.0], "value": 222.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 85.0, 62.0, 58.0, 57.0, 58.0, 77.0, 60.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 85.0, 105.0, 103.0, 105.0, 90.0, 71.0, 78.0, 90.0], "value": 88.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 88.0, 90.0, 108.0, 94.0, 88.0, 90.0, 91.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 97.0, 97.0, 100.0, 96.0, 97.0, 104.0, 100.0, 96.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 95.0, 89.0, 91.0, 94.0, 91.0, 93.0, 95.0, 93.0, 147.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 51.0, 52.0, 52.0, 50.0, 53.0, 51.0], "value": 50.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 57.0, 62.0, 64.0, 59.0, 62.0, 60.0, 59.0, 60.0, 59.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 83.0, 84.0, 83.0, 80.0, 84.0, 83.0, 84.0, 81.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 139.0, 135.0, 137.0, 138.0, 145.0, 150.0, 155.0, 212.0, 154.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [243.0, 186.0, 186.0, 191.0, 183.0, 182.0, 234.0, 190.0, 185.0, 184.0], "value": 196.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 85.0, 88.0, 69.0, 71.0, 67.0, 68.0, 63.0, 68.0, 79.0], "value": 72.3, "unit": "score"}]}]} 03:37:41 INFO - Return code: 0 03:37:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:37:42 ERROR - # TBPL SUCCESS # 03:37:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:37:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:37:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:37:42 INFO - 2017-04-28 03:37:42.063 screenresolution[1946:21204] starting screenresolution argv=screenresolution get 03:37:42 INFO - 2017-04-28 03:37:42.066 screenresolution[1946:21204] Display 0: 1600x1200x32@60 03:37:42 INFO - 2017-04-28 03:37:42.072 screenresolution[1947:21207] starting screenresolution argv=screenresolution list 03:37:42 INFO - Available Modes on Display 0 03:37:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:37:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:37:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:37:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:37:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:37:42 INFO - Intel Iris: 03:37:42 INFO - Chipset Model: Intel Iris 03:37:42 INFO - Type: GPU 03:37:42 INFO - Bus: Built-In 03:37:42 INFO - VRAM (Dynamic, Max): 1536 MB 03:37:42 INFO - Vendor: Intel (0x8086) 03:37:42 INFO - Device ID: 0x0a2e 03:37:42 INFO - Revision ID: 0x0009 03:37:42 INFO - Displays: 03:37:42 INFO - Display: 03:37:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:37:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:37:42 INFO - Display Serial Number: 1600x1200 60 03:37:42 INFO - Main Display: Yes 03:37:42 INFO - Mirror: Off 03:37:42 INFO - Online: Yes 03:37:42 INFO - Rotation: Supported 03:37:42 INFO - Return code: 0 03:37:42 INFO - Running post-action listener: _resource_record_post_action 03:37:42 INFO - [mozharness: 2017-04-28 10:37:42.316903Z] Finished run-tests step (success) 03:37:42 INFO - Running post-run listener: _resource_record_post_run 03:37:42 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 1037824; Write bytes: 510928896; Read time: 12; Write time: 1594 03:37:42 INFO - TinderboxPrint: CPU usage
54.3% 03:37:42 INFO - TinderboxPrint: I/O read bytes / time
1,037,824 / 12 03:37:42 INFO - TinderboxPrint: I/O write bytes / time
510,928,896 / 1,594 03:37:42 INFO - TinderboxPrint: CPU idle
2,187.8 (45.7%) 03:37:42 INFO - TinderboxPrint: CPU system
965.8 (20.2%) 03:37:42 INFO - TinderboxPrint: CPU user
1,632.1 (34.1%) 03:37:42 INFO - TinderboxPrint: Swap in / out
209,477,632 / 0 03:37:42 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195142144; Write bytes: 192905216; Read time: 14954; Write time: 365 03:37:42 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 1037824; Write bytes: 301180928; Read time: 12; Write time: 1178 03:37:42 INFO - Running post-run listener: _upload_blobber_files 03:37:42 INFO - Blob upload gear active. 03:37:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:37:42 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 03:37:42 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'] 03:37:42 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 03:37:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:37:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:37:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:37:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:43 INFO - (blobuploader) - INFO - Done attempting. 03:37:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:37:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:45 INFO - (blobuploader) - INFO - Done attempting. 03:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:45 INFO - (blobuploader) - INFO - Done attempting. 03:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:37:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:37:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:37:48 INFO - (blobuploader) - INFO - Done attempting. 03:37:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:37:48 INFO - Return code: 0 03:37:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:37:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:37:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55885f0c90d736558e56f58b70073609e4f1d4ae6db581671a9d7a7b493d9af88904652c445fc22c4d478defabb2be8c5264b6d1f8d0bc5b54ccf2ddd3594063", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6614f714408f3e1fe736aefbd4536184bb6ba7fd2b572623990e674a680cb912e4a905f97b33c05adac00a712877b5cbd83472af9643ebaf09258faeb02f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ced3fe52a2f1b11467e7a9d8291cd7a5686f818ed44b241934bcb7821fec1b6e15b159b5ae3515375edfff03c75bea910f49c9f8ee768d83a8f51125146d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537897c9db8745e9116fee4df85c0a99aeecb9c934dbce56e7f8422c0c4004b8e8f405b37650638db06ed71a54bf97399259b2aecf71f83f50e44107852e7847"} 03:37:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:37:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:37:48 INFO - Contents: 03:37:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55885f0c90d736558e56f58b70073609e4f1d4ae6db581671a9d7a7b493d9af88904652c445fc22c4d478defabb2be8c5264b6d1f8d0bc5b54ccf2ddd3594063", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6614f714408f3e1fe736aefbd4536184bb6ba7fd2b572623990e674a680cb912e4a905f97b33c05adac00a712877b5cbd83472af9643ebaf09258faeb02f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ced3fe52a2f1b11467e7a9d8291cd7a5686f818ed44b241934bcb7821fec1b6e15b159b5ae3515375edfff03c75bea910f49c9f8ee768d83a8f51125146d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537897c9db8745e9116fee4df85c0a99aeecb9c934dbce56e7f8422c0c4004b8e8f405b37650638db06ed71a54bf97399259b2aecf71f83f50e44107852e7847"} 03:37:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:37:48 INFO - Copying logs to upload dir... 03:37:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:37:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.268986 ========= master_lag: 1.25 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-28 03:37:49.590073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:49.593714) ========= 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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55885f0c90d736558e56f58b70073609e4f1d4ae6db581671a9d7a7b493d9af88904652c445fc22c4d478defabb2be8c5264b6d1f8d0bc5b54ccf2ddd3594063", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6614f714408f3e1fe736aefbd4536184bb6ba7fd2b572623990e674a680cb912e4a905f97b33c05adac00a712877b5cbd83472af9643ebaf09258faeb02f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ced3fe52a2f1b11467e7a9d8291cd7a5686f818ed44b241934bcb7821fec1b6e15b159b5ae3515375edfff03c75bea910f49c9f8ee768d83a8f51125146d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537897c9db8745e9116fee4df85c0a99aeecb9c934dbce56e7f8422c0c4004b8e8f405b37650638db06ed71a54bf97399259b2aecf71f83f50e44107852e7847"} build_url:https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/SNl6Ex8UTtiq_yrjCXw3dQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55885f0c90d736558e56f58b70073609e4f1d4ae6db581671a9d7a7b493d9af88904652c445fc22c4d478defabb2be8c5264b6d1f8d0bc5b54ccf2ddd3594063", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f6614f714408f3e1fe736aefbd4536184bb6ba7fd2b572623990e674a680cb912e4a905f97b33c05adac00a712877b5cbd83472af9643ebaf09258faeb02f34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/56ced3fe52a2f1b11467e7a9d8291cd7a5686f818ed44b241934bcb7821fec1b6e15b159b5ae3515375edfff03c75bea910f49c9f8ee768d83a8f51125146d6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/537897c9db8745e9116fee4df85c0a99aeecb9c934dbce56e7f8422c0c4004b8e8f405b37650638db06ed71a54bf97399259b2aecf71f83f50e44107852e7847"}' ========= master_lag: 0.79 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:50.393863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:50.394195) ========= 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.Qs08CiQg8q/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.l6WlZrv8Hn/Listeners TMPDIR=/var/folders/5n/qj9h8_p94j3fbvp8w7v03z9m00000w/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.005150 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-28 03:37:50.426511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 03:37:50.427159) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-28 03:37:50.427884) ========= ========= Total master_lag: 2.15 =========