builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0036 starttime: 1486558439.6 results: success (0) buildid: 20170208030203 builduid: a9138c194146463981b09c76be271570 revision: 3a95aa4246653a7863914ffec032897d13359fb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.597530) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.598027) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.598308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.623246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.623654) ========= 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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-08 04:53:59-- 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% 8.21M=0.001s 2017-02-08 04:53:59 (8.21 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115792 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.763036) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.763378) ========= 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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.021459 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 04:53:59.812236) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-08 04:53:59.812601) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3a95aa4246653a7863914ffec032897d13359fb0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3a95aa4246653a7863914ffec032897d13359fb0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-08 04:53:59,895 truncating revision to first 12 chars 2017-02-08 04:53:59,895 Setting DEBUG logging. 2017-02-08 04:53:59,895 attempt 1/10 2017-02-08 04:53:59,895 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3a95aa424665?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 04:54:01,969 unpacking tar archive at: mozilla-central-3a95aa424665/testing/mozharness/ program finished with exit code 0 elapsedTime=2.326720 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-08 04:54:02.165539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 04:54:02.166064) ========= script_repo_revision: 3a95aa4246653a7863914ffec032897d13359fb0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 04:54:02.166757) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 04:54:02.167232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 04:54:02.187430) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-08 04:54:02.187837) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:02 INFO - MultiFileLogger online at 20170208 04:54:02 in /builds/slave/test 04:54:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:54:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:54:02 INFO - {'append_to_log': False, 04:54:02 INFO - 'base_work_dir': '/builds/slave/test', 04:54:02 INFO - 'blob_upload_branch': 'Firefox', 04:54:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:54:02 INFO - 'branch': 'Firefox', 04:54:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:54:02 INFO - 'config_files': ('talos/mac_config.py',), 04:54:02 INFO - 'default_actions': ('clobber', 04:54:02 INFO - 'read-buildbot-config', 04:54:02 INFO - 'download-and-extract', 04:54:02 INFO - 'populate-webroot', 04:54:02 INFO - 'create-virtualenv', 04:54:02 INFO - 'install', 04:54:02 INFO - 'run-tests'), 04:54:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:54:02 INFO - 'download_minidump_stackwalk': True, 04:54:02 INFO - 'download_symbols': 'ondemand', 04:54:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:54:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:54:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:54:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:54:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:54:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:54:02 INFO - 'installer_path': 'installer.exe', 04:54:02 INFO - 'log_level': 'info', 04:54:02 INFO - 'log_name': 'talos', 04:54:02 INFO - 'log_to_console': True, 04:54:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:54:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:54:02 INFO - 'opt_config_files': (), 04:54:02 INFO - 'pip_index': False, 04:54:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:02 INFO - 'cmd': ('bash', 04:54:02 INFO - '-c', 04:54:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:02 INFO - 'enabled': True, 04:54:02 INFO - 'halt_on_failure': False, 04:54:02 INFO - 'name': 'check_screen_resolution'},), 04:54:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:54:02 INFO - 'cmd': ('bash', 04:54:02 INFO - '-c', 04:54:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:54:02 INFO - 'enabled': True, 04:54:02 INFO - 'halt_on_failure': False, 04:54:02 INFO - 'name': 'check_screen_resolution'},), 04:54:02 INFO - 'run_cmd_checks_enabled': True, 04:54:02 INFO - 'sps_profile': False, 04:54:02 INFO - 'sps_profile_interval': 0, 04:54:02 INFO - 'suite': 'dromaeojs', 04:54:02 INFO - 'system_bits': '32', 04:54:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:54:02 INFO - 'title': 't-yosemite-r7-0036', 04:54:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:54:02 INFO - 'use_talos_json': True, 04:54:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:54:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:54:02 INFO - 'work_dir': 'build'} 04:54:02 INFO - [mozharness: 2017-02-08 12:54:02.395032Z] Running clobber step. 04:54:02 INFO - Running pre-action listener: _resource_record_pre_action 04:54:02 INFO - Running main action method: clobber 04:54:02 INFO - rmtree: /builds/slave/test/build 04:54:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:54:04 INFO - Running post-action listener: _resource_record_post_action 04:54:04 INFO - [mozharness: 2017-02-08 12:54:04.140229Z] Finished clobber step (success) 04:54:04 INFO - [mozharness: 2017-02-08 12:54:04.140363Z] Running read-buildbot-config step. 04:54:04 INFO - Running pre-action listener: _resource_record_pre_action 04:54:04 INFO - Running main action method: read_buildbot_config 04:54:04 INFO - Using buildbot properties: 04:54:04 INFO - { 04:54:04 INFO - "project": "", 04:54:04 INFO - "product": "firefox", 04:54:04 INFO - "script_repo_revision": "production", 04:54:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:54:04 INFO - "repository": "", 04:54:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:54:04 INFO - "buildid": "20170208030203", 04:54:04 INFO - "stage_platform": "macosx64", 04:54:04 INFO - "basedir": "/builds/slave/test", 04:54:04 INFO - "nightly_build": "True", 04:54:04 INFO - "buildnumber": 5, 04:54:04 INFO - "slavename": "t-yosemite-r7-0036", 04:54:04 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:54:04 INFO - "platform": "yosemite_r7", 04:54:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:54:04 INFO - "branch": "mozilla-central", 04:54:04 INFO - "repo_path": "mozilla-central", 04:54:04 INFO - "revision": "3a95aa4246653a7863914ffec032897d13359fb0", 04:54:04 INFO - "pgo_build": "False", 04:54:04 INFO - "builduid": "a9138c194146463981b09c76be271570", 04:54:04 INFO - "slavebuilddir": "test" 04:54:04 INFO - } 04:54:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:54:04 INFO - Running post-action listener: _resource_record_post_action 04:54:04 INFO - [mozharness: 2017-02-08 12:54:04.143768Z] Finished read-buildbot-config step (success) 04:54:04 INFO - [mozharness: 2017-02-08 12:54:04.143885Z] Running download-and-extract step. 04:54:04 INFO - Running pre-action listener: _resource_record_pre_action 04:54:04 INFO - Running main action method: download_and_extract 04:54:04 INFO - mkdir: /builds/slave/test/build/tests 04:54:04 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')]} 04:54:04 INFO - trying https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:54:04 INFO - Downloading https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:54:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:54:05 INFO - Downloaded 1199 bytes. 04:54:05 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:54:05 INFO - Using the following test package requirements: 04:54:05 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:54:05 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:54:05 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:54:05 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'jsshell-mac.zip'], 04:54:05 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:54:05 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:54:05 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:54:05 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:54:05 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:54:05 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:54:05 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:54:05 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:54:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:54:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:05 INFO - Fetch https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:54:06 INFO - Expected file size: 34938689 04:54:06 INFO - Obtained file size: 34938689 04:54:13 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:54:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:54:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:54:13 INFO - Fetch https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:54:14 INFO - Expected file size: 34938689 04:54:14 INFO - Obtained file size: 34938689 04:54:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:54:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:54:21 INFO - Fetch https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:54:22 INFO - Expected file size: 14403454 04:54:22 INFO - Obtained file size: 14403454 04:54: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')]} 04:54:23 INFO - trying https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:54:23 INFO - Downloading https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:54:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:54:25 INFO - Downloaded 70441145 bytes. 04:54:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:54:25 INFO - mkdir: /builds/slave/test/properties 04:54:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:54:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:54:25 INFO - Contents: 04:54:25 INFO - build_url:https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:54:25 INFO - Running post-action listener: _resource_record_post_action 04:54:25 INFO - Running post-action listener: set_extra_try_arguments 04:54:25 INFO - [mozharness: 2017-02-08 12:54:25.734073Z] Finished download-and-extract step (success) 04:54:25 INFO - [mozharness: 2017-02-08 12:54:25.734236Z] Running populate-webroot step. 04:54:25 INFO - Running pre-action listener: _resource_record_pre_action 04:54:25 INFO - Running main action method: populate_webroot 04:54:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:54:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:54:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:54:25 INFO - '--tppagecycles', 04:54:25 INFO - '7'], 04:54:25 INFO - 'tests': ['tsvgm']}}, 04:54:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:54:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:54:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:54:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:54:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:54:25 INFO - 'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:54:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:54:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:54:25 INFO - 'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['damp', 'tps']}, 04:54:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:54:25 INFO - 'tests': ['damp', 'tps']}, 04:54:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['dromaeo_dom']}, 04:54:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:54:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['basic_compositor_video']}, 04:54:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:54:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['a11yr', 04:54:25 INFO - 'ts_paint', 04:54:25 INFO - 'tpaint', 04:54:25 INFO - 'sessionrestore', 04:54:25 INFO - 'sessionrestore_no_auto_restore', 04:54:25 INFO - 'tabpaint']}, 04:54:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:54:25 INFO - 'ts_paint', 04:54:25 INFO - 'tpaint', 04:54:25 INFO - 'sessionrestore', 04:54:25 INFO - 'sessionrestore_no_auto_restore', 04:54:25 INFO - 'tabpaint']}, 04:54:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:54:25 INFO - 'ts_paint', 04:54:25 INFO - 'tpaint', 04:54:25 INFO - 'sessionrestore', 04:54:25 INFO - 'sessionrestore_no_auto_restore', 04:54:25 INFO - 'tabpaint']}, 04:54:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:54:25 INFO - 'ts_paint', 04:54:25 INFO - 'tpaint', 04:54:25 INFO - 'sessionrestore', 04:54:25 INFO - 'sessionrestore_no_auto_restore', 04:54:25 INFO - 'tabpaint']}, 04:54:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['a11yr', 04:54:25 INFO - 'ts_paint', 04:54:25 INFO - 'tpaint', 04:54:25 INFO - 'sessionrestore', 04:54:25 INFO - 'sessionrestore_no_auto_restore', 04:54:25 INFO - 'tabpaint']}, 04:54:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['a11yr', 04:54:25 INFO - 'ts_paint', 04:54:25 INFO - 'tpaint', 04:54:25 INFO - 'sessionrestore', 04:54:25 INFO - 'sessionrestore_no_auto_restore', 04:54:25 INFO - 'tabpaint']}, 04:54:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['tsvgx', 04:54:25 INFO - 'tsvgr_opacity', 04:54:25 INFO - 'tart', 04:54:25 INFO - 'tscrollx', 04:54:25 INFO - 'cart', 04:54:25 INFO - 'tsvg_static']}, 04:54:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:54:25 INFO - 'tsvgr_opacity', 04:54:25 INFO - 'tart', 04:54:25 INFO - 'tscrollx', 04:54:25 INFO - 'cart', 04:54:25 INFO - 'tsvg_static']}, 04:54:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:54:25 INFO - 'talos_options': ['--disable-e10s'], 04:54:25 INFO - 'tests': ['tp5o']}, 04:54:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:54:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:54:25 INFO - 'talos_options': ['--disable-e10s', 04:54:25 INFO - '--xperf_path', 04:54:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:25 INFO - 'tests': ['tp5n']}, 04:54:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:54:25 INFO - 'talos_options': ['--xperf_path', 04:54:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:54:25 INFO - 'tests': ['tp5n']}}, 04:54:25 INFO - 'talos.zip': {'path': '', 04:54:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:54:25 INFO - Running post-action listener: _resource_record_post_action 04:54:25 INFO - [mozharness: 2017-02-08 12:54:25.752584Z] Finished populate-webroot step (success) 04:54:25 INFO - [mozharness: 2017-02-08 12:54:25.752722Z] Running create-virtualenv step. 04:54:25 INFO - Running pre-action listener: _resource_record_pre_action 04:54:25 INFO - Running main action method: create_virtualenv 04:54:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:54:25 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 04:54:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:54:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:54:25 INFO - Using real prefix '/tools/python27' 04:54:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:54:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:54:29 INFO - Installing pip.................done. 04:54:29 INFO - Return code: 0 04:54:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:54:29 INFO - Reading from file tmpfile_stdout 04:54:29 INFO - Output received: 04:54:29 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) 04:54:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:29 INFO - 'HOME': '/Users/cltbld', 04:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:29 INFO - 'LOGNAME': 'cltbld', 04:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:29 INFO - 'MOZ_NO_REMOTE': '1', 04:54:29 INFO - 'NO_EM_RESTART': '1', 04:54:29 INFO - 'PAGER': '/bin/cat', 04:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:29 INFO - 'PWD': '/builds/slave/test', 04:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:29 INFO - 'SHELL': '/bin/bash', 04:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:29 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:29 INFO - 'USER': 'cltbld', 04:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:29 INFO - 'XPC_FLAGS': '0x0', 04:54:29 INFO - 'XPC_SERVICE_NAME': '0', 04:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:29 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 04:54:29 INFO - Cleaning up... 04:54:29 INFO - Return code: 0 04:54:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:54: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')]} 04:54:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54: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')]} 04:54:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:54:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:54:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:29 INFO - 'HOME': '/Users/cltbld', 04:54:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:29 INFO - 'LOGNAME': 'cltbld', 04:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:29 INFO - 'MOZ_NO_REMOTE': '1', 04:54:29 INFO - 'NO_EM_RESTART': '1', 04:54:29 INFO - 'PAGER': '/bin/cat', 04:54:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:29 INFO - 'PWD': '/builds/slave/test', 04:54:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:29 INFO - 'SHELL': '/bin/bash', 04:54:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:29 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:29 INFO - 'USER': 'cltbld', 04:54:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:29 INFO - 'XPC_FLAGS': '0x0', 04:54:29 INFO - 'XPC_SERVICE_NAME': '0', 04:54:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:30 INFO - Downloading/unpacking psutil>=3.1.1 04:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:33 INFO - Installing collected packages: psutil 04:54:33 INFO - Running setup.py install for psutil 04:54:33 INFO - building 'psutil._psutil_osx' extension 04:54:33 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 04:54:34 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 04:54:34 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 04:54:34 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 04:54:34 INFO - building 'psutil._psutil_posix' extension 04:54:34 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 04:54:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:54:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:54:34 INFO - ^ 04:54:34 INFO - 1 warning generated. 04:54:34 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 04:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:54:34 INFO - Successfully installed psutil 04:54:34 INFO - Cleaning up... 04:54:34 INFO - Return code: 0 04:54:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:34 INFO - 'HOME': '/Users/cltbld', 04:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:34 INFO - 'LOGNAME': 'cltbld', 04:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:34 INFO - 'MOZ_NO_REMOTE': '1', 04:54:34 INFO - 'NO_EM_RESTART': '1', 04:54:34 INFO - 'PAGER': '/bin/cat', 04:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:34 INFO - 'PWD': '/builds/slave/test', 04:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:34 INFO - 'SHELL': '/bin/bash', 04:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:34 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:34 INFO - 'USER': 'cltbld', 04:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:34 INFO - 'XPC_FLAGS': '0x0', 04:54:34 INFO - 'XPC_SERVICE_NAME': '0', 04:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:54:37 INFO - Installing collected packages: mozsystemmonitor 04:54:37 INFO - Running setup.py install for mozsystemmonitor 04:54:37 INFO - Successfully installed mozsystemmonitor 04:54:37 INFO - Cleaning up... 04:54:37 INFO - Return code: 0 04:54:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:37 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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:37 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 04:54:37 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 04:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:37 INFO - 'HOME': '/Users/cltbld', 04:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:37 INFO - 'LOGNAME': 'cltbld', 04:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:37 INFO - 'MOZ_NO_REMOTE': '1', 04:54:37 INFO - 'NO_EM_RESTART': '1', 04:54:37 INFO - 'PAGER': '/bin/cat', 04:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:37 INFO - 'PWD': '/builds/slave/test', 04:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:37 INFO - 'SHELL': '/bin/bash', 04:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:37 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:37 INFO - 'USER': 'cltbld', 04:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:37 INFO - 'XPC_FLAGS': '0x0', 04:54:37 INFO - 'XPC_SERVICE_NAME': '0', 04:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:54:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:54:40 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 04:54:40 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 04:54:40 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 04:54:40 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 04:54:40 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 04:54:40 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 04:54:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:54:41 INFO - warning: no files found matching '*.txt' 04:54:41 INFO - no previously-included directories found matching 'build' 04:54:41 INFO - no previously-included directories found matching 'dist' 04:54:41 INFO - no previously-included directories found matching '.git*' 04:54:41 INFO - Installing collected packages: jsonschema, functools32 04:54:41 INFO - Running setup.py install for functools32 04:54:41 INFO - warning: no files found matching '*.txt' 04:54:41 INFO - no previously-included directories found matching 'build' 04:54:41 INFO - no previously-included directories found matching 'dist' 04:54:41 INFO - no previously-included directories found matching '.git*' 04:54:41 INFO - Successfully installed jsonschema functools32 04:54:41 INFO - Cleaning up... 04:54:41 INFO - Return code: 0 04:54:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:54:41 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')]} 04:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:41 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')]} 04:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:41 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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:41 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 04:54:41 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 04:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:41 INFO - 'HOME': '/Users/cltbld', 04:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:41 INFO - 'LOGNAME': 'cltbld', 04:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:41 INFO - 'MOZ_NO_REMOTE': '1', 04:54:41 INFO - 'NO_EM_RESTART': '1', 04:54:41 INFO - 'PAGER': '/bin/cat', 04:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:41 INFO - 'PWD': '/builds/slave/test', 04:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:41 INFO - 'SHELL': '/bin/bash', 04:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:41 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:41 INFO - 'USER': 'cltbld', 04:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:41 INFO - 'XPC_FLAGS': '0x0', 04:54:41 INFO - 'XPC_SERVICE_NAME': '0', 04:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:54:41 INFO - Cleaning up... 04:54:41 INFO - Return code: 0 04:54:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:54:41 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')]} 04:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:41 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')]} 04:54:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:41 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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:41 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 04:54:41 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 04:54:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:41 INFO - 'HOME': '/Users/cltbld', 04:54:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:41 INFO - 'LOGNAME': 'cltbld', 04:54:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:41 INFO - 'MOZ_NO_REMOTE': '1', 04:54:41 INFO - 'NO_EM_RESTART': '1', 04:54:41 INFO - 'PAGER': '/bin/cat', 04:54:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:41 INFO - 'PWD': '/builds/slave/test', 04:54:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:41 INFO - 'SHELL': '/bin/bash', 04:54:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:41 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:41 INFO - 'USER': 'cltbld', 04:54:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:41 INFO - 'XPC_FLAGS': '0x0', 04:54:41 INFO - 'XPC_SERVICE_NAME': '0', 04:54:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:54:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:54:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:54:45 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 04:54:45 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 04:54:45 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 04:54:45 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 04:54:45 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 04:54:45 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 04:54:45 INFO - Downloading docopt-0.6.1.tar.gz 04:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:54:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:54:45 INFO - Running setup.py install for blobuploader 04:54:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:54:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:54:45 INFO - Running setup.py install for requests 04:54:46 INFO - Running setup.py install for docopt 04:54:46 INFO - Successfully installed blobuploader requests docopt 04:54:46 INFO - Cleaning up... 04:54:46 INFO - Return code: 0 04:54:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:46 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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:46 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 04:54:46 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 04:54:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:46 INFO - 'HOME': '/Users/cltbld', 04:54:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:46 INFO - 'LOGNAME': 'cltbld', 04:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:46 INFO - 'MOZ_NO_REMOTE': '1', 04:54:46 INFO - 'NO_EM_RESTART': '1', 04:54:46 INFO - 'PAGER': '/bin/cat', 04:54:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:46 INFO - 'PWD': '/builds/slave/test', 04:54:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:46 INFO - 'SHELL': '/bin/bash', 04:54:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:46 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:46 INFO - 'USER': 'cltbld', 04:54:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:46 INFO - 'XPC_FLAGS': '0x0', 04:54:46 INFO - 'XPC_SERVICE_NAME': '0', 04:54:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:46 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-I82e6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-4IxFdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-utibEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-X07mV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-MsstAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-oIcC1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-EBj9Nx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qMyXnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Rtb3Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:47 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-5p4Waj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:48 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-c5unE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:48 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-qCShQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:48 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-dG91lF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:48 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Hw6kR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:48 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-uVrbpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:48 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-QqSBOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:48 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CJJ5OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:54:48 INFO - Running setup.py install for manifestparser 04:54:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:54:48 INFO - Running setup.py install for mozcrash 04:54:49 INFO - Running setup.py install for mozdebug 04:54:49 INFO - Running setup.py install for mozdevice 04:54:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Running setup.py install for mozfile 04:54:49 INFO - Running setup.py install for mozhttpd 04:54:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Running setup.py install for mozinfo 04:54:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Running setup.py install for mozInstall 04:54:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:54:49 INFO - Running setup.py install for mozleak 04:54:50 INFO - Running setup.py install for mozlog 04:54:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for moznetwork 04:54:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for mozprocess 04:54:50 INFO - Running setup.py install for mozprofile 04:54:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for mozrunner 04:54:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:54:50 INFO - Running setup.py install for mozscreenshot 04:54:51 INFO - Running setup.py install for moztest 04:54:51 INFO - Running setup.py install for mozversion 04:54:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:54:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:54:51 INFO - Cleaning up... 04:54:51 INFO - Return code: 0 04:54:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:51 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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:51 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 04:54:51 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 04:54:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:51 INFO - 'HOME': '/Users/cltbld', 04:54:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:51 INFO - 'LOGNAME': 'cltbld', 04:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:51 INFO - 'MOZ_NO_REMOTE': '1', 04:54:51 INFO - 'NO_EM_RESTART': '1', 04:54:51 INFO - 'PAGER': '/bin/cat', 04:54:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:51 INFO - 'PWD': '/builds/slave/test', 04:54:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:51 INFO - 'SHELL': '/bin/bash', 04:54:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:51 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:51 INFO - 'USER': 'cltbld', 04:54:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:51 INFO - 'XPC_FLAGS': '0x0', 04:54:51 INFO - 'XPC_SERVICE_NAME': '0', 04:54:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:54:51 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-83nChx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:54:51 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)) 04:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:54:51 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-s3C2xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:54:51 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)) 04:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:54:51 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-PwUEYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:54:51 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)) 04:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:54:51 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-38AQnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-_IVNIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vXbf3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-nRQ5f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-JAucYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-6HogKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-oIH1Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-ju5iL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-vAA1x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:54:52 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)) 04:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:54:52 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-Lojk5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:54:53 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)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:54:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-YALbBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:54:53 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)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-CYEFUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:54:53 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)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:54:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-bUN_NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:54:53 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)) 04:54:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:54:53 INFO - Running setup.py (path:/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/pip-cPrFhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:54:53 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)) 04:54:53 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)) 04:54:53 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)) 04:54:53 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)) 04:54:53 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)) 04:54:53 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)) 04:54:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:54:53 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 04:54:53 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 04:54:53 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 04:54:53 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 04:54:53 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 04:54:53 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 04:54:56 INFO - Downloading blessings-1.6.tar.gz 04:54:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:54:56 INFO - Installing collected packages: blessings 04:54:56 INFO - Running setup.py install for blessings 04:54:56 INFO - Successfully installed blessings 04:54:56 INFO - Cleaning up... 04:54:56 INFO - Return code: 0 04:54:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:56 INFO - Reading from file tmpfile_stdout 04:54:56 INFO - Current package versions: 04:54:56 INFO - blessings == 1.6 04:54:56 INFO - blobuploader == 1.2.4 04:54:56 INFO - docopt == 0.6.1 04:54:56 INFO - functools32 == 3.2.3-2 04:54:56 INFO - jsonschema == 2.5.1 04:54:56 INFO - manifestparser == 1.1 04:54:56 INFO - mozInstall == 1.12 04:54:56 INFO - mozcrash == 1.0 04:54:56 INFO - mozdebug == 0.1 04:54:56 INFO - mozdevice == 0.49 04:54:56 INFO - mozfile == 1.2 04:54:56 INFO - mozhttpd == 0.7 04:54:56 INFO - mozinfo == 0.9 04:54:56 INFO - mozleak == 0.1 04:54:56 INFO - mozlog == 3.4 04:54:56 INFO - moznetwork == 0.27 04:54:56 INFO - mozprocess == 0.24 04:54:56 INFO - mozprofile == 0.28 04:54:56 INFO - mozrunner == 6.13 04:54:56 INFO - mozscreenshot == 0.1 04:54:56 INFO - mozsystemmonitor == 0.3 04:54:56 INFO - moztest == 0.8 04:54:56 INFO - mozversion == 1.4 04:54:56 INFO - psutil == 3.1.1 04:54:56 INFO - requests == 1.2.3 04:54:56 INFO - wsgiref == 0.1.2 04:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:54:56 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')]} 04:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:57 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 04:54:57 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 04:54:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:57 INFO - 'HOME': '/Users/cltbld', 04:54:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:57 INFO - 'LOGNAME': 'cltbld', 04:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:57 INFO - 'MOZ_NO_REMOTE': '1', 04:54:57 INFO - 'NO_EM_RESTART': '1', 04:54:57 INFO - 'PAGER': '/bin/cat', 04:54:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:57 INFO - 'PWD': '/builds/slave/test', 04:54:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:57 INFO - 'SHELL': '/bin/bash', 04:54:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:57 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:57 INFO - 'USER': 'cltbld', 04:54:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:57 INFO - 'XPC_FLAGS': '0x0', 04:54:57 INFO - 'XPC_SERVICE_NAME': '0', 04:54:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 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)) 04:54:57 INFO - Cleaning up... 04:54:57 INFO - Return code: 0 04:54:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:54:58 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 0x10c9c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c9c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe314b1320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, '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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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 04:54:58 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 04:54:58 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 04:54:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:54:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:54:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:54:58 INFO - 'HOME': '/Users/cltbld', 04:54:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:54:58 INFO - 'LOGNAME': 'cltbld', 04:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:54:58 INFO - 'MOZ_NO_REMOTE': '1', 04:54:58 INFO - 'NO_EM_RESTART': '1', 04:54:58 INFO - 'PAGER': '/bin/cat', 04:54:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:54:58 INFO - 'PWD': '/builds/slave/test', 04:54:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:54:58 INFO - 'SHELL': '/bin/bash', 04:54:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:54:58 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:54:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:54:58 INFO - 'USER': 'cltbld', 04:54:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:54:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:54:58 INFO - 'XPC_FLAGS': '0x0', 04:54:58 INFO - 'XPC_SERVICE_NAME': '0', 04:54:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:54:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:54:58 INFO - Cleaning up... 04:54:58 INFO - Return code: 0 04:54:58 INFO - Running post-action listener: _resource_record_post_action 04:54:58 INFO - Running post-action listener: _start_resource_monitoring 04:54:58 INFO - Starting resource monitoring. 04:54:58 INFO - [mozharness: 2017-02-08 12:54:58.583652Z] Finished create-virtualenv step (success) 04:54:58 INFO - [mozharness: 2017-02-08 12:54:58.584583Z] Running install step. 04:54:58 INFO - Running pre-action listener: _resource_record_pre_action 04:54:58 INFO - Running main action method: install 04:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:54:58 INFO - Reading from file tmpfile_stdout 04:54:58 INFO - Detecting whether we're running mozinstall >=1.0... 04:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:54:58 INFO - Reading from file tmpfile_stdout 04:54:58 INFO - Output received: 04:54:58 INFO - Usage: mozinstall [options] installer 04:54:58 INFO - Options: 04:54:58 INFO - -h, --help show this help message and exit 04:54:58 INFO - -d DEST, --destination=DEST 04:54:58 INFO - Directory to install application into. [default: 04:54:58 INFO - "/builds/slave/test"] 04:54:58 INFO - --app=APP Application being installed. [default: firefox] 04:54:58 INFO - mkdir: /builds/slave/test/build/application 04:54:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:54:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:55:21 INFO - Reading from file tmpfile_stdout 04:55:21 INFO - Output received: 04:55:21 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:55:21 INFO - Running post-action listener: _resource_record_post_action 04:55:21 INFO - [mozharness: 2017-02-08 12:55:21.306394Z] Finished install step (success) 04:55:21 INFO - [mozharness: 2017-02-08 12:55:21.306541Z] Running run-tests step. 04:55:21 INFO - Running pre-action listener: _resource_record_pre_action 04:55:21 INFO - Running main action method: run_tests 04:55:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:21 INFO - 2017-02-08 04:55:21.321 screenresolution[1899:15634] starting screenresolution argv=screenresolution get 04:55:21 INFO - 2017-02-08 04:55:21.323 screenresolution[1899:15634] Display 0: 1600x1200x32@60 04:55:21 INFO - 2017-02-08 04:55:21.329 screenresolution[1900:15636] starting screenresolution argv=screenresolution list 04:55:21 INFO - Available Modes on Display 0 04:55:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:21 INFO - Intel Iris: 04:55:21 INFO - Chipset Model: Intel Iris 04:55:21 INFO - Type: GPU 04:55:21 INFO - Bus: Built-In 04:55:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:21 INFO - Vendor: Intel (0x8086) 04:55:21 INFO - Device ID: 0x0a2e 04:55:21 INFO - Revision ID: 0x0009 04:55:21 INFO - Displays: 04:55:21 INFO - Display: 04:55:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:21 INFO - Display Serial Number: 1600x1200 60 04:55:21 INFO - Main Display: Yes 04:55:21 INFO - Mirror: Off 04:55:21 INFO - Online: Yes 04:55:21 INFO - Rotation: Supported 04:55:21 INFO - Return code: 0 04:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:55:21 INFO - Python 2.7.3 04:55:21 INFO - Return code: 0 04:55:21 INFO - grabbing minidump binary from tooltool 04:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:55:21 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 0x10c7a2d30>, '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 0x10c6c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c797be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:55:21 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 04:55:21 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 04:55:21 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 04:55:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:55:21 INFO - Return code: 0 04:55:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:55:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:55:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:55:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:55:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dZzSk5Qqxv/Render', 04:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:55:21 INFO - 'HOME': '/Users/cltbld', 04:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:55:21 INFO - 'LOGNAME': 'cltbld', 04:55:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:55:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:21 INFO - 'MOZ_NO_REMOTE': '1', 04:55:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:55:21 INFO - 'NO_EM_RESTART': '1', 04:55:21 INFO - 'PAGER': '/bin/cat', 04:55:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:55:21 INFO - 'PWD': '/builds/slave/test', 04:55:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:55:21 INFO - 'SHELL': '/bin/bash', 04:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.u7wFRIhsbh/Listeners', 04:55:21 INFO - 'TMPDIR': '/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/', 04:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:55:21 INFO - 'USER': 'cltbld', 04:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:21 INFO - 'XPC_FLAGS': '0x0', 04:55:21 INFO - 'XPC_SERVICE_NAME': '0', 04:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:55:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:55:21 INFO - mozversion application_buildid: 20170208030203 04:55:21 INFO - mozversion application_changeset: 3a95aa4246653a7863914ffec032897d13359fb0 04:55:21 INFO - mozversion application_display_name: Nightly 04:55:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:55:21 INFO - mozversion application_name: Firefox 04:55:21 INFO - mozversion application_remotingname: firefox 04:55:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:55:21 INFO - mozversion application_vendor: Mozilla 04:55:21 INFO - mozversion application_version: 54.0a1 04:55:21 INFO - mozversion platform_buildid: 20170208030203 04:55:21 INFO - mozversion platform_changeset: 3a95aa4246653a7863914ffec032897d13359fb0 04:55:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:55:21 INFO - mozversion platform_version: 54.0a1 04:55:21 INFO - using testdate: 1486558521 04:55:21 INFO - actual date: 1486558521 04:55:21 INFO - starting webserver on 'localhost:52797' 04:55:21 INFO - SUITE-START | Running 2 tests 04:55:21 INFO - TEST-START | dromaeo_css 04:55:21 INFO - operating with platform_type : mac_ 04:55:21 INFO - Initialising browser for dromaeo_css test... 04:55:21 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp4BXJSJ/profile http://localhost:52797/getInfo.html) 04:55:23 INFO - PROCESS | 1910 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:55:24 INFO - PROCESS | 1910 | __metrics Screen width/height:1600/1200 04:55:24 INFO - PROCESS | 1910 | colorDepth:24 04:55:24 INFO - PROCESS | 1910 | Browser inner width/height: 1024/689 04:55:24 INFO - PROCESS | 1910 | __metrics 04:55:24 INFO - PROCESS | 1910 | 1486558524349 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 04:55:24 INFO - PROCESS | 1910 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:55:24 INFO - PROCESS | 1910 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:55:25 INFO - TEST-INFO | 1910: exit 0 04:55:25 INFO - Browser initialized. 04:55:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:55:25 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmp4BXJSJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:37 INFO - PROCESS | 1913 | RSS: Main: 236650496 04:55:37 INFO - PROCESS | 1913 | 04:58:40 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:52797/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52797/tests/dromaeo/cssquery-ext.html) 04:58:42 INFO - PROCESS | 1913 | RSS: Main: 395366400 04:58:42 INFO - PROCESS | 1913 | 05:00:25 INFO - PROCESS | 1913 | ************************* 05:00:25 INFO - PROCESS | 1913 | A coding exception was thrown and uncaught in a Task. 05:00:25 INFO - PROCESS | 1913 | 05:00:25 ERROR - PROCESS | 1913 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:00:25 INFO - PROCESS | 1913 | Full stack: 05:00:25 INFO - PROCESS | 1913 | ************************* 05:01:45 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:52797/tests/dromaeo/cssquery-ext.html (next: http://localhost:52797/tests/dromaeo/cssquery-jquery.html) 05:01:46 INFO - PROCESS | 1913 | RSS: Main: 374988800 05:01:46 INFO - PROCESS | 1913 | 05:04:48 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:52797/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52797/tests/dromaeo/cssquery-mootools.html) 05:04:49 INFO - PROCESS | 1913 | RSS: Main: 361902080 05:04:49 INFO - PROCESS | 1913 | 05:07:51 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:52797/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52797/tests/dromaeo/cssquery-prototype.html) 05:07:52 INFO - PROCESS | 1913 | RSS: Main: 351911936 05:07:52 INFO - PROCESS | 1913 | 05:10:55 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:52797/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52797/tests/dromaeo/cssquery-yui.html) 05:10:56 INFO - PROCESS | 1913 | RSS: Main: 332099584 05:10:56 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:52797/tests/dromaeo/cssquery-yui.html (next: http://localhost:52797/tests/dromaeo/cssquery-dojo.html) 05:13:59 INFO - PROCESS | 1913 | RSS: Main: 483852288 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | __start_tp_report 05:13:59 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 05:13:59 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 05:13:59 INFO - PROCESS | 1913 | |i|pagename|runs| 05:13:59 INFO - PROCESS | 1913 | |0;dojo.html;3285;3285.342931413717;3294.3246634439934;3305.3719793239297;3317.021478663794;5412.2422860799425;5477.424870388611;5515.696636684986;5588.972055139724;5593.972030139854;5443.564514838813;5463.289772329592;5504.972475137629;5576.191452239423;5605.27131472908;4941.851744447663;4972.129877271481;4983.377077865267;4983.775730092155;5007.69953802773;5132.871678208056;5153.6392452528335;5159.045576568328;5178.275041494175;5181.041507321158;3863.2466668999555;4502.212112880233;4962.454130045692;4995.050940321327;5115.872103197413;5021.723805190713;5082.593392528589;5090.490950904917;5122.103631864409;5153.2785410042625;4992.625553083533;5040.16837221858;5044.243363495469;5073.695578265316;5077.365329333833;5349.919751203735;5408.756605952742;5535.6955367454775;5550.4449555044575;5554.611177217596;5982.222311099529;6016.789412370546;6095.6952152392205;6113.293877754025;6144.78493252734;6105.908411373833;6177.135201071854;6190;6194.256689197326;6195.81412557624;5645.435456454322;5653.802116925888;5662.68855212959;5671.2060311556415;5685.772569097231;6018.638881667114;6110.43725517484;6118.131909153758;6147.508199344042;6175.104609831549;5990.131430942489;6045.667488288098;6068.120122582201;6085.452309292096;6096.451319381277;5009.323741294951;6154.753809847645;6163.568550201443;6173.81478555644;6176.722047507873;5789.334226563915;6006.339302676702;6103.816885493442;6118.296395914438;6129.754809807558;5909.852253693606;5977.402259774075;6022.307434644984;6075.058365953284;6105.175801266861;4917.28699338601;4917.606591472673;4923.064617722621;4948.5546300832375;4957;4378.693491455568;4382.035952090535;4386.71486353386;4390.231709450897;4402.911941761146;5469.179623056573;5495.148252020943;5685.976524225596;5718.285214348207;5722.77108915647;4905.411350637946;6067.878642427127;6106.908396374058;6133.671320645534;6139;5680.914786278209;5707.258056452718;5708.40061793514;5717.142428635655;5742.253507044057;5345.278387417727;5346.946530534645;5348.893022139536;5358.089124848785;5359.517643412111;6124.265088189446;6174.8147555573405;6204.038374052029;6215.409536093974;6226.906596400967;5949.881002379841;6028.638281703112;6115.816525504242;6124.899720462962;6130.795626845359;6177.227846519185;6226.719797609027;6232.719527621177;6235.75056997715;6239.844003899939;5894.646321220741;6035.18524999137;6040.939590604214;6043.002904520705;6084.33072362031;6085.939140608537;6127.325994140552;6139.3553676863285;6142.170806941184;6151.0773383992755;5103.693778373309;5695.544356451557;5749.8275051748515;5753.1370294456165;5821.476067153976;5944.138099975393;5951.672658003851;5960.374160713062;5963.731632076654;5971.880562388641;5740.052891272893;5780.884382312246;5781.82654520365;5790.1893734877995;5792.986227410102;5683.147527870852;5725.541956643375;5868.823935281948;5956;5963.2844058713235;4591.65562582801;4685.906281874275;5614.887702246014;5626.2967129108865;5652.378238393856 05:13:59 INFO - PROCESS | 1913 | |1;ext.html;492.8521443566929;493.85184444666595;510.2550276596169;514.451500982044;522.2479629333757;28816.423671526558;30391.544126838115;38224.99999999996;39613.60386396143;40208.39687404691;40951.59048409515;41344;41380.379294310536;41440.585594144046;41464.58535414645;9192.310576706757;9423.34036617437;9432.575534100948;9433.433993960385;9442.527873606326;7982.241687039722;8187.877181842277;9224.07759224079;10961.451927403637;11248.718782030473;11149.832752508719;11186.496607652674;11201.551937922513;11244.212905096647;11323.490442930046;11106.6112686056;11162.609308674238;11187.720306992309;11196.936291052338;11215.271007384536;7899;8128.593570321519;10793;11084.057855082247;11085.002349788478;38353.616463835286;38906.61093389058;38958.415623765664;39243.60756392428;39270.8218753435;3821.5796262411113;3834.9424758628643;3837.520309961255;3849.2301539692176;3849.749766265184;26825.731742682518;27131.864340678367;28613.28466788347;29202.707972920212;30106.84946575253;2685.1810197889636;3028.5154375299844;3056.526238433024;3064.6782087880674;3095.133362658459;435286;436803;440914;442962.785186072;444204.77897610626;43527.782361088626;51253.74373128185;52364.214536781976;52533.68665783386;52819.28481800537;49181;50432;50472.4858254253;50508.74745626322;50544.747276263384;12604.243745375306;13940.790888136686;14279.286935482225;14329.78505322421;14618.853811461962;10452.32059916103;10469.371837689763;10470.842937355947;10473.581056757797;10498.475076246157;16170.35318587267;16791.984961804417;16855.831441685426;16875.32498700063;16895.915520422564;7445.590492522855;7564.810879728051;7607.212305108295;7654.349380302625;7677.654505547263;802.2018091998499;830.1076342931373;840.5083026429485;863.2662237098542;867.4881819726392;27918;28872.566911496346;28983.275418114295;29761.404771904872;29817.701822981493;981.1415011864618;1006.6124542051217;1023.6007956896816;1042.2183362478142;1059.4067322299384;13685.657858553615;14995.625109372135;15092.924535377473;15207.391704331703;15231.61920951963;610050;615166;617051;617489;618052;46627;57627.71186144126;57724.71137644285;57731.13403298954;57734.711326443095;1335.933203339829;1370.869767372098;1377.7175678985784;1380.0201856681867;1380.792881067848;25803.612945805453;27160.049398270967;27721.44557108806;28315.43369132647;29425.264368390963;47798.52201477941;48019.75990120027;48107;48129.75935120302;48170.518294816604;487970;489846;490903;491018.5449072732;492059;22352.77647223507;22946.01701778825;25098.498030039664;25766;25812.22563323103;37532.624673754006;44896.87757806081;46025.30962035505;46257.30614040725;46296.30555541737;28502;34934;35994.64005359913;37891.81054094822;37902.62097378991;36031;36241.27517449689;36322.63677363192;37580;37670.058248544;36383.636163638024;36863.262734745695;37106.628933710315;37226.44160337543;37327.626723732414;30139;32327.51508727418;32661.510077349332;32730.50904236391;32742.50886236756;23843.523129537658;23901.043958241477;24005.639915401633;24567;24615.753842461345 05:13:59 INFO - PROCESS | 1913 | |2;jquery.html;385.974911630744;387.30478790570925;390.9582376655599;397.4753325610194;417.5469615467218;15617.921910390447;19799.40601781949;20426.591468170627;20439.59120817583;20685.276015339467;12165.452554635063;12280.877191228084;12455.937720311409;16597.585060373465;21061.473463163427;5277.947220527803;5309.761060752266;5378.354597448311;5531;5543.362513310981;5342.813001544947;5436.891262174754;5447.536959358459;5453.700046497441;5464.781408743645;5434.91847622286;5451.918221226685;5458.399576046631;5475.06923822951;5966.164736936832;5942.108683697436;5984.222051133368;5988.341282458926;6012.308584512772;6012.609180403259;5127.307813445174;5246.711430871301;5259.63182577216;5305.814296499604;5339.973300133474;13281.601551953458;13534.796978045337;13685.836703880183;15471.922640386838;24980.250592482254;2575.394782226194;2658.0962472759356;2660.428007978294;2664.067576348282;2675.4515324358654;9669.903300966971;10074.546645400902;10164.44095574743;10535.420551869644;10602.628907988183;1561.2974161627312;1790.534461040126;1805.7562229099167;1811.6467288878673;1819.7998220195768;111955;114290.9987053169;121792;127487;127822;9342.673006444742;10633.627823026158;10914.345139291669;11579.942100289445;11721.069732566859;15887.364505419653;15893.205339732967;15894.682106357808;15905.840941590435;15924.522264332089;7171.569705817667;7856;8114.188581141839;8141.104478507359;8289.253967142866;7600.196839630348;7603.163651998276;7625.466217364842;7755.573443460551;7805.180456052146;3882.242962622318;4784.449788274393;4805.663603547718;4810.182269014276;4946.975265123651;1647.522218556629;1791.4177892185091;1971.2115153938253;2035.4707775978352;2041.6325061489074;878.9428687135315;901.2249465459699;926.967556135532;970.9757256068655;1005.3465247589126;17377.391791287246;19462.902685486482;19984.400467985983;20091.698624520643;20342.898285508774;894.4633220068038;974.6783561424713;980.789130336981;987.4766373821886;996.7757254617798;9961.800763984824;10210.489475526194;10494.055535001886;10519.386674321731;10546.736331591617;665313;672145.9178112332;676475;702323;702754;115499;131115.7221069481;140300;146706.5329346693;147969;978.222313260945;978.9902100978899;993.6124911284605;995.955182016811;996.3872218585518;17116.229769660644;17616.207270672596;17765.378211762527;17825.643487130445;18237.54406139804;45271;50093.49906500888;52639.73680131575;54653.63365915725;55452.16821747596;58469.70765146147;59109.11336330044;60524;61550;61796.69101654463;7879.763607091796;8040.718574849852;8128.187181282061;8196.754097377088;8514.659413623633;11858;12469.314187719763;12559.550887577201;12668.556600518938;12882.871171288167;10539.26225164231;10593.682189534326;10768.138548916224;10939.23425360249;11045.944770276097;10295.33080349805;10387.68836934893;10486.737831553966;10673.199510036624;10712.839307410552;10854.208091445955;11045.723856903642;11098.334099954029;11112.166587505808;11225.66323010311;7922.524648521107;7923.484973476706;8390.622421991147;8405.621747021276;8548.145185481402;9777.706668799663;10383.740406489898;10746.892531074589;10770.407627580558;10851.240413171003 05:13:59 INFO - PROCESS | 1913 | |3;mootools.html;1241.5716577780674;1430.8569143085692;1438.7050654615805;1456.1990905002253;1458.8249410070794;6836.521443498951;7814;7829.686812527492;7840;8198.959005204966;8246.91753082469;8430.95784521078;8437.987441507012;8450.154984501547;8451.281641060501;2241.361212054569;2273.7385200701883;2273.7726227377298;2274;2276.2829708641807;1812.8096549862273;1963.7741659709172;2040.9693854592192;2256.5261295128043;2272.0798076778933;2258.2434884313775;2264.2527965771337;2269.2851751698245;2271.432141964509;2272.2047283450825;2197.0223250653466;2212.524307273936;2221.033850275119;2221.144859229192;2221.833362497819;2205.2943058221376;2212.7012853264923;2265.637498000312;2269.795718385337;2294.4493321602695;8458.915410845875;8533.658653653847;8552.486850788973;8553.230209281195;8565.614547345385;5029.673071250357;5196.220566914955;5197.974010129963;5199.896002079937;5204.271402003723;3251.7073463388174;3429.0398688367295;3471.930561388783;3492.4761285807076;3506.5266189064405;1161.809630024728;1167.3754541320352;1222.1811386371153;1238.6841355454392;1245.582729785523;10980.615678451215;10984.725381865437;10999.61501347457;11001;11041.171912106623;4480.462344518679;4602.378678878308;4686.976565117153;4693.342931989524;4708.987567672898;9649.758756031155;9700.708978730649;9704.078112579293;9714.368566043184;9741;5223.2948551945;5232.372115346183;5233.790648374099;5240.161574148118;5247.003069416799;4630.143423466669;4705.9646877686855;4762.499937506581;4788.736619485892;4805.495422980537;3035.3929214157256;3395.3888300105723;3530.7351948603446;3533.6925337625244;3800.771953682788;1249.8625151233357;1251.1117106854053;1259.9496020159274;1268.460904115747;1272.4719241514667;737.4985010193013;831.9932881213679;882.6866462405882;892.1123482135188;912.9908700913039;4291.849785257564;5524;5658.462446067617;5688.232088667977;5776.393478684761;955.6559638530124;957.8706874571983;964.9951750241345;977.2914636888199;1000.924930630191;3688.5020522229156;3824.713146513967;3857.903552411156;3875.205582855508;3887.319719049155;9806.901930980599;10148.238882083873;10281.691549253534;10338.896611033944;10349.844752328721;9574.521273936276;10147.695569132939;10277.075063244343;10295;10295.021972912562;7555.16893141754;7808.6095695216145;7893;7909.644066017043;7942.285194332538;4642.675012749075;5083.38999320084;5283.2075188722;5601.823617040304;5752.9712351437975;9136.26909847224;9213.493257870881;9251.213646840093;9277.86083208766;9320.813583728423;8977.910220897707;9357.625694972125;9375.531223438937;9444.905550944402;9485.193758530602;7081.681324340314;7161.4986950912935;7230.927690723236;7244.311790379906;7254.89117663246;7026.543274687129;7116.537425067561;7687.2697093776005;7793.961030194812;7827.608619568885;6968.825779355557;7097.964510177416;7109.075820143348;7158.248383919822;7220.097487814023;7104.857902842017;7122.323379278961;7155.499115061895;7204.423646108404;7255.2019277880445;6370.617762934239;6380.521460890359;6439.356064393711;6468.223813142265;6475.805725828232;4570.748608826547;4797;4849.975750121227;4897.2654101885;5012.899742005213;4926.802927882844;4930.926036109533;5031.647784655039;5033.094043072282;5111.642185047011 05:13:59 INFO - PROCESS | 1913 | |4;prototype.html;270.47721328918186;346.19682336978207;364.1515269422246;365.1929236387583;365.211143929113;4928.605711543077;5186.521841275237;5207.869803254921;5245.527902488775;5419.184573167989;4927.802887884481;4992.276119962603;5047.49525047496;5136.534463457542;5158.226266060093;2949.4101179764025;3249.5775549178575;3758.4174452959833;3961.3067713150226;3963.3064213762477;3384.2047118927035;3509.3683137035323;3898.902527436808;3933.940990885139;3975.82108805103;3152.4010438016703;3907.374820028796;3911.8239679214503;3931.2137572485476;3970.2258059678375;3264.4450443424676;3554.36021516127;3877.4571559981623;3918.3338832398563;3924.646781789638;2957.926051848721;3133.373325334919;3385.5598772159706;3432.3821712091813;3455.8444869980913;4836.443808961944;5066.594672426197;5100.030994111107;5108.2848401223855;5126.94970972931;3828.272628200633;4122.886820558462;4451.866444006685;4490.326451032339;4513.796879140414;4890.755462226874;5146.665466744687;5190.290680251731;5444.809431669913;5465.508104270595;3329.200991761984;3599.5500562429697;3762.623737626243;3777.8488860445823;3779.281936432069;4936;5171.663841850268;5293.512049336806;5434.7826086956475;5849;3668.119651283726;3693.2244228711734;3818.5608655004476;3823.7323387362617;3830.138218900725;3081.245094951751;3292;3881.165549406891;3885.8445662173763;3901.035213237903;4200.4959404871615;4384.605385515319;4522.954770452319;4543.750093744876;4550.567696068868;5165.66423182492;5451.48210919962;5513.862153446115;5527.982286465492;5553.694546799965;1171.683645415733;1216.288471244332;1249.5564074753513;1260.2230854495117;1267.309316422552;749.4341771962133;797.8962734844433;841.8232171243985;856.6873091321747;867.7440155154245;4080.693947953856;4375.890602734957;4540.750258735735;4567.657425693086;4955.4301255356095;4762.666613337033;5385.626665200349;5428.9185662215095;5477.561795056386;5493.972530137324;4536.9092618148115;4766.880827979259;4967.726775027409;4968.254761785761;4984.476629953875;2463.470353873926;2543.936401589975;2767.764739997123;2846.4591727571697;2853;5184.922226166535;5530.6128570999645;5606.962711898312;5693.3168019837885;5720.456556627114;4690.7654617269;5130.615203859726;5303.992241474108;5550.91673624896;5555.666660000413;4902.362692849978;5145.459726728789;5492.340919089735;5644.85887852807;5699.971500142556;4771.045790841915;5150.253213284128;5390;5435.130379139318;5435.537979271806;4267.231898258343;4401.009772801094;4878.609711223165;5149.845504634867;5274.657147285414;5028.622853285945;5276.498732620395;5531.612787104864;5646.265985421869;5674.893395787782;3348.3972884880955;3657.122290650278;3728.7203459740085;3778.7543809652284;3790.7869481766675;5173.22401639757;5590.714135748719;5647.068233741551;5658.009848276617;5675.375708672125;5086.415062267739;5317.867053323543;5344.465553444625;5366.302380690641;5533.837894042296;4704.388429504143;4811.591014763784;5365.758540865749;5386.380566234933;5413.350397952271;5347.545458636059;5354.892902141857;5374.516293533601;5383.569314454912;5399.649022813504;5062.240663900445;5390.919136212881;5400.189971504149;5431.972840135774;5493.615446918678;4542.250528662734;5268;5317.601179911445;5359.919601206063;5405.675659460445 05:13:59 INFO - PROCESS | 1913 | |5;yui.html;694.4930200953307;720.3984672798214;756.0813611462075;802.8073262417021;817.431884840036;14153.433862645496;14811.259437028159;14830.703385932275;14853;14861.92569037156;13286.800697989538;13388.531401400953;13419.664508387295;13438;13452.192868427901;848.8684253940634;849.413904405958;868.053821334745;872.0320444306846;876.6493402638931;842.0821304777791;855.7176131876497;867.5748883047293;867.8698195270697;869.4956924983494;904.3488688144525;905.4160066756938;905.8414777413959;905.9456432614031;906.2704522859095;779.3687113438133;898.4878619187066;901.0088902207552;901.2069378946518;901.4816480523659;674.642439507062;675.530506298123;675.5372569789661;675.7229535890261;676.1311714446962;14659.780103298459;14718.852811471963;14730.779038314435;15095.245237738069;15123.621909452351;13569.660758481117;13726.862731372657;13789.448422063106;13934.93032534841;14004.72855778987;11437.828432573519;11445.771084578262;11509;11586.884131158666;12018.639440816789;3596.226811235597;3605.5132557104716;3648.7081033517256;3661.0847288177956;3674.65090816372;101006;103164.48417757938;103888.96111038869;104902;105794.47102764514;10427.530761115617;10511.684649460529;10538.156947444186;10606.681799545871;10700.732481688021;22024.11903523841;22211.66682499764;22249.55500889973;22265;22282.554348913254;6945.548539344926;7374.889376659355;7422.257774222535;7508.061492313461;7582.431317651198;3841.654251117357;3912.5891781363116;3951.308521008812;3953.6244056814558;3954.26846033479;3452.4993875887853;3532.3465158945164;3554.20030493137;3564.429691249388;3571.464280357915;583.553581510145;609.4088733928082;656.4420242793587;671.1543455246425;731.8572878288683;578.12702818744;677.444495513674;693.5284006875373;705.0939542687622;710.5701050864153;9445.858312125323;9520.476373799507;9823.459709715891;9905.752356191153;10197.74505637365;603.1831347606687;674.7132468700783;688.5834070387443;690.7824035428824;693.2963042511855;4574.336721175411;4745.305519330774;4824.08342414947;4836.153673107263;4863.683860549124;88632;96317.51841240888;100992;101250;102044.48977755064;68113.82634083842;74768;85062;89417;92392;71260;71324.64337678382;72690.27309726941;72939;74264.02943882185;8131.698928171464;8621.439606425562;9214.861777073484;9229.446233226028;9243;39909.60090399059;49329.01341973068;49759.50240497549;51940.740296298274;52075.2188717162;66067.34831629248;66299.33700662931;66843.33156668565;67126.66436667785;67981;9436.669716559887;9923.255755818487;11569.190156689288;11695.298282103102;12007.339596322287;12168.817467738168;12400.19398739079;12412.75174496487;12545.49818007306;12663.240205587694;11655.358955257543;11788.174827761974;11825.52697892109;11825.704357391134;11873.881261187624;11754;11779.587714429954;11804.350760708243;11877.643670689893;12212.267263964191;11611.709707257049;11647.766766627636;11750.471228794895;11778.587749428729;11858.703532411759;9363.812723745623;9459.905400946178;9597.047368447355;9864.753381165528;9943.850842237516;9607.951960240154;9655.758606034906;9693;9783;9810.803783924424 05:13:59 INFO - PROCESS | 1913 | __end_tp_report 05:13:59 INFO - PROCESS | 1913 | __start_cc_report 05:13:59 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,1786 05:13:59 INFO - PROCESS | 1913 | __end_cc_report 05:13:59 INFO - PROCESS | 1913 | __startTimestamp1486559639713__endTimestamp 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | ------- Summary: start ------- 05:13:59 INFO - PROCESS | 1913 | Number of tests: 6 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | [#0] dojo.html Cycles:165 Average:5569.02 Median:5718.29 stddev:645.19 (11.3%) stddev-sans-first:621.79 05:13:59 INFO - PROCESS | 1913 | Values: 3285.0 3285.3 3294.3 3305.4 3317.0 5412.2 5477.4 5515.7 5589.0 5594.0 5443.6 5463.3 5505.0 5576.2 5605.3 4941.9 4972.1 4983.4 4983.8 5007.7 5132.9 5153.6 5159.0 5178.3 5181.0 3863.2 4502.2 4962.5 4995.1 5115.9 5021.7 5082.6 5090.5 5122.1 5153.3 4992.6 5040.2 5044.2 5073.7 5077.4 5349.9 5408.8 5535.7 5550.4 5554.6 5982.2 6016.8 6095.7 6113.3 6144.8 6105.9 6177.1 6190.0 6194.3 6195.8 5645.4 5653.8 5662.7 5671.2 5685.8 6018.6 6110.4 6118.1 6147.5 6175.1 5990.1 6045.7 6068.1 6085.5 6096.5 5009.3 6154.8 6163.6 6173.8 6176.7 5789.3 6006.3 6103.8 6118.3 6129.8 5909.9 5977.4 6022.3 6075.1 6105.2 4917.3 4917.6 4923.1 4948.6 4957.0 4378.7 4382.0 4386.7 4390.2 4402.9 5469.2 5495.1 5686.0 5718.3 5722.8 4905.4 6067.9 6106.9 6133.7 6139.0 5680.9 5707.3 5708.4 5717.1 5742.3 5345.3 5346.9 5348.9 5358.1 5359.5 6124.3 6174.8 6204.0 6215.4 6226.9 5949.9 6028.6 6115.8 6124.9 6130.8 6177.2 6226.7 6232.7 6235.8 6239.8 5894.6 6035.2 6040.9 6043.0 6084.3 6085.9 6127.3 6139.4 6142.2 6151.1 5103.7 5695.5 5749.8 5753.1 5821.5 5944.1 5951.7 5960.4 5963.7 5971.9 5740.1 5780.9 5781.8 5790.2 5793.0 5683.1 5725.5 5868.8 5956.0 5963.3 4591.7 4685.9 5614.9 5626.3 5652.4 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | [#1] ext.html Cycles:180 Average:64166.72 Median:37277.03 stddev:139008.18 (372.9%) stddev-sans-first:139315.92 05:13:59 INFO - PROCESS | 1913 | Values: 492.9 493.9 510.3 514.5 522.2 28816.4 30391.5 38225.0 39613.6 40208.4 40951.6 41344.0 41380.4 41440.6 41464.6 9192.3 9423.3 9432.6 9433.4 9442.5 7982.2 8187.9 9224.1 10961.5 11248.7 11149.8 11186.5 11201.6 11244.2 11323.5 11106.6 11162.6 11187.7 11196.9 11215.3 7899.0 8128.6 10793.0 11084.1 11085.0 38353.6 38906.6 38958.4 39243.6 39270.8 3821.6 3834.9 3837.5 3849.2 3849.7 26825.7 27131.9 28613.3 29202.7 30106.8 2685.2 3028.5 3056.5 3064.7 3095.1 435286.0 436803.0 440914.0 442962.8 444204.8 43527.8 51253.7 52364.2 52533.7 52819.3 49181.0 50432.0 50472.5 50508.7 50544.7 12604.2 13940.8 14279.3 14329.8 14618.9 10452.3 10469.4 10470.8 10473.6 10498.5 16170.4 16792.0 16855.8 16875.3 16895.9 7445.6 7564.8 7607.2 7654.3 7677.7 802.2 830.1 840.5 863.3 867.5 27918.0 28872.6 28983.3 29761.4 29817.7 981.1 1006.6 1023.6 1042.2 1059.4 13685.7 14995.6 15092.9 15207.4 15231.6 610050.0 615166.0 617051.0 617489.0 618052.0 46627.0 57627.7 57724.7 57731.1 57734.7 1335.9 1370.9 1377.7 1380.0 1380.8 25803.6 27160.0 27721.4 28315.4 29425.3 47798.5 48019.8 48107.0 48129.8 48170.5 487970.0 489846.0 490903.0 491018.5 492059.0 22352.8 22946.0 25098.5 25766.0 25812.2 37532.6 44896.9 46025.3 46257.3 46296.3 28502.0 34934.0 35994.6 37891.8 37902.6 36031.0 36241.3 36322.6 37580.0 37670.1 36383.6 36863.3 37106.6 37226.4 37327.6 30139.0 32327.5 32661.5 32730.5 32742.5 23843.5 23901.0 24005.6 24567.0 24615.8 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | [#2] jquery.html Cycles:180 Average:36579.55 Median:2669.76 stddev:113667.10 (4257.6%) stddev-sans-first:113953.47 05:13:59 INFO - PROCESS | 1913 | Values: 386.0 387.3 391.0 397.5 417.5 15617.9 19799.4 20426.6 20439.6 20685.3 12165.5 12280.9 12455.9 16597.6 21061.5 5277.9 5309.8 5378.4 5531.0 5543.4 5342.8 5436.9 5447.5 5453.7 5464.8 5434.9 5451.9 5458.4 5475.1 5966.2 5942.1 5984.2 5988.3 6012.3 6012.6 5127.3 5246.7 5259.6 5305.8 5340.0 13281.6 13534.8 13685.8 15471.9 24980.3 2575.4 2658.1 2660.4 2664.1 2675.5 9669.9 10074.5 10164.4 10535.4 10602.6 1561.3 1790.5 1805.8 1811.6 1819.8 111955.0 114291.0 121792.0 127487.0 127822.0 9342.7 10633.6 10914.3 11579.9 11721.1 15887.4 15893.2 15894.7 15905.8 15924.5 7171.6 7856.0 8114.2 8141.1 8289.3 7600.2 7603.2 7625.5 7755.6 7805.2 3882.2 4784.4 4805.7 4810.2 4947.0 1647.5 1791.4 1971.2 2035.5 2041.6 878.9 901.2 927.0 971.0 1005.3 17377.4 19462.9 19984.4 20091.7 20342.9 894.5 974.7 980.8 987.5 996.8 9961.8 10210.5 10494.1 10519.4 10546.7 665313.0 672145.9 676475.0 702323.0 702754.0 115499.0 131115.7 140300.0 146706.5 147969.0 978.2 979.0 993.6 996.0 996.4 17116.2 17616.2 17765.4 17825.6 18237.5 45271.0 50093.5 52639.7 54653.6 55452.2 58469.7 59109.1 60524.0 61550.0 61796.7 7879.8 8040.7 8128.2 8196.8 8514.7 11858.0 12469.3 12559.6 12668.6 12882.9 10539.3 10593.7 10768.1 10939.2 11045.9 10295.3 10387.7 10486.7 10673.2 10712.8 10854.2 11045.7 11098.3 11112.2 11225.7 7922.5 7923.5 8390.6 8405.6 8548.1 9777.7 10383.7 10746.9 10770.4 10851.2 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | [#3] mootools.html Cycles:180 Average:5421.52 Median:5058.24 stddev:3010.94 (59.5%) stddev-sans-first:3002.99 05:13:59 INFO - PROCESS | 1913 | Values: 1241.6 1430.9 1438.7 1456.2 1458.8 6836.5 7814.0 7829.7 7840.0 8199.0 8246.9 8431.0 8438.0 8450.2 8451.3 2241.4 2273.7 2273.8 2274.0 2276.3 1812.8 1963.8 2041.0 2256.5 2272.1 2258.2 2264.3 2269.3 2271.4 2272.2 2197.0 2212.5 2221.0 2221.1 2221.8 2205.3 2212.7 2265.6 2269.8 2294.4 8458.9 8533.7 8552.5 8553.2 8565.6 5029.7 5196.2 5198.0 5199.9 5204.3 3251.7 3429.0 3471.9 3492.5 3506.5 1161.8 1167.4 1222.2 1238.7 1245.6 10980.6 10984.7 10999.6 11001.0 11041.2 4480.5 4602.4 4687.0 4693.3 4709.0 9649.8 9700.7 9704.1 9714.4 9741.0 5223.3 5232.4 5233.8 5240.2 5247.0 4630.1 4706.0 4762.5 4788.7 4805.5 3035.4 3395.4 3530.7 3533.7 3800.8 1249.9 1251.1 1259.9 1268.5 1272.5 737.5 832.0 882.7 892.1 913.0 4291.8 5524.0 5658.5 5688.2 5776.4 955.7 957.9 965.0 977.3 1000.9 3688.5 3824.7 3857.9 3875.2 3887.3 9806.9 10148.2 10281.7 10338.9 10349.8 9574.5 10147.7 10277.1 10295.0 10295.0 7555.2 7808.6 7893.0 7909.6 7942.3 4642.7 5083.4 5283.2 5601.8 5753.0 9136.3 9213.5 9251.2 9277.9 9320.8 8977.9 9357.6 9375.5 9444.9 9485.2 7081.7 7161.5 7230.9 7244.3 7254.9 7026.5 7116.5 7687.3 7794.0 7827.6 6968.8 7098.0 7109.1 7158.2 7220.1 7104.9 7122.3 7155.5 7204.4 7255.2 6370.6 6380.5 6439.4 6468.2 6475.8 4570.7 4797.0 4850.0 4897.3 5012.9 4926.8 4930.9 5031.6 5033.1 5111.6 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | [#4] prototype.html Cycles:180 Average:4335.85 Median:4945.72 stddev:1343.77 (27.2%) stddev-sans-first:1312.43 05:13:59 INFO - PROCESS | 1913 | Values: 270.5 346.2 364.2 365.2 365.2 4928.6 5186.5 5207.9 5245.5 5419.2 4927.8 4992.3 5047.5 5136.5 5158.2 2949.4 3249.6 3758.4 3961.3 3963.3 3384.2 3509.4 3898.9 3933.9 3975.8 3152.4 3907.4 3911.8 3931.2 3970.2 3264.4 3554.4 3877.5 3918.3 3924.6 2957.9 3133.4 3385.6 3432.4 3455.8 4836.4 5066.6 5100.0 5108.3 5126.9 3828.3 4122.9 4451.9 4490.3 4513.8 4890.8 5146.7 5190.3 5444.8 5465.5 3329.2 3599.6 3762.6 3777.8 3779.3 4936.0 5171.7 5293.5 5434.8 5849.0 3668.1 3693.2 3818.6 3823.7 3830.1 3081.2 3292.0 3881.2 3885.8 3901.0 4200.5 4384.6 4523.0 4543.8 4550.6 5165.7 5451.5 5513.9 5528.0 5553.7 1171.7 1216.3 1249.6 1260.2 1267.3 749.4 797.9 841.8 856.7 867.7 4080.7 4375.9 4540.8 4567.7 4955.4 4762.7 5385.6 5428.9 5477.6 5494.0 4536.9 4766.9 4967.7 4968.3 4984.5 2463.5 2543.9 2767.8 2846.5 2853.0 5184.9 5530.6 5607.0 5693.3 5720.5 4690.8 5130.6 5304.0 5550.9 5555.7 4902.4 5145.5 5492.3 5644.9 5700.0 4771.0 5150.3 5390.0 5435.1 5435.5 4267.2 4401.0 4878.6 5149.8 5274.7 5028.6 5276.5 5531.6 5646.3 5674.9 3348.4 3657.1 3728.7 3778.8 3790.8 5173.2 5590.7 5647.1 5658.0 5675.4 5086.4 5317.9 5344.5 5366.3 5533.8 4704.4 4811.6 5365.8 5386.4 5413.4 5347.5 5354.9 5374.5 5383.6 5399.6 5062.2 5390.9 5400.2 5432.0 5493.6 4542.3 5268.0 5317.6 5359.9 5405.7 05:13:59 INFO - PROCESS | 1913 | 05:13:59 INFO - PROCESS | 1913 | [#5] yui.html Cycles:180 Average:19433.41 Median:52007.98 stddev:28168.53 (54.2%) stddev-sans-first:28212.41 05:13:59 INFO - PROCESS | 1913 | Values: 694.5 720.4 756.1 802.8 817.4 14153.4 14811.3 14830.7 14853.0 14861.9 13286.8 13388.5 13419.7 13438.0 13452.2 848.9 849.4 868.1 872.0 876.6 842.1 855.7 867.6 867.9 869.5 904.3 905.4 905.8 905.9 906.3 779.4 898.5 901.0 901.2 901.5 674.6 675.5 675.5 675.7 676.1 14659.8 14718.9 14730.8 15095.2 15123.6 13569.7 13726.9 13789.4 13934.9 14004.7 11437.8 11445.8 11509.0 11586.9 12018.6 3596.2 3605.5 3648.7 3661.1 3674.7 101006.0 103164.5 103889.0 104902.0 105794.5 10427.5 10511.7 10538.2 10606.7 10700.7 22024.1 22211.7 22249.6 22265.0 22282.6 6945.5 7374.9 7422.3 7508.1 7582.4 3841.7 3912.6 3951.3 3953.6 3954.3 3452.5 3532.3 3554.2 3564.4 3571.5 583.6 609.4 656.4 671.2 731.9 578.1 677.4 693.5 705.1 710.6 9445.9 9520.5 9823.5 9905.8 10197.7 603.2 674.7 688.6 690.8 693.3 4574.3 4745.3 4824.1 4836.2 4863.7 88632.0 96317.5 100992.0 101250.0 102044.5 68113.8 74768.0 85062.0 89417.0 92392.0 71260.0 71324.6 72690.3 72939.0 74264.0 8131.7 8621.4 9214.9 9229.4 9243.0 39909.6 49329.0 49759.5 51940.7 52075.2 66067.3 66299.3 66843.3 67126.7 67981.0 9436.7 9923.3 11569.2 11695.3 12007.3 12168.8 12400.2 12412.8 12545.5 12663.2 11655.4 11788.2 11825.5 11825.7 11873.9 11754.0 11779.6 11804.4 11877.6 12212.3 11611.7 11647.8 11750.5 11778.6 11858.7 9363.8 9459.9 9597.0 9864.8 9943.9 9608.0 9655.8 9693.0 9783.0 9810.8 05:13:59 INFO - PROCESS | 1913 | -------- Summary: end -------- 05:13:59 INFO - PROCESS | 1913 | 05:14:00 INFO - TEST-INFO | 1913: exit 0 05:14:00 INFO - TEST-OK | dromaeo_css | took 1118450ms 05:14:00 INFO - TEST-START | kraken 05:14:00 INFO - operating with platform_type : mac_ 05:14:00 INFO - Initialising browser for kraken test... 05:14:00 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpZSUwBy/profile http://localhost:52797/getInfo.html) 05:14:02 INFO - PROCESS | 1917 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:14:02 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 05:14:02 INFO - PROCESS | 1917 | colorDepth:24 05:14:02 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 05:14:02 INFO - PROCESS | 1917 | __metrics 05:14:02 INFO - PROCESS | 1917 | 1486559642679 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/FirefoxNightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 05:14:02 INFO - PROCESS | 1917 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:14:02 INFO - PROCESS | 1917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:03 INFO - TEST-INFO | 1917: exit 0 05:14:03 INFO - Browser initialized. 05:14:03 INFO - Running cycle 1/1 for kraken test... 05:14:03 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/tmpZSUwBy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:14:15 INFO - PROCESS | 1919 | RSS: Main: 236888064 05:14:15 INFO - PROCESS | 1919 | 05:14:18 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52797/tests/kraken/driver.html?testName=audio-beat-detection) 05:14:19 INFO - PROCESS | 1919 | RSS: Main: 288935936 05:14:19 INFO - PROCESS | 1919 | 05:14:21 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52797/tests/kraken/driver.html?testName=audio-dft) 05:14:22 INFO - PROCESS | 1919 | RSS: Main: 290803712 05:14:22 INFO - PROCESS | 1919 | 05:14:25 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52797/tests/kraken/driver.html?testName=audio-fft) 05:14:26 INFO - PROCESS | 1919 | RSS: Main: 381259776 05:14:26 INFO - PROCESS | 1919 | 05:14:28 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52797/tests/kraken/driver.html?testName=audio-oscillator) 05:14:29 INFO - PROCESS | 1919 | RSS: Main: 284602368 05:14:29 INFO - PROCESS | 1919 | 05:14:31 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52797/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:14:31 INFO - PROCESS | 1919 | RSS: Main: 289026048 05:14:31 INFO - PROCESS | 1919 | 05:14:34 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52797/tests/kraken/driver.html?testName=imaging-darkroom) 05:14:35 INFO - PROCESS | 1919 | RSS: Main: 329125888 05:14:35 INFO - PROCESS | 1919 | 05:14:38 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52797/tests/kraken/driver.html?testName=imaging-desaturate) 05:14:38 INFO - PROCESS | 1919 | RSS: Main: 331321344 05:14:38 INFO - PROCESS | 1919 | 05:14:41 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52797/tests/kraken/driver.html?testName=json-parse-financial) 05:14:42 INFO - PROCESS | 1919 | RSS: Main: 329363456 05:14:42 INFO - PROCESS | 1919 | 05:14:43 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52797/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:14:44 INFO - PROCESS | 1919 | RSS: Main: 306638848 05:14:44 INFO - PROCESS | 1919 | 05:14:46 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:14:46 INFO - PROCESS | 1919 | RSS: Main: 307974144 05:14:46 INFO - PROCESS | 1919 | 05:14:49 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:14:49 INFO - PROCESS | 1919 | RSS: Main: 310325248 05:14:49 INFO - PROCESS | 1919 | 05:14:52 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:14:53 INFO - PROCESS | 1919 | RSS: Main: 328835072 05:14:53 INFO - PROCESS | 1919 | 05:14:56 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:14:57 INFO - PROCESS | 1919 | RSS: Main: 322822144 05:14:57 INFO - PROCESS | 1919 | 05:14:58 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:52797/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52797/tests/kraken/driver.html?testName=ai-astar) 05:14:59 INFO - PROCESS | 1919 | RSS: Main: 367489024 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | __start_tp_report 05:14:59 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 05:14:59 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 05:14:59 INFO - PROCESS | 1919 | |i|pagename|runs| 05:14:59 INFO - PROCESS | 1919 | |0;ai-astar;112;113;115;113;114;115;114;114;114;114 05:14:59 INFO - PROCESS | 1919 | |1;audio-beat-detection;143;113;112;150;113;112;111;112;134;114 05:14:59 INFO - PROCESS | 1919 | |2;audio-dft;183;187;184;187;184;185;181;185;209;261 05:14:59 INFO - PROCESS | 1919 | |3;audio-fft;81;59;60;89;61;58;58;60;66;75 05:14:59 INFO - PROCESS | 1919 | |4;audio-oscillator;91;72;88;70;70;71;87;71;70;86 05:14:59 INFO - PROCESS | 1919 | |5;imaging-gaussian-blur;89;87;90;88;89;86;90;87;90;86 05:14:59 INFO - PROCESS | 1919 | |6;imaging-darkroom;95;96;95;96;96;95;97;96;95;96 05:14:59 INFO - PROCESS | 1919 | |7;imaging-desaturate;87;85;94;84;84;85;86;87;89;87 05:14:59 INFO - PROCESS | 1919 | |8;json-parse-financial;61;59;59;58;59;58;59;59;58;59 05:14:59 INFO - PROCESS | 1919 | |9;json-stringify-tinderbox;65;76;66;76;74;66;70;69;70;71 05:14:59 INFO - PROCESS | 1919 | |10;stanford-crypto-aes;89;89;89;88;90;87;87;88;89;89 05:14:59 INFO - PROCESS | 1919 | |11;stanford-crypto-ccm;145;146;146;142;142;142;161;139;205;153 05:14:59 INFO - PROCESS | 1919 | |12;stanford-crypto-pbkdf2;172;167;175;172;172;177;173;175;172;174 05:14:59 INFO - PROCESS | 1919 | |13;stanford-crypto-sha256-iterative;68;67;67;68;68;71;82;82;84;79 05:14:59 INFO - PROCESS | 1919 | __end_tp_report 05:14:59 INFO - PROCESS | 1919 | __start_cc_report 05:14:59 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,2143 05:14:59 INFO - PROCESS | 1919 | __end_cc_report 05:14:59 INFO - PROCESS | 1919 | __startTimestamp1486559699211__endTimestamp 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | ------- Summary: start ------- 05:14:59 INFO - PROCESS | 1919 | Number of tests: 14 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 05:14:59 INFO - PROCESS | 1919 | Values: 112.0 113.0 115.0 113.0 114.0 115.0 114.0 114.0 114.0 114.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#1] audio-beat-detection Cycles:10 Average:121.40 Median:113.50 stddev:14.95 (13.2%) stddev-sans-first:13.67 05:14:59 INFO - PROCESS | 1919 | Values: 143.0 113.0 112.0 150.0 113.0 112.0 111.0 112.0 134.0 114.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#2] audio-dft Cycles:10 Average:194.60 Median:186.00 stddev:24.63 (13.2%) stddev-sans-first:25.77 05:14:59 INFO - PROCESS | 1919 | Values: 183.0 187.0 184.0 187.0 184.0 185.0 181.0 185.0 209.0 261.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#3] audio-fft Cycles:10 Average:66.70 Median:63.50 stddev:11.08 (17.4%) stddev-sans-first:10.47 05:14:59 INFO - PROCESS | 1919 | Values: 81.0 59.0 60.0 89.0 61.0 58.0 58.0 60.0 66.0 75.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:79.00 stddev:9.06 (11.5%) stddev-sans-first:8.21 05:14:59 INFO - PROCESS | 1919 | Values: 91.0 72.0 88.0 70.0 70.0 71.0 87.0 71.0 70.0 86.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.00 stddev:1.62 (1.8%) stddev-sans-first:1.69 05:14:59 INFO - PROCESS | 1919 | Values: 89.0 87.0 90.0 88.0 89.0 86.0 90.0 87.0 90.0 86.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#6] imaging-darkroom Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 05:14:59 INFO - PROCESS | 1919 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 97.0 96.0 95.0 96.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:2.97 (3.4%) stddev-sans-first:3.15 05:14:59 INFO - PROCESS | 1919 | Values: 87.0 85.0 94.0 84.0 84.0 85.0 86.0 87.0 89.0 87.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.50 05:14:59 INFO - PROCESS | 1919 | Values: 61.0 59.0 59.0 58.0 59.0 58.0 59.0 59.0 58.0 59.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:4.03 (5.7%) stddev-sans-first:3.79 05:14:59 INFO - PROCESS | 1919 | Values: 65.0 76.0 66.0 76.0 74.0 66.0 70.0 69.0 70.0 71.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 05:14:59 INFO - PROCESS | 1919 | Values: 89.0 89.0 89.0 88.0 90.0 87.0 87.0 88.0 89.0 89.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#11] stanford-crypto-ccm Cycles:10 Average:152.10 Median:146.00 stddev:19.67 (13.5%) stddev-sans-first:20.69 05:14:59 INFO - PROCESS | 1919 | Values: 145.0 146.0 146.0 142.0 142.0 142.0 161.0 139.0 205.0 153.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:173.50 stddev:2.69 (1.5%) stddev-sans-first:2.83 05:14:59 INFO - PROCESS | 1919 | Values: 172.0 167.0 175.0 172.0 172.0 177.0 173.0 175.0 172.0 174.0 05:14:59 INFO - PROCESS | 1919 | 05:14:59 INFO - PROCESS | 1919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:75.00 stddev:7.20 (9.6%) stddev-sans-first:7.34 05:14:59 INFO - PROCESS | 1919 | Values: 68.0 67.0 67.0 68.0 68.0 71.0 82.0 82.0 84.0 79.0 05:14:59 INFO - PROCESS | 1919 | -------- Summary: end -------- 05:14:59 INFO - PROCESS | 1919 | 05:15:00 INFO - TEST-INFO | 1919: exit 0 05:15:00 INFO - TEST-OK | kraken | took 59816ms 05:15:00 INFO - SUITE-END | took 1178s 05:15:00 INFO - Completed test suite (00:19:38) 05:15:00 INFO - javascript benchmark 05:15:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7010.325072674703, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.0, 3285.342931413717, 3294.3246634439934, 3305.3719793239297, 3317.021478663794, 5412.2422860799425, 5477.424870388611, 5515.696636684986, 5588.972055139724, 5593.972030139854, 5443.564514838813, 5463.289772329592, 5504.972475137629, 5576.191452239423, 5605.27131472908, 4941.851744447663, 4972.129877271481, 4983.377077865267, 4983.775730092155, 5007.69953802773, 5132.871678208056, 5153.6392452528335, 5159.045576568328, 5178.275041494175, 5181.041507321158, 3863.2466668999555, 4502.212112880233, 4962.454130045692, 4995.050940321327, 5115.872103197413, 5021.723805190713, 5082.593392528589, 5090.490950904917, 5122.103631864409, 5153.2785410042625, 4992.625553083533, 5040.16837221858, 5044.243363495469, 5073.695578265316, 5077.365329333833, 5349.919751203735, 5408.756605952742, 5535.6955367454775, 5550.4449555044575, 5554.611177217596, 5982.222311099529, 6016.789412370546, 6095.6952152392205, 6113.293877754025, 6144.78493252734, 6105.908411373833, 6177.135201071854, 6190.0, 6194.256689197326, 6195.81412557624, 5645.435456454322, 5653.802116925888, 5662.68855212959, 5671.2060311556415, 5685.772569097231, 6018.638881667114, 6110.43725517484, 6118.131909153758, 6147.508199344042, 6175.104609831549, 5990.131430942489, 6045.667488288098, 6068.120122582201, 6085.452309292096, 6096.451319381277, 5009.323741294951, 6154.753809847645, 6163.568550201443, 6173.81478555644, 6176.722047507873, 5789.334226563915, 6006.339302676702, 6103.816885493442, 6118.296395914438, 6129.754809807558, 5909.852253693606, 5977.402259774075, 6022.307434644984, 6075.058365953284, 6105.175801266861, 4917.28699338601, 4917.606591472673, 4923.064617722621, 4948.5546300832375, 4957.0, 4378.693491455568, 4382.035952090535, 4386.71486353386, 4390.231709450897, 4402.911941761146, 5469.179623056573, 5495.148252020943, 5685.976524225596, 5718.285214348207, 5722.77108915647, 4905.411350637946, 6067.878642427127, 6106.908396374058, 6133.671320645534, 6139.0, 5680.914786278209, 5707.258056452718, 5708.40061793514, 5717.142428635655, 5742.253507044057, 5345.278387417727, 5346.946530534645, 5348.893022139536, 5358.089124848785, 5359.517643412111, 6124.265088189446, 6174.8147555573405, 6204.038374052029, 6215.409536093974, 6226.906596400967, 5949.881002379841, 6028.638281703112, 6115.816525504242, 6124.899720462962, 6130.795626845359, 6177.227846519185, 6226.719797609027, 6232.719527621177, 6235.75056997715, 6239.844003899939, 5894.646321220741, 6035.18524999137, 6040.939590604214, 6043.002904520705, 6084.33072362031, 6085.939140608537, 6127.325994140552, 6139.3553676863285, 6142.170806941184, 6151.0773383992755, 5103.693778373309, 5695.544356451557, 5749.8275051748515, 5753.1370294456165, 5821.476067153976, 5944.138099975393, 5951.672658003851, 5960.374160713062, 5963.731632076654, 5971.880562388641, 5740.052891272893, 5780.884382312246, 5781.82654520365, 5790.1893734877995, 5792.986227410102, 5683.147527870852, 5725.541956643375, 5868.823935281948, 5956.0, 5963.2844058713235, 4591.65562582801, 4685.906281874275, 5614.887702246014, 5626.2967129108865, 5652.378238393856], "value": 5528.731172720627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.8521443566929, 493.85184444666595, 510.2550276596169, 514.451500982044, 522.2479629333757, 28816.423671526558, 30391.544126838115, 38224.99999999996, 39613.60386396143, 40208.39687404691, 40951.59048409515, 41344.0, 41380.379294310536, 41440.585594144046, 41464.58535414645, 9192.310576706757, 9423.34036617437, 9432.575534100948, 9433.433993960385, 9442.527873606326, 7982.241687039722, 8187.877181842277, 9224.07759224079, 10961.451927403637, 11248.718782030473, 11149.832752508719, 11186.496607652674, 11201.551937922513, 11244.212905096647, 11323.490442930046, 11106.6112686056, 11162.609308674238, 11187.720306992309, 11196.936291052338, 11215.271007384536, 7899.0, 8128.593570321519, 10793.0, 11084.057855082247, 11085.002349788478, 38353.616463835286, 38906.61093389058, 38958.415623765664, 39243.60756392428, 39270.8218753435, 3821.5796262411113, 3834.9424758628643, 3837.520309961255, 3849.2301539692176, 3849.749766265184, 26825.731742682518, 27131.864340678367, 28613.28466788347, 29202.707972920212, 30106.84946575253, 2685.1810197889636, 3028.5154375299844, 3056.526238433024, 3064.6782087880674, 3095.133362658459, 435286.0, 436803.0, 440914.0, 442962.785186072, 444204.77897610626, 43527.782361088626, 51253.74373128185, 52364.214536781976, 52533.68665783386, 52819.28481800537, 49181.0, 50432.0, 50472.4858254253, 50508.74745626322, 50544.747276263384, 12604.243745375306, 13940.790888136686, 14279.286935482225, 14329.78505322421, 14618.853811461962, 10452.32059916103, 10469.371837689763, 10470.842937355947, 10473.581056757797, 10498.475076246157, 16170.35318587267, 16791.984961804417, 16855.831441685426, 16875.32498700063, 16895.915520422564, 7445.590492522855, 7564.810879728051, 7607.212305108295, 7654.349380302625, 7677.654505547263, 802.2018091998499, 830.1076342931373, 840.5083026429485, 863.2662237098542, 867.4881819726392, 27918.0, 28872.566911496346, 28983.275418114295, 29761.404771904872, 29817.701822981493, 981.1415011864618, 1006.6124542051217, 1023.6007956896816, 1042.2183362478142, 1059.4067322299384, 13685.657858553615, 14995.625109372135, 15092.924535377473, 15207.391704331703, 15231.61920951963, 610050.0, 615166.0, 617051.0, 617489.0, 618052.0, 46627.0, 57627.71186144126, 57724.71137644285, 57731.13403298954, 57734.711326443095, 1335.933203339829, 1370.869767372098, 1377.7175678985784, 1380.0201856681867, 1380.792881067848, 25803.612945805453, 27160.049398270967, 27721.44557108806, 28315.43369132647, 29425.264368390963, 47798.52201477941, 48019.75990120027, 48107.0, 48129.75935120302, 48170.518294816604, 487970.0, 489846.0, 490903.0, 491018.5449072732, 492059.0, 22352.77647223507, 22946.01701778825, 25098.498030039664, 25766.0, 25812.22563323103, 37532.624673754006, 44896.87757806081, 46025.30962035505, 46257.30614040725, 46296.30555541737, 28502.0, 34934.0, 35994.64005359913, 37891.81054094822, 37902.62097378991, 36031.0, 36241.27517449689, 36322.63677363192, 37580.0, 37670.058248544, 36383.636163638024, 36863.262734745695, 37106.628933710315, 37226.44160337543, 37327.626723732414, 30139.0, 32327.51508727418, 32661.510077349332, 32730.50904236391, 32742.50886236756, 23843.523129537658, 23901.043958241477, 24005.639915401633, 24567.0, 24615.753842461345], "value": 18941.102842400862, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.974911630744, 387.30478790570925, 390.9582376655599, 397.4753325610194, 417.5469615467218, 15617.921910390447, 19799.40601781949, 20426.591468170627, 20439.59120817583, 20685.276015339467, 12165.452554635063, 12280.877191228084, 12455.937720311409, 16597.585060373465, 21061.473463163427, 5277.947220527803, 5309.761060752266, 5378.354597448311, 5531.0, 5543.362513310981, 5342.813001544947, 5436.891262174754, 5447.536959358459, 5453.700046497441, 5464.781408743645, 5434.91847622286, 5451.918221226685, 5458.399576046631, 5475.06923822951, 5966.164736936832, 5942.108683697436, 5984.222051133368, 5988.341282458926, 6012.308584512772, 6012.609180403259, 5127.307813445174, 5246.711430871301, 5259.63182577216, 5305.814296499604, 5339.973300133474, 13281.601551953458, 13534.796978045337, 13685.836703880183, 15471.922640386838, 24980.250592482254, 2575.394782226194, 2658.0962472759356, 2660.428007978294, 2664.067576348282, 2675.4515324358654, 9669.903300966971, 10074.546645400902, 10164.44095574743, 10535.420551869644, 10602.628907988183, 1561.2974161627312, 1790.534461040126, 1805.7562229099167, 1811.6467288878673, 1819.7998220195768, 111955.0, 114290.9987053169, 121792.0, 127487.0, 127822.0, 9342.673006444742, 10633.627823026158, 10914.345139291669, 11579.942100289445, 11721.069732566859, 15887.364505419653, 15893.205339732967, 15894.682106357808, 15905.840941590435, 15924.522264332089, 7171.569705817667, 7856.0, 8114.188581141839, 8141.104478507359, 8289.253967142866, 7600.196839630348, 7603.163651998276, 7625.466217364842, 7755.573443460551, 7805.180456052146, 3882.242962622318, 4784.449788274393, 4805.663603547718, 4810.182269014276, 4946.975265123651, 1647.522218556629, 1791.4177892185091, 1971.2115153938253, 2035.4707775978352, 2041.6325061489074, 878.9428687135315, 901.2249465459699, 926.967556135532, 970.9757256068655, 1005.3465247589126, 17377.391791287246, 19462.902685486482, 19984.400467985983, 20091.698624520643, 20342.898285508774, 894.4633220068038, 974.6783561424713, 980.789130336981, 987.4766373821886, 996.7757254617798, 9961.800763984824, 10210.489475526194, 10494.055535001886, 10519.386674321731, 10546.736331591617, 665313.0, 672145.9178112332, 676475.0, 702323.0, 702754.0, 115499.0, 131115.7221069481, 140300.0, 146706.5329346693, 147969.0, 978.222313260945, 978.9902100978899, 993.6124911284605, 995.955182016811, 996.3872218585518, 17116.229769660644, 17616.207270672596, 17765.378211762527, 17825.643487130445, 18237.54406139804, 45271.0, 50093.49906500888, 52639.73680131575, 54653.63365915725, 55452.16821747596, 58469.70765146147, 59109.11336330044, 60524.0, 61550.0, 61796.69101654463, 7879.763607091796, 8040.718574849852, 8128.187181282061, 8196.754097377088, 8514.659413623633, 11858.0, 12469.314187719763, 12559.550887577201, 12668.556600518938, 12882.871171288167, 10539.26225164231, 10593.682189534326, 10768.138548916224, 10939.23425360249, 11045.944770276097, 10295.33080349805, 10387.68836934893, 10486.737831553966, 10673.199510036624, 10712.839307410552, 10854.208091445955, 11045.723856903642, 11098.334099954029, 11112.166587505808, 11225.66323010311, 7922.524648521107, 7923.484973476706, 8390.622421991147, 8405.621747021276, 8548.145185481402, 9777.706668799663, 10383.740406489898, 10746.892531074589, 10770.407627580558, 10851.240413171003], "value": 9210.683157001204, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.5716577780674, 1430.8569143085692, 1438.7050654615805, 1456.1990905002253, 1458.8249410070794, 6836.521443498951, 7814.0, 7829.686812527492, 7840.0, 8198.959005204966, 8246.91753082469, 8430.95784521078, 8437.987441507012, 8450.154984501547, 8451.281641060501, 2241.361212054569, 2273.7385200701883, 2273.7726227377298, 2274.0, 2276.2829708641807, 1812.8096549862273, 1963.7741659709172, 2040.9693854592192, 2256.5261295128043, 2272.0798076778933, 2258.2434884313775, 2264.2527965771337, 2269.2851751698245, 2271.432141964509, 2272.2047283450825, 2197.0223250653466, 2212.524307273936, 2221.033850275119, 2221.144859229192, 2221.833362497819, 2205.2943058221376, 2212.7012853264923, 2265.637498000312, 2269.795718385337, 2294.4493321602695, 8458.915410845875, 8533.658653653847, 8552.486850788973, 8553.230209281195, 8565.614547345385, 5029.673071250357, 5196.220566914955, 5197.974010129963, 5199.896002079937, 5204.271402003723, 3251.7073463388174, 3429.0398688367295, 3471.930561388783, 3492.4761285807076, 3506.5266189064405, 1161.809630024728, 1167.3754541320352, 1222.1811386371153, 1238.6841355454392, 1245.582729785523, 10980.615678451215, 10984.725381865437, 10999.61501347457, 11001.0, 11041.171912106623, 4480.462344518679, 4602.378678878308, 4686.976565117153, 4693.342931989524, 4708.987567672898, 9649.758756031155, 9700.708978730649, 9704.078112579293, 9714.368566043184, 9741.0, 5223.2948551945, 5232.372115346183, 5233.790648374099, 5240.161574148118, 5247.003069416799, 4630.143423466669, 4705.9646877686855, 4762.499937506581, 4788.736619485892, 4805.495422980537, 3035.3929214157256, 3395.3888300105723, 3530.7351948603446, 3533.6925337625244, 3800.771953682788, 1249.8625151233357, 1251.1117106854053, 1259.9496020159274, 1268.460904115747, 1272.4719241514667, 737.4985010193013, 831.9932881213679, 882.6866462405882, 892.1123482135188, 912.9908700913039, 4291.849785257564, 5524.0, 5658.462446067617, 5688.232088667977, 5776.393478684761, 955.6559638530124, 957.8706874571983, 964.9951750241345, 977.2914636888199, 1000.924930630191, 3688.5020522229156, 3824.713146513967, 3857.903552411156, 3875.205582855508, 3887.319719049155, 9806.901930980599, 10148.238882083873, 10281.691549253534, 10338.896611033944, 10349.844752328721, 9574.521273936276, 10147.695569132939, 10277.075063244343, 10295.0, 10295.021972912562, 7555.16893141754, 7808.6095695216145, 7893.0, 7909.644066017043, 7942.285194332538, 4642.675012749075, 5083.38999320084, 5283.2075188722, 5601.823617040304, 5752.9712351437975, 9136.26909847224, 9213.493257870881, 9251.213646840093, 9277.86083208766, 9320.813583728423, 8977.910220897707, 9357.625694972125, 9375.531223438937, 9444.905550944402, 9485.193758530602, 7081.681324340314, 7161.4986950912935, 7230.927690723236, 7244.311790379906, 7254.89117663246, 7026.543274687129, 7116.537425067561, 7687.2697093776005, 7793.961030194812, 7827.608619568885, 6968.825779355557, 7097.964510177416, 7109.075820143348, 7158.248383919822, 7220.097487814023, 7104.857902842017, 7122.323379278961, 7155.499115061895, 7204.423646108404, 7255.2019277880445, 6370.617762934239, 6380.521460890359, 6439.356064393711, 6468.223813142265, 6475.805725828232, 4570.748608826547, 4797.0, 4849.975750121227, 4897.2654101885, 5012.899742005213, 4926.802927882844, 4930.926036109533, 5031.647784655039, 5033.094043072282, 5111.642185047011], "value": 4381.8682787867, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.47721328918186, 346.19682336978207, 364.1515269422246, 365.1929236387583, 365.211143929113, 4928.605711543077, 5186.521841275237, 5207.869803254921, 5245.527902488775, 5419.184573167989, 4927.802887884481, 4992.276119962603, 5047.49525047496, 5136.534463457542, 5158.226266060093, 2949.4101179764025, 3249.5775549178575, 3758.4174452959833, 3961.3067713150226, 3963.3064213762477, 3384.2047118927035, 3509.3683137035323, 3898.902527436808, 3933.940990885139, 3975.82108805103, 3152.4010438016703, 3907.374820028796, 3911.8239679214503, 3931.2137572485476, 3970.2258059678375, 3264.4450443424676, 3554.36021516127, 3877.4571559981623, 3918.3338832398563, 3924.646781789638, 2957.926051848721, 3133.373325334919, 3385.5598772159706, 3432.3821712091813, 3455.8444869980913, 4836.443808961944, 5066.594672426197, 5100.030994111107, 5108.2848401223855, 5126.94970972931, 3828.272628200633, 4122.886820558462, 4451.866444006685, 4490.326451032339, 4513.796879140414, 4890.755462226874, 5146.665466744687, 5190.290680251731, 5444.809431669913, 5465.508104270595, 3329.200991761984, 3599.5500562429697, 3762.623737626243, 3777.8488860445823, 3779.281936432069, 4936.0, 5171.663841850268, 5293.512049336806, 5434.7826086956475, 5849.0, 3668.119651283726, 3693.2244228711734, 3818.5608655004476, 3823.7323387362617, 3830.138218900725, 3081.245094951751, 3292.0, 3881.165549406891, 3885.8445662173763, 3901.035213237903, 4200.4959404871615, 4384.605385515319, 4522.954770452319, 4543.750093744876, 4550.567696068868, 5165.66423182492, 5451.48210919962, 5513.862153446115, 5527.982286465492, 5553.694546799965, 1171.683645415733, 1216.288471244332, 1249.5564074753513, 1260.2230854495117, 1267.309316422552, 749.4341771962133, 797.8962734844433, 841.8232171243985, 856.6873091321747, 867.7440155154245, 4080.693947953856, 4375.890602734957, 4540.750258735735, 4567.657425693086, 4955.4301255356095, 4762.666613337033, 5385.626665200349, 5428.9185662215095, 5477.561795056386, 5493.972530137324, 4536.9092618148115, 4766.880827979259, 4967.726775027409, 4968.254761785761, 4984.476629953875, 2463.470353873926, 2543.936401589975, 2767.764739997123, 2846.4591727571697, 2853.0, 5184.922226166535, 5530.6128570999645, 5606.962711898312, 5693.3168019837885, 5720.456556627114, 4690.7654617269, 5130.615203859726, 5303.992241474108, 5550.91673624896, 5555.666660000413, 4902.362692849978, 5145.459726728789, 5492.340919089735, 5644.85887852807, 5699.971500142556, 4771.045790841915, 5150.253213284128, 5390.0, 5435.130379139318, 5435.537979271806, 4267.231898258343, 4401.009772801094, 4878.609711223165, 5149.845504634867, 5274.657147285414, 5028.622853285945, 5276.498732620395, 5531.612787104864, 5646.265985421869, 5674.893395787782, 3348.3972884880955, 3657.122290650278, 3728.7203459740085, 3778.7543809652284, 3790.7869481766675, 5173.22401639757, 5590.714135748719, 5647.068233741551, 5658.009848276617, 5675.375708672125, 5086.415062267739, 5317.867053323543, 5344.465553444625, 5366.302380690641, 5533.837894042296, 4704.388429504143, 4811.591014763784, 5365.758540865749, 5386.380566234933, 5413.350397952271, 5347.545458636059, 5354.892902141857, 5374.516293533601, 5383.569314454912, 5399.649022813504, 5062.240663900445, 5390.919136212881, 5400.189971504149, 5431.972840135774, 5493.615446918678, 4542.250528662734, 5268.0, 5317.601179911445, 5359.919601206063, 5405.675659460445], "value": 3917.802385749038, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.4930200953307, 720.3984672798214, 756.0813611462075, 802.8073262417021, 817.431884840036, 14153.433862645496, 14811.259437028159, 14830.703385932275, 14853.0, 14861.92569037156, 13286.800697989538, 13388.531401400953, 13419.664508387295, 13438.0, 13452.192868427901, 848.8684253940634, 849.413904405958, 868.053821334745, 872.0320444306846, 876.6493402638931, 842.0821304777791, 855.7176131876497, 867.5748883047293, 867.8698195270697, 869.4956924983494, 904.3488688144525, 905.4160066756938, 905.8414777413959, 905.9456432614031, 906.2704522859095, 779.3687113438133, 898.4878619187066, 901.0088902207552, 901.2069378946518, 901.4816480523659, 674.642439507062, 675.530506298123, 675.5372569789661, 675.7229535890261, 676.1311714446962, 14659.780103298459, 14718.852811471963, 14730.779038314435, 15095.245237738069, 15123.621909452351, 13569.660758481117, 13726.862731372657, 13789.448422063106, 13934.93032534841, 14004.72855778987, 11437.828432573519, 11445.771084578262, 11509.0, 11586.884131158666, 12018.639440816789, 3596.226811235597, 3605.5132557104716, 3648.7081033517256, 3661.0847288177956, 3674.65090816372, 101006.0, 103164.48417757938, 103888.96111038869, 104902.0, 105794.47102764514, 10427.530761115617, 10511.684649460529, 10538.156947444186, 10606.681799545871, 10700.732481688021, 22024.11903523841, 22211.66682499764, 22249.55500889973, 22265.0, 22282.554348913254, 6945.548539344926, 7374.889376659355, 7422.257774222535, 7508.061492313461, 7582.431317651198, 3841.654251117357, 3912.5891781363116, 3951.308521008812, 3953.6244056814558, 3954.26846033479, 3452.4993875887853, 3532.3465158945164, 3554.20030493137, 3564.429691249388, 3571.464280357915, 583.553581510145, 609.4088733928082, 656.4420242793587, 671.1543455246425, 731.8572878288683, 578.12702818744, 677.444495513674, 693.5284006875373, 705.0939542687622, 710.5701050864153, 9445.858312125323, 9520.476373799507, 9823.459709715891, 9905.752356191153, 10197.74505637365, 603.1831347606687, 674.7132468700783, 688.5834070387443, 690.7824035428824, 693.2963042511855, 4574.336721175411, 4745.305519330774, 4824.08342414947, 4836.153673107263, 4863.683860549124, 88632.0, 96317.51841240888, 100992.0, 101250.0, 102044.48977755064, 68113.82634083842, 74768.0, 85062.0, 89417.0, 92392.0, 71260.0, 71324.64337678382, 72690.27309726941, 72939.0, 74264.02943882185, 8131.698928171464, 8621.439606425562, 9214.861777073484, 9229.446233226028, 9243.0, 39909.60090399059, 49329.01341973068, 49759.50240497549, 51940.740296298274, 52075.2188717162, 66067.34831629248, 66299.33700662931, 66843.33156668565, 67126.66436667785, 67981.0, 9436.669716559887, 9923.255755818487, 11569.190156689288, 11695.298282103102, 12007.339596322287, 12168.817467738168, 12400.19398739079, 12412.75174496487, 12545.49818007306, 12663.240205587694, 11655.358955257543, 11788.174827761974, 11825.52697892109, 11825.704357391134, 11873.881261187624, 11754.0, 11779.587714429954, 11804.350760708243, 11877.643670689893, 12212.267263964191, 11611.709707257049, 11647.766766627636, 11750.471228794895, 11778.587749428729, 11858.703532411759, 9363.812723745623, 9459.905400946178, 9597.047368447355, 9864.753381165528, 9943.850842237516, 9607.951960240154, 9655.758606034906, 9693.0, 9783.0, 9810.803783924424], "value": 7167.324155377446, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 115.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 113.0, 112.0, 150.0, 113.0, 112.0, 111.0, 112.0, 134.0, 114.0], "value": 121.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 184.0, 187.0, 184.0, 185.0, 181.0, 185.0, 209.0, 261.0], "value": 194.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 60.0, 89.0, 61.0, 58.0, 58.0, 60.0, 66.0, 75.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 72.0, 88.0, 70.0, 70.0, 71.0, 87.0, 71.0, 70.0, 86.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 90.0, 88.0, 89.0, 86.0, 90.0, 87.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 94.0, 84.0, 84.0, 85.0, 86.0, 87.0, 89.0, 87.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 58.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 66.0, 76.0, 74.0, 66.0, 70.0, 69.0, 70.0, 71.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 88.0, 90.0, 87.0, 87.0, 88.0, 89.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 142.0, 142.0, 142.0, 161.0, 139.0, 205.0, 153.0], "value": 152.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 175.0, 172.0, 172.0, 177.0, 173.0, 175.0, 172.0, 174.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 68.0, 68.0, 71.0, 82.0, 82.0, 84.0, 79.0], "value": 73.6, "unit": "score"}]}]} 05:15:00 INFO - Return code: 0 05:15:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:15:00 ERROR - # TBPL SUCCESS # 05:15:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:00 INFO - 2017-02-08 05:15:00.492 screenresolution[1923:17784] starting screenresolution argv=screenresolution get 05:15:00 INFO - 2017-02-08 05:15:00.495 screenresolution[1923:17784] Display 0: 1600x1200x32@60 05:15:00 INFO - 2017-02-08 05:15:00.501 screenresolution[1924:17787] starting screenresolution argv=screenresolution list 05:15:00 INFO - Available Modes on Display 0 05:15:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:00 INFO - Intel Iris: 05:15:00 INFO - Chipset Model: Intel Iris 05:15:00 INFO - Type: GPU 05:15:00 INFO - Bus: Built-In 05:15:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:00 INFO - Vendor: Intel (0x8086) 05:15:00 INFO - Device ID: 0x0a2e 05:15:00 INFO - Revision ID: 0x0009 05:15:00 INFO - Displays: 05:15:00 INFO - Display: 05:15:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:00 INFO - Display Serial Number: 1600x1200 60 05:15:00 INFO - Main Display: Yes 05:15:00 INFO - Mirror: Off 05:15:00 INFO - Online: Yes 05:15:00 INFO - Rotation: Supported 05:15:00 INFO - Return code: 0 05:15:00 INFO - Running post-action listener: _resource_record_post_action 05:15:00 INFO - [mozharness: 2017-02-08 13:15:00.742145Z] Finished run-tests step (success) 05:15:00 INFO - Running post-run listener: _resource_record_post_run 05:15:00 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 651264; Write bytes: 553678336; Read time: 10; Write time: 1729 05:15:00 INFO - TinderboxPrint: CPU usage
53.7% 05:15:00 INFO - TinderboxPrint: I/O read bytes / time
651,264 / 10 05:15:00 INFO - TinderboxPrint: I/O write bytes / time
553,678,336 / 1,729 05:15:00 INFO - TinderboxPrint: CPU idle
2,225.9 (46.3%) 05:15:00 INFO - TinderboxPrint: CPU system
958.9 (20.0%) 05:15:00 INFO - TinderboxPrint: CPU user
1,620.9 (33.7%) 05:15:00 INFO - TinderboxPrint: Swap in / out
253,059,072 / 0 05:15:00 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 237885952; Write bytes: 232380416; Read time: 17964; Write time: 489 05:15:00 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 651264; Write bytes: 298573312; Read time: 10; Write time: 1190 05:15:01 INFO - Running post-run listener: _upload_blobber_files 05:15:01 INFO - Blob upload gear active. 05:15:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:15:01 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 05:15:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:15:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:02 INFO - (blobuploader) - INFO - Done attempting. 05:15:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:15:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:15:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:03 INFO - (blobuploader) - INFO - Done attempting. 05:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:04 INFO - (blobuploader) - INFO - Done attempting. 05:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:15:07 INFO - (blobuploader) - INFO - Done attempting. 05:15:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:15:07 INFO - Return code: 0 05:15:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:15:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:15:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2036fe1a56c8390006a293e3097e73cc9b639ebc94a59a3e74e446e865cbd68e6a597ffca4fd344cce6d9339de9b58731da22ecfe8353600bf36973280081683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81ab4b740ac44a14a845330704264457a9789b7264d1dfbb6366b3977d281e63ab07c0e731dc2d752374f65fb5fb68d7a016017124d52994ebdf03297d3fee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/309b618871349a074deb2b0de914923a47ecd350a9118506de6a60a79fb0023392ce61e07f452679f904dd7155411424af5c73b6e878b5a7052e1e2ec40b13b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b35f9808de471f6e714bbab2d6fae99eba4775e8329f30919ce914c8ddce66dae1fc4db4d8c76678a1d37c032a27ffe4787e30b9ef7402e1104d212a2ed9491"} 05:15:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:15:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:15:07 INFO - Contents: 05:15:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2036fe1a56c8390006a293e3097e73cc9b639ebc94a59a3e74e446e865cbd68e6a597ffca4fd344cce6d9339de9b58731da22ecfe8353600bf36973280081683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81ab4b740ac44a14a845330704264457a9789b7264d1dfbb6366b3977d281e63ab07c0e731dc2d752374f65fb5fb68d7a016017124d52994ebdf03297d3fee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/309b618871349a074deb2b0de914923a47ecd350a9118506de6a60a79fb0023392ce61e07f452679f904dd7155411424af5c73b6e878b5a7052e1e2ec40b13b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b35f9808de471f6e714bbab2d6fae99eba4775e8329f30919ce914c8ddce66dae1fc4db4d8c76678a1d37c032a27ffe4787e30b9ef7402e1104d212a2ed9491"} 05:15:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:15:07 INFO - Copying logs to upload dir... 05:15:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:15:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.012617 ========= master_lag: 0.22 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-08 05:15:07.422749) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 05:15:07.428876) ========= 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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2036fe1a56c8390006a293e3097e73cc9b639ebc94a59a3e74e446e865cbd68e6a597ffca4fd344cce6d9339de9b58731da22ecfe8353600bf36973280081683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81ab4b740ac44a14a845330704264457a9789b7264d1dfbb6366b3977d281e63ab07c0e731dc2d752374f65fb5fb68d7a016017124d52994ebdf03297d3fee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/309b618871349a074deb2b0de914923a47ecd350a9118506de6a60a79fb0023392ce61e07f452679f904dd7155411424af5c73b6e878b5a7052e1e2ec40b13b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b35f9808de471f6e714bbab2d6fae99eba4775e8329f30919ce914c8ddce66dae1fc4db4d8c76678a1d37c032a27ffe4787e30b9ef7402e1104d212a2ed9491"} build_url:https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/BdEa08dKSP66NTRGTmT_6w/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2036fe1a56c8390006a293e3097e73cc9b639ebc94a59a3e74e446e865cbd68e6a597ffca4fd344cce6d9339de9b58731da22ecfe8353600bf36973280081683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f81ab4b740ac44a14a845330704264457a9789b7264d1dfbb6366b3977d281e63ab07c0e731dc2d752374f65fb5fb68d7a016017124d52994ebdf03297d3fee0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/309b618871349a074deb2b0de914923a47ecd350a9118506de6a60a79fb0023392ce61e07f452679f904dd7155411424af5c73b6e878b5a7052e1e2ec40b13b0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b35f9808de471f6e714bbab2d6fae99eba4775e8329f30919ce914c8ddce66dae1fc4db4d8c76678a1d37c032a27ffe4787e30b9ef7402e1104d212a2ed9491"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 05:15:07.464422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 05:15:07.464756) ========= 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.dZzSk5Qqxv/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.u7wFRIhsbh/Listeners TMPDIR=/var/folders/bh/xg6w1cj94n1g623nbw37rr_c00000w/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.005354 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 05:15:07.515102) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 05:15:07.515490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 05:15:07.515865) ========= ========= Total master_lag: 0.37 =========