builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0361 starttime: 1491838591.75 results: success (0) buildid: 20170410070150 builduid: 35f70f1447074e6cb349420917e1bc82 revision: 73696638f90109cfb05599ab28bd79faad8cf20d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.750411) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.750968) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.751295) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.778342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.778762) ========= 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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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-10 08:36:31-- 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% 153M=0s 2017-04-10 08:36:31 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.900153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.900465) ========= 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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.027334 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:31.949178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 08:36:31.949521) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 73696638f90109cfb05599ab28bd79faad8cf20d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 73696638f90109cfb05599ab28bd79faad8cf20d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rDdUvtBEJC/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.I85Bp0DiUS/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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-10 08:36:32,075 truncating revision to first 12 chars 2017-04-10 08:36:32,075 Setting DEBUG logging. 2017-04-10 08:36:32,075 attempt 1/10 2017-04-10 08:36:32,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/73696638f901?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-10 08:36:33,725 unpacking tar archive at: mozilla-beta-73696638f901/testing/mozharness/ program finished with exit code 0 elapsedTime=1.937346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-10 08:36:33.910331) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:33.910671) ========= script_repo_revision: 73696638f90109cfb05599ab28bd79faad8cf20d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:33.911074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:33.911350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-10 08:36:33.930883) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-10 08:36:33.931270) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rDdUvtBEJC/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.I85Bp0DiUS/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:36:34 INFO - MultiFileLogger online at 20170410 08:36:34 in /builds/slave/test 08:36:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:36:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:36:34 INFO - {'append_to_log': False, 08:36:34 INFO - 'base_work_dir': '/builds/slave/test', 08:36:34 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:36:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:36:34 INFO - 'branch': 'Mozilla-Beta', 08:36:34 INFO - 'buildbot_json_path': 'buildprops.json', 08:36:34 INFO - 'config_files': ('talos/mac_config.py',), 08:36:34 INFO - 'default_actions': ('clobber', 08:36:34 INFO - 'read-buildbot-config', 08:36:34 INFO - 'download-and-extract', 08:36:34 INFO - 'populate-webroot', 08:36:34 INFO - 'create-virtualenv', 08:36:34 INFO - 'install', 08:36:34 INFO - 'run-tests'), 08:36:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:36:34 INFO - 'download_minidump_stackwalk': True, 08:36:34 INFO - 'download_symbols': 'ondemand', 08:36:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:36:34 INFO - 'tooltool.py': '/tools/tooltool.py', 08:36:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:36:34 INFO - '/tools/misc-python/virtualenv.py')}, 08:36:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:36:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:36:34 INFO - 'installer_path': 'installer.exe', 08:36:34 INFO - 'log_level': 'info', 08:36:34 INFO - 'log_name': 'talos', 08:36:34 INFO - 'log_to_console': True, 08:36:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:36:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:36:34 INFO - 'opt_config_files': (), 08:36:34 INFO - 'pip_index': False, 08:36:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:36:34 INFO - 'cmd': ('bash', 08:36:34 INFO - '-c', 08:36:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:36:34 INFO - 'enabled': True, 08:36:34 INFO - 'halt_on_failure': False, 08:36:34 INFO - 'name': 'check_screen_resolution'},), 08:36:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:36:34 INFO - 'cmd': ('bash', 08:36:34 INFO - '-c', 08:36:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:36:34 INFO - 'enabled': True, 08:36:34 INFO - 'halt_on_failure': False, 08:36:34 INFO - 'name': 'check_screen_resolution'},), 08:36:34 INFO - 'run_cmd_checks_enabled': True, 08:36:34 INFO - 'sps_profile': False, 08:36:34 INFO - 'sps_profile_interval': 0, 08:36:34 INFO - 'suite': 'dromaeojs-e10s', 08:36:34 INFO - 'system_bits': '32', 08:36:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:36:34 INFO - 'title': 't-yosemite-r7-0361', 08:36:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:36:34 INFO - 'use_talos_json': True, 08:36:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:36:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:36:34 INFO - 'work_dir': 'build'} 08:36:34 INFO - [mozharness: 2017-04-10 15:36:34.164549Z] Running clobber step. 08:36:34 INFO - Running pre-action listener: _resource_record_pre_action 08:36:34 INFO - Running main action method: clobber 08:36:34 INFO - rmtree: /builds/slave/test/build 08:36:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:36:36 INFO - Running post-action listener: _resource_record_post_action 08:36:36 INFO - [mozharness: 2017-04-10 15:36:36.654474Z] Finished clobber step (success) 08:36:36 INFO - [mozharness: 2017-04-10 15:36:36.654622Z] Running read-buildbot-config step. 08:36:36 INFO - Running pre-action listener: _resource_record_pre_action 08:36:36 INFO - Running main action method: read_buildbot_config 08:36:36 INFO - Using buildbot properties: 08:36:36 INFO - { 08:36:36 INFO - "project": "", 08:36:36 INFO - "product": "firefox", 08:36:36 INFO - "script_repo_revision": "production", 08:36:36 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:36:36 INFO - "repository": "", 08:36:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:36:36 INFO - "buildid": "20170410070150", 08:36:36 INFO - "pgo_build": "False", 08:36:36 INFO - "basedir": "/builds/slave/test", 08:36:36 INFO - "buildnumber": 15, 08:36:36 INFO - "slavename": "t-yosemite-r7-0361", 08:36:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:36:36 INFO - "platform": "yosemite_r7", 08:36:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:36:36 INFO - "branch": "mozilla-beta", 08:36:36 INFO - "repo_path": "releases/mozilla-beta", 08:36:36 INFO - "revision": "73696638f90109cfb05599ab28bd79faad8cf20d", 08:36:36 INFO - "stage_platform": "macosx64", 08:36:36 INFO - "builduid": "35f70f1447074e6cb349420917e1bc82", 08:36:36 INFO - "slavebuilddir": "test" 08:36:36 INFO - } 08:36:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 08:36:36 INFO - Running post-action listener: _resource_record_post_action 08:36:36 INFO - [mozharness: 2017-04-10 15:36:36.658078Z] Finished read-buildbot-config step (success) 08:36:36 INFO - [mozharness: 2017-04-10 15:36:36.658212Z] Running download-and-extract step. 08:36:36 INFO - Running pre-action listener: _resource_record_pre_action 08:36:36 INFO - Running main action method: download_and_extract 08:36:36 INFO - mkdir: /builds/slave/test/build/tests 08:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:36 INFO - trying https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 08:36:36 INFO - Downloading https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 08:36:37 INFO - Downloaded 1165 bytes. 08:36:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 08:36:37 INFO - Using the following test package requirements: 08:36:37 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:36:37 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:36:37 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 08:36:37 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:36:37 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 08:36:37 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:36:37 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:36:37 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 08:36:37 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 08:36:37 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:36:37 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 08:36:37 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:36:37 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 08:36:37 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:36:37 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 08:36:37 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 08:36:37 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 08:36:37 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 08:36:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:36:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:36:37 INFO - Fetch https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:36:38 INFO - Expected file size: 16116605 08:36:38 INFO - Obtained file size: 16116605 08:36:45 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:36:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 08:36:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 08:36:45 INFO - Fetch https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 08:36:46 INFO - Expected file size: 16116605 08:36:46 INFO - Obtained file size: 16116605 08:36:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 08:36:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 08:36:53 INFO - Fetch https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 08:36:54 INFO - Expected file size: 14403650 08:36:54 INFO - Obtained file size: 14403650 08:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:36:54 INFO - trying https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:36:54 INFO - Downloading https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 08:36:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 08:36:56 INFO - Downloaded 58734356 bytes. 08:36:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:36:56 INFO - mkdir: /builds/slave/test/properties 08:36:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:36:56 INFO - Writing to file /builds/slave/test/properties/build_url 08:36:56 INFO - Contents: 08:36:56 INFO - build_url:https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 08:36:56 INFO - Running post-action listener: _resource_record_post_action 08:36:56 INFO - Running post-action listener: set_extra_try_arguments 08:36:56 INFO - [mozharness: 2017-04-10 15:36:56.823001Z] Finished download-and-extract step (success) 08:36:56 INFO - [mozharness: 2017-04-10 15:36:56.823155Z] Running populate-webroot step. 08:36:56 INFO - Running pre-action listener: _resource_record_pre_action 08:36:56 INFO - Running main action method: populate_webroot 08:36:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:36:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:36:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:36:56 INFO - '--tppagecycles', 08:36:56 INFO - '7'], 08:36:56 INFO - 'tests': ['tsvgm']}}, 08:36:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:36:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:36:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:36:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:36:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:36:56 INFO - 'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:36:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:36:56 INFO - 'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['damp', 'tps']}, 08:36:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:36:56 INFO - 'tests': ['damp', 'tps']}, 08:36:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['dromaeo_dom']}, 08:36:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:36:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['basic_compositor_video']}, 08:36:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:36:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['a11yr', 08:36:56 INFO - 'ts_paint', 08:36:56 INFO - 'tpaint', 08:36:56 INFO - 'sessionrestore', 08:36:56 INFO - 'sessionrestore_no_auto_restore', 08:36:56 INFO - 'tabpaint']}, 08:36:56 INFO - 'other-e10s': {'tests': ['a11yr', 08:36:56 INFO - 'ts_paint', 08:36:56 INFO - 'tpaint', 08:36:56 INFO - 'sessionrestore', 08:36:56 INFO - 'sessionrestore_no_auto_restore', 08:36:56 INFO - 'tabpaint']}, 08:36:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:36:56 INFO - 'ts_paint', 08:36:56 INFO - 'tpaint', 08:36:56 INFO - 'sessionrestore', 08:36:56 INFO - 'sessionrestore_no_auto_restore', 08:36:56 INFO - 'tabpaint']}, 08:36:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:36:56 INFO - 'ts_paint', 08:36:56 INFO - 'tpaint', 08:36:56 INFO - 'sessionrestore', 08:36:56 INFO - 'sessionrestore_no_auto_restore', 08:36:56 INFO - 'tabpaint']}, 08:36:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['a11yr', 08:36:56 INFO - 'ts_paint', 08:36:56 INFO - 'tpaint', 08:36:56 INFO - 'sessionrestore', 08:36:56 INFO - 'sessionrestore_no_auto_restore', 08:36:56 INFO - 'tabpaint']}, 08:36:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['a11yr', 08:36:56 INFO - 'ts_paint', 08:36:56 INFO - 'tpaint', 08:36:56 INFO - 'sessionrestore', 08:36:56 INFO - 'sessionrestore_no_auto_restore', 08:36:56 INFO - 'tabpaint']}, 08:36:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['tsvgx', 08:36:56 INFO - 'tsvgr_opacity', 08:36:56 INFO - 'tart', 08:36:56 INFO - 'tscrollx', 08:36:56 INFO - 'cart', 08:36:56 INFO - 'tsvg_static']}, 08:36:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:36:56 INFO - 'tsvgr_opacity', 08:36:56 INFO - 'tart', 08:36:56 INFO - 'tscrollx', 08:36:56 INFO - 'cart', 08:36:56 INFO - 'tsvg_static']}, 08:36:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:36:56 INFO - 'talos_options': ['--disable-e10s'], 08:36:56 INFO - 'tests': ['tp5o']}, 08:36:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:36:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:36:56 INFO - 'talos_options': ['--disable-e10s', 08:36:56 INFO - '--xperf_path', 08:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:56 INFO - 'tests': ['tp5n']}, 08:36:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:36:56 INFO - 'talos_options': ['--xperf_path', 08:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:36:56 INFO - 'tests': ['tp5n']}}, 08:36:56 INFO - 'talos.zip': {'path': '', 08:36:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:36:56 INFO - Running post-action listener: _resource_record_post_action 08:36:56 INFO - [mozharness: 2017-04-10 15:36:56.842442Z] Finished populate-webroot step (success) 08:36:56 INFO - [mozharness: 2017-04-10 15:36:56.842579Z] Running create-virtualenv step. 08:36:56 INFO - Running pre-action listener: _resource_record_pre_action 08:36:56 INFO - Running main action method: create_virtualenv 08:36:56 INFO - Creating virtualenv /builds/slave/test/build/venv 08:36:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:36:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:36:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:36:56 INFO - Using real prefix '/tools/python27' 08:36:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:36:57 INFO - Installing distribute.............................................................................................................................................................................................done. 08:37:00 INFO - Installing pip.................done. 08:37:00 INFO - Return code: 0 08:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:37:00 INFO - Reading from file tmpfile_stdout 08:37:00 INFO - Output received: 08:37:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:37:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:00 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 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:00 INFO - 'HOME': '/Users/cltbld', 08:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:00 INFO - 'LOGNAME': 'cltbld', 08:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:00 INFO - 'MOZ_NO_REMOTE': '1', 08:37:00 INFO - 'NO_EM_RESTART': '1', 08:37:00 INFO - 'PAGER': '/bin/cat', 08:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:00 INFO - 'PWD': '/builds/slave/test', 08:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:00 INFO - 'SHELL': '/bin/bash', 08:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:00 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:00 INFO - 'USER': 'cltbld', 08:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:00 INFO - 'XPC_FLAGS': '0x0', 08:37:00 INFO - 'XPC_SERVICE_NAME': '0', 08:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:37:01 INFO - Cleaning up... 08:37:01 INFO - Return code: 0 08:37:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:37:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:01 INFO - 'HOME': '/Users/cltbld', 08:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:01 INFO - 'LOGNAME': 'cltbld', 08:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:01 INFO - 'MOZ_NO_REMOTE': '1', 08:37:01 INFO - 'NO_EM_RESTART': '1', 08:37:01 INFO - 'PAGER': '/bin/cat', 08:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:01 INFO - 'PWD': '/builds/slave/test', 08:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:01 INFO - 'SHELL': '/bin/bash', 08:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:01 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:01 INFO - 'USER': 'cltbld', 08:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:01 INFO - 'XPC_FLAGS': '0x0', 08:37:01 INFO - 'XPC_SERVICE_NAME': '0', 08:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:01 INFO - Downloading/unpacking psutil>=3.1.1 08:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:37:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:04 INFO - Installing collected packages: psutil 08:37:04 INFO - Running setup.py install for psutil 08:37:04 INFO - building 'psutil._psutil_osx' extension 08:37:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:37:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:37:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:37:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:37:05 INFO - building 'psutil._psutil_posix' extension 08:37:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:37:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:37:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:37:05 INFO - ^ 08:37:05 INFO - 1 warning generated. 08:37:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:37:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:37:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:37:06 INFO - Successfully installed psutil 08:37:06 INFO - Cleaning up... 08:37:06 INFO - Return code: 0 08:37:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:06 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 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:06 INFO - 'HOME': '/Users/cltbld', 08:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:06 INFO - 'LOGNAME': 'cltbld', 08:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:06 INFO - 'MOZ_NO_REMOTE': '1', 08:37:06 INFO - 'NO_EM_RESTART': '1', 08:37:06 INFO - 'PAGER': '/bin/cat', 08:37:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:06 INFO - 'PWD': '/builds/slave/test', 08:37:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:06 INFO - 'SHELL': '/bin/bash', 08:37:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:06 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:06 INFO - 'USER': 'cltbld', 08:37:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:06 INFO - 'XPC_FLAGS': '0x0', 08:37:06 INFO - 'XPC_SERVICE_NAME': '0', 08:37:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:37:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:37:09 INFO - Installing collected packages: mozsystemmonitor 08:37:09 INFO - Running setup.py install for mozsystemmonitor 08:37:09 INFO - Successfully installed mozsystemmonitor 08:37:09 INFO - Cleaning up... 08:37:09 INFO - Return code: 0 08:37:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:37: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')]} 08:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37: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')]} 08:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:09 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 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:09 INFO - 'HOME': '/Users/cltbld', 08:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:09 INFO - 'LOGNAME': 'cltbld', 08:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:09 INFO - 'MOZ_NO_REMOTE': '1', 08:37:09 INFO - 'NO_EM_RESTART': '1', 08:37:09 INFO - 'PAGER': '/bin/cat', 08:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:09 INFO - 'PWD': '/builds/slave/test', 08:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:09 INFO - 'SHELL': '/bin/bash', 08:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:09 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:09 INFO - 'USER': 'cltbld', 08:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:09 INFO - 'XPC_FLAGS': '0x0', 08:37:09 INFO - 'XPC_SERVICE_NAME': '0', 08:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:09 INFO - Downloading/unpacking jsonschema==2.5.1 08:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:37:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:12 INFO - Downloading functools32-3.2.3-2.tar.gz 08:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:37:12 INFO - warning: no files found matching '*.txt' 08:37:12 INFO - no previously-included directories found matching 'build' 08:37:12 INFO - no previously-included directories found matching 'dist' 08:37:12 INFO - no previously-included directories found matching '.git*' 08:37:12 INFO - Installing collected packages: jsonschema, functools32 08:37:12 INFO - Running setup.py install for functools32 08:37:12 INFO - warning: no files found matching '*.txt' 08:37:12 INFO - no previously-included directories found matching 'build' 08:37:12 INFO - no previously-included directories found matching 'dist' 08:37:12 INFO - no previously-included directories found matching '.git*' 08:37:12 INFO - Successfully installed jsonschema functools32 08:37:12 INFO - Cleaning up... 08:37:13 INFO - Return code: 0 08:37:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:13 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 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:13 INFO - 'HOME': '/Users/cltbld', 08:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:13 INFO - 'LOGNAME': 'cltbld', 08:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:13 INFO - 'MOZ_NO_REMOTE': '1', 08:37:13 INFO - 'NO_EM_RESTART': '1', 08:37:13 INFO - 'PAGER': '/bin/cat', 08:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:13 INFO - 'PWD': '/builds/slave/test', 08:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:13 INFO - 'SHELL': '/bin/bash', 08:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:13 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:13 INFO - 'USER': 'cltbld', 08:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:13 INFO - 'XPC_FLAGS': '0x0', 08:37:13 INFO - 'XPC_SERVICE_NAME': '0', 08:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:37:13 INFO - Cleaning up... 08:37:13 INFO - Return code: 0 08:37:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:13 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 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:13 INFO - 'HOME': '/Users/cltbld', 08:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:13 INFO - 'LOGNAME': 'cltbld', 08:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:13 INFO - 'MOZ_NO_REMOTE': '1', 08:37:13 INFO - 'NO_EM_RESTART': '1', 08:37:13 INFO - 'PAGER': '/bin/cat', 08:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:13 INFO - 'PWD': '/builds/slave/test', 08:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:13 INFO - 'SHELL': '/bin/bash', 08:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:13 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:13 INFO - 'USER': 'cltbld', 08:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:13 INFO - 'XPC_FLAGS': '0x0', 08:37:13 INFO - 'XPC_SERVICE_NAME': '0', 08:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:13 INFO - Downloading/unpacking blobuploader==1.2.4 08:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:16 INFO - Downloading blobuploader-1.2.4.tar.gz 08:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:37:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:37: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 08:37: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 08:37: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 08:37: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 08:37: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 08:37: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 08:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:37:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:17 INFO - Downloading docopt-0.6.1.tar.gz 08:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:37:17 INFO - Installing collected packages: blobuploader, requests, docopt 08:37:17 INFO - Running setup.py install for blobuploader 08:37:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:37:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:37:17 INFO - Running setup.py install for requests 08:37:18 INFO - Running setup.py install for docopt 08:37:18 INFO - Successfully installed blobuploader requests docopt 08:37:18 INFO - Cleaning up... 08:37:18 INFO - Return code: 0 08:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:19 INFO - 'HOME': '/Users/cltbld', 08:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:19 INFO - 'LOGNAME': 'cltbld', 08:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:19 INFO - 'MOZ_NO_REMOTE': '1', 08:37:19 INFO - 'NO_EM_RESTART': '1', 08:37:19 INFO - 'PAGER': '/bin/cat', 08:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:19 INFO - 'PWD': '/builds/slave/test', 08:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:19 INFO - 'SHELL': '/bin/bash', 08:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:19 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:19 INFO - 'USER': 'cltbld', 08:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:19 INFO - 'XPC_FLAGS': '0x0', 08:37:19 INFO - 'XPC_SERVICE_NAME': '0', 08:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:19 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-tI14J1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:19 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-HrXgOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:19 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-kxRHwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:19 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-tfHVls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:19 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-oZbTRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:19 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-ytqcla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-4vSHKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-P30b9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-LQdqV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6QKoEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-V9te67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6ufGcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-_jMsO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-OeegHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-pF1Exi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:20 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-wQ9GTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:21 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-mgfVC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:37:21 INFO - Running setup.py install for manifestparser 08:37:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:37:21 INFO - Running setup.py install for mozcrash 08:37:21 INFO - Running setup.py install for mozdebug 08:37:21 INFO - Running setup.py install for mozdevice 08:37:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:37:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:37:21 INFO - Running setup.py install for mozfile 08:37:21 INFO - Running setup.py install for mozhttpd 08:37:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Running setup.py install for mozinfo 08:37:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Running setup.py install for mozInstall 08:37:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Running setup.py install for mozleak 08:37:22 INFO - Running setup.py install for mozlog 08:37:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Running setup.py install for moznetwork 08:37:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:37:22 INFO - Running setup.py install for mozprocess 08:37:22 INFO - Running setup.py install for mozprofile 08:37:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:37:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:37:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:37:23 INFO - Running setup.py install for mozrunner 08:37:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:37:23 INFO - Running setup.py install for mozscreenshot 08:37:23 INFO - Running setup.py install for moztest 08:37:23 INFO - Running setup.py install for mozversion 08:37:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:37:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:37:23 INFO - Cleaning up... 08:37:23 INFO - Return code: 0 08:37:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:37:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:37:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:24 INFO - 'HOME': '/Users/cltbld', 08:37:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:24 INFO - 'LOGNAME': 'cltbld', 08:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:24 INFO - 'MOZ_NO_REMOTE': '1', 08:37:24 INFO - 'NO_EM_RESTART': '1', 08:37:24 INFO - 'PAGER': '/bin/cat', 08:37:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:24 INFO - 'PWD': '/builds/slave/test', 08:37:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:24 INFO - 'SHELL': '/bin/bash', 08:37:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:24 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:24 INFO - 'USER': 'cltbld', 08:37:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:24 INFO - 'XPC_FLAGS': '0x0', 08:37:24 INFO - 'XPC_SERVICE_NAME': '0', 08:37:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:37:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-muz00R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:37:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-XcBb5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:37:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-GtTb6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:37:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-zbvG5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:37:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-uQPM1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:37:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-ImOd7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:37:24 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-f8XHo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-vClBsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-vVBoXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-NVWvTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-8iG4YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6aNa3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-mAhU0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-4jagkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-UC60Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:37:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:37:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:37:25 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-t9zwfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:37:26 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-4Of6ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:37:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:37:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:37:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:37:29 INFO - Downloading blessings-1.6.tar.gz 08:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:37:29 INFO - Installing collected packages: blessings 08:37:29 INFO - Running setup.py install for blessings 08:37:29 INFO - Successfully installed blessings 08:37:29 INFO - Cleaning up... 08:37:29 INFO - Return code: 0 08:37:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:29 INFO - Reading from file tmpfile_stdout 08:37:29 INFO - Current package versions: 08:37:29 INFO - blessings == 1.6 08:37:29 INFO - blobuploader == 1.2.4 08:37:29 INFO - docopt == 0.6.1 08:37:29 INFO - functools32 == 3.2.3-2 08:37:29 INFO - jsonschema == 2.5.1 08:37:29 INFO - manifestparser == 1.1 08:37:29 INFO - mozInstall == 1.12 08:37:29 INFO - mozcrash == 1.0 08:37:29 INFO - mozdebug == 0.1 08:37:29 INFO - mozdevice == 0.49 08:37:29 INFO - mozfile == 1.2 08:37:29 INFO - mozhttpd == 0.7 08:37:29 INFO - mozinfo == 0.9 08:37:29 INFO - mozleak == 0.1 08:37:29 INFO - mozlog == 3.4 08:37:29 INFO - moznetwork == 0.27 08:37:29 INFO - mozprocess == 0.24 08:37:29 INFO - mozprofile == 0.28 08:37:29 INFO - mozrunner == 6.13 08:37:29 INFO - mozscreenshot == 0.1 08:37:29 INFO - mozsystemmonitor == 0.3 08:37:29 INFO - moztest == 0.8 08:37:29 INFO - mozversion == 1.4 08:37:29 INFO - psutil == 3.1.1 08:37:29 INFO - requests == 1.2.3 08:37:29 INFO - wsgiref == 0.1.2 08:37:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:37:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:29 INFO - 'HOME': '/Users/cltbld', 08:37:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:29 INFO - 'LOGNAME': 'cltbld', 08:37:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:29 INFO - 'MOZ_NO_REMOTE': '1', 08:37:29 INFO - 'NO_EM_RESTART': '1', 08:37:29 INFO - 'PAGER': '/bin/cat', 08:37:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:29 INFO - 'PWD': '/builds/slave/test', 08:37:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:29 INFO - 'SHELL': '/bin/bash', 08:37:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:29 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:29 INFO - 'USER': 'cltbld', 08:37:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:29 INFO - 'XPC_FLAGS': '0x0', 08:37:29 INFO - 'XPC_SERVICE_NAME': '0', 08:37:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:37:30 INFO - Cleaning up... 08:37:30 INFO - Return code: 0 08:37:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:37:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1077adb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe123584c10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, '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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:37:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:30 INFO - 'HOME': '/Users/cltbld', 08:37:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:30 INFO - 'LOGNAME': 'cltbld', 08:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:30 INFO - 'MOZ_NO_REMOTE': '1', 08:37:30 INFO - 'NO_EM_RESTART': '1', 08:37:30 INFO - 'PAGER': '/bin/cat', 08:37:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:30 INFO - 'PWD': '/builds/slave/test', 08:37:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:30 INFO - 'SHELL': '/bin/bash', 08:37:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:30 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:30 INFO - 'USER': 'cltbld', 08:37:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:30 INFO - 'XPC_FLAGS': '0x0', 08:37:30 INFO - 'XPC_SERVICE_NAME': '0', 08:37:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:37:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:37:30 INFO - Cleaning up... 08:37:30 INFO - Return code: 0 08:37:30 INFO - Running post-action listener: _resource_record_post_action 08:37:30 INFO - Running post-action listener: _start_resource_monitoring 08:37:30 INFO - Starting resource monitoring. 08:37:30 INFO - [mozharness: 2017-04-10 15:37:30.382300Z] Finished create-virtualenv step (success) 08:37:30 INFO - [mozharness: 2017-04-10 15:37:30.383185Z] Running install step. 08:37:30 INFO - Running pre-action listener: _resource_record_pre_action 08:37:30 INFO - Running main action method: install 08:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:37:30 INFO - Reading from file tmpfile_stdout 08:37:30 INFO - Detecting whether we're running mozinstall >=1.0... 08:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:37:30 INFO - Reading from file tmpfile_stdout 08:37:30 INFO - Output received: 08:37:30 INFO - Usage: mozinstall [options] installer 08:37:30 INFO - Options: 08:37:30 INFO - -h, --help show this help message and exit 08:37:30 INFO - -d DEST, --destination=DEST 08:37:30 INFO - Directory to install application into. [default: 08:37:30 INFO - "/builds/slave/test"] 08:37:30 INFO - --app=APP Application being installed. [default: firefox] 08:37:30 INFO - mkdir: /builds/slave/test/build/application 08:37:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:37:45 INFO - Reading from file tmpfile_stdout 08:37:45 INFO - Output received: 08:37:45 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:37:45 INFO - Running post-action listener: _resource_record_post_action 08:37:45 INFO - [mozharness: 2017-04-10 15:37:45.392883Z] Finished install step (success) 08:37:45 INFO - [mozharness: 2017-04-10 15:37:45.393024Z] Running run-tests step. 08:37:45 INFO - Running pre-action listener: _resource_record_pre_action 08:37:45 INFO - Running main action method: run_tests 08:37:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:37:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:37:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:37:45 INFO - 2017-04-10 08:37:45.407 screenresolution[1629:7252] starting screenresolution argv=screenresolution get 08:37:45 INFO - 2017-04-10 08:37:45.410 screenresolution[1629:7252] Display 0: 1600x1200x32@60 08:37:45 INFO - 2017-04-10 08:37:45.416 screenresolution[1630:7254] starting screenresolution argv=screenresolution list 08:37:45 INFO - Available Modes on Display 0 08:37:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:37:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:37:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:37:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:37:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:37:45 INFO - Intel Iris: 08:37:45 INFO - Chipset Model: Intel Iris 08:37:45 INFO - Type: GPU 08:37:45 INFO - Bus: Built-In 08:37:45 INFO - VRAM (Dynamic, Max): 1536 MB 08:37:45 INFO - Vendor: Intel (0x8086) 08:37:45 INFO - Device ID: 0x0a2e 08:37:45 INFO - Revision ID: 0x0009 08:37:45 INFO - Displays: 08:37:45 INFO - Display: 08:37:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:37:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:37:45 INFO - Display Serial Number: 1600x1200 60 08:37:45 INFO - Main Display: Yes 08:37:45 INFO - Mirror: Off 08:37:45 INFO - Online: Yes 08:37:45 INFO - Rotation: Supported 08:37:45 INFO - Return code: 0 08:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:37:45 INFO - Python 2.7.3 08:37:45 INFO - Return code: 0 08:37:45 INFO - grabbing minidump binary from tooltool 08:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:37:45 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 0x10758bd30>, '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 0x1074b2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107580be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:37:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:37:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:37:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:37:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:37:45 INFO - Return code: 0 08:37:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:37:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:37:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:37:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:37:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0361 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rDdUvtBEJC/Render', 08:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:37:45 INFO - 'HOME': '/Users/cltbld', 08:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:37:45 INFO - 'LOGNAME': 'cltbld', 08:37:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:37:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:37:45 INFO - 'MOZ_NO_REMOTE': '1', 08:37:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:37:45 INFO - 'NO_EM_RESTART': '1', 08:37:45 INFO - 'PAGER': '/bin/cat', 08:37:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:37:45 INFO - 'PWD': '/builds/slave/test', 08:37:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:37:45 INFO - 'SHELL': '/bin/bash', 08:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.I85Bp0DiUS/Listeners', 08:37:45 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 08:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:37:45 INFO - 'USER': 'cltbld', 08:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:37:45 INFO - 'XPC_FLAGS': '0x0', 08:37:45 INFO - 'XPC_SERVICE_NAME': '0', 08:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:37:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:37:46 INFO - mozversion application_buildid: 20170410070150 08:37:46 INFO - mozversion application_changeset: 73696638f90109cfb05599ab28bd79faad8cf20d 08:37:46 INFO - mozversion application_display_name: Firefox 08:37:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:37:46 INFO - mozversion application_name: Firefox 08:37:46 INFO - mozversion application_remotingname: firefox 08:37:46 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:37:46 INFO - mozversion application_vendor: Mozilla 08:37:46 INFO - mozversion application_version: 53.0 08:37:46 INFO - mozversion platform_buildid: 20170410070150 08:37:46 INFO - mozversion platform_changeset: 73696638f90109cfb05599ab28bd79faad8cf20d 08:37:46 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:37:46 INFO - mozversion platform_version: 53.0 08:37:46 INFO - using testdate: 1491838666 08:37:46 INFO - actual date: 1491838666 08:37:46 INFO - starting webserver on 'localhost:49236' 08:37:46 INFO - SUITE-START | Running 2 tests 08:37:46 INFO - TEST-START | dromaeo_css 08:37:46 INFO - operating with platform_type : mac_ 08:37:46 INFO - Initialising browser for dromaeo_css test... 08:37:46 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpf2mqzj/profile http://localhost:49236/getInfo.html) 08:37:48 INFO - PROCESS | 1640 | 2017-04-10 08:37:48.969 plugin-container[1643:7432] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d37, name = 'com.apple.tsm.portname' 08:37:48 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:37:48 INFO - PROCESS | 1640 | 2017-04-10 08:37:48.970 plugin-container[1643:7432] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 08:37:48 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:37:48 INFO - PROCESS | 1640 | 2017-04-10 08:37:48.970 plugin-container[1643:7432] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:37:49 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 08:37:49 INFO - PROCESS | 1640 | colorDepth:24 08:37:49 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 08:37:49 INFO - PROCESS | 1640 | __metrics 08:37:49 ERROR - PROCESS | 1640 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 08:37:49 INFO - TEST-INFO | 1640: exit 0 08:37:49 INFO - Browser initialized. 08:37:49 INFO - Running cycle 1/1 for dromaeo_css test... 08:37:49 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpf2mqzj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:37:52 INFO - PROCESS | 1644 | 2017-04-10 08:37:52.066 plugin-container[1645:7572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8547, name = 'com.apple.tsm.portname' 08:37:52 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:37:52 INFO - PROCESS | 1644 | 2017-04-10 08:37:52.066 plugin-container[1645:7572] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0f, name = 'com.apple.CFPasteboardClient' 08:37:52 INFO - PROCESS | 1644 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:37:52 INFO - PROCESS | 1644 | 2017-04-10 08:37:52.066 plugin-container[1645:7572] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:38:01 INFO - PROCESS | 1644 | RSS: Main: 173064192 08:38:01 INFO - PROCESS | 1644 | 08:41:03 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 08:41:05 INFO - PROCESS | 1644 | RSS: Main: 192552960 08:41:05 INFO - PROCESS | 1644 | 08:44:07 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 08:44:08 INFO - PROCESS | 1644 | RSS: Main: 201424896 08:44:08 INFO - PROCESS | 1644 | 08:47:10 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 08:47:10 INFO - PROCESS | 1644 | RSS: Main: 206635008 08:47:10 INFO - PROCESS | 1644 | 08:50:12 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 08:50:13 INFO - PROCESS | 1644 | RSS: Main: 209690624 08:50:13 INFO - PROCESS | 1644 | 08:53:15 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 08:53:16 INFO - PROCESS | 1644 | RSS: Main: 210403328 08:53:16 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 08:56:19 INFO - PROCESS | 1644 | RSS: Main: 214130688 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | __start_tp_report 08:56:19 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 08:56:19 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 08:56:19 INFO - PROCESS | 1644 | |i|pagename|runs| 08:56:19 INFO - PROCESS | 1644 | |0;dojo.html;3085.969140308597;3524.8413821378035;3551.698105661019;3580.1944562473445;3585.049961760132;5297.973510132449;5319.335083114611;5960.7317670704815;5967.224260846089;6063.757449702018;6003.279606447221;6008.639481631105;6066.423689749467;6085.4827339676185;6110.969445152779;5326.813561525338;5395.082835917884;5427.565794736412;5430.456954304557;5446.509814116729;5441.7279136043235;5451.373092094401;5454.7272636368225;5466.769976755238;5472.72636368182;5316.096263635172;5325.254464374991;5448.210009548613;5453.3728621208475;5501.669899806005;5375.247465354873;5383.757730902119;5429.837104886859;5430.13117901134;5496.560275177976;5322.973385133088;5410.702411367373;5427.864303392407;5428.348598168245;5433.1035379162395;4619.930701039487;4932.679375840559;5824.184614154022;6138.14066030756;6148.754049838001;6234.096056071844;6237.469815065725;6250.874982500324;6276.686165691743;6320.988641817333;6380.489560835122;6393.200849893763;6407.103005579223;6420.582662126947;6424.293327733945;6127.632342059446;6130.96934515329;6132.448079672851;6150.200473938359;6152.5693201475915;6290.370962903673;6317.46301564363;6398.200224971879;6436.13112229843;6475.384838440341;6162.168107305546;6216.751329946752;6217.347178546278;6228.159198508234;6234.1583886175695;6337.746490140435;6376.234851817719;6381.617102973836;6390.297067322591;6391.58454700443;6138.600990935575;6144.631322120687;6151.83115208109;6170.722317495633;6234.1583886175695;6185.659788711574;6214.720337584819;6218.720157592919;6219.751209951552;6261.436470717657;5096.566791822736;5099.4390617032095;5114.795408183705;5126.8974620508125;5131.332926719502;3761.962380376161;4411.558844115627;4554.84058057973;4565.817367305271;4607.331936869202;5040.873978150576;6132.570720049643;6134.5092392608485;6164.8767024659255;6181.567290289637;6380.680965951684;6394.104825324458;6395.104685344056;6408;6411;6052.757889684452;6118.893302669129;6120.325235636551;6129.478994285536;6178.289496707936;5720.799772007959;5736.569757268222;5739.454751798572;5740.799072032459;5767.106098554646;6610.702518386588;6620.172478440195;6638.83402914931;6648.7340506379205;6660.3672651100005;6206.689665516797;6262.968685156545;6360.809175724736;6394.872102558016;6421;6518.771842985473;6529.7061632227615;6559;6655.101561289164;6673.866522669422;6347.619142851444;6349.9682501587195;6356.682165891594;6357.23713154406;6383.808485745435;6214.533909956681;6388.265349484683;6392.0411938209645;6461.289258181502;6477.4170324671;5191.948080519146;6219.036049412348;6246.781362652286;6274.341194174546;6298.937010629835;6223.471004964447;6246.968765156145;6265.718042688181;6268.623882567061;6278.4035516625845;6116.357782432959;6259.65571893532;6259.843503912439;6271.43557079865;6305.337939516468;6194.845128871814;6199.442050215503;6236.688165591611;6242.3133455320785;6287;4557.4531056272135;5814.651120932757;6155.84610384744;6267.811965641038;6276.560640755103 08:56:19 INFO - PROCESS | 1644 | |1;ext.html;472.832144588671;486.42358804816286;498.1183305549176;520.6095428428679;531.0255680825685;28854.1343759687;44133.8966525837;44513;44567.77716111423;44573.33140002903;46274.537254627445;46763.53236467634;46790.7660461698;47016.52983470164;47041.52958470414;9570.904290957089;9766.804663906752;9768.755781105458;9791.314607977409;11192.776144477106;11264.267822591546;11504.424778761071;11523.250988685708;11523.308601483937;11525.942370288138;11439.771204575904;11469.08247340215;11488.540458381654;11498.080153587693;11503.827442588368;11376.772464550746;11411.714707132305;11444.427778611078;11468.885311146865;11480.540778368897;11398.316101033965;11426.828597571042;11456.4844581994;11458.82811757816;11475.196736228467;36626;36929;36946.8152659235;36987.63012369869;37037.814810925775;4079.5308539518037;4086.162336720995;4108.77401742904;4174.039970806732;4186.162767446523;24291.663958482277;28037;28769.28076798076;28995.855020724972;30511;3196.31279274957;3284.802911825298;3317.834108294576;3384.729221662261;3464.3764122457947;420258;507732;510061;512676;515927;59996;60789.392106079256;60859.69570152121;60900;61257.69371153116;63308;63627;63727.36272637307;64011.67994160092;64117.67941160264;16449.930754500918;17214.05322707238;17223;17232.310707571807;17267.74098388525;12231.143819932697;12548.686282843002;13234.205947643171;13974;14040.017198796191;22210.66683999709;22647.094116235494;22678.546429071655;23067;23125.95933183011;8851.867221991546;9059.864102038475;9071.682491112912;9100.954495227481;9136.451812891248;905.8369493491103;925.5141050948172;929.2333824594737;947.7962238118838;955.19763398744;31637.8418107908;32172;32381.514277285387;32410.513842292385;32928;1089.2103225161695;1101.7410908436511;1119.972000699989;1144.3134119528218;1155.3356819828464;14909.628032775416;16293.51119466418;16404.343826247055;16468.258928348252;17144.742828857576;574389;961352;964788;978183;978251;50423.49576504188;56120.43879561234;57699.13451298234;57718.42281577131;57880.71059644675;1499.9775003374957;1503.8721708654887;1529.9541013769383;1533.9156346400832;1534.8004759381433;27912.58131127994;29044.27389315284;29429.558556622094;29952.801887924237;31145.37709245848;49824.50175498344;49939.250911235635;50192;50450.990980180926;50478.49521504738;558119.2094039504;632744.8362758341;635384;635464;639285.4107188303;24185;24791.132310369052;26671.46657066809;26718;27445.588316174875;43583.56416435795;43967;44862.775686121364;45392.09215815731;45457;30092.548611770402;30562.541561877035;30853;31204.843975779975;32096.518552221267;29437.705622943497;30612;31075.533866992464;31673.36653266968;31926.840365798023;35854.28291434104;36621;36846.44730328993;36921.63078369182;37009.889703308945;27067.187984360502;30972.690273097884;31234;31462.528062079546;31740.682593173773;19943;24647.630285545372;24704.7647617622;25077.247682569552;25196 08:56:19 INFO - PROCESS | 1644 | |2;jquery.html;404.3752402538078;404.64391335624646;409.88932988093205;413.70626854933005;430.6920551805458;20533.589328213446;20931.581368372663;21181.894090529524;21271.680924786142;21938.561228775416;21657.241996530123;21698.783012169875;22020.449488762788;22088.33734987949;22557.887210563924;5774.220480235156;6086.573939824192;6090.299615544225;6097.939020609781;6110.480609148228;5814.912776308359;5940.702964851762;5978.671173085479;5995.760169593211;6011.75952961881;5935.49548288396;5943.138244954479;5957.553183511232;5961.552883533731;5972.611780234292;4942.728149951751;5737.110747834093;5915.526757859361;5919.408059194067;5943.108533719934;5189.922151167735;5236.005159019812;5250.658707184059;5256.8685782855355;5257;26141.823617937047;26428.207153785224;26496.73503264962;26727.331816704544;26785.79463924128;2738.5344491436304;2762.709915458888;2778.8332700038063;2789.5257806172795;2802.1453456695904;15296.311665975058;15417.537473875802;15538;15611.219439028117;15902.920485397499;1700.7363858601936;1731.1084791332473;1894.194967138974;1907.4563749331512;1915.24347882587;129369;130977;131695;133335;135170;11963.940180299216;11983.400829958468;12136.33250171249;12148.331841748612;12545.435455404346;16248.025118492691;16248.75626865598;16250.918745406198;16269.430569929995;16286.674266514603;7877.842443151105;8536.847525584091;9085.77285567853;9127;9154.99295077541;8960.327975401871;8979.922409310924;9036.81926361469;9174.311926605398;9193.080691930754;4889.144399730033;4934.9013019739405;4966.726830024383;4970.925436118461;5005.299258103868;2049.2028381259474;2083.666613341858;2087.937361879146;2094.895255237232;2101.233049936762;808.5068108453838;912.5574096563162;958.7794807194384;1033.1682995188944;1034.99482502587;20467;22598.887005564866;22663.093476261096;22696;22762.886185568965;1044.2220545693508;1061.4586560853866;1085.137315833914;1100.7743412600398;1106.778644271149;9348.532573371303;9844.310898237054;9916.008399160171;10707.518161682743;11072.723181920355;756506;764035;766791.2636319326;774196;789995;139683;144312;149323;151440.2427987875;161899.19050404674;1008.7175590834578;1058.571278632155;1083.8861919498497;1086.896744809242;1094.5676457799125;15825;19954.30159944395;20551.280705175246;20711.171553137705;20851.374458766262;48891.75554122207;50768.49231507638;56721.43278567161;62875.685621571596;63727.6813615929;89367.55316223377;89491.55254223687;91250.54374728349;92786.53606731923;92833;7493.587852668155;7846.646900889587;8465.915340846514;8701.956490217508;8965.596548155218;11637.650870473899;12630.621081367573;13074.28091454979;13373.465061397825;13418.792308692264;8916.420432671855;11523.250988686044;11627.825582616098;11811.350375729073;11820.940895295469;8616.870746938675;10339.638112666322;10590.576376944837;10687.358758474516;10727.892721073002;11515.884841151816;11568.826467603161;11583.42082895835;11834.940825295818;11999.280043197436;7640.80897977555;7705.728554788621;7729;7876.369890408868;8023.719169829262;8351.373646976623;10683.94658026705;11560.42197890119;11581.189316747746;11861.881381186078 08:56:19 INFO - PROCESS | 1644 | |3;mootools.html;1415.6814716688739;1485.8885583581234;1493.6340596553844;1497.408523633165;1503.827059888113;7661.118971318286;7911.841763164748;8239.711610093647;8644.783880402985;8655.78360540986;8169.877451838227;8430.072692003874;8443.282321002707;8565.400421970464;8567.785805354853;2268.12677119309;2302.6085565453827;2307.9884600576975;2308.549832782608;2313.109452860644;2427.2111563741764;2437.122635851092;2456.1403508771964;2456.5455390752677;2461;2379.809615230786;2404.326788499223;2410.915617953372;2419;2434.1237154624323;2373.9525209495887;2381.868997205153;2396.496735685508;2398.016813106618;2402.5675378431874;2374.263978166774;2408.6989126359204;2416.794572461343;2432.477017441259;2441.8779061047053;7414.925850741478;8512.489250644981;8538.231559159643;8567.657293708244;8620.482771033758;5206.921896171561;5350.3312085989255;5359.517643412073;5364.839054828361;5365.463453654604;3585.579733679782;3606.963930360689;3613.6747692707518;3643.908902277438;3692.335379631665;1269.3272565540278;1271.5486002469083;1300.1678925487695;1317.4993502469097;1322.3784821134052;10979.560817567368;11027.117830573536;11047.281926674821;11051.502682379232;11064.336139831636;3995.62041606047;4684.929726054112;4822.445418776815;4867.537583929521;4869.050535145612;9599.712008639752;9685.70942871715;9697.224222062217;9703;9717.319787614799;5321.547668448148;5344.759485823147;5421.972890135603;5425.9186112208345;5429.511343979061;4346.456692913386;4466.6203372713035;4604;4804.702730262879;4915.090708218991;3931.4889064422014;3973.006748312922;3986.7641031280396;4064.146529228836;4076.2458945095254;1234.1484375780683;1319.0436933223336;1323.7815760399426;1324.675454513631;1328.3225554967037;936.4568550240843;944.187998321443;951.7573018880141;962.6101428921158;967.6371360739722;5536.695481748542;5604.719764011783;5759.481646651821;5893.204417403681;5898.14476900847;584.1908956095838;584.2959234122872;595.8540157661314;602.4156568128908;612.0818771842237;3762.774233545996;3798.867039653599;3799.848006079781;3898.571157172709;3917.5298964123917;9131;10294.227932905062;10310.587576496857;10328.070473657257;10345.27583069193;9960.950195248977;10223.852990872001;10231.59073637061;10256.58973641046;10261.640842570474;8118.797030074295;8119.594020298961;8124.471909325875;8142.145074767182;8168.387370947203;5510.779568817363;5523.116301391758;5558.221848941071;5728.484436400744;5821.679807610622;9439.716808495756;9477.810443791224;9583;9605.663801766905;9648.75878103025;9380.67167649129;9473.721047658479;9508.714738557854;9598.760030999281;9650.806983860142;7243.492955493276;7315.049043624294;7381.778546643609;7388.408927285912;7406.740764073232;7982.481138725964;7994.960025200069;8053.395995300259;8088.636011379384;8097.39269554774;7005.649717514206;7031.964840175767;7054.506184567236;7190.928090719026;7193.748218812317;6756;6883.380495755406;6885.173779146535;6890.896636550556;6898.275681053417;6141.815745527641;6464.256610489666;6601.33986601336;6606.570572912938;6615.966920165369;4728.668993170445;4809.0862736080035;4819.927701084416;4830.372051633265;4832.95167048339;4623.398958135421;4634.814607415666;4706;4817.542333478314;4865.1242776300605 08:56:19 INFO - PROCESS | 1644 | |4;prototype.html;300.37372079214833;340.5249676701002;367.48552027161986;379.7702390054017;387.55044148787414;5338.786448542059;5364.758585863636;5540.529055030317;5643.915341269879;5684.431556844308;5382.327209098863;5454.54545454545;5500.167413781905;5542.4457554244555;5550.222968784374;4290.999999999992;4345.587169218919;4345.760983145926;4357.3899654048455;4368.344748287766;4239.40648309237;4281.850135245267;4312.568743125694;4382.561743825624;4413.984783499797;3522.7181825453904;3912.3740201567753;4287.6569874410125;4302.225599392108;4314.3528470729325;3519.331327047853;4010.3382941814566;4277.978610106945;4294.613484786369;4325.264705000126;3219.3722224166295;3226.548283240325;3374.9325013499592;3850.961490385116;3874.728768986172;4927.359443272388;5271.182966640177;5353.57171426285;5359.606502309389;5367.677939323653;5022.4224214215465;5025.522575355372;5030.84907452777;5038;5063.898722025576;4425.867223983286;5880.235569375954;5883.823485295448;5886.970565147147;5943.009091954201;4133.793310334471;4223.408722778813;4268.399350243659;4281.978590107061;4292.9393890932215;5161.690298582097;5585.067839384315;6167.321594624587;6193.535484838655;6198.566100372976;3675.687566556819;3849.268638958589;4198.580141985777;4377.956220437819;4388.210122178039;3574.4102223133414;3666.5783434904793;4412.117576484716;4442.888927776831;4444.488883778342;5043.924341134886;5048.3184770056305;5067.163917953497;5067.239914012854;5079.23181865884;4795.520447955177;5218.895622087537;5968.343482216953;5989.730462129215;5999.92001439745;1216.9716589481873;1394.8256467941508;1460.1312219229542;1464.3776395032069;1469.9489864746758;908.9000209976897;952.642758965388;1019.658414431159;1027.50679673757;1031.9690409287734;4443.37792709021;4941.654084214142;5039.672421292605;5253.789848406097;5335.692755274982;5218.66078704883;5356.437574054746;5602.523785478198;5860.589758716849;5879.265091863517;4785.521447855187;4805.303231031481;5188.507091826271;5332.306800116037;5372.946270537323;2530.8993535365603;2637.485690290375;2782.8173026463674;2969.9655735821034;3052.862621182008;5154.871128221825;5365.785368585213;5408.3509978802795;5568.693721845257;5582.665040097607;5415.835595347019;5664.54683625309;5958.493528050078;6014.6391216527145;6054.8183554493435;5110.693358398434;5247.454984332596;5670.5463562914865;6052.727627256784;6094.531714655572;4601.755762187717;4936.333594964777;5178;5504.330399756195;5606.635568688022;4865.099956508057;5509.135249670229;5669.858253543694;5750.6262092963825;5772.074989007515;5312.468753124656;5466.098093814476;5554.861128471821;5586.916196257141;6120.898238317146;3497.527833742514;3720.014196238053;3843.0016391476834;3862.845486180521;3875.256134739435;5749.051406518045;5909.31584498433;5949.494292985145;5966.254218222723;6023.548233882389;4795.544423279783;5828.825135245949;5830.5044071254415;5866.2373891393845;5866.970665146818;5537.207013195974;5801.796937107181;5829.5336373090895;5859.9121013183985;5869.911951320819;5253.8178909745;5695.373508914099;5719.771209151754;5726.341470730919;5746.42535746422;4459.799309031167;5514.310711161105;5731.996900542472;5861.912071319019;5892.469677729025;4816.518348165156;4998.550130488274;5237.450067742984;5792.94207057924;5843.328017277898 08:56:19 INFO - PROCESS | 1644 | |5;yui.html;719.7984564321991;740.2375553180225;756.59900252866;816.9420600322582;855.4097672605903;15285.847141528582;15858.444954426597;16147.757783633255;16250.431234906795;16329.673406531861;14437.205953672545;14582.708345833076;14693.265336733148;14758.778618320734;14761.18813465259;694.357719109824;708.355396589104;726.6366816591704;880.3881302494768;883.0551310098182;862.9395942284043;867.7440155154213;872.9432586881865;875.2866413872705;876.1939016105199;927.14702473724;949.264320151881;962.6341990043774;962.8988956159608;965.0879918477042;828.668532586964;921.8847644044495;945.3854994253721;957.9616815327379;961.2070042215131;579.2007030298204;704.2921863527174;716.5163514627606;720.1358369956074;721.1202333153544;12546.749065018648;15509.922450387789;15531.5340539784;15788.763168552481;16383.754243686355;15144.318505667272;15304;15320.310586023656;15323.31045102962;15371;10251.79496410075;11671.416429178507;11819.763604727943;11990.460429280616;11997.280163190237;3739.775613463201;3866.2654095722005;3870;3957.6240257175523;4095.1195492969155;90497;104643.4767826156;104944.95055049428;110295;110503.78992420188;9571.234301255883;11101.278416902875;11530.365829879269;11632.83671632847;11850;24858;25016.874240659214;25059.4988100237;25095.749042509706;25122.748772512405;8094.15011423792;8155.918440815634;8205.753827385188;8214.958925205336;8253.628586713612;4436.8447104351835;4440.33394990754;4499.887502812456;4614.76926153691;4616.1229366420275;3744.8689295874515;3793.5447746270074;3796.6583007529457;3826.0626146594263;3841.769493830379;678.8994473380725;691.595416681237;696.7805141380449;698.4203111417511;708.7023450150949;566.7308028686424;711.8718630646533;719.665355609644;723.2080871445759;748.6032402826511;9590.952045239728;10661.680149595524;10738.688919168988;10786.352818830896;10974.725631859268;664.259350823828;724.5688815154974;735.4331492262484;744.0884915977883;746.4811955690743;4834.806607735722;4834.975825120852;5110.28456016158;5136.8202112925865;5164.535191832753;107516.9248307507;109136.4543177279;109427;110062.44968775265;110120;87249;89391.55304223437;90309.54845225863;90399.09600904038;92885.071149289;80565;81923.18076819275;83139.58430207931;83404;83491.58254208691;9757.560909758937;9953.353032052893;10014.499275036365;10021.74945626336;10023.248256380946;46382.768086159354;54200.72899635477;54277;54530.454695452536;55337.44662553323;65982;70092.89721308369;72020.63989680017;72196;72901.6354918222;11206.887931120584;11442.94278528602;11754.941225293818;11869.347185904859;12773.850353468233;12784.936075319563;13270.203787772765;15250.389984400499;15664.921675392006;15991.440299589924;13705.931470342584;14118;14442;14543.490977815725;14973.608852259305;13844.930775346058;14082.647933801736;14268;14636.487722929647;14710.779338310149;13709.97175211883;13998;14078.648033799236;14308.713825723635;14359.569212923629;9710.898440228659;9926.057024582653;10003.2997690161;10182;10308.175345972155;10284.742881428025;10876.45617719095;11496.88503114958;11623.244489108181;12045.277283363026 08:56:19 INFO - PROCESS | 1644 | __end_tp_report 08:56:19 INFO - PROCESS | 1644 | __start_cc_report 08:56:19 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,370 08:56:19 INFO - PROCESS | 1644 | __end_cc_report 08:56:19 INFO - PROCESS | 1644 | __startTimestamp1491839779522__endTimestamp 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | ------- Summary: start ------- 08:56:19 INFO - PROCESS | 1644 | Number of tests: 6 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5897.42 Median:6170.72 stddev:681.59 (11.0%) stddev-sans-first:647.01 08:56:19 INFO - PROCESS | 1644 | Values: 3086.0 3524.8 3551.7 3580.2 3585.0 5298.0 5319.3 5960.7 5967.2 6063.8 6003.3 6008.6 6066.4 6085.5 6111.0 5326.8 5395.1 5427.6 5430.5 5446.5 5441.7 5451.4 5454.7 5466.8 5472.7 5316.1 5325.3 5448.2 5453.4 5501.7 5375.2 5383.8 5429.8 5430.1 5496.6 5323.0 5410.7 5427.9 5428.3 5433.1 4619.9 4932.7 5824.2 6138.1 6148.8 6234.1 6237.5 6250.9 6276.7 6321.0 6380.5 6393.2 6407.1 6420.6 6424.3 6127.6 6131.0 6132.4 6150.2 6152.6 6290.4 6317.5 6398.2 6436.1 6475.4 6162.2 6216.8 6217.3 6228.2 6234.2 6337.7 6376.2 6381.6 6390.3 6391.6 6138.6 6144.6 6151.8 6170.7 6234.2 6185.7 6214.7 6218.7 6219.8 6261.4 5096.6 5099.4 5114.8 5126.9 5131.3 3762.0 4411.6 4554.8 4565.8 4607.3 5040.9 6132.6 6134.5 6164.9 6181.6 6380.7 6394.1 6395.1 6408.0 6411.0 6052.8 6118.9 6120.3 6129.5 6178.3 5720.8 5736.6 5739.5 5740.8 5767.1 6610.7 6620.2 6638.8 6648.7 6660.4 6206.7 6263.0 6360.8 6394.9 6421.0 6518.8 6529.7 6559.0 6655.1 6673.9 6347.6 6350.0 6356.7 6357.2 6383.8 6214.5 6388.3 6392.0 6461.3 6477.4 5191.9 6219.0 6246.8 6274.3 6298.9 6223.5 6247.0 6265.7 6268.6 6278.4 6116.4 6259.7 6259.8 6271.4 6305.3 6194.8 6199.4 6236.7 6242.3 6287.0 4557.5 5814.7 6155.8 6267.8 6276.6 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:78327.79 Median:32396.01 stddev:187609.66 (579.1%) stddev-sans-first:188044.89 08:56:19 INFO - PROCESS | 1644 | Values: 472.8 486.4 498.1 520.6 531.0 28854.1 44133.9 44513.0 44567.8 44573.3 46274.5 46763.5 46790.8 47016.5 47041.5 9570.9 9766.8 9768.8 9791.3 11192.8 11264.3 11504.4 11523.3 11523.3 11525.9 11439.8 11469.1 11488.5 11498.1 11503.8 11376.8 11411.7 11444.4 11468.9 11480.5 11398.3 11426.8 11456.5 11458.8 11475.2 36626.0 36929.0 36946.8 36987.6 37037.8 4079.5 4086.2 4108.8 4174.0 4186.2 24291.7 28037.0 28769.3 28995.9 30511.0 3196.3 3284.8 3317.8 3384.7 3464.4 420258.0 507732.0 510061.0 512676.0 515927.0 59996.0 60789.4 60859.7 60900.0 61257.7 63308.0 63627.0 63727.4 64011.7 64117.7 16449.9 17214.1 17223.0 17232.3 17267.7 12231.1 12548.7 13234.2 13974.0 14040.0 22210.7 22647.1 22678.5 23067.0 23126.0 8851.9 9059.9 9071.7 9101.0 9136.5 905.8 925.5 929.2 947.8 955.2 31637.8 32172.0 32381.5 32410.5 32928.0 1089.2 1101.7 1120.0 1144.3 1155.3 14909.6 16293.5 16404.3 16468.3 17144.7 574389.0 961352.0 964788.0 978183.0 978251.0 50423.5 56120.4 57699.1 57718.4 57880.7 1500.0 1503.9 1530.0 1533.9 1534.8 27912.6 29044.3 29429.6 29952.8 31145.4 49824.5 49939.3 50192.0 50451.0 50478.5 558119.2 632744.8 635384.0 635464.0 639285.4 24185.0 24791.1 26671.5 26718.0 27445.6 43583.6 43967.0 44862.8 45392.1 45457.0 30092.5 30562.5 30853.0 31204.8 32096.5 29437.7 30612.0 31075.5 31673.4 31926.8 35854.3 36621.0 36846.4 36921.6 37009.9 27067.2 30972.7 31234.0 31462.5 31740.7 19943.0 24647.6 24704.8 25077.2 25196.0 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:41659.44 Median:24452.35 stddev:128028.53 (523.6%) stddev-sans-first:128350.20 08:56:19 INFO - PROCESS | 1644 | Values: 404.4 404.6 409.9 413.7 430.7 20533.6 20931.6 21181.9 21271.7 21938.6 21657.2 21698.8 22020.4 22088.3 22557.9 5774.2 6086.6 6090.3 6097.9 6110.5 5814.9 5940.7 5978.7 5995.8 6011.8 5935.5 5943.1 5957.6 5961.6 5972.6 4942.7 5737.1 5915.5 5919.4 5943.1 5189.9 5236.0 5250.7 5256.9 5257.0 26141.8 26428.2 26496.7 26727.3 26785.8 2738.5 2762.7 2778.8 2789.5 2802.1 15296.3 15417.5 15538.0 15611.2 15902.9 1700.7 1731.1 1894.2 1907.5 1915.2 129369.0 130977.0 131695.0 133335.0 135170.0 11963.9 11983.4 12136.3 12148.3 12545.4 16248.0 16248.8 16250.9 16269.4 16286.7 7877.8 8536.8 9085.8 9127.0 9155.0 8960.3 8979.9 9036.8 9174.3 9193.1 4889.1 4934.9 4966.7 4970.9 5005.3 2049.2 2083.7 2087.9 2094.9 2101.2 808.5 912.6 958.8 1033.2 1035.0 20467.0 22598.9 22663.1 22696.0 22762.9 1044.2 1061.5 1085.1 1100.8 1106.8 9348.5 9844.3 9916.0 10707.5 11072.7 756506.0 764035.0 766791.3 774196.0 789995.0 139683.0 144312.0 149323.0 151440.2 161899.2 1008.7 1058.6 1083.9 1086.9 1094.6 15825.0 19954.3 20551.3 20711.2 20851.4 48891.8 50768.5 56721.4 62875.7 63727.7 89367.6 89491.6 91250.5 92786.5 92833.0 7493.6 7846.6 8465.9 8702.0 8965.6 11637.7 12630.6 13074.3 13373.5 13418.8 8916.4 11523.3 11627.8 11811.4 11820.9 8616.9 10339.6 10590.6 10687.4 10727.9 11515.9 11568.8 11583.4 11834.9 11999.3 7640.8 7705.7 7729.0 7876.4 8023.7 8351.4 10683.9 11560.4 11581.2 11861.9 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5526.99 Median:5347.55 stddev:3019.57 (56.5%) stddev-sans-first:3012.23 08:56:19 INFO - PROCESS | 1644 | Values: 1415.7 1485.9 1493.6 1497.4 1503.8 7661.1 7911.8 8239.7 8644.8 8655.8 8169.9 8430.1 8443.3 8565.4 8567.8 2268.1 2302.6 2308.0 2308.5 2313.1 2427.2 2437.1 2456.1 2456.5 2461.0 2379.8 2404.3 2410.9 2419.0 2434.1 2374.0 2381.9 2396.5 2398.0 2402.6 2374.3 2408.7 2416.8 2432.5 2441.9 7414.9 8512.5 8538.2 8567.7 8620.5 5206.9 5350.3 5359.5 5364.8 5365.5 3585.6 3607.0 3613.7 3643.9 3692.3 1269.3 1271.5 1300.2 1317.5 1322.4 10979.6 11027.1 11047.3 11051.5 11064.3 3995.6 4684.9 4822.4 4867.5 4869.1 9599.7 9685.7 9697.2 9703.0 9717.3 5321.5 5344.8 5422.0 5425.9 5429.5 4346.5 4466.6 4604.0 4804.7 4915.1 3931.5 3973.0 3986.8 4064.1 4076.2 1234.1 1319.0 1323.8 1324.7 1328.3 936.5 944.2 951.8 962.6 967.6 5536.7 5604.7 5759.5 5893.2 5898.1 584.2 584.3 595.9 602.4 612.1 3762.8 3798.9 3799.8 3898.6 3917.5 9131.0 10294.2 10310.6 10328.1 10345.3 9961.0 10223.9 10231.6 10256.6 10261.6 8118.8 8119.6 8124.5 8142.1 8168.4 5510.8 5523.1 5558.2 5728.5 5821.7 9439.7 9477.8 9583.0 9605.7 9648.8 9380.7 9473.7 9508.7 9598.8 9650.8 7243.5 7315.0 7381.8 7388.4 7406.7 7982.5 7995.0 8053.4 8088.6 8097.4 7005.6 7032.0 7054.5 7190.9 7193.7 6756.0 6883.4 6885.2 6890.9 6898.3 6141.8 6464.3 6601.3 6606.6 6616.0 4728.7 4809.1 4819.9 4830.4 4833.0 4623.4 4634.8 4706.0 4817.5 4865.1 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4670.20 Median:5169.85 stddev:1397.64 (27.0%) stddev-sans-first:1362.53 08:56:19 INFO - PROCESS | 1644 | Values: 300.4 340.5 367.5 379.8 387.6 5338.8 5364.8 5540.5 5643.9 5684.4 5382.3 5454.5 5500.2 5542.4 5550.2 4291.0 4345.6 4345.8 4357.4 4368.3 4239.4 4281.9 4312.6 4382.6 4414.0 3522.7 3912.4 4287.7 4302.2 4314.4 3519.3 4010.3 4278.0 4294.6 4325.3 3219.4 3226.5 3374.9 3851.0 3874.7 4927.4 5271.2 5353.6 5359.6 5367.7 5022.4 5025.5 5030.8 5038.0 5063.9 4425.9 5880.2 5883.8 5887.0 5943.0 4133.8 4223.4 4268.4 4282.0 4292.9 5161.7 5585.1 6167.3 6193.5 6198.6 3675.7 3849.3 4198.6 4378.0 4388.2 3574.4 3666.6 4412.1 4442.9 4444.5 5043.9 5048.3 5067.2 5067.2 5079.2 4795.5 5218.9 5968.3 5989.7 5999.9 1217.0 1394.8 1460.1 1464.4 1469.9 908.9 952.6 1019.7 1027.5 1032.0 4443.4 4941.7 5039.7 5253.8 5335.7 5218.7 5356.4 5602.5 5860.6 5879.3 4785.5 4805.3 5188.5 5332.3 5372.9 2530.9 2637.5 2782.8 2970.0 3052.9 5154.9 5365.8 5408.4 5568.7 5582.7 5415.8 5664.5 5958.5 6014.6 6054.8 5110.7 5247.5 5670.5 6052.7 6094.5 4601.8 4936.3 5178.0 5504.3 5606.6 4865.1 5509.1 5669.9 5750.6 5772.1 5312.5 5466.1 5554.9 5586.9 6120.9 3497.5 3720.0 3843.0 3862.8 3875.3 5749.1 5909.3 5949.5 5966.3 6023.5 4795.5 5828.8 5830.5 5866.2 5867.0 5537.2 5801.8 5829.5 5859.9 5869.9 5253.8 5695.4 5719.8 5726.3 5746.4 4459.8 5514.3 5732.0 5861.9 5892.5 4816.5 4998.6 5237.5 5792.9 5843.3 08:56:19 INFO - PROCESS | 1644 | 08:56:19 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:21162.00 Median:3913.81 stddev:30279.03 (773.6%) stddev-sans-first:30325.06 08:56:19 INFO - PROCESS | 1644 | Values: 719.8 740.2 756.6 816.9 855.4 15285.8 15858.4 16147.8 16250.4 16329.7 14437.2 14582.7 14693.3 14758.8 14761.2 694.4 708.4 726.6 880.4 883.1 862.9 867.7 872.9 875.3 876.2 927.1 949.3 962.6 962.9 965.1 828.7 921.9 945.4 958.0 961.2 579.2 704.3 716.5 720.1 721.1 12546.7 15509.9 15531.5 15788.8 16383.8 15144.3 15304.0 15320.3 15323.3 15371.0 10251.8 11671.4 11819.8 11990.5 11997.3 3739.8 3866.3 3870.0 3957.6 4095.1 90497.0 104643.5 104945.0 110295.0 110503.8 9571.2 11101.3 11530.4 11632.8 11850.0 24858.0 25016.9 25059.5 25095.7 25122.7 8094.2 8155.9 8205.8 8215.0 8253.6 4436.8 4440.3 4499.9 4614.8 4616.1 3744.9 3793.5 3796.7 3826.1 3841.8 678.9 691.6 696.8 698.4 708.7 566.7 711.9 719.7 723.2 748.6 9591.0 10661.7 10738.7 10786.4 10974.7 664.3 724.6 735.4 744.1 746.5 4834.8 4835.0 5110.3 5136.8 5164.5 107516.9 109136.5 109427.0 110062.4 110120.0 87249.0 89391.6 90309.5 90399.1 92885.1 80565.0 81923.2 83139.6 83404.0 83491.6 9757.6 9953.4 10014.5 10021.7 10023.2 46382.8 54200.7 54277.0 54530.5 55337.4 65982.0 70092.9 72020.6 72196.0 72901.6 11206.9 11442.9 11754.9 11869.3 12773.9 12784.9 13270.2 15250.4 15664.9 15991.4 13705.9 14118.0 14442.0 14543.5 14973.6 13844.9 14082.6 14268.0 14636.5 14710.8 13710.0 13998.0 14078.6 14308.7 14359.6 9710.9 9926.1 10003.3 10182.0 10308.2 10284.7 10876.5 11496.9 11623.2 12045.3 08:56:19 INFO - PROCESS | 1644 | -------- Summary: end -------- 08:56:19 INFO - PROCESS | 1644 | 08:56:20 INFO - TEST-INFO | 1644: exit 0 08:56:20 INFO - TEST-OK | dromaeo_css | took 1114117ms 08:56:20 INFO - TEST-START | kraken 08:56:20 INFO - operating with platform_type : mac_ 08:56:20 INFO - Initialising browser for kraken test... 08:56:20 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpZNjtJP/profile http://localhost:49236/getInfo.html) 08:56:22 INFO - PROCESS | 1655 | 2017-04-10 08:56:22.816 plugin-container[1657:9774] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 08:56:22 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:22 INFO - PROCESS | 1655 | 2017-04-10 08:56:22.817 plugin-container[1657:9774] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x432b, name = 'com.apple.CFPasteboardClient' 08:56:22 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:22 INFO - PROCESS | 1655 | 2017-04-10 08:56:22.817 plugin-container[1657:9774] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:56:22 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 08:56:22 INFO - PROCESS | 1655 | colorDepth:24 08:56:22 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 08:56:22 INFO - PROCESS | 1655 | __metrics 08:56:22 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 08:56:23 INFO - TEST-INFO | 1655: exit 0 08:56:23 INFO - Browser initialized. 08:56:23 INFO - Running cycle 1/1 for kraken test... 08:56:23 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpZNjtJP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:56:25 INFO - PROCESS | 1658 | 2017-04-10 08:56:25.809 plugin-container[1659:9903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 08:56:25 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:25 INFO - PROCESS | 1658 | 2017-04-10 08:56:25.810 plugin-container[1659:9903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x450b, name = 'com.apple.CFPasteboardClient' 08:56:25 INFO - PROCESS | 1658 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:56:25 INFO - PROCESS | 1658 | 2017-04-10 08:56:25.810 plugin-container[1659:9903] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:56:35 INFO - PROCESS | 1658 | RSS: Main: 173105152 08:56:35 INFO - PROCESS | 1658 | 08:56:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 08:56:39 INFO - PROCESS | 1658 | RSS: Main: 186064896 08:56:39 INFO - PROCESS | 1658 | 08:56:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 08:56:42 INFO - PROCESS | 1658 | RSS: Main: 193871872 08:56:42 INFO - PROCESS | 1658 | 08:56:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 08:56:46 INFO - PROCESS | 1658 | RSS: Main: 197812224 08:56:46 INFO - PROCESS | 1658 | 08:56:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 08:56:49 INFO - PROCESS | 1658 | RSS: Main: 198057984 08:56:49 INFO - PROCESS | 1658 | 08:56:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:56:51 INFO - PROCESS | 1658 | RSS: Main: 198094848 08:56:51 INFO - PROCESS | 1658 | 08:56:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 08:56:55 INFO - PROCESS | 1658 | RSS: Main: 202178560 08:56:55 INFO - PROCESS | 1658 | 08:56:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 08:56:58 INFO - PROCESS | 1658 | RSS: Main: 203739136 08:56:58 INFO - PROCESS | 1658 | 08:57:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 08:57:02 INFO - PROCESS | 1658 | RSS: Main: 202899456 08:57:02 INFO - PROCESS | 1658 | 08:57:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:57:04 INFO - PROCESS | 1658 | RSS: Main: 202137600 08:57:04 INFO - PROCESS | 1658 | 08:57:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:57:07 INFO - PROCESS | 1658 | RSS: Main: 202219520 08:57:07 INFO - PROCESS | 1658 | 08:57:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:57:10 INFO - PROCESS | 1658 | RSS: Main: 202104832 08:57:10 INFO - PROCESS | 1658 | 08:57:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:57:13 INFO - PROCESS | 1658 | RSS: Main: 202399744 08:57:13 INFO - PROCESS | 1658 | 08:57:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:57:17 INFO - PROCESS | 1658 | RSS: Main: 202547200 08:57:17 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 08:57:19 INFO - PROCESS | 1658 | RSS: Main: 204279808 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | __start_tp_report 08:57:19 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 08:57:19 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 08:57:19 INFO - PROCESS | 1658 | |i|pagename|runs| 08:57:19 INFO - PROCESS | 1658 | |0;ai-astar;83;168;172;143;118;126;123;117;118;113 08:57:19 INFO - PROCESS | 1658 | |1;audio-beat-detection;138;106;110;140;114;108;111;114;110;126 08:57:19 INFO - PROCESS | 1658 | |2;audio-dft;263;254;192;198;194;197;195;195;194;197 08:57:19 INFO - PROCESS | 1658 | |3;audio-fft;80;59;59;88;53;70;81;84;98;59 08:57:19 INFO - PROCESS | 1658 | |4;audio-oscillator;86;71;83;76;86;103;96;68;71;80 08:57:19 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;89;87;88;119;90;87;91;85;80;116 08:57:19 INFO - PROCESS | 1658 | |6;imaging-darkroom;95;96;94;96;96;151;135;94;124;153 08:57:19 INFO - PROCESS | 1658 | |7;imaging-desaturate;99;122;96;140;85;149;80;142;76;101 08:57:19 INFO - PROCESS | 1658 | |8;json-parse-financial;59;58;58;59;61;63;61;61;62;61 08:57:19 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;69;71;74;75;76;69;69;72;73;70 08:57:19 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;81;83;85;85;84;84;86;87;102;71 08:57:19 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;122;181;151;151;135;137;140;151;155;125 08:57:19 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;171;165;164;200;228;176;167;209;222;156 08:57:19 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;63;65;66;65;64;63;65;65;67;72 08:57:19 INFO - PROCESS | 1658 | __end_tp_report 08:57:19 INFO - PROCESS | 1658 | __start_cc_report 08:57:19 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,925 08:57:19 INFO - PROCESS | 1658 | __end_cc_report 08:57:19 INFO - PROCESS | 1658 | __startTimestamp1491839839387__endTimestamp 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | ------- Summary: start ------- 08:57:19 INFO - PROCESS | 1658 | Number of tests: 14 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:128.10 Median:134.50 stddev:26.59 (19.8%) stddev-sans-first:22.64 08:57:19 INFO - PROCESS | 1658 | Values: 83.0 168.0 172.0 143.0 118.0 126.0 123.0 117.0 118.0 113.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:117.70 Median:114.00 stddev:12.47 (10.9%) stddev-sans-first:10.85 08:57:19 INFO - PROCESS | 1658 | Values: 138.0 106.0 110.0 140.0 114.0 108.0 111.0 114.0 110.0 126.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:207.90 Median:197.00 stddev:26.81 (13.6%) stddev-sans-first:19.67 08:57:19 INFO - PROCESS | 1658 | Values: 263.0 254.0 192.0 198.0 194.0 197.0 195.0 195.0 194.0 197.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:73.10 Median:80.50 stddev:15.21 (18.9%) stddev-sans-first:15.92 08:57:19 INFO - PROCESS | 1658 | Values: 80.0 59.0 59.0 88.0 53.0 70.0 81.0 84.0 98.0 59.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:82.00 Median:81.50 stddev:11.29 (13.9%) stddev-sans-first:11.89 08:57:19 INFO - PROCESS | 1658 | Values: 86.0 71.0 83.0 76.0 86.0 103.0 96.0 68.0 71.0 80.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:87.50 stddev:13.18 (15.1%) stddev-sans-first:13.89 08:57:19 INFO - PROCESS | 1658 | Values: 89.0 87.0 88.0 119.0 90.0 87.0 91.0 85.0 80.0 116.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:113.40 Median:94.50 stddev:24.86 (26.3%) stddev-sans-first:25.46 08:57:19 INFO - PROCESS | 1658 | Values: 95.0 96.0 94.0 96.0 96.0 151.0 135.0 94.0 124.0 153.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:109.00 Median:78.00 stddev:27.20 (34.9%) stddev-sans-first:28.61 08:57:19 INFO - PROCESS | 1658 | Values: 99.0 122.0 96.0 140.0 85.0 149.0 80.0 142.0 76.0 101.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:61.00 stddev:1.70 (2.8%) stddev-sans-first:1.74 08:57:19 INFO - PROCESS | 1658 | Values: 59.0 58.0 58.0 59.0 61.0 63.0 61.0 61.0 62.0 61.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.50 stddev:2.62 (3.6%) stddev-sans-first:2.57 08:57:19 INFO - PROCESS | 1658 | Values: 69.0 71.0 74.0 75.0 76.0 69.0 69.0 72.0 73.0 70.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:7.54 (8.9%) stddev-sans-first:7.87 08:57:19 INFO - PROCESS | 1658 | Values: 81.0 83.0 85.0 85.0 84.0 84.0 86.0 87.0 102.0 71.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:151.00 stddev:17.07 (11.3%) stddev-sans-first:15.98 08:57:19 INFO - PROCESS | 1658 | Values: 122.0 181.0 151.0 151.0 135.0 137.0 140.0 151.0 155.0 125.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:188.00 stddev:26.45 (14.1%) stddev-sans-first:27.51 08:57:19 INFO - PROCESS | 1658 | Values: 171.0 165.0 164.0 200.0 228.0 176.0 167.0 209.0 222.0 156.0 08:57:19 INFO - PROCESS | 1658 | 08:57:19 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:65.00 stddev:2.59 (4.0%) stddev-sans-first:2.59 08:57:19 INFO - PROCESS | 1658 | Values: 63.0 65.0 66.0 65.0 64.0 63.0 65.0 65.0 67.0 72.0 08:57:19 INFO - PROCESS | 1658 | -------- Summary: end -------- 08:57:19 INFO - PROCESS | 1658 | 08:57:20 INFO - TEST-INFO | 1658: exit 0 08:57:20 INFO - TEST-OK | kraken | took 60100ms 08:57:20 INFO - SUITE-END | took 1174s 08:57:20 INFO - Completed test suite (00:19:34) 08:57:20 INFO - javascript benchmark 08:57:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7521.2373764966915, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.969140308597, 3524.8413821378035, 3551.698105661019, 3580.1944562473445, 3585.049961760132, 5297.973510132449, 5319.335083114611, 5960.7317670704815, 5967.224260846089, 6063.757449702018, 6003.279606447221, 6008.639481631105, 6066.423689749467, 6085.4827339676185, 6110.969445152779, 5326.813561525338, 5395.082835917884, 5427.565794736412, 5430.456954304557, 5446.509814116729, 5441.7279136043235, 5451.373092094401, 5454.7272636368225, 5466.769976755238, 5472.72636368182, 5316.096263635172, 5325.254464374991, 5448.210009548613, 5453.3728621208475, 5501.669899806005, 5375.247465354873, 5383.757730902119, 5429.837104886859, 5430.13117901134, 5496.560275177976, 5322.973385133088, 5410.702411367373, 5427.864303392407, 5428.348598168245, 5433.1035379162395, 4619.930701039487, 4932.679375840559, 5824.184614154022, 6138.14066030756, 6148.754049838001, 6234.096056071844, 6237.469815065725, 6250.874982500324, 6276.686165691743, 6320.988641817333, 6380.489560835122, 6393.200849893763, 6407.103005579223, 6420.582662126947, 6424.293327733945, 6127.632342059446, 6130.96934515329, 6132.448079672851, 6150.200473938359, 6152.5693201475915, 6290.370962903673, 6317.46301564363, 6398.200224971879, 6436.13112229843, 6475.384838440341, 6162.168107305546, 6216.751329946752, 6217.347178546278, 6228.159198508234, 6234.1583886175695, 6337.746490140435, 6376.234851817719, 6381.617102973836, 6390.297067322591, 6391.58454700443, 6138.600990935575, 6144.631322120687, 6151.83115208109, 6170.722317495633, 6234.1583886175695, 6185.659788711574, 6214.720337584819, 6218.720157592919, 6219.751209951552, 6261.436470717657, 5096.566791822736, 5099.4390617032095, 5114.795408183705, 5126.8974620508125, 5131.332926719502, 3761.962380376161, 4411.558844115627, 4554.84058057973, 4565.817367305271, 4607.331936869202, 5040.873978150576, 6132.570720049643, 6134.5092392608485, 6164.8767024659255, 6181.567290289637, 6380.680965951684, 6394.104825324458, 6395.104685344056, 6408.0, 6411.0, 6052.757889684452, 6118.893302669129, 6120.325235636551, 6129.478994285536, 6178.289496707936, 5720.799772007959, 5736.569757268222, 5739.454751798572, 5740.799072032459, 5767.106098554646, 6610.702518386588, 6620.172478440195, 6638.83402914931, 6648.7340506379205, 6660.3672651100005, 6206.689665516797, 6262.968685156545, 6360.809175724736, 6394.872102558016, 6421.0, 6518.771842985473, 6529.7061632227615, 6559.0, 6655.101561289164, 6673.866522669422, 6347.619142851444, 6349.9682501587195, 6356.682165891594, 6357.23713154406, 6383.808485745435, 6214.533909956681, 6388.265349484683, 6392.0411938209645, 6461.289258181502, 6477.4170324671, 5191.948080519146, 6219.036049412348, 6246.781362652286, 6274.341194174546, 6298.937010629835, 6223.471004964447, 6246.968765156145, 6265.718042688181, 6268.623882567061, 6278.4035516625845, 6116.357782432959, 6259.65571893532, 6259.843503912439, 6271.43557079865, 6305.337939516468, 6194.845128871814, 6199.442050215503, 6236.688165591611, 6242.3133455320785, 6287.0, 4557.4531056272135, 5814.651120932757, 6155.84610384744, 6267.811965641038, 6276.560640755103], "value": 5855.074760797831, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.832144588671, 486.42358804816286, 498.1183305549176, 520.6095428428679, 531.0255680825685, 28854.1343759687, 44133.8966525837, 44513.0, 44567.77716111423, 44573.33140002903, 46274.537254627445, 46763.53236467634, 46790.7660461698, 47016.52983470164, 47041.52958470414, 9570.904290957089, 9766.804663906752, 9768.755781105458, 9791.314607977409, 11192.776144477106, 11264.267822591546, 11504.424778761071, 11523.250988685708, 11523.308601483937, 11525.942370288138, 11439.771204575904, 11469.08247340215, 11488.540458381654, 11498.080153587693, 11503.827442588368, 11376.772464550746, 11411.714707132305, 11444.427778611078, 11468.885311146865, 11480.540778368897, 11398.316101033965, 11426.828597571042, 11456.4844581994, 11458.82811757816, 11475.196736228467, 36626.0, 36929.0, 36946.8152659235, 36987.63012369869, 37037.814810925775, 4079.5308539518037, 4086.162336720995, 4108.77401742904, 4174.039970806732, 4186.162767446523, 24291.663958482277, 28037.0, 28769.28076798076, 28995.855020724972, 30511.0, 3196.31279274957, 3284.802911825298, 3317.834108294576, 3384.729221662261, 3464.3764122457947, 420258.0, 507732.0, 510061.0, 512676.0, 515927.0, 59996.0, 60789.392106079256, 60859.69570152121, 60900.0, 61257.69371153116, 63308.0, 63627.0, 63727.36272637307, 64011.67994160092, 64117.67941160264, 16449.930754500918, 17214.05322707238, 17223.0, 17232.310707571807, 17267.74098388525, 12231.143819932697, 12548.686282843002, 13234.205947643171, 13974.0, 14040.017198796191, 22210.66683999709, 22647.094116235494, 22678.546429071655, 23067.0, 23125.95933183011, 8851.867221991546, 9059.864102038475, 9071.682491112912, 9100.954495227481, 9136.451812891248, 905.8369493491103, 925.5141050948172, 929.2333824594737, 947.7962238118838, 955.19763398744, 31637.8418107908, 32172.0, 32381.514277285387, 32410.513842292385, 32928.0, 1089.2103225161695, 1101.7410908436511, 1119.972000699989, 1144.3134119528218, 1155.3356819828464, 14909.628032775416, 16293.51119466418, 16404.343826247055, 16468.258928348252, 17144.742828857576, 574389.0, 961352.0, 964788.0, 978183.0, 978251.0, 50423.49576504188, 56120.43879561234, 57699.13451298234, 57718.42281577131, 57880.71059644675, 1499.9775003374957, 1503.8721708654887, 1529.9541013769383, 1533.9156346400832, 1534.8004759381433, 27912.58131127994, 29044.27389315284, 29429.558556622094, 29952.801887924237, 31145.37709245848, 49824.50175498344, 49939.250911235635, 50192.0, 50450.990980180926, 50478.49521504738, 558119.2094039504, 632744.8362758341, 635384.0, 635464.0, 639285.4107188303, 24185.0, 24791.132310369052, 26671.46657066809, 26718.0, 27445.588316174875, 43583.56416435795, 43967.0, 44862.775686121364, 45392.09215815731, 45457.0, 30092.548611770402, 30562.541561877035, 30853.0, 31204.843975779975, 32096.518552221267, 29437.705622943497, 30612.0, 31075.533866992464, 31673.36653266968, 31926.840365798023, 35854.28291434104, 36621.0, 36846.44730328993, 36921.63078369182, 37009.889703308945, 27067.187984360502, 30972.690273097884, 31234.0, 31462.528062079546, 31740.682593173773, 19943.0, 24647.630285545372, 24704.7647617622, 25077.247682569552, 25196.0], "value": 20710.614886843185, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.3752402538078, 404.64391335624646, 409.88932988093205, 413.70626854933005, 430.6920551805458, 20533.589328213446, 20931.581368372663, 21181.894090529524, 21271.680924786142, 21938.561228775416, 21657.241996530123, 21698.783012169875, 22020.449488762788, 22088.33734987949, 22557.887210563924, 5774.220480235156, 6086.573939824192, 6090.299615544225, 6097.939020609781, 6110.480609148228, 5814.912776308359, 5940.702964851762, 5978.671173085479, 5995.760169593211, 6011.75952961881, 5935.49548288396, 5943.138244954479, 5957.553183511232, 5961.552883533731, 5972.611780234292, 4942.728149951751, 5737.110747834093, 5915.526757859361, 5919.408059194067, 5943.108533719934, 5189.922151167735, 5236.005159019812, 5250.658707184059, 5256.8685782855355, 5257.0, 26141.823617937047, 26428.207153785224, 26496.73503264962, 26727.331816704544, 26785.79463924128, 2738.5344491436304, 2762.709915458888, 2778.8332700038063, 2789.5257806172795, 2802.1453456695904, 15296.311665975058, 15417.537473875802, 15538.0, 15611.219439028117, 15902.920485397499, 1700.7363858601936, 1731.1084791332473, 1894.194967138974, 1907.4563749331512, 1915.24347882587, 129369.0, 130977.0, 131695.0, 133335.0, 135170.0, 11963.940180299216, 11983.400829958468, 12136.33250171249, 12148.331841748612, 12545.435455404346, 16248.025118492691, 16248.75626865598, 16250.918745406198, 16269.430569929995, 16286.674266514603, 7877.842443151105, 8536.847525584091, 9085.77285567853, 9127.0, 9154.99295077541, 8960.327975401871, 8979.922409310924, 9036.81926361469, 9174.311926605398, 9193.080691930754, 4889.144399730033, 4934.9013019739405, 4966.726830024383, 4970.925436118461, 5005.299258103868, 2049.2028381259474, 2083.666613341858, 2087.937361879146, 2094.895255237232, 2101.233049936762, 808.5068108453838, 912.5574096563162, 958.7794807194384, 1033.1682995188944, 1034.99482502587, 20467.0, 22598.887005564866, 22663.093476261096, 22696.0, 22762.886185568965, 1044.2220545693508, 1061.4586560853866, 1085.137315833914, 1100.7743412600398, 1106.778644271149, 9348.532573371303, 9844.310898237054, 9916.008399160171, 10707.518161682743, 11072.723181920355, 756506.0, 764035.0, 766791.2636319326, 774196.0, 789995.0, 139683.0, 144312.0, 149323.0, 151440.2427987875, 161899.19050404674, 1008.7175590834578, 1058.571278632155, 1083.8861919498497, 1086.896744809242, 1094.5676457799125, 15825.0, 19954.30159944395, 20551.280705175246, 20711.171553137705, 20851.374458766262, 48891.75554122207, 50768.49231507638, 56721.43278567161, 62875.685621571596, 63727.6813615929, 89367.55316223377, 89491.55254223687, 91250.54374728349, 92786.53606731923, 92833.0, 7493.587852668155, 7846.646900889587, 8465.915340846514, 8701.956490217508, 8965.596548155218, 11637.650870473899, 12630.621081367573, 13074.28091454979, 13373.465061397825, 13418.792308692264, 8916.420432671855, 11523.250988686044, 11627.825582616098, 11811.350375729073, 11820.940895295469, 8616.870746938675, 10339.638112666322, 10590.576376944837, 10687.358758474516, 10727.892721073002, 11515.884841151816, 11568.826467603161, 11583.42082895835, 11834.940825295818, 11999.280043197436, 7640.80897977555, 7705.728554788621, 7729.0, 7876.369890408868, 8023.719169829262, 8351.373646976623, 10683.94658026705, 11560.42197890119, 11581.189316747746, 11861.881381186078], "value": 10178.252346302299, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.6814716688739, 1485.8885583581234, 1493.6340596553844, 1497.408523633165, 1503.827059888113, 7661.118971318286, 7911.841763164748, 8239.711610093647, 8644.783880402985, 8655.78360540986, 8169.877451838227, 8430.072692003874, 8443.282321002707, 8565.400421970464, 8567.785805354853, 2268.12677119309, 2302.6085565453827, 2307.9884600576975, 2308.549832782608, 2313.109452860644, 2427.2111563741764, 2437.122635851092, 2456.1403508771964, 2456.5455390752677, 2461.0, 2379.809615230786, 2404.326788499223, 2410.915617953372, 2419.0, 2434.1237154624323, 2373.9525209495887, 2381.868997205153, 2396.496735685508, 2398.016813106618, 2402.5675378431874, 2374.263978166774, 2408.6989126359204, 2416.794572461343, 2432.477017441259, 2441.8779061047053, 7414.925850741478, 8512.489250644981, 8538.231559159643, 8567.657293708244, 8620.482771033758, 5206.921896171561, 5350.3312085989255, 5359.517643412073, 5364.839054828361, 5365.463453654604, 3585.579733679782, 3606.963930360689, 3613.6747692707518, 3643.908902277438, 3692.335379631665, 1269.3272565540278, 1271.5486002469083, 1300.1678925487695, 1317.4993502469097, 1322.3784821134052, 10979.560817567368, 11027.117830573536, 11047.281926674821, 11051.502682379232, 11064.336139831636, 3995.62041606047, 4684.929726054112, 4822.445418776815, 4867.537583929521, 4869.050535145612, 9599.712008639752, 9685.70942871715, 9697.224222062217, 9703.0, 9717.319787614799, 5321.547668448148, 5344.759485823147, 5421.972890135603, 5425.9186112208345, 5429.511343979061, 4346.456692913386, 4466.6203372713035, 4604.0, 4804.702730262879, 4915.090708218991, 3931.4889064422014, 3973.006748312922, 3986.7641031280396, 4064.146529228836, 4076.2458945095254, 1234.1484375780683, 1319.0436933223336, 1323.7815760399426, 1324.675454513631, 1328.3225554967037, 936.4568550240843, 944.187998321443, 951.7573018880141, 962.6101428921158, 967.6371360739722, 5536.695481748542, 5604.719764011783, 5759.481646651821, 5893.204417403681, 5898.14476900847, 584.1908956095838, 584.2959234122872, 595.8540157661314, 602.4156568128908, 612.0818771842237, 3762.774233545996, 3798.867039653599, 3799.848006079781, 3898.571157172709, 3917.5298964123917, 9131.0, 10294.227932905062, 10310.587576496857, 10328.070473657257, 10345.27583069193, 9960.950195248977, 10223.852990872001, 10231.59073637061, 10256.58973641046, 10261.640842570474, 8118.797030074295, 8119.594020298961, 8124.471909325875, 8142.145074767182, 8168.387370947203, 5510.779568817363, 5523.116301391758, 5558.221848941071, 5728.484436400744, 5821.679807610622, 9439.716808495756, 9477.810443791224, 9583.0, 9605.663801766905, 9648.75878103025, 9380.67167649129, 9473.721047658479, 9508.714738557854, 9598.760030999281, 9650.806983860142, 7243.492955493276, 7315.049043624294, 7381.778546643609, 7388.408927285912, 7406.740764073232, 7982.481138725964, 7994.960025200069, 8053.395995300259, 8088.636011379384, 8097.39269554774, 7005.649717514206, 7031.964840175767, 7054.506184567236, 7190.928090719026, 7193.748218812317, 6756.0, 6883.380495755406, 6885.173779146535, 6890.896636550556, 6898.275681053417, 6141.815745527641, 6464.256610489666, 6601.33986601336, 6606.570572912938, 6615.966920165369, 4728.668993170445, 4809.0862736080035, 4819.927701084416, 4830.372051633265, 4832.95167048339, 4623.398958135421, 4634.814607415666, 4706.0, 4817.542333478314, 4865.1242776300605], "value": 4464.7260156175835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.37372079214833, 340.5249676701002, 367.48552027161986, 379.7702390054017, 387.55044148787414, 5338.786448542059, 5364.758585863636, 5540.529055030317, 5643.915341269879, 5684.431556844308, 5382.327209098863, 5454.54545454545, 5500.167413781905, 5542.4457554244555, 5550.222968784374, 4290.999999999992, 4345.587169218919, 4345.760983145926, 4357.3899654048455, 4368.344748287766, 4239.40648309237, 4281.850135245267, 4312.568743125694, 4382.561743825624, 4413.984783499797, 3522.7181825453904, 3912.3740201567753, 4287.6569874410125, 4302.225599392108, 4314.3528470729325, 3519.331327047853, 4010.3382941814566, 4277.978610106945, 4294.613484786369, 4325.264705000126, 3219.3722224166295, 3226.548283240325, 3374.9325013499592, 3850.961490385116, 3874.728768986172, 4927.359443272388, 5271.182966640177, 5353.57171426285, 5359.606502309389, 5367.677939323653, 5022.4224214215465, 5025.522575355372, 5030.84907452777, 5038.0, 5063.898722025576, 4425.867223983286, 5880.235569375954, 5883.823485295448, 5886.970565147147, 5943.009091954201, 4133.793310334471, 4223.408722778813, 4268.399350243659, 4281.978590107061, 4292.9393890932215, 5161.690298582097, 5585.067839384315, 6167.321594624587, 6193.535484838655, 6198.566100372976, 3675.687566556819, 3849.268638958589, 4198.580141985777, 4377.956220437819, 4388.210122178039, 3574.4102223133414, 3666.5783434904793, 4412.117576484716, 4442.888927776831, 4444.488883778342, 5043.924341134886, 5048.3184770056305, 5067.163917953497, 5067.239914012854, 5079.23181865884, 4795.520447955177, 5218.895622087537, 5968.343482216953, 5989.730462129215, 5999.92001439745, 1216.9716589481873, 1394.8256467941508, 1460.1312219229542, 1464.3776395032069, 1469.9489864746758, 908.9000209976897, 952.642758965388, 1019.658414431159, 1027.50679673757, 1031.9690409287734, 4443.37792709021, 4941.654084214142, 5039.672421292605, 5253.789848406097, 5335.692755274982, 5218.66078704883, 5356.437574054746, 5602.523785478198, 5860.589758716849, 5879.265091863517, 4785.521447855187, 4805.303231031481, 5188.507091826271, 5332.306800116037, 5372.946270537323, 2530.8993535365603, 2637.485690290375, 2782.8173026463674, 2969.9655735821034, 3052.862621182008, 5154.871128221825, 5365.785368585213, 5408.3509978802795, 5568.693721845257, 5582.665040097607, 5415.835595347019, 5664.54683625309, 5958.493528050078, 6014.6391216527145, 6054.8183554493435, 5110.693358398434, 5247.454984332596, 5670.5463562914865, 6052.727627256784, 6094.531714655572, 4601.755762187717, 4936.333594964777, 5178.0, 5504.330399756195, 5606.635568688022, 4865.099956508057, 5509.135249670229, 5669.858253543694, 5750.6262092963825, 5772.074989007515, 5312.468753124656, 5466.098093814476, 5554.861128471821, 5586.916196257141, 6120.898238317146, 3497.527833742514, 3720.014196238053, 3843.0016391476834, 3862.845486180521, 3875.256134739435, 5749.051406518045, 5909.31584498433, 5949.494292985145, 5966.254218222723, 6023.548233882389, 4795.544423279783, 5828.825135245949, 5830.5044071254415, 5866.2373891393845, 5866.970665146818, 5537.207013195974, 5801.796937107181, 5829.5336373090895, 5859.9121013183985, 5869.911951320819, 5253.8178909745, 5695.373508914099, 5719.771209151754, 5726.341470730919, 5746.42535746422, 4459.799309031167, 5514.310711161105, 5731.996900542472, 5861.912071319019, 5892.469677729025, 4816.518348165156, 4998.550130488274, 5237.450067742984, 5792.94207057924, 5843.328017277898], "value": 4240.98867803178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.7984564321991, 740.2375553180225, 756.59900252866, 816.9420600322582, 855.4097672605903, 15285.847141528582, 15858.444954426597, 16147.757783633255, 16250.431234906795, 16329.673406531861, 14437.205953672545, 14582.708345833076, 14693.265336733148, 14758.778618320734, 14761.18813465259, 694.357719109824, 708.355396589104, 726.6366816591704, 880.3881302494768, 883.0551310098182, 862.9395942284043, 867.7440155154213, 872.9432586881865, 875.2866413872705, 876.1939016105199, 927.14702473724, 949.264320151881, 962.6341990043774, 962.8988956159608, 965.0879918477042, 828.668532586964, 921.8847644044495, 945.3854994253721, 957.9616815327379, 961.2070042215131, 579.2007030298204, 704.2921863527174, 716.5163514627606, 720.1358369956074, 721.1202333153544, 12546.749065018648, 15509.922450387789, 15531.5340539784, 15788.763168552481, 16383.754243686355, 15144.318505667272, 15304.0, 15320.310586023656, 15323.31045102962, 15371.0, 10251.79496410075, 11671.416429178507, 11819.763604727943, 11990.460429280616, 11997.280163190237, 3739.775613463201, 3866.2654095722005, 3870.0, 3957.6240257175523, 4095.1195492969155, 90497.0, 104643.4767826156, 104944.95055049428, 110295.0, 110503.78992420188, 9571.234301255883, 11101.278416902875, 11530.365829879269, 11632.83671632847, 11850.0, 24858.0, 25016.874240659214, 25059.4988100237, 25095.749042509706, 25122.748772512405, 8094.15011423792, 8155.918440815634, 8205.753827385188, 8214.958925205336, 8253.628586713612, 4436.8447104351835, 4440.33394990754, 4499.887502812456, 4614.76926153691, 4616.1229366420275, 3744.8689295874515, 3793.5447746270074, 3796.6583007529457, 3826.0626146594263, 3841.769493830379, 678.8994473380725, 691.595416681237, 696.7805141380449, 698.4203111417511, 708.7023450150949, 566.7308028686424, 711.8718630646533, 719.665355609644, 723.2080871445759, 748.6032402826511, 9590.952045239728, 10661.680149595524, 10738.688919168988, 10786.352818830896, 10974.725631859268, 664.259350823828, 724.5688815154974, 735.4331492262484, 744.0884915977883, 746.4811955690743, 4834.806607735722, 4834.975825120852, 5110.28456016158, 5136.8202112925865, 5164.535191832753, 107516.9248307507, 109136.4543177279, 109427.0, 110062.44968775265, 110120.0, 87249.0, 89391.55304223437, 90309.54845225863, 90399.09600904038, 92885.071149289, 80565.0, 81923.18076819275, 83139.58430207931, 83404.0, 83491.58254208691, 9757.560909758937, 9953.353032052893, 10014.499275036365, 10021.74945626336, 10023.248256380946, 46382.768086159354, 54200.72899635477, 54277.0, 54530.454695452536, 55337.44662553323, 65982.0, 70092.89721308369, 72020.63989680017, 72196.0, 72901.6354918222, 11206.887931120584, 11442.94278528602, 11754.941225293818, 11869.347185904859, 12773.850353468233, 12784.936075319563, 13270.203787772765, 15250.389984400499, 15664.921675392006, 15991.440299589924, 13705.931470342584, 14118.0, 14442.0, 14543.490977815725, 14973.608852259305, 13844.930775346058, 14082.647933801736, 14268.0, 14636.487722929647, 14710.779338310149, 13709.97175211883, 13998.0, 14078.648033799236, 14308.713825723635, 14359.569212923629, 9710.898440228659, 9926.057024582653, 10003.2997690161, 10182.0, 10308.175345972155, 10284.742881428025, 10876.45617719095, 11496.88503114958, 11623.244489108181, 12045.277283363026], "value": 7745.119100145118, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 168.0, 172.0, 143.0, 118.0, 126.0, 123.0, 117.0, 118.0, 113.0], "value": 128.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 106.0, 110.0, 140.0, 114.0, 108.0, 111.0, 114.0, 110.0, 126.0], "value": 117.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [263.0, 254.0, 192.0, 198.0, 194.0, 197.0, 195.0, 195.0, 194.0, 197.0], "value": 207.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 88.0, 53.0, 70.0, 81.0, 84.0, 98.0, 59.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 83.0, 76.0, 86.0, 103.0, 96.0, 68.0, 71.0, 80.0], "value": 82.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 119.0, 90.0, 87.0, 91.0, 85.0, 80.0, 116.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 96.0, 96.0, 151.0, 135.0, 94.0, 124.0, 153.0], "value": 113.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 122.0, 96.0, 140.0, 85.0, 149.0, 80.0, 142.0, 76.0, 101.0], "value": 109.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 61.0, 63.0, 61.0, 61.0, 62.0, 61.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 74.0, 75.0, 76.0, 69.0, 69.0, 72.0, 73.0, 70.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 85.0, 85.0, 84.0, 84.0, 86.0, 87.0, 102.0, 71.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 181.0, 151.0, 151.0, 135.0, 137.0, 140.0, 151.0, 155.0, 125.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 165.0, 164.0, 200.0, 228.0, 176.0, 167.0, 209.0, 222.0, 156.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 65.0, 64.0, 63.0, 65.0, 65.0, 67.0, 72.0], "value": 65.5, "unit": "score"}]}]} 08:57:20 INFO - Return code: 0 08:57:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:57:20 ERROR - # TBPL SUCCESS # 08:57:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:20 INFO - 2017-04-10 08:57:20.693 screenresolution[1663:10281] starting screenresolution argv=screenresolution get 08:57:20 INFO - 2017-04-10 08:57:20.696 screenresolution[1663:10281] Display 0: 1600x1200x32@60 08:57:20 INFO - 2017-04-10 08:57:20.702 screenresolution[1664:10284] starting screenresolution argv=screenresolution list 08:57:20 INFO - Available Modes on Display 0 08:57:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:20 INFO - Intel Iris: 08:57:20 INFO - Chipset Model: Intel Iris 08:57:20 INFO - Type: GPU 08:57:20 INFO - Bus: Built-In 08:57:20 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:20 INFO - Vendor: Intel (0x8086) 08:57:20 INFO - Device ID: 0x0a2e 08:57:20 INFO - Revision ID: 0x0009 08:57:20 INFO - Displays: 08:57:20 INFO - Display: 08:57:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:20 INFO - Display Serial Number: 1600x1200 60 08:57:20 INFO - Main Display: Yes 08:57:20 INFO - Mirror: Off 08:57:20 INFO - Online: Yes 08:57:20 INFO - Rotation: Supported 08:57:20 INFO - Return code: 0 08:57:20 INFO - Running post-action listener: _resource_record_post_action 08:57:20 INFO - [mozharness: 2017-04-10 15:57:20.927949Z] Finished run-tests step (success) 08:57:20 INFO - Running post-run listener: _resource_record_post_run 08:57:21 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 39536640; Write bytes: 426376192; Read time: 257; Write time: 1435 08:57:21 INFO - TinderboxPrint: CPU usage
54.3% 08:57:21 INFO - TinderboxPrint: I/O read bytes / time
39,536,640 / 257 08:57:21 INFO - TinderboxPrint: I/O write bytes / time
426,376,192 / 1,435 08:57:21 INFO - TinderboxPrint: CPU idle
2,178.3 (45.7%) 08:57:21 INFO - TinderboxPrint: CPU system
960.1 (20.2%) 08:57:21 INFO - TinderboxPrint: CPU user
1,623.3 (34.1%) 08:57:21 INFO - TinderboxPrint: Swap in / out
161,431,552 / 0 08:57:21 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 245760; Write bytes: 122634240; Read time: 4; Write time: 285 08:57:21 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35600384; Write bytes: 298583040; Read time: 223; Write time: 1129 08:57:21 INFO - Running post-run listener: _upload_blobber_files 08:57:21 INFO - Blob upload gear active. 08:57:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:57:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:57:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:57:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:57:21 INFO - (blobuploader) - INFO - Open directory for files ... 08:57:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:57:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:57:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:22 INFO - (blobuploader) - INFO - Done attempting. 08:57:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:57:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:23 INFO - (blobuploader) - INFO - Done attempting. 08:57:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:57:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:57:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:24 INFO - (blobuploader) - INFO - Done attempting. 08:57:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:57:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:57:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:57:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:57:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:57:26 INFO - (blobuploader) - INFO - Done attempting. 08:57:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:57:26 INFO - Return code: 0 08:57:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:57:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:57:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358529af16e49ade572591947b216828bcda1c7f4d270c9e394471fb45b9dcc067f412c7d342fe2ba2b32e92ad8d69ea81cc438649b74be4103d23fd29b4832e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c32eca176b39fc4387d7ac56c167d871dab67b82b0ac4c1e55101bdb18c2bb2eea790dd31b79a79a6dcddda3e8677d78193413acbfe82164e1ddce5ab838990", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20acd429ec3a36b722751b0563905e840e429d4c1b36633a04c4c6d426e1b00ccbd278af26d07f8dbe1d15e5c956eb0bfcf8959b1b1f546e0e401ba5509054e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12db4ad3c6fb8c30ea92e51d61aabc6b586c1ce9abaeae84e4f41867cf3cb88e2cb04a6379e413f78183009c1d4387ca605849d94c7640db6bee776e9a8d289a"} 08:57:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:57:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:57:26 INFO - Contents: 08:57:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358529af16e49ade572591947b216828bcda1c7f4d270c9e394471fb45b9dcc067f412c7d342fe2ba2b32e92ad8d69ea81cc438649b74be4103d23fd29b4832e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c32eca176b39fc4387d7ac56c167d871dab67b82b0ac4c1e55101bdb18c2bb2eea790dd31b79a79a6dcddda3e8677d78193413acbfe82164e1ddce5ab838990", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20acd429ec3a36b722751b0563905e840e429d4c1b36633a04c4c6d426e1b00ccbd278af26d07f8dbe1d15e5c956eb0bfcf8959b1b1f546e0e401ba5509054e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12db4ad3c6fb8c30ea92e51d61aabc6b586c1ce9abaeae84e4f41867cf3cb88e2cb04a6379e413f78183009c1d4387ca605849d94c7640db6bee776e9a8d289a"} 08:57:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:57:26 INFO - Copying logs to upload dir... 08:57:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:57:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.671401 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-04-10 08:57:26.654357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 08:57:26.658169) ========= 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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358529af16e49ade572591947b216828bcda1c7f4d270c9e394471fb45b9dcc067f412c7d342fe2ba2b32e92ad8d69ea81cc438649b74be4103d23fd29b4832e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c32eca176b39fc4387d7ac56c167d871dab67b82b0ac4c1e55101bdb18c2bb2eea790dd31b79a79a6dcddda3e8677d78193413acbfe82164e1ddce5ab838990", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20acd429ec3a36b722751b0563905e840e429d4c1b36633a04c4c6d426e1b00ccbd278af26d07f8dbe1d15e5c956eb0bfcf8959b1b1f546e0e401ba5509054e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12db4ad3c6fb8c30ea92e51d61aabc6b586c1ce9abaeae84e4f41867cf3cb88e2cb04a6379e413f78183009c1d4387ca605849d94c7640db6bee776e9a8d289a"} build_url:https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011048 build_url: 'https://queue.taskcluster.net/v1/task/O-Oesq9MRYu0etlx8yYnXg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358529af16e49ade572591947b216828bcda1c7f4d270c9e394471fb45b9dcc067f412c7d342fe2ba2b32e92ad8d69ea81cc438649b74be4103d23fd29b4832e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0c32eca176b39fc4387d7ac56c167d871dab67b82b0ac4c1e55101bdb18c2bb2eea790dd31b79a79a6dcddda3e8677d78193413acbfe82164e1ddce5ab838990", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/20acd429ec3a36b722751b0563905e840e429d4c1b36633a04c4c6d426e1b00ccbd278af26d07f8dbe1d15e5c956eb0bfcf8959b1b1f546e0e401ba5509054e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12db4ad3c6fb8c30ea92e51d61aabc6b586c1ce9abaeae84e4f41867cf3cb88e2cb04a6379e413f78183009c1d4387ca605849d94c7640db6bee776e9a8d289a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-10 08:57:26.695941) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 08:57:26.696268) ========= 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.rDdUvtBEJC/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.I85Bp0DiUS/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.005133 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-10 08:57:26.744664) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 08:57:26.744987) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-10 08:57:26.745307) ========= ========= Total master_lag: 0.19 =========