builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0051 starttime: 1490095447.73 results: success (0) buildid: 20170321024728 builduid: 4ece961f669e479f8b066ee50c732c5e revision: b32458403f1f335b457483c9dc62a9059364c6fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.728426) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.728875) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.729150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.755770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.756059) ========= 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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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-03-21 04:24:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.1M=0s 2017-03-21 04:24:07 (29.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089996 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.870532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.870866) ========= 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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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.028441 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:07.920811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:24:07.921155) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b32458403f1f335b457483c9dc62a9059364c6fb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b32458403f1f335b457483c9dc62a9059364c6fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3X4BDHJ2PS/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.ce24LJg7kd/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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-03-21 04:24:08,023 truncating revision to first 12 chars 2017-03-21 04:24:08,023 Setting DEBUG logging. 2017-03-21 04:24:08,023 attempt 1/10 2017-03-21 04:24:08,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b32458403f1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-21 04:24:09,263 unpacking tar archive at: mozilla-beta-b32458403f1f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.516807 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-21 04:24:09.462158) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:09.462469) ========= script_repo_revision: b32458403f1f335b457483c9dc62a9059364c6fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:09.462868) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:09.463155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-21 04:24:09.483311) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-21 04:24:09.483773) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3X4BDHJ2PS/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.ce24LJg7kd/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:09 INFO - MultiFileLogger online at 20170321 04:24:09 in /builds/slave/test 04:24:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:24:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:09 INFO - {'append_to_log': False, 04:24:09 INFO - 'base_work_dir': '/builds/slave/test', 04:24:09 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:24:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:09 INFO - 'branch': 'Mozilla-Beta', 04:24:09 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:09 INFO - 'config_files': ('talos/mac_config.py',), 04:24:09 INFO - 'default_actions': ('clobber', 04:24:09 INFO - 'read-buildbot-config', 04:24:09 INFO - 'download-and-extract', 04:24:09 INFO - 'populate-webroot', 04:24:09 INFO - 'create-virtualenv', 04:24:09 INFO - 'install', 04:24:09 INFO - 'run-tests'), 04:24:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:09 INFO - 'download_minidump_stackwalk': True, 04:24:09 INFO - 'download_symbols': 'ondemand', 04:24:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:09 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:09 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:09 INFO - 'installer_path': 'installer.exe', 04:24:09 INFO - 'log_level': 'info', 04:24:09 INFO - 'log_name': 'talos', 04:24:09 INFO - 'log_to_console': True, 04:24:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:24:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:24:09 INFO - 'opt_config_files': (), 04:24:09 INFO - 'pip_index': False, 04:24:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:24:09 INFO - 'cmd': ('bash', 04:24:09 INFO - '-c', 04:24:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:24:09 INFO - 'enabled': True, 04:24:09 INFO - 'halt_on_failure': False, 04:24:09 INFO - 'name': 'check_screen_resolution'},), 04:24:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:24:09 INFO - 'cmd': ('bash', 04:24:09 INFO - '-c', 04:24:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:24:09 INFO - 'enabled': True, 04:24:09 INFO - 'halt_on_failure': False, 04:24:09 INFO - 'name': 'check_screen_resolution'},), 04:24:09 INFO - 'run_cmd_checks_enabled': True, 04:24:09 INFO - 'sps_profile': False, 04:24:09 INFO - 'sps_profile_interval': 0, 04:24:09 INFO - 'suite': 'dromaeojs-e10s', 04:24:09 INFO - 'system_bits': '32', 04:24:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:09 INFO - 'title': 't-yosemite-r7-0051', 04:24:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:09 INFO - 'use_talos_json': True, 04:24:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:09 INFO - 'work_dir': 'build'} 04:24:09 INFO - [mozharness: 2017-03-21 11:24:09.692184Z] Running clobber step. 04:24:09 INFO - Running pre-action listener: _resource_record_pre_action 04:24:09 INFO - Running main action method: clobber 04:24:09 INFO - rmtree: /builds/slave/test/build 04:24:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:12 INFO - Running post-action listener: _resource_record_post_action 04:24:12 INFO - [mozharness: 2017-03-21 11:24:12.296727Z] Finished clobber step (success) 04:24:12 INFO - [mozharness: 2017-03-21 11:24:12.296866Z] Running read-buildbot-config step. 04:24:12 INFO - Running pre-action listener: _resource_record_pre_action 04:24:12 INFO - Running main action method: read_buildbot_config 04:24:12 INFO - Using buildbot properties: 04:24:12 INFO - { 04:24:12 INFO - "project": "", 04:24:12 INFO - "product": "firefox", 04:24:12 INFO - "script_repo_revision": "production", 04:24:12 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:24:12 INFO - "repository": "", 04:24:12 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:24:12 INFO - "buildid": "20170321024728", 04:24:12 INFO - "pgo_build": "False", 04:24:12 INFO - "basedir": "/builds/slave/test", 04:24:12 INFO - "buildnumber": 1, 04:24:12 INFO - "slavename": "t-yosemite-r7-0051", 04:24:12 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:24:12 INFO - "platform": "yosemite_r7", 04:24:12 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:24:12 INFO - "branch": "mozilla-beta", 04:24:12 INFO - "repo_path": "releases/mozilla-beta", 04:24:12 INFO - "revision": "b32458403f1f335b457483c9dc62a9059364c6fb", 04:24:12 INFO - "stage_platform": "macosx64", 04:24:12 INFO - "builduid": "4ece961f669e479f8b066ee50c732c5e", 04:24:12 INFO - "slavebuilddir": "test" 04:24:12 INFO - } 04:24:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 04:24:12 INFO - Running post-action listener: _resource_record_post_action 04:24:12 INFO - [mozharness: 2017-03-21 11:24:12.300302Z] Finished read-buildbot-config step (success) 04:24:12 INFO - [mozharness: 2017-03-21 11:24:12.300438Z] Running download-and-extract step. 04:24:12 INFO - Running pre-action listener: _resource_record_pre_action 04:24:12 INFO - Running main action method: download_and_extract 04:24:12 INFO - mkdir: /builds/slave/test/build/tests 04:24:12 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:24:12 INFO - trying https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 04:24:12 INFO - Downloading https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:24:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 04:24:13 INFO - Downloaded 1165 bytes. 04:24:13 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 04:24:13 INFO - Using the following test package requirements: 04:24:13 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:24:13 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:24:13 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 04:24:13 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:24:13 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 04:24:13 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:24:13 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:24:13 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 04:24:13 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 04:24:13 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:24:13 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 04:24:13 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:24:13 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 04:24:13 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:24:13 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 04:24:13 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 04:24:13 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 04:24:13 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 04:24:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:24:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:24:13 INFO - Fetch https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:24:14 INFO - Expected file size: 16108131 04:24:14 INFO - Obtained file size: 16108131 04:24:20 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:24:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 04:24:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 04:24:20 INFO - Fetch https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 04:24:21 INFO - Expected file size: 16108131 04:24:21 INFO - Obtained file size: 16108131 04:24:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 04:24:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 04:24:28 INFO - Fetch https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 04:24:29 INFO - Expected file size: 14403663 04:24:29 INFO - Obtained file size: 14403663 04:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:30 INFO - trying https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:24:30 INFO - Downloading https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 04:24:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 04:24:31 INFO - Downloaded 58738506 bytes. 04:24:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:24:31 INFO - mkdir: /builds/slave/test/properties 04:24:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:31 INFO - Contents: 04:24:31 INFO - build_url:https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 04:24:32 INFO - Running post-action listener: _resource_record_post_action 04:24:32 INFO - Running post-action listener: set_extra_try_arguments 04:24:32 INFO - [mozharness: 2017-03-21 11:24:32.655996Z] Finished download-and-extract step (success) 04:24:32 INFO - [mozharness: 2017-03-21 11:24:32.656142Z] Running populate-webroot step. 04:24:32 INFO - Running pre-action listener: _resource_record_pre_action 04:24:32 INFO - Running main action method: populate_webroot 04:24:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:32 INFO - '--tppagecycles', 04:24:32 INFO - '7'], 04:24:32 INFO - 'tests': ['tsvgm']}}, 04:24:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:24:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:24:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:24:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:24:32 INFO - 'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:24:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:24:32 INFO - 'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['damp', 'tps']}, 04:24:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:24:32 INFO - 'tests': ['damp', 'tps']}, 04:24:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['dromaeo_dom']}, 04:24:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['basic_compositor_video']}, 04:24:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:24:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['a11yr', 04:24:32 INFO - 'ts_paint', 04:24:32 INFO - 'tpaint', 04:24:32 INFO - 'sessionrestore', 04:24:32 INFO - 'sessionrestore_no_auto_restore', 04:24:32 INFO - 'tabpaint']}, 04:24:32 INFO - 'other-e10s': {'tests': ['a11yr', 04:24:32 INFO - 'ts_paint', 04:24:32 INFO - 'tpaint', 04:24:32 INFO - 'sessionrestore', 04:24:32 INFO - 'sessionrestore_no_auto_restore', 04:24:32 INFO - 'tabpaint']}, 04:24:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:24:32 INFO - 'ts_paint', 04:24:32 INFO - 'tpaint', 04:24:32 INFO - 'sessionrestore', 04:24:32 INFO - 'sessionrestore_no_auto_restore', 04:24:32 INFO - 'tabpaint']}, 04:24:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:24:32 INFO - 'ts_paint', 04:24:32 INFO - 'tpaint', 04:24:32 INFO - 'sessionrestore', 04:24:32 INFO - 'sessionrestore_no_auto_restore', 04:24:32 INFO - 'tabpaint']}, 04:24:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['a11yr', 04:24:32 INFO - 'ts_paint', 04:24:32 INFO - 'tpaint', 04:24:32 INFO - 'sessionrestore', 04:24:32 INFO - 'sessionrestore_no_auto_restore', 04:24:32 INFO - 'tabpaint']}, 04:24:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['a11yr', 04:24:32 INFO - 'ts_paint', 04:24:32 INFO - 'tpaint', 04:24:32 INFO - 'sessionrestore', 04:24:32 INFO - 'sessionrestore_no_auto_restore', 04:24:32 INFO - 'tabpaint']}, 04:24:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['tsvgx', 04:24:32 INFO - 'tsvgr_opacity', 04:24:32 INFO - 'tart', 04:24:32 INFO - 'tscrollx', 04:24:32 INFO - 'cart', 04:24:32 INFO - 'tsvg_static']}, 04:24:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:24:32 INFO - 'tsvgr_opacity', 04:24:32 INFO - 'tart', 04:24:32 INFO - 'tscrollx', 04:24:32 INFO - 'cart', 04:24:32 INFO - 'tsvg_static']}, 04:24:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:24:32 INFO - 'talos_options': ['--disable-e10s'], 04:24:32 INFO - 'tests': ['tp5o']}, 04:24:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:24:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:24:32 INFO - 'talos_options': ['--disable-e10s', 04:24:32 INFO - '--xperf_path', 04:24:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:32 INFO - 'tests': ['tp5n']}, 04:24:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:24:32 INFO - 'talos_options': ['--xperf_path', 04:24:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:32 INFO - 'tests': ['tp5n']}}, 04:24:32 INFO - 'talos.zip': {'path': '', 04:24:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:32 INFO - Running post-action listener: _resource_record_post_action 04:24:32 INFO - [mozharness: 2017-03-21 11:24:32.674870Z] Finished populate-webroot step (success) 04:24:32 INFO - [mozharness: 2017-03-21 11:24:32.675000Z] Running create-virtualenv step. 04:24:32 INFO - Running pre-action listener: _resource_record_pre_action 04:24:32 INFO - Running main action method: create_virtualenv 04:24:32 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:32 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:24:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:32 INFO - Using real prefix '/tools/python27' 04:24:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:33 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:36 INFO - Installing pip.................done. 04:24:36 INFO - Return code: 0 04:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:24:36 INFO - Reading from file tmpfile_stdout 04:24:36 INFO - Output received: 04:24:36 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:24:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:36 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:36 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:24:36 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:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:36 INFO - 'HOME': '/Users/cltbld', 04:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:36 INFO - 'LOGNAME': 'cltbld', 04:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:36 INFO - 'MOZ_NO_REMOTE': '1', 04:24:36 INFO - 'NO_EM_RESTART': '1', 04:24:36 INFO - 'PAGER': '/bin/cat', 04:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:36 INFO - 'PWD': '/builds/slave/test', 04:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:36 INFO - 'SHELL': '/bin/bash', 04:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:36 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:36 INFO - 'USER': 'cltbld', 04:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:36 INFO - 'XPC_FLAGS': '0x0', 04:24:36 INFO - 'XPC_SERVICE_NAME': '0', 04:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:36 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:24:36 INFO - Cleaning up... 04:24:36 INFO - Return code: 0 04:24:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:36 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:36 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:24:36 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:24:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:36 INFO - 'HOME': '/Users/cltbld', 04:24:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:36 INFO - 'LOGNAME': 'cltbld', 04:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:36 INFO - 'MOZ_NO_REMOTE': '1', 04:24:36 INFO - 'NO_EM_RESTART': '1', 04:24:36 INFO - 'PAGER': '/bin/cat', 04:24:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:36 INFO - 'PWD': '/builds/slave/test', 04:24:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:36 INFO - 'SHELL': '/bin/bash', 04:24:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:36 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:36 INFO - 'USER': 'cltbld', 04:24:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:36 INFO - 'XPC_FLAGS': '0x0', 04:24:36 INFO - 'XPC_SERVICE_NAME': '0', 04:24:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:37 INFO - Downloading/unpacking psutil>=3.1.1 04:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:40 INFO - Installing collected packages: psutil 04:24:40 INFO - Running setup.py install for psutil 04:24:40 INFO - building 'psutil._psutil_osx' extension 04:24:40 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:24:41 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:24:41 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:24:41 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:24:41 INFO - building 'psutil._psutil_posix' extension 04:24:41 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:24:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:24:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:24:41 INFO - ^ 04:24:41 INFO - 1 warning generated. 04:24:41 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:24:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:41 INFO - Successfully installed psutil 04:24:41 INFO - Cleaning up... 04:24:41 INFO - Return code: 0 04:24:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:24: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:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:24: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 mozsystemmonitor==0.3 04:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:41 INFO - 'HOME': '/Users/cltbld', 04:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:41 INFO - 'LOGNAME': 'cltbld', 04:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:41 INFO - 'MOZ_NO_REMOTE': '1', 04:24:41 INFO - 'NO_EM_RESTART': '1', 04:24:41 INFO - 'PAGER': '/bin/cat', 04:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:41 INFO - 'PWD': '/builds/slave/test', 04:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:41 INFO - 'SHELL': '/bin/bash', 04:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:41 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:41 INFO - 'USER': 'cltbld', 04:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:41 INFO - 'XPC_FLAGS': '0x0', 04:24:41 INFO - 'XPC_SERVICE_NAME': '0', 04:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:24:42 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:24:42 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:24:42 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:24:42 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:24:42 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:24:42 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:24:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:24:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:24:44 INFO - Installing collected packages: mozsystemmonitor 04:24:44 INFO - Running setup.py install for mozsystemmonitor 04:24:45 INFO - Successfully installed mozsystemmonitor 04:24:45 INFO - Cleaning up... 04:24:45 INFO - Return code: 0 04:24:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:45 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:45 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:24:45 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:24:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:45 INFO - 'HOME': '/Users/cltbld', 04:24:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:45 INFO - 'LOGNAME': 'cltbld', 04:24:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:45 INFO - 'MOZ_NO_REMOTE': '1', 04:24:45 INFO - 'NO_EM_RESTART': '1', 04:24:45 INFO - 'PAGER': '/bin/cat', 04:24:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:45 INFO - 'PWD': '/builds/slave/test', 04:24:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:45 INFO - 'SHELL': '/bin/bash', 04:24:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:45 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:45 INFO - 'USER': 'cltbld', 04:24:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:45 INFO - 'XPC_FLAGS': '0x0', 04:24:45 INFO - 'XPC_SERVICE_NAME': '0', 04:24:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:24: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:24: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:24: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:24: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:24: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:24: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:24:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:24:47 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:24:47 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:24:47 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:24:47 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:24:47 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:24:47 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:24:48 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:48 INFO - warning: no files found matching '*.txt' 04:24:48 INFO - no previously-included directories found matching 'build' 04:24:48 INFO - no previously-included directories found matching 'dist' 04:24:48 INFO - no previously-included directories found matching '.git*' 04:24:48 INFO - Installing collected packages: jsonschema, functools32 04:24:48 INFO - Running setup.py install for functools32 04:24:48 INFO - warning: no files found matching '*.txt' 04:24:48 INFO - no previously-included directories found matching 'build' 04:24:48 INFO - no previously-included directories found matching 'dist' 04:24:48 INFO - no previously-included directories found matching '.git*' 04:24:48 INFO - Successfully installed jsonschema functools32 04:24:48 INFO - Cleaning up... 04:24:48 INFO - Return code: 0 04:24:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:24:48 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:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:48 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:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:48 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:48 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:24:48 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:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:48 INFO - 'HOME': '/Users/cltbld', 04:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:48 INFO - 'LOGNAME': 'cltbld', 04:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:48 INFO - 'MOZ_NO_REMOTE': '1', 04:24:48 INFO - 'NO_EM_RESTART': '1', 04:24:48 INFO - 'PAGER': '/bin/cat', 04:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:48 INFO - 'PWD': '/builds/slave/test', 04:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:48 INFO - 'SHELL': '/bin/bash', 04:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:48 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:48 INFO - 'USER': 'cltbld', 04:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:48 INFO - 'XPC_FLAGS': '0x0', 04:24:48 INFO - 'XPC_SERVICE_NAME': '0', 04:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:24:48 INFO - Cleaning up... 04:24:49 INFO - Return code: 0 04:24:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:49 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:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:49 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:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:49 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:49 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:24:49 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:24:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:49 INFO - 'HOME': '/Users/cltbld', 04:24:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:49 INFO - 'LOGNAME': 'cltbld', 04:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:49 INFO - 'MOZ_NO_REMOTE': '1', 04:24:49 INFO - 'NO_EM_RESTART': '1', 04:24:49 INFO - 'PAGER': '/bin/cat', 04:24:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:49 INFO - 'PWD': '/builds/slave/test', 04:24:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:49 INFO - 'SHELL': '/bin/bash', 04:24:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:49 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:49 INFO - 'USER': 'cltbld', 04:24:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:49 INFO - 'XPC_FLAGS': '0x0', 04:24:49 INFO - 'XPC_SERVICE_NAME': '0', 04:24:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:49 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:49 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:24:49 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:24:49 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:24:49 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:24:49 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:24:49 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:24:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:52 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:24:53 INFO - Downloading docopt-0.6.1.tar.gz 04:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:53 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:53 INFO - Running setup.py install for blobuploader 04:24:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:53 INFO - Running setup.py install for requests 04:24:53 INFO - Running setup.py install for docopt 04:24:54 INFO - Successfully installed blobuploader requests docopt 04:24:54 INFO - Cleaning up... 04:24:54 INFO - Return code: 0 04:24:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:54 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:54 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:24:54 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:24:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:54 INFO - 'HOME': '/Users/cltbld', 04:24:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:54 INFO - 'LOGNAME': 'cltbld', 04:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:54 INFO - 'MOZ_NO_REMOTE': '1', 04:24:54 INFO - 'NO_EM_RESTART': '1', 04:24:54 INFO - 'PAGER': '/bin/cat', 04:24:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:54 INFO - 'PWD': '/builds/slave/test', 04:24:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:54 INFO - 'SHELL': '/bin/bash', 04:24:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:54 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:54 INFO - 'USER': 'cltbld', 04:24:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:54 INFO - 'XPC_FLAGS': '0x0', 04:24:54 INFO - 'XPC_SERVICE_NAME': '0', 04:24:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:54 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-bRoapb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:54 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-pvafsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:54 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-oJXYgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:54 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-uJTTdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:54 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-YXIzfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:54 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-OsmugN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-aw1B9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-Vt9EZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-O5MnMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-oRL2OG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-6wiBAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-iGV7gO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-woHWkJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-fp4al3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:55 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-F7CQDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:56 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-SMnGpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:56 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-uSpOvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:56 INFO - Running setup.py install for manifestparser 04:24:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:56 INFO - Running setup.py install for mozcrash 04:24:56 INFO - Running setup.py install for mozdebug 04:24:56 INFO - Running setup.py install for mozdevice 04:24:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:56 INFO - Running setup.py install for mozfile 04:24:56 INFO - Running setup.py install for mozhttpd 04:24:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Running setup.py install for mozinfo 04:24:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Running setup.py install for mozInstall 04:24:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Running setup.py install for mozleak 04:24:57 INFO - Running setup.py install for mozlog 04:24:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Running setup.py install for moznetwork 04:24:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:57 INFO - Running setup.py install for mozprocess 04:24:58 INFO - Running setup.py install for mozprofile 04:24:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:58 INFO - Running setup.py install for mozrunner 04:24:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:58 INFO - Running setup.py install for mozscreenshot 04:24:58 INFO - Running setup.py install for moztest 04:24:58 INFO - Running setup.py install for mozversion 04:24:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:58 INFO - Cleaning up... 04:24:58 INFO - Return code: 0 04:24:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:58 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:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:58 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:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:58 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:24:58 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:24:58 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:24:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:24:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:58 INFO - 'HOME': '/Users/cltbld', 04:24:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:58 INFO - 'LOGNAME': 'cltbld', 04:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:58 INFO - 'MOZ_NO_REMOTE': '1', 04:24:58 INFO - 'NO_EM_RESTART': '1', 04:24:58 INFO - 'PAGER': '/bin/cat', 04:24:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:58 INFO - 'PWD': '/builds/slave/test', 04:24:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:58 INFO - 'SHELL': '/bin/bash', 04:24:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:24:58 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:24:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:58 INFO - 'USER': 'cltbld', 04:24:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:58 INFO - 'XPC_FLAGS': '0x0', 04:24:58 INFO - 'XPC_SERVICE_NAME': '0', 04:24:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-BiaOQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-YBkUng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-MXj8VL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-Tv63VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-PydJDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-ScXrE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-Whwsjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-2T_k_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:59 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:24:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:59 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-gYH5xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-KgOVI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-iXSl9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-h5pNp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-0MDKGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-jZ9mb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-bJDmuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-grRYGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:00 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:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:00 INFO - Running setup.py (path:/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/pip-LUFwS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:00 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:25:00 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:25:00 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:25:00 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:25:00 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:25:00 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:25:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:00 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:25:00 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:25:00 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:25:00 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:25:00 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:25:00 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:25:03 INFO - Downloading blessings-1.6.tar.gz 04:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:03 INFO - Installing collected packages: blessings 04:25:03 INFO - Running setup.py install for blessings 04:25:03 INFO - Successfully installed blessings 04:25:03 INFO - Cleaning up... 04:25:03 INFO - Return code: 0 04:25:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:04 INFO - Reading from file tmpfile_stdout 04:25:04 INFO - Current package versions: 04:25:04 INFO - blessings == 1.6 04:25:04 INFO - blobuploader == 1.2.4 04:25:04 INFO - docopt == 0.6.1 04:25:04 INFO - functools32 == 3.2.3-2 04:25:04 INFO - jsonschema == 2.5.1 04:25:04 INFO - manifestparser == 1.1 04:25:04 INFO - mozInstall == 1.12 04:25:04 INFO - mozcrash == 1.0 04:25:04 INFO - mozdebug == 0.1 04:25:04 INFO - mozdevice == 0.49 04:25:04 INFO - mozfile == 1.2 04:25:04 INFO - mozhttpd == 0.7 04:25:04 INFO - mozinfo == 0.9 04:25:04 INFO - mozleak == 0.1 04:25:04 INFO - mozlog == 3.4 04:25:04 INFO - moznetwork == 0.27 04:25:04 INFO - mozprocess == 0.24 04:25:04 INFO - mozprofile == 0.28 04:25:04 INFO - mozrunner == 6.13 04:25:04 INFO - mozscreenshot == 0.1 04:25:04 INFO - mozsystemmonitor == 0.3 04:25:04 INFO - moztest == 0.8 04:25:04 INFO - mozversion == 1.4 04:25:04 INFO - psutil == 3.1.1 04:25:04 INFO - requests == 1.2.3 04:25:04 INFO - wsgiref == 0.1.2 04:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25: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:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:04 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:25:04 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:25:04 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:25:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:25:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:04 INFO - 'HOME': '/Users/cltbld', 04:25:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:04 INFO - 'LOGNAME': 'cltbld', 04:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:04 INFO - 'MOZ_NO_REMOTE': '1', 04:25:04 INFO - 'NO_EM_RESTART': '1', 04:25:04 INFO - 'PAGER': '/bin/cat', 04:25:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:04 INFO - 'PWD': '/builds/slave/test', 04:25:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:04 INFO - 'SHELL': '/bin/bash', 04:25:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:25:04 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:25:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:04 INFO - 'USER': 'cltbld', 04:25:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:04 INFO - 'XPC_FLAGS': '0x0', 04:25:04 INFO - 'XPC_SERVICE_NAME': '0', 04:25:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 INFO - Cleaning up... 04:25:05 INFO - Return code: 0 04:25:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 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 0x104d17b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d1a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fc9dcd7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, '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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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:25:05 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:25:05 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:25:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:25:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:05 INFO - 'HOME': '/Users/cltbld', 04:25:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:05 INFO - 'LOGNAME': 'cltbld', 04:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:05 INFO - 'MOZ_NO_REMOTE': '1', 04:25:05 INFO - 'NO_EM_RESTART': '1', 04:25:05 INFO - 'PAGER': '/bin/cat', 04:25:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:05 INFO - 'PWD': '/builds/slave/test', 04:25:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:05 INFO - 'SHELL': '/bin/bash', 04:25:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:25:05 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:25:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:05 INFO - 'USER': 'cltbld', 04:25:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:05 INFO - 'XPC_FLAGS': '0x0', 04:25:05 INFO - 'XPC_SERVICE_NAME': '0', 04:25:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:25:05 INFO - Cleaning up... 04:25:05 INFO - Return code: 0 04:25:05 INFO - Running post-action listener: _resource_record_post_action 04:25:05 INFO - Running post-action listener: _start_resource_monitoring 04:25:05 INFO - Starting resource monitoring. 04:25:05 INFO - [mozharness: 2017-03-21 11:25:05.993876Z] Finished create-virtualenv step (success) 04:25:05 INFO - [mozharness: 2017-03-21 11:25:05.994829Z] Running install step. 04:25:05 INFO - Running pre-action listener: _resource_record_pre_action 04:25:05 INFO - Running main action method: install 04:25:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:06 INFO - Reading from file tmpfile_stdout 04:25:06 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:06 INFO - Reading from file tmpfile_stdout 04:25:06 INFO - Output received: 04:25:06 INFO - Usage: mozinstall [options] installer 04:25:06 INFO - Options: 04:25:06 INFO - -h, --help show this help message and exit 04:25:06 INFO - -d DEST, --destination=DEST 04:25:06 INFO - Directory to install application into. [default: 04:25:06 INFO - "/builds/slave/test"] 04:25:06 INFO - --app=APP Application being installed. [default: firefox] 04:25:06 INFO - mkdir: /builds/slave/test/build/application 04:25:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:25:21 INFO - Reading from file tmpfile_stdout 04:25:21 INFO - Output received: 04:25:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:25:21 INFO - Running post-action listener: _resource_record_post_action 04:25:21 INFO - [mozharness: 2017-03-21 11:25:21.214711Z] Finished install step (success) 04:25:21 INFO - [mozharness: 2017-03-21 11:25:21.214845Z] Running run-tests step. 04:25:21 INFO - Running pre-action listener: _resource_record_pre_action 04:25:21 INFO - Running main action method: run_tests 04:25:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:25:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:25:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:25:21 INFO - 2017-03-21 04:25:21.229 screenresolution[1620:7279] starting screenresolution argv=screenresolution get 04:25:21 INFO - 2017-03-21 04:25:21.231 screenresolution[1620:7279] Display 0: 1600x1200x32@60 04:25:21 INFO - 2017-03-21 04:25:21.237 screenresolution[1621:7281] starting screenresolution argv=screenresolution list 04:25:21 INFO - Available Modes on Display 0 04:25:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:25:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:25:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:25:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:25:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:25:21 INFO - Intel Iris: 04:25:21 INFO - Chipset Model: Intel Iris 04:25:21 INFO - Type: GPU 04:25:21 INFO - Bus: Built-In 04:25:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:25:21 INFO - Vendor: Intel (0x8086) 04:25:21 INFO - Device ID: 0x0a2e 04:25:21 INFO - Revision ID: 0x0009 04:25:21 INFO - Displays: 04:25:21 INFO - Display: 04:25:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:25:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:25:21 INFO - Display Serial Number: 1600x1200 60 04:25:21 INFO - Main Display: Yes 04:25:21 INFO - Mirror: Off 04:25:21 INFO - Online: Yes 04:25:21 INFO - Rotation: Supported 04:25:21 INFO - Return code: 0 04:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:21 INFO - Python 2.7.3 04:25:21 INFO - Return code: 0 04:25:21 INFO - grabbing minidump binary from tooltool 04:25: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:25: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 0x104af5d30>, '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 0x104a1cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104aeabe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25: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:25: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:25: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:25:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:21 INFO - Return code: 0 04:25:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:25:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:25:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:25:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:25:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3X4BDHJ2PS/Render', 04:25:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:21 INFO - 'HOME': '/Users/cltbld', 04:25:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:21 INFO - 'LOGNAME': 'cltbld', 04:25:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:21 INFO - 'MOZ_NO_REMOTE': '1', 04:25:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:21 INFO - 'NO_EM_RESTART': '1', 04:25:21 INFO - 'PAGER': '/bin/cat', 04:25: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:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:21 INFO - 'PWD': '/builds/slave/test', 04:25:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:21 INFO - 'SHELL': '/bin/bash', 04:25:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ce24LJg7kd/Listeners', 04:25:21 INFO - 'TMPDIR': '/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/', 04:25:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:21 INFO - 'USER': 'cltbld', 04:25:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:21 INFO - 'XPC_FLAGS': '0x0', 04:25:21 INFO - 'XPC_SERVICE_NAME': '0', 04:25:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:25:21 INFO - mozversion application_buildid: 20170321024728 04:25:21 INFO - mozversion application_changeset: b32458403f1f335b457483c9dc62a9059364c6fb 04:25:21 INFO - mozversion application_display_name: Firefox 04:25:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:21 INFO - mozversion application_name: Firefox 04:25:21 INFO - mozversion application_remotingname: firefox 04:25:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:25:21 INFO - mozversion application_vendor: Mozilla 04:25:21 INFO - mozversion application_version: 53.0 04:25:21 INFO - mozversion platform_buildid: 20170321024728 04:25:21 INFO - mozversion platform_changeset: b32458403f1f335b457483c9dc62a9059364c6fb 04:25:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:25:21 INFO - mozversion platform_version: 53.0 04:25:21 INFO - using testdate: 1490095521 04:25:21 INFO - actual date: 1490095521 04:25:21 INFO - starting webserver on 'localhost:49240' 04:25:21 INFO - SUITE-START | Running 2 tests 04:25:21 INFO - TEST-START | dromaeo_css 04:25:21 INFO - operating with platform_type : mac_ 04:25:21 INFO - Initialising browser for dromaeo_css test... 04:25:21 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpnGDLN9/profile http://localhost:49240/getInfo.html) 04:25:24 INFO - PROCESS | 1631 | 2017-03-21 04:25:24.773 plugin-container[1635:7453] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b4f, name = 'com.apple.tsm.portname' 04:25:24 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:24 INFO - PROCESS | 1631 | 2017-03-21 04:25:24.773 plugin-container[1635:7453] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 04:25:24 INFO - PROCESS | 1631 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:24 INFO - PROCESS | 1631 | 2017-03-21 04:25:24.773 plugin-container[1635:7453] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:25:24 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 04:25:24 INFO - PROCESS | 1631 | colorDepth:24 04:25:24 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 04:25:24 INFO - PROCESS | 1631 | __metrics 04:25:24 ERROR - PROCESS | 1631 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 04:25:25 INFO - TEST-INFO | 1631: exit 0 04:25:25 INFO - Browser initialized. 04:25:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:25 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpnGDLN9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:27 INFO - PROCESS | 1636 | 2017-03-21 04:25:27.927 plugin-container[1637:7581] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 04:25:27 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:27 INFO - PROCESS | 1636 | 2017-03-21 04:25:27.928 plugin-container[1637:7581] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c03, name = 'com.apple.CFPasteboardClient' 04:25:27 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:27 INFO - PROCESS | 1636 | 2017-03-21 04:25:27.928 plugin-container[1637:7581] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:25:37 INFO - PROCESS | 1636 | RSS: Main: 172818432 04:25:37 INFO - PROCESS | 1636 | 04:28:38 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 04:28:40 INFO - PROCESS | 1636 | RSS: Main: 188846080 04:28:40 INFO - PROCESS | 1636 | 04:31:42 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 04:31:43 INFO - PROCESS | 1636 | RSS: Main: 203698176 04:31:43 INFO - PROCESS | 1636 | 04:34:45 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 04:34:45 INFO - PROCESS | 1636 | RSS: Main: 205492224 04:34:45 INFO - PROCESS | 1636 | 04:37:47 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 04:37:48 INFO - PROCESS | 1636 | RSS: Main: 208621568 04:37:48 INFO - PROCESS | 1636 | 04:40:50 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 04:40:51 INFO - PROCESS | 1636 | RSS: Main: 210067456 04:40:51 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 04:43:54 INFO - PROCESS | 1636 | RSS: Main: 210788352 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | __start_tp_report 04:43:54 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 04:43:54 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 04:43:54 INFO - PROCESS | 1636 | |i|pagename|runs| 04:43:54 INFO - PROCESS | 1636 | |0;dojo.html;3425.3663072331606;3442.707369873561;3478.982605086974;3501.842417091231;3502.9824850875743;4674.3923289972345;5712.257406537149;5732.283464566929;5833.562482813795;5840.737166827493;4857.271409288608;5783;5891.793787217448;5927.170196172528;5936.782959493305;4479.641628669699;4485.461744590637;5185.611079169059;5206.635535512516;5329.307190065286;4321.54623764505;5174.120399532088;5306.416294207634;5315.707636080014;5322.866928326784;5159.5614372778355;5194.428612852583;5206.21906713994;5211.088059589594;5213.7393130343335;5136.948630513722;5139.717315547643;5148.510891465305;5193.2989046479;5216.217567364888;4572.177008138534;4678.95321046792;5112.872178195537;5148.639595228336;5163.122269214243;5561.944380556223;5562.360328562227;5639.15412688096;5718.485336319751;5722.37053924068;6168.259808822925;6171.722272497704;6240.251169859601;6257.843553911143;6283.937160628427;6232.8130156095385;6246.375362463763;6247.312795592481;6257.78097766576;6278.30938596754;6019.819405417845;6030.698465076729;6043.48630366415;6047.425494578008;6052.515798736179;6146.0166373380935;6194.845128871724;6199.070139479114;6200.7519699211525;6232.626042437469;6035.637861728223;6103.938960610426;6119.938800612026;6125.05232106189;6137.96931015342;6184.134221209034;6213.347598502182;6237.002079667232;6237.033259844731;6237.251529816361;6036;6120.355709576947;6188.81433556994;6191.288001879841;6195.81412557624;5458.45415458459;6211.3478084801345;6237.282712488122;6256.7810126645345;6259.530535209787;4667;4926.630502712311;4983.6013118950395;5047.646664733506;5067.341245638044;4447.688661793708;4449.1991441540185;4480.260756975128;4504.256797628354;4527.501974782771;5790.334111577223;5797.826065218051;5853;5872.412758724094;5958.851028724316;6244.579358196007;6251.343608921089;6261.123442718023;6265.561410701207;6277.748890044347;4775.761211939389;5798.623089499169;5807.0998995155815;5867.677277749679;5955.52355811534;5498.560115190775;5543.445655434505;5551.861203469864;5552.52803511706;5561.527270181999;6406.487481001509;6411.3909178627955;6415.743370265231;6415.807525774234;6450.387213214737;6125.571219981412;6141.2098563120835;6143.481172719164;6304.338044505261;6307.842303942438;6298.401651843067;6387.648679322682;6399.6800159992745;6400;6414.711337989895;6217.906731399123;6226.968865155826;6238.220222472191;6239.0953311770445;6254;5924.763009479572;6152.323244443197;6271.871063208666;6272.905906411316;6289.842753931189;6105.114758360101;6112.572119951738;6134.447899689049;6138.631682099089;6167.383261673976;6118.541124375593;6170.876582468415;6173.59871608344;6182.783602573888;6190.41191086864;5950.821475355746;6000.399960003964;6045.425684559959;6118.5411094169;6130.080487926846;6102.420270074336;6109.602875813058;6112.235970503687;6113.141862489121;6174.783882564088;6112.862044203218;6117.806688482678;6131.957816599936;6133.509319254538;6159.753609855556 04:43:54 INFO - PROCESS | 1636 | |1;ext.html;450.279552715655;518.3675915383233;520.4561233510981;521.9086659834529;534.8475684429933;35424.645753542456;43650;44053.77973110138;45625.31562026564;45685.771571142184;37044.81477592608;45269;45489.0902181957;45526.772366138204;45577;9153.771155721128;9538.952305238481;9732.075452832005;9752.4636145012;9776.071273229032;9117.772055698595;11897.464614092343;12012;12252.754944901097;12419.192752471106;10709.518071686754;11465.426728663575;12226.021918246519;12227.938860305687;12261.019118470502;11880.524779008872;12041.939790300992;12105.273683579013;12118.091143164209;12152.21010634306;11736.941315293368;11800.114991375596;11933.582324618597;12068.758624827542;12136.878631213664;42735.35896961548;42891.785541072095;42934.141317173795;43203.56796432027;43275.134497309875;4057.2088442753675;4065.4918135233097;4082.4284600156;4102.835886564534;4155.8753237402925;27227.319317017234;30563.38873222523;30681;30799.538006929914;31010.224744381347;3230.9327294577974;3232.191952011997;3285.474324108155;3335.933281334384;3376.915577110592;448663;527086.3645681785;528251;528660;531602;66110.67778644401;66487.33512664812;66684;66704.33295667078;66721.66556668936;69336.65331673309;69947.65026174836;70067.64966175238;70086;70322;17021.829781702025;17694.203760830795;17698.380556680455;17737.467875963743;17811;11431.542738290374;12495.68795276501;12741.49034038628;13513.716196961273;13759.243241621807;17108.82891171097;17214.569635758955;17530.29878804859;17615.798025246844;17635.941843489174;7497.1753107158165;7535.472516923763;7582.582957937367;7632.885506717404;7632.885506717404;819.880862622516;908.3323757038571;909.8635204719212;924.177482040984;944.2587568758491;27007.459850802872;31139.532907006414;31463.685363146076;31747.69384193468;31966.840165799487;987.0770829274651;1050.8949105089582;1097.9505922233518;1141.3209140561353;1245.3959829482694;15133.319000644997;15149.718794677825;16145.273462694207;16358.83641163597;16525.58686032859;222422;224454;224707;225043.87478062834;225136;59968.70015649894;62117.68941155265;62474.68762656158;62809.37190628127;63077;1445.595233334668;1448.5726710620181;1466.6699992501815;1487.7842712806582;1495.5887131038833;29646;30954.226144346572;31230;31644.367112658078;31651.683483164874;53115.67210819761;53248.4675153259;53728;55187.17219241795;58378;579150.1042494761;582350;582523;582898;583148;23602.763972360055;25428;25440.23679289624;25811.741882581686;25882;36762.63237367699;45051.774741126086;45497;45906.081878361576;46451.53613905302;34080.48879266763;35888.92333230007;36666.63333366632;36960.815195923846;37812.81093594514;36874.81562592277;36959.44560831536;37845.62154378421;38027.80986095052;38182;28503.572446412905;36494.63505364912;37394.813025934694;37461;37581;29738.8513057442;33089.33821323608;33199.33601328008;33213.335733284715;33279;24653.876730616234;24843.751562484867;24913.626295605944;25005.74994250107;25389.365265867764 04:43:54 INFO - PROCESS | 1636 | |2;jquery.html;376.61961418966837;394.14077311461006;415.43085972218057;416.25282617701225;432.19611522568016;20979;21470.677939830915;21942;22198.334049978486;22454.3263702089;21842.235521756742;22070.779292207073;22443.438914027116;22505;22534.985925633344;5615.578831587627;5751.396103409144;5762.135679648044;5859.384764599719;5885.176075349455;5695.886082278352;5710.086386178213;5766.279215098113;5779.248697669318;5873.2658417697785;5727.684977326246;5799.797007104752;5808.59339846211;5818.06910894257;5822.563307751935;4805.639577031719;5780.682062486561;6077.24034495688;6152.938470615326;6193.256809182927;5855.648661080306;6058.0610005449225;6080.513558915276;6087.57386982907;6090.33006369299;13536.458541658321;13698.931505342509;13885.583432497042;13890;13890.722185556333;2609.595512695535;2628.8554129522868;2668.2528891910297;2675.799315051379;2680.2361327021704;10161.695149145537;10329.84505232422;10376.63681771142;10790.51442685081;10823.945880270627;1880.6238752249467;1910.3791267838008;1911.7801452832964;1917.8273955344087;1925.4031250312307;130538;146452.26773866062;154895.2255238728;155066;156255;11813;11882.881171188177;12040.638780836414;12129.090318226168;12306.938465307616;16153.192340382933;16160.676786464204;16167;16168;16194.02835829854;8884.466931984101;9118.726438206864;9131.726048218565;9195.356325057315;9301.72094837156;8953.328500362499;8981.790970316788;9085.50029748357;9196.35625506208;9275.953620231856;3987.401889716508;4890.804367825247;4915.827946021944;4958.826441074617;5007.924881126786;1796.9281228750704;1814.2652225848553;2079.147549504726;2098.412444515538;2128.2019242783954;343.3270789253092;389.7914615680654;405.17748969591776;426.1158096948844;1023.8157131716214;11674.88325116755;12159.392030398445;12236.938815306044;12254.326012069243;12418.937905310597;463.7287186995578;474.7821836988114;479.99520004800206;481.51607634327274;485.5726960274935;6143.754249830046;6203.596766210182;6228.968855155696;6246.500279977591;6414.422701956846;714236;838326;838848;844209;857068;98647;143008.28495857454;163107;166011.50982735268;171129;460.3095356964553;475.1115414175445;1011.7521207304258;1085.8968398002335;1090.1224514266091;14827.703445930805;19859.900700496404;20351.694724578847;20447.59104817925;20464.181432742524;53232;61538;63080.369196309286;64570;66202.35190592516;82959.17040829515;84641.73037404567;84989;85857.14142858492;86081.23390242655;6596.8350791230605;8327.417080804285;8391.832163356821;8600.053994060774;8663.6101375437;11694.941525292319;12565.994720422526;12784.61646150617;12996.610101696964;13033.608991730263;10791.244612877337;11166.05088567481;11478.139139564399;11484.36835973996;11558.07535397183;9512.90487095148;10815.242932994615;10895.455227238765;10952.780944381228;11331.660050198507;10935.671929842118;11143.777124457627;11402.543898243977;11563.6530904073;11610.6516804496;8411.663533458837;8426.915730842613;8484.448510846774;8751.168638979287;8751.956240218758;8672.566371681516;10894.291871028357;10984.176186786182;11360.431978400882;11378.601748938747 04:43:54 INFO - PROCESS | 1636 | |3;mootools.html;1331.2012792324604;1459.4162335065978;1510.516634676903;1511.486094727793;1514.8333683294838;7012.43900487961;7764.378849692025;7993.640286187121;8799.384043116992;8830.86753698695;8226;8493.532855692934;8539.146085391458;8559.48643081414;8588.312934965203;2103.9900847593126;2332.8483648562787;2433;2439.3657649011298;2444.8655323957173;2409.4217387826884;2442.9755702442926;2450.4363996280867;2452.5830608796546;2456.091246238894;2381.8094552435764;2386.224477044959;2413.2036427978815;2415.0339864054345;2418.9758102419014;2068.596623658387;2241.7870302321253;2385.9284221473386;2410.650455683916;2413.2880800163994;2380.083667787897;2409.8192635552405;2422.563938491071;2428.76926691964;2432.221689059502;8601;8617.61220745068;8628.82742345156;8708.433951793113;8710.651573937099;4616.891945932985;5350.545203657655;5405.783768649249;5413.810516631938;5416.350037995427;3189.856456459465;3573.6247693992277;3597.3524765542193;3620.8913732588067;3705.221903400289;1166.5742004168503;1190.1668831817763;1200.2498438475952;1302.648284963064;1313.579654510557;10039.096481316716;10459.738506537322;11192.888071119267;11229.326240425518;11240.887591124067;3917.6082391760597;4668.709513995832;4821.63837712173;4867.70793752376;4902.338184345139;8368.707095251637;9799.951000244953;9811.166050885611;9838;9845.655402060893;5353.170258609922;5426.321709786277;5438;5455.481729235717;5457.2905522282645;4423.955760442354;4508.639308855284;4907.509249075064;4947.431045429822;4976.178930476503;3995.4006898965386;4039.434479172918;4091.7340372876265;4119.876403707894;4123.969007748063;1317.637649646355;1329.2224048931485;1329.7407005633809;1335.1922087137143;1335.7528857161456;933.6265493802533;940.7601061729353;954.2461455450256;958.8705524754068;999.980000399988;5568.248286481355;5808.88382232353;5948.821535353946;5959.374265702126;6035.2637814481395;589.964602123874;593.7417223507788;597.4205021129497;597.4742226840352;606.2512796696077;3854.7494412863075;3860.517435320585;3923.2545816294814;3944.6252606002386;3966.1076257842333;9930.404175749334;10250.794984100276;10266.486675666187;10302.948485257675;10351.016653417913;10102.545385457672;10223.846642300372;10242.334248273839;10258.12805911491;10285;7725.266099720518;8016.559089250147;8039.598020098972;8045.718399855977;8157.46976446541;5920.851978700567;5922.555808314308;5951.256092988377;6051.152838602688;6108.694565271808;9389.906100938902;9510.667126650535;9603.47180905029;9622.711318660451;9650.131488166098;9284.907150928675;9724.027597240502;9825.656102036395;9827.361221520578;9877.950610246902;6833.931660683528;7042;7250.927490725237;7399.038125043709;7527.1720110788865;7985.840283194188;8295.170482951657;8297.626606802587;8307;8325.791855203426;7202.207757146814;7349.853002939804;7392.778216653509;7470;7495.475316727777;7121.608311542707;7161.4270858330165;7177.2463891292755;7304.356519783219;7304.780856574312;5439.755211015435;5441.238226648352;6552.443042341454;6662.267150613332;6910.412614927787;5033.144365457808;5104.923426148685;5157.690538567698;5235.869103272448;5248.2390053442805;4271.914561708686;5103.897922041464;5257.710825904612;5273.209018647233;5400.1899715043055 04:43:54 INFO - PROCESS | 1636 | |4;prototype.html;319.66435242994856;379.26990543204323;381.2888962085711;382.7129652760429;384.49438987731133;4693.577578017977;4743.8814029649275;4983.426905905817;5651.337646441687;5685.516731077858;5128.9230661540105;5435.171208389604;5583.720813959296;5604.439556044394;5630.648644325363;3398.7281017518662;4240.830366785325;4364.476262848447;4366.847160349388;4420.452841505479;4325.863748782139;4425.8229670813125;4426.313921342181;4432.689711720181;4438.400815889862;3513.9297214055705;3819;4391.6486681065435;4399.714018588797;4426.490953540352;4284.078923031548;4326.459192600925;4371.868843934687;4394.8461803837035;4420.690551661385;3867.3038853006447;3871.090293780959;3871.412720784493;3908.7850168240734;3941.507311586052;4586.472555656109;4823.3729615149805;5442.374126975369;5536.280283563111;5559.388467268597;4161.812718427648;5047.570956468705;5064.366954130734;5091.770870310808;5103.673045008288;4875.122477953967;5930.140129681172;5948.40515948406;6008.188894499274;6067.938110830632;4318.963448772303;4319.719218250803;4337.869863904088;4348.304271316606;4358.738475691437;5328.66783304174;5498.477644623755;5961.731722072517;6102.908456373158;6310.274318453391;4053.7365071270274;4194.496660400771;4271.23117838792;4415.470143582791;4428.446444194476;4489.34904438861;4493.123840851003;4493.752843593568;4500.842470513517;4502.347159661831;4119.8970025748995;4667.509911459248;5084.3898732152375;5119.87200319995;5162.5611822994715;5241;5975.462208401178;5990.9101363479585;5990.940090599125;6061.605995610359;1268.8540817805886;1472.3521650473758;1475.0854470228312;1475.8155230596176;1490.972277702324;954.3319676226669;1017.4505766885947;1020.4438580973388;1021.9846702299471;1032.695354870315;5058.570021548209;5148.4079330876675;5207.244949482304;5356.892862142813;5432.071614576847;4950.529699678525;5239.607029472805;5391.56867450603;5991.670458124758;5993.880122397528;4838.153323168432;4838.363092114806;4865.7860673393525;4999.350344317518;5363;2485.9751402486104;3051.71008754168;3069.677683843209;3110.4401207782817;3116.2988327626103;5476.205950137288;5650.74571644277;5733.31200255972;5954.451842520975;6138.7237574309265;4620.198122732138;5162.354705661793;5842.88985092831;6257.2804127525915;6328.71520781566;5300.734963251822;6354.682265886687;6367.745290188341;6411.487081033506;6456.999999999906;4699.130660827758;5122.692638441706;5470.124780035176;6090.462605358859;6198.380161983766;5475.342958844964;5622.437756224344;6076.058210977306;6091.908621370594;6169.259688837368;5335.706536140549;5501.982133305191;5604.467575580314;6285.811425657238;6436.549441539235;4077.8776636700945;4108.2334596122755;4110.46563946697;4113.629773320416;4128.752274863517;5936.63959506294;6142.846428839315;6185.597936134137;6188.752449901954;6219.906701399392;5919.260092488439;5960.493358064613;5978.252718410199;5978.491828194478;5995.16067750524;5315.813946512008;5944.335586035917;5950.642961422329;5963.3142188647125;5981.222441082806;4862.878428039327;5566.91649625264;5753.338366087954;5769.105788602773;5827.737751801264;5960.940390596039;5964.165016897725;5967.076132695035;5982.1584747244715;5982.910256346071;5471.151971444432;5539.750711218086;5700.515456186271;5860.912086318624;5907.4683278505145 04:43:54 INFO - PROCESS | 1636 | |5;yui.html;749.2170681637684;757.4016526943715;792.8414317136574;816.3713940265994;886.8758373827666;14264;16197;18355.449336519894;18642.53393665159;18709.251629934803;15715.764263536028;17445.21496532656;17833.286668533274;17909.28362865487;17941.461756147335;887.9511626860503;904.8552231642939;908.1236606674557;911.1162172692477;911.4713466189594;697.6232834269489;717.7559629725893;736.2416710787898;882.9690960816373;905.7826121730803;943.8301105800953;952.4808979106369;953.4803532075035;954.2556805691572;957.0238356876017;798.5448294472153;939.567798812547;946.5456580841166;947.5262368815593;948.6063283737241;682.3722175598461;692.1935944624506;698.5075521757149;706.7349743846057;709.1383968478272;15735.606609834731;16289.941153824964;16333.509994700178;16676.999380037236;16739.581510462212;15074.698506029818;15088.24558772068;15146.924265378713;15190.544283671508;15304.852136089838;11710.707232319175;11836.349000804952;11870.703232419171;11880.465379057876;11946.940265298705;3806;3901.7247476131197;3904.3557812960826;3946.565877753445;4075;92002.07997920002;108037.9775314602;109203.45398272958;110149;111091;11390.601328953448;11447.942760286145;11708.00481959026;12105.757884842254;12310.076744244217;24648.507029859302;25114.121005765075;25262.494750105263;25266.11568595127;25326.366840829127;8085.231902969209;8165.755027349189;8173.060098088677;8259.49272249584;8422.452540584842;4314.266574682249;4320.524742278347;4392.407025051641;4480.059187570647;4614.423197100363;3744.045268456526;3773.6792372648633;3844.942325865114;3864.3430616795213;3870.3807390817333;690.147667630476;698.7135274537416;709.4253654539839;711.8327193109615;714.5855403865745;604.1179877378988;687.8658661561047;701.2671758012889;704.8555046215514;712.1276436365514;10519.105876000473;10631.84052239217;10847.620333288298;10975.83536246957;11035.282706624204;590.9438603332677;623.0840664223584;625.8529245627274;652.7617419641891;663.6250518457057;5084.669496482717;5201.713905735221;5228.63399562027;5239.47605239473;5252.264682944391;111220;112815.43592281986;115135.84864151418;115870;117295;95373.5231323839;96817;97309;98222;100788;60147.39852601418;66626.66686666536;77810.6109469449;85252.14747852566;86310;8115.75652730419;9253.491057991874;10123.79752404933;10252;10270.794584108426;47003.76498117488;53190.46809531855;54432.727836360566;55587;56751.14873276822;72981;74749.6262518684;75492;76899;77793.61103194449;11993.820092698443;12088.879111208775;12113.273203607812;12140.33228172459;12216.389180541115;12875.935620321838;13281.601551953458;13669.726605468033;13724.245166515937;14198.219097949712;12218.511259549874;12637;12824.679383015498;12863.935680321913;13165.868341316464;12645.304508252135;12730.490780368682;12839.614811555668;12990.610281691565;13102;12113.394330283627;12467.5012999479;12530.624081277576;12702.237865727717;12842.807357889826;9664.806703866025;9795.559199836167;9863;10117.949410252902;10143.34068285559;8162.265396114378;8366.958165209378;8493.660253589787;8951.73144805657;8975.102489751234 04:43:54 INFO - PROCESS | 1636 | __end_tp_report 04:43:54 INFO - PROCESS | 1636 | __start_cc_report 04:43:54 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,374 04:43:54 INFO - PROCESS | 1636 | __end_cc_report 04:43:54 INFO - PROCESS | 1636 | __startTimestamp1490096634552__endTimestamp 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | ------- Summary: start ------- 04:43:54 INFO - PROCESS | 1636 | Number of tests: 6 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5747.95 Median:6102.42 stddev:673.71 (11.0%) stddev-sans-first:650.67 04:43:54 INFO - PROCESS | 1636 | Values: 3425.4 3442.7 3479.0 3501.8 3503.0 4674.4 5712.3 5732.3 5833.6 5840.7 4857.3 5783.0 5891.8 5927.2 5936.8 4479.6 4485.5 5185.6 5206.6 5329.3 4321.5 5174.1 5306.4 5315.7 5322.9 5159.6 5194.4 5206.2 5211.1 5213.7 5136.9 5139.7 5148.5 5193.3 5216.2 4572.2 4679.0 5112.9 5148.6 5163.1 5561.9 5562.4 5639.2 5718.5 5722.4 6168.3 6171.7 6240.3 6257.8 6283.9 6232.8 6246.4 6247.3 6257.8 6278.3 6019.8 6030.7 6043.5 6047.4 6052.5 6146.0 6194.8 6199.1 6200.8 6232.6 6035.6 6103.9 6119.9 6125.1 6138.0 6184.1 6213.3 6237.0 6237.0 6237.3 6036.0 6120.4 6188.8 6191.3 6195.8 5458.5 6211.3 6237.3 6256.8 6259.5 4667.0 4926.6 4983.6 5047.6 5067.3 4447.7 4449.2 4480.3 4504.3 4527.5 5790.3 5797.8 5853.0 5872.4 5958.9 6244.6 6251.3 6261.1 6265.6 6277.7 4775.8 5798.6 5807.1 5867.7 5955.5 5498.6 5543.4 5551.9 5552.5 5561.5 6406.5 6411.4 6415.7 6415.8 6450.4 6125.6 6141.2 6143.5 6304.3 6307.8 6298.4 6387.6 6399.7 6400.0 6414.7 6217.9 6227.0 6238.2 6239.1 6254.0 5924.8 6152.3 6271.9 6272.9 6289.8 6105.1 6112.6 6134.4 6138.6 6167.4 6118.5 6170.9 6173.6 6182.8 6190.4 5950.8 6000.4 6045.4 6118.5 6130.1 6102.4 6109.6 6112.2 6113.1 6174.8 6112.9 6117.8 6132.0 6133.5 6159.8 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:60262.48 Median:35656.78 stddev:124739.81 (349.8%) stddev-sans-first:125008.90 04:43:54 INFO - PROCESS | 1636 | Values: 450.3 518.4 520.5 521.9 534.8 35424.6 43650.0 44053.8 45625.3 45685.8 37044.8 45269.0 45489.1 45526.8 45577.0 9153.8 9539.0 9732.1 9752.5 9776.1 9117.8 11897.5 12012.0 12252.8 12419.2 10709.5 11465.4 12226.0 12227.9 12261.0 11880.5 12041.9 12105.3 12118.1 12152.2 11736.9 11800.1 11933.6 12068.8 12136.9 42735.4 42891.8 42934.1 43203.6 43275.1 4057.2 4065.5 4082.4 4102.8 4155.9 27227.3 30563.4 30681.0 30799.5 31010.2 3230.9 3232.2 3285.5 3335.9 3376.9 448663.0 527086.4 528251.0 528660.0 531602.0 66110.7 66487.3 66684.0 66704.3 66721.7 69336.7 69947.7 70067.6 70086.0 70322.0 17021.8 17694.2 17698.4 17737.5 17811.0 11431.5 12495.7 12741.5 13513.7 13759.2 17108.8 17214.6 17530.3 17615.8 17635.9 7497.2 7535.5 7582.6 7632.9 7632.9 819.9 908.3 909.9 924.2 944.3 27007.5 31139.5 31463.7 31747.7 31966.8 987.1 1050.9 1098.0 1141.3 1245.4 15133.3 15149.7 16145.3 16358.8 16525.6 222422.0 224454.0 224707.0 225043.9 225136.0 59968.7 62117.7 62474.7 62809.4 63077.0 1445.6 1448.6 1466.7 1487.8 1495.6 29646.0 30954.2 31230.0 31644.4 31651.7 53115.7 53248.5 53728.0 55187.2 58378.0 579150.1 582350.0 582523.0 582898.0 583148.0 23602.8 25428.0 25440.2 25811.7 25882.0 36762.6 45051.8 45497.0 45906.1 46451.5 34080.5 35888.9 36666.6 36960.8 37812.8 36874.8 36959.4 37845.6 38027.8 38182.0 28503.6 36494.6 37394.8 37461.0 37581.0 29738.9 33089.3 33199.3 33213.3 33279.0 24653.9 24843.8 24913.6 25005.7 25389.4 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:42515.19 Median:1511.78 stddev:136501.73 (9029.2%) stddev-sans-first:136847.98 04:43:54 INFO - PROCESS | 1636 | Values: 376.6 394.1 415.4 416.3 432.2 20979.0 21470.7 21942.0 22198.3 22454.3 21842.2 22070.8 22443.4 22505.0 22535.0 5615.6 5751.4 5762.1 5859.4 5885.2 5695.9 5710.1 5766.3 5779.2 5873.3 5727.7 5799.8 5808.6 5818.1 5822.6 4805.6 5780.7 6077.2 6152.9 6193.3 5855.6 6058.1 6080.5 6087.6 6090.3 13536.5 13698.9 13885.6 13890.0 13890.7 2609.6 2628.9 2668.3 2675.8 2680.2 10161.7 10329.8 10376.6 10790.5 10823.9 1880.6 1910.4 1911.8 1917.8 1925.4 130538.0 146452.3 154895.2 155066.0 156255.0 11813.0 11882.9 12040.6 12129.1 12306.9 16153.2 16160.7 16167.0 16168.0 16194.0 8884.5 9118.7 9131.7 9195.4 9301.7 8953.3 8981.8 9085.5 9196.4 9276.0 3987.4 4890.8 4915.8 4958.8 5007.9 1796.9 1814.3 2079.1 2098.4 2128.2 343.3 389.8 405.2 426.1 1023.8 11674.9 12159.4 12236.9 12254.3 12418.9 463.7 474.8 480.0 481.5 485.6 6143.8 6203.6 6229.0 6246.5 6414.4 714236.0 838326.0 838848.0 844209.0 857068.0 98647.0 143008.3 163107.0 166011.5 171129.0 460.3 475.1 1011.8 1085.9 1090.1 14827.7 19859.9 20351.7 20447.6 20464.2 53232.0 61538.0 63080.4 64570.0 66202.4 82959.2 84641.7 84989.0 85857.1 86081.2 6596.8 8327.4 8391.8 8600.1 8663.6 11694.9 12566.0 12784.6 12996.6 13033.6 10791.2 11166.1 11478.1 11484.4 11558.1 9512.9 10815.2 10895.5 10952.8 11331.7 10935.7 11143.8 11402.5 11563.7 11610.7 8411.7 8426.9 8484.4 8751.2 8752.0 8672.6 10894.3 10984.2 11360.4 11378.6 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5574.46 Median:5376.68 stddev:3037.11 (56.5%) stddev-sans-first:3028.89 04:43:54 INFO - PROCESS | 1636 | Values: 1331.2 1459.4 1510.5 1511.5 1514.8 7012.4 7764.4 7993.6 8799.4 8830.9 8226.0 8493.5 8539.1 8559.5 8588.3 2104.0 2332.8 2433.0 2439.4 2444.9 2409.4 2443.0 2450.4 2452.6 2456.1 2381.8 2386.2 2413.2 2415.0 2419.0 2068.6 2241.8 2385.9 2410.7 2413.3 2380.1 2409.8 2422.6 2428.8 2432.2 8601.0 8617.6 8628.8 8708.4 8710.7 4616.9 5350.5 5405.8 5413.8 5416.4 3189.9 3573.6 3597.4 3620.9 3705.2 1166.6 1190.2 1200.2 1302.6 1313.6 10039.1 10459.7 11192.9 11229.3 11240.9 3917.6 4668.7 4821.6 4867.7 4902.3 8368.7 9800.0 9811.2 9838.0 9845.7 5353.2 5426.3 5438.0 5455.5 5457.3 4424.0 4508.6 4907.5 4947.4 4976.2 3995.4 4039.4 4091.7 4119.9 4124.0 1317.6 1329.2 1329.7 1335.2 1335.8 933.6 940.8 954.2 958.9 1000.0 5568.2 5808.9 5948.8 5959.4 6035.3 590.0 593.7 597.4 597.5 606.3 3854.7 3860.5 3923.3 3944.6 3966.1 9930.4 10250.8 10266.5 10302.9 10351.0 10102.5 10223.8 10242.3 10258.1 10285.0 7725.3 8016.6 8039.6 8045.7 8157.5 5920.9 5922.6 5951.3 6051.2 6108.7 9389.9 9510.7 9603.5 9622.7 9650.1 9284.9 9724.0 9825.7 9827.4 9878.0 6833.9 7042.0 7250.9 7399.0 7527.2 7985.8 8295.2 8297.6 8307.0 8325.8 7202.2 7349.9 7392.8 7470.0 7495.5 7121.6 7161.4 7177.2 7304.4 7304.8 5439.8 5441.2 6552.4 6662.3 6910.4 5033.1 5104.9 5157.7 5235.9 5248.2 4271.9 5103.9 5257.7 5273.2 5400.2 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4796.22 Median:5155.38 stddev:1427.34 (27.7%) stddev-sans-first:1391.23 04:43:54 INFO - PROCESS | 1636 | Values: 319.7 379.3 381.3 382.7 384.5 4693.6 4743.9 4983.4 5651.3 5685.5 5128.9 5435.2 5583.7 5604.4 5630.6 3398.7 4240.8 4364.5 4366.8 4420.5 4325.9 4425.8 4426.3 4432.7 4438.4 3513.9 3819.0 4391.6 4399.7 4426.5 4284.1 4326.5 4371.9 4394.8 4420.7 3867.3 3871.1 3871.4 3908.8 3941.5 4586.5 4823.4 5442.4 5536.3 5559.4 4161.8 5047.6 5064.4 5091.8 5103.7 4875.1 5930.1 5948.4 6008.2 6067.9 4319.0 4319.7 4337.9 4348.3 4358.7 5328.7 5498.5 5961.7 6102.9 6310.3 4053.7 4194.5 4271.2 4415.5 4428.4 4489.3 4493.1 4493.8 4500.8 4502.3 4119.9 4667.5 5084.4 5119.9 5162.6 5241.0 5975.5 5990.9 5990.9 6061.6 1268.9 1472.4 1475.1 1475.8 1491.0 954.3 1017.5 1020.4 1022.0 1032.7 5058.6 5148.4 5207.2 5356.9 5432.1 4950.5 5239.6 5391.6 5991.7 5993.9 4838.2 4838.4 4865.8 4999.4 5363.0 2486.0 3051.7 3069.7 3110.4 3116.3 5476.2 5650.7 5733.3 5954.5 6138.7 4620.2 5162.4 5842.9 6257.3 6328.7 5300.7 6354.7 6367.7 6411.5 6457.0 4699.1 5122.7 5470.1 6090.5 6198.4 5475.3 5622.4 6076.1 6091.9 6169.3 5335.7 5502.0 5604.5 6285.8 6436.5 4077.9 4108.2 4110.5 4113.6 4128.8 5936.6 6142.8 6185.6 6188.8 6219.9 5919.3 5960.5 5978.3 5978.5 5995.2 5315.8 5944.3 5950.6 5963.3 5981.2 4862.9 5566.9 5753.3 5769.1 5827.7 5960.9 5964.2 5967.1 5982.2 5982.9 5471.2 5539.8 5700.5 5860.9 5907.5 04:43:54 INFO - PROCESS | 1636 | 04:43:54 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:21464.82 Median:4317.40 stddev:31302.67 (725.0%) stddev-sans-first:31351.84 04:43:54 INFO - PROCESS | 1636 | Values: 749.2 757.4 792.8 816.4 886.9 14264.0 16197.0 18355.4 18642.5 18709.3 15715.8 17445.2 17833.3 17909.3 17941.5 888.0 904.9 908.1 911.1 911.5 697.6 717.8 736.2 883.0 905.8 943.8 952.5 953.5 954.3 957.0 798.5 939.6 946.5 947.5 948.6 682.4 692.2 698.5 706.7 709.1 15735.6 16289.9 16333.5 16677.0 16739.6 15074.7 15088.2 15146.9 15190.5 15304.9 11710.7 11836.3 11870.7 11880.5 11946.9 3806.0 3901.7 3904.4 3946.6 4075.0 92002.1 108038.0 109203.5 110149.0 111091.0 11390.6 11447.9 11708.0 12105.8 12310.1 24648.5 25114.1 25262.5 25266.1 25326.4 8085.2 8165.8 8173.1 8259.5 8422.5 4314.3 4320.5 4392.4 4480.1 4614.4 3744.0 3773.7 3844.9 3864.3 3870.4 690.1 698.7 709.4 711.8 714.6 604.1 687.9 701.3 704.9 712.1 10519.1 10631.8 10847.6 10975.8 11035.3 590.9 623.1 625.9 652.8 663.6 5084.7 5201.7 5228.6 5239.5 5252.3 111220.0 112815.4 115135.8 115870.0 117295.0 95373.5 96817.0 97309.0 98222.0 100788.0 60147.4 66626.7 77810.6 85252.1 86310.0 8115.8 9253.5 10123.8 10252.0 10270.8 47003.8 53190.5 54432.7 55587.0 56751.1 72981.0 74749.6 75492.0 76899.0 77793.6 11993.8 12088.9 12113.3 12140.3 12216.4 12875.9 13281.6 13669.7 13724.2 14198.2 12218.5 12637.0 12824.7 12863.9 13165.9 12645.3 12730.5 12839.6 12990.6 13102.0 12113.4 12467.5 12530.6 12702.2 12842.8 9664.8 9795.6 9863.0 10117.9 10143.3 8162.3 8367.0 8493.7 8951.7 8975.1 04:43:54 INFO - PROCESS | 1636 | -------- Summary: end -------- 04:43:54 INFO - PROCESS | 1636 | 04:43:55 INFO - TEST-INFO | 1636: exit 0 04:43:55 INFO - TEST-OK | dromaeo_css | took 1113340ms 04:43:55 INFO - TEST-START | kraken 04:43:55 INFO - operating with platform_type : mac_ 04:43:55 INFO - Initialising browser for kraken test... 04:43:55 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpaYa5EW/profile http://localhost:49240/getInfo.html) 04:43:57 INFO - PROCESS | 1648 | 2017-03-21 04:43:57.927 plugin-container[1650:9850] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8537, name = 'com.apple.tsm.portname' 04:43:57 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:57 INFO - PROCESS | 1648 | 2017-03-21 04:43:57.928 plugin-container[1650:9850] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880b, name = 'com.apple.CFPasteboardClient' 04:43:57 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:57 INFO - PROCESS | 1648 | 2017-03-21 04:43:57.928 plugin-container[1650:9850] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:57 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 04:43:57 INFO - PROCESS | 1648 | colorDepth:24 04:43:57 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 04:43:57 INFO - PROCESS | 1648 | __metrics 04:43:58 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 04:43:58 INFO - TEST-INFO | 1648: exit 0 04:43:58 INFO - Browser initialized. 04:43:58 INFO - Running cycle 1/1 for kraken test... 04:43:58 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/tmpaYa5EW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:01 INFO - PROCESS | 1651 | 2017-03-21 04:44:01.099 plugin-container[1652:9979] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 04:44:01 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:01 INFO - PROCESS | 1651 | 2017-03-21 04:44:01.100 plugin-container[1652:9979] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8713, name = 'com.apple.CFPasteboardClient' 04:44:01 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:44:01 INFO - PROCESS | 1651 | 2017-03-21 04:44:01.100 plugin-container[1652:9979] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:44:10 INFO - PROCESS | 1651 | RSS: Main: 172843008 04:44:10 INFO - PROCESS | 1651 | 04:44:13 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:14 INFO - PROCESS | 1651 | RSS: Main: 186097664 04:44:14 INFO - PROCESS | 1651 | 04:44:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 04:44:17 INFO - PROCESS | 1651 | RSS: Main: 193540096 04:44:17 INFO - PROCESS | 1651 | 04:44:21 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 04:44:21 INFO - PROCESS | 1651 | RSS: Main: 197120000 04:44:21 INFO - PROCESS | 1651 | 04:44:23 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 04:44:24 INFO - PROCESS | 1651 | RSS: Main: 198496256 04:44:24 INFO - PROCESS | 1651 | 04:44:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:27 INFO - PROCESS | 1651 | RSS: Main: 198574080 04:44:27 INFO - PROCESS | 1651 | 04:44:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:30 INFO - PROCESS | 1651 | RSS: Main: 202711040 04:44:30 INFO - PROCESS | 1651 | 04:44:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:34 INFO - PROCESS | 1651 | RSS: Main: 201953280 04:44:34 INFO - PROCESS | 1651 | 04:44:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 04:44:37 INFO - PROCESS | 1651 | RSS: Main: 202526720 04:44:37 INFO - PROCESS | 1651 | 04:44:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:40 INFO - PROCESS | 1651 | RSS: Main: 201560064 04:44:40 INFO - PROCESS | 1651 | 04:44:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:42 INFO - PROCESS | 1651 | RSS: Main: 201564160 04:44:42 INFO - PROCESS | 1651 | 04:44:45 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:45 INFO - PROCESS | 1651 | RSS: Main: 201564160 04:44:45 INFO - PROCESS | 1651 | 04:44:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:49 INFO - PROCESS | 1651 | RSS: Main: 202051584 04:44:49 INFO - PROCESS | 1651 | 04:44:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:52 INFO - PROCESS | 1651 | RSS: Main: 202137600 04:44:52 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 04:44:54 INFO - PROCESS | 1651 | RSS: Main: 204120064 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | __start_tp_report 04:44:54 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 04:44:54 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 04:44:54 INFO - PROCESS | 1651 | |i|pagename|runs| 04:44:54 INFO - PROCESS | 1651 | |0;ai-astar;104;117;118;117;118;116;116;118;117;120 04:44:54 INFO - PROCESS | 1651 | |1;audio-beat-detection;138;120;127;153;132;99;126;146;162;147 04:44:54 INFO - PROCESS | 1651 | |2;audio-dft;280;270;192;195;196;197;196;194;193;192 04:44:54 INFO - PROCESS | 1651 | |3;audio-fft;81;59;68;109;82;77;59;60;75;57 04:44:54 INFO - PROCESS | 1651 | |4;audio-oscillator;81;71;83;72;69;70;80;71;72;83 04:44:54 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;89;96;89;95;130;79;74;108;121 04:44:54 INFO - PROCESS | 1651 | |6;imaging-darkroom;99;97;94;153;152;100;97;96;97;98 04:44:54 INFO - PROCESS | 1651 | |7;imaging-desaturate;101;94;113;74;89;146;148;83;155;75 04:44:54 INFO - PROCESS | 1651 | |8;json-parse-financial;48;63;90;89;89;61;63;62;63;62 04:44:54 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;65;73;72;74;69;68;75;61;89;98 04:44:54 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;84;84;82;85;91;103;102;107;87;104 04:44:54 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;143;133;155;147;138;125;147;150;169;137 04:44:54 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;163;168;161;162;177;220;164;166;161;162 04:44:54 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;65;63;63;64;55;77;88;85;85;83 04:44:54 INFO - PROCESS | 1651 | __end_tp_report 04:44:54 INFO - PROCESS | 1651 | __start_cc_report 04:44:54 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,938 04:44:54 INFO - PROCESS | 1651 | __end_cc_report 04:44:54 INFO - PROCESS | 1651 | __startTimestamp1490096694682__endTimestamp 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | ------- Summary: start ------- 04:44:54 INFO - PROCESS | 1651 | Number of tests: 14 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:116.10 Median:117.50 stddev:4.41 (3.8%) stddev-sans-first:1.24 04:44:54 INFO - PROCESS | 1651 | Values: 104.0 117.0 118.0 117.0 118.0 116.0 116.0 118.0 117.0 120.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:146.50 stddev:18.26 (12.5%) stddev-sans-first:19.34 04:44:54 INFO - PROCESS | 1651 | Values: 138.0 120.0 127.0 153.0 132.0 99.0 126.0 146.0 162.0 147.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:210.50 Median:196.00 stddev:34.12 (17.4%) stddev-sans-first:25.27 04:44:54 INFO - PROCESS | 1651 | Values: 280.0 270.0 192.0 195.0 196.0 197.0 196.0 194.0 193.0 192.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:72.70 Median:71.50 stddev:15.99 (22.4%) stddev-sans-first:16.68 04:44:54 INFO - PROCESS | 1651 | Values: 81.0 59.0 68.0 109.0 82.0 77.0 59.0 60.0 75.0 57.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.00 stddev:5.77 (7.6%) stddev-sans-first:5.73 04:44:54 INFO - PROCESS | 1651 | Values: 81.0 71.0 83.0 72.0 69.0 70.0 80.0 71.0 72.0 83.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:97.10 Median:89.00 stddev:17.70 (19.9%) stddev-sans-first:18.59 04:44:54 INFO - PROCESS | 1651 | Values: 90.0 89.0 96.0 89.0 95.0 130.0 79.0 74.0 108.0 121.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:108.30 Median:97.00 stddev:23.35 (24.1%) stddev-sans-first:24.53 04:44:54 INFO - PROCESS | 1651 | Values: 99.0 97.0 94.0 153.0 152.0 100.0 97.0 96.0 97.0 98.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:74.50 stddev:31.19 (41.9%) stddev-sans-first:32.98 04:44:54 INFO - PROCESS | 1651 | Values: 101.0 94.0 113.0 74.0 89.0 146.0 148.0 83.0 155.0 75.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:69.00 Median:63.00 stddev:14.73 (23.4%) stddev-sans-first:13.52 04:44:54 INFO - PROCESS | 1651 | Values: 48.0 63.0 90.0 89.0 89.0 61.0 63.0 62.0 63.0 62.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:74.40 Median:73.50 stddev:11.14 (15.2%) stddev-sans-first:11.28 04:44:54 INFO - PROCESS | 1651 | Values: 65.0 73.0 72.0 74.0 69.0 68.0 75.0 61.0 89.0 98.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:84.00 stddev:9.92 (11.8%) stddev-sans-first:9.98 04:44:54 INFO - PROCESS | 1651 | Values: 84.0 84.0 82.0 85.0 91.0 103.0 102.0 107.0 87.0 104.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:147.00 stddev:12.32 (8.4%) stddev-sans-first:13.06 04:44:54 INFO - PROCESS | 1651 | Values: 143.0 133.0 155.0 147.0 138.0 125.0 147.0 150.0 169.0 137.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:165.00 stddev:18.08 (11.0%) stddev-sans-first:18.98 04:44:54 INFO - PROCESS | 1651 | Values: 163.0 168.0 161.0 162.0 177.0 220.0 164.0 166.0 161.0 162.0 04:44:54 INFO - PROCESS | 1651 | 04:44:54 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:80.00 stddev:12.01 (15.0%) stddev-sans-first:12.40 04:44:54 INFO - PROCESS | 1651 | Values: 65.0 63.0 63.0 64.0 55.0 77.0 88.0 85.0 85.0 83.0 04:44:54 INFO - PROCESS | 1651 | -------- Summary: end -------- 04:44:54 INFO - PROCESS | 1651 | 04:44:55 INFO - TEST-INFO | 1651: exit 0 04:44:55 INFO - TEST-OK | kraken | took 60292ms 04:44:55 INFO - SUITE-END | took 1173s 04:44:55 INFO - Completed test suite (00:19:34) 04:44:55 INFO - javascript benchmark 04:44:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7371.456472223853, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3425.3663072331606, 3442.707369873561, 3478.982605086974, 3501.842417091231, 3502.9824850875743, 4674.3923289972345, 5712.257406537149, 5732.283464566929, 5833.562482813795, 5840.737166827493, 4857.271409288608, 5783.0, 5891.793787217448, 5927.170196172528, 5936.782959493305, 4479.641628669699, 4485.461744590637, 5185.611079169059, 5206.635535512516, 5329.307190065286, 4321.54623764505, 5174.120399532088, 5306.416294207634, 5315.707636080014, 5322.866928326784, 5159.5614372778355, 5194.428612852583, 5206.21906713994, 5211.088059589594, 5213.7393130343335, 5136.948630513722, 5139.717315547643, 5148.510891465305, 5193.2989046479, 5216.217567364888, 4572.177008138534, 4678.95321046792, 5112.872178195537, 5148.639595228336, 5163.122269214243, 5561.944380556223, 5562.360328562227, 5639.15412688096, 5718.485336319751, 5722.37053924068, 6168.259808822925, 6171.722272497704, 6240.251169859601, 6257.843553911143, 6283.937160628427, 6232.8130156095385, 6246.375362463763, 6247.312795592481, 6257.78097766576, 6278.30938596754, 6019.819405417845, 6030.698465076729, 6043.48630366415, 6047.425494578008, 6052.515798736179, 6146.0166373380935, 6194.845128871724, 6199.070139479114, 6200.7519699211525, 6232.626042437469, 6035.637861728223, 6103.938960610426, 6119.938800612026, 6125.05232106189, 6137.96931015342, 6184.134221209034, 6213.347598502182, 6237.002079667232, 6237.033259844731, 6237.251529816361, 6036.0, 6120.355709576947, 6188.81433556994, 6191.288001879841, 6195.81412557624, 5458.45415458459, 6211.3478084801345, 6237.282712488122, 6256.7810126645345, 6259.530535209787, 4667.0, 4926.630502712311, 4983.6013118950395, 5047.646664733506, 5067.341245638044, 4447.688661793708, 4449.1991441540185, 4480.260756975128, 4504.256797628354, 4527.501974782771, 5790.334111577223, 5797.826065218051, 5853.0, 5872.412758724094, 5958.851028724316, 6244.579358196007, 6251.343608921089, 6261.123442718023, 6265.561410701207, 6277.748890044347, 4775.761211939389, 5798.623089499169, 5807.0998995155815, 5867.677277749679, 5955.52355811534, 5498.560115190775, 5543.445655434505, 5551.861203469864, 5552.52803511706, 5561.527270181999, 6406.487481001509, 6411.3909178627955, 6415.743370265231, 6415.807525774234, 6450.387213214737, 6125.571219981412, 6141.2098563120835, 6143.481172719164, 6304.338044505261, 6307.842303942438, 6298.401651843067, 6387.648679322682, 6399.6800159992745, 6400.0, 6414.711337989895, 6217.906731399123, 6226.968865155826, 6238.220222472191, 6239.0953311770445, 6254.0, 5924.763009479572, 6152.323244443197, 6271.871063208666, 6272.905906411316, 6289.842753931189, 6105.114758360101, 6112.572119951738, 6134.447899689049, 6138.631682099089, 6167.383261673976, 6118.541124375593, 6170.876582468415, 6173.59871608344, 6182.783602573888, 6190.41191086864, 5950.821475355746, 6000.399960003964, 6045.425684559959, 6118.5411094169, 6130.080487926846, 6102.420270074336, 6109.602875813058, 6112.235970503687, 6113.141862489121, 6174.783882564088, 6112.862044203218, 6117.806688482678, 6131.957816599936, 6133.509319254538, 6159.753609855556], "value": 5705.571675051322, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.279552715655, 518.3675915383233, 520.4561233510981, 521.9086659834529, 534.8475684429933, 35424.645753542456, 43650.0, 44053.77973110138, 45625.31562026564, 45685.771571142184, 37044.81477592608, 45269.0, 45489.0902181957, 45526.772366138204, 45577.0, 9153.771155721128, 9538.952305238481, 9732.075452832005, 9752.4636145012, 9776.071273229032, 9117.772055698595, 11897.464614092343, 12012.0, 12252.754944901097, 12419.192752471106, 10709.518071686754, 11465.426728663575, 12226.021918246519, 12227.938860305687, 12261.019118470502, 11880.524779008872, 12041.939790300992, 12105.273683579013, 12118.091143164209, 12152.21010634306, 11736.941315293368, 11800.114991375596, 11933.582324618597, 12068.758624827542, 12136.878631213664, 42735.35896961548, 42891.785541072095, 42934.141317173795, 43203.56796432027, 43275.134497309875, 4057.2088442753675, 4065.4918135233097, 4082.4284600156, 4102.835886564534, 4155.8753237402925, 27227.319317017234, 30563.38873222523, 30681.0, 30799.538006929914, 31010.224744381347, 3230.9327294577974, 3232.191952011997, 3285.474324108155, 3335.933281334384, 3376.915577110592, 448663.0, 527086.3645681785, 528251.0, 528660.0, 531602.0, 66110.67778644401, 66487.33512664812, 66684.0, 66704.33295667078, 66721.66556668936, 69336.65331673309, 69947.65026174836, 70067.64966175238, 70086.0, 70322.0, 17021.829781702025, 17694.203760830795, 17698.380556680455, 17737.467875963743, 17811.0, 11431.542738290374, 12495.68795276501, 12741.49034038628, 13513.716196961273, 13759.243241621807, 17108.82891171097, 17214.569635758955, 17530.29878804859, 17615.798025246844, 17635.941843489174, 7497.1753107158165, 7535.472516923763, 7582.582957937367, 7632.885506717404, 7632.885506717404, 819.880862622516, 908.3323757038571, 909.8635204719212, 924.177482040984, 944.2587568758491, 27007.459850802872, 31139.532907006414, 31463.685363146076, 31747.69384193468, 31966.840165799487, 987.0770829274651, 1050.8949105089582, 1097.9505922233518, 1141.3209140561353, 1245.3959829482694, 15133.319000644997, 15149.718794677825, 16145.273462694207, 16358.83641163597, 16525.58686032859, 222422.0, 224454.0, 224707.0, 225043.87478062834, 225136.0, 59968.70015649894, 62117.68941155265, 62474.68762656158, 62809.37190628127, 63077.0, 1445.595233334668, 1448.5726710620181, 1466.6699992501815, 1487.7842712806582, 1495.5887131038833, 29646.0, 30954.226144346572, 31230.0, 31644.367112658078, 31651.683483164874, 53115.67210819761, 53248.4675153259, 53728.0, 55187.17219241795, 58378.0, 579150.1042494761, 582350.0, 582523.0, 582898.0, 583148.0, 23602.763972360055, 25428.0, 25440.23679289624, 25811.741882581686, 25882.0, 36762.63237367699, 45051.774741126086, 45497.0, 45906.081878361576, 46451.53613905302, 34080.48879266763, 35888.92333230007, 36666.63333366632, 36960.815195923846, 37812.81093594514, 36874.81562592277, 36959.44560831536, 37845.62154378421, 38027.80986095052, 38182.0, 28503.572446412905, 36494.63505364912, 37394.813025934694, 37461.0, 37581.0, 29738.8513057442, 33089.33821323608, 33199.33601328008, 33213.335733284715, 33279.0, 24653.876730616234, 24843.751562484867, 24913.626295605944, 25005.74994250107, 25389.365265867764], "value": 20179.6729878046, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.61961418966837, 394.14077311461006, 415.43085972218057, 416.25282617701225, 432.19611522568016, 20979.0, 21470.677939830915, 21942.0, 22198.334049978486, 22454.3263702089, 21842.235521756742, 22070.779292207073, 22443.438914027116, 22505.0, 22534.985925633344, 5615.578831587627, 5751.396103409144, 5762.135679648044, 5859.384764599719, 5885.176075349455, 5695.886082278352, 5710.086386178213, 5766.279215098113, 5779.248697669318, 5873.2658417697785, 5727.684977326246, 5799.797007104752, 5808.59339846211, 5818.06910894257, 5822.563307751935, 4805.639577031719, 5780.682062486561, 6077.24034495688, 6152.938470615326, 6193.256809182927, 5855.648661080306, 6058.0610005449225, 6080.513558915276, 6087.57386982907, 6090.33006369299, 13536.458541658321, 13698.931505342509, 13885.583432497042, 13890.0, 13890.722185556333, 2609.595512695535, 2628.8554129522868, 2668.2528891910297, 2675.799315051379, 2680.2361327021704, 10161.695149145537, 10329.84505232422, 10376.63681771142, 10790.51442685081, 10823.945880270627, 1880.6238752249467, 1910.3791267838008, 1911.7801452832964, 1917.8273955344087, 1925.4031250312307, 130538.0, 146452.26773866062, 154895.2255238728, 155066.0, 156255.0, 11813.0, 11882.881171188177, 12040.638780836414, 12129.090318226168, 12306.938465307616, 16153.192340382933, 16160.676786464204, 16167.0, 16168.0, 16194.02835829854, 8884.466931984101, 9118.726438206864, 9131.726048218565, 9195.356325057315, 9301.72094837156, 8953.328500362499, 8981.790970316788, 9085.50029748357, 9196.35625506208, 9275.953620231856, 3987.401889716508, 4890.804367825247, 4915.827946021944, 4958.826441074617, 5007.924881126786, 1796.9281228750704, 1814.2652225848553, 2079.147549504726, 2098.412444515538, 2128.2019242783954, 343.3270789253092, 389.7914615680654, 405.17748969591776, 426.1158096948844, 1023.8157131716214, 11674.88325116755, 12159.392030398445, 12236.938815306044, 12254.326012069243, 12418.937905310597, 463.7287186995578, 474.7821836988114, 479.99520004800206, 481.51607634327274, 485.5726960274935, 6143.754249830046, 6203.596766210182, 6228.968855155696, 6246.500279977591, 6414.422701956846, 714236.0, 838326.0, 838848.0, 844209.0, 857068.0, 98647.0, 143008.28495857454, 163107.0, 166011.50982735268, 171129.0, 460.3095356964553, 475.1115414175445, 1011.7521207304258, 1085.8968398002335, 1090.1224514266091, 14827.703445930805, 19859.900700496404, 20351.694724578847, 20447.59104817925, 20464.181432742524, 53232.0, 61538.0, 63080.369196309286, 64570.0, 66202.35190592516, 82959.17040829515, 84641.73037404567, 84989.0, 85857.14142858492, 86081.23390242655, 6596.8350791230605, 8327.417080804285, 8391.832163356821, 8600.053994060774, 8663.6101375437, 11694.941525292319, 12565.994720422526, 12784.61646150617, 12996.610101696964, 13033.608991730263, 10791.244612877337, 11166.05088567481, 11478.139139564399, 11484.36835973996, 11558.07535397183, 9512.90487095148, 10815.242932994615, 10895.455227238765, 10952.780944381228, 11331.660050198507, 10935.671929842118, 11143.777124457627, 11402.543898243977, 11563.6530904073, 11610.6516804496, 8411.663533458837, 8426.915730842613, 8484.448510846774, 8751.168638979287, 8751.956240218758, 8672.566371681516, 10894.291871028357, 10984.176186786182, 11360.431978400882, 11378.601748938747], "value": 9221.035281205217, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.2012792324604, 1459.4162335065978, 1510.516634676903, 1511.486094727793, 1514.8333683294838, 7012.43900487961, 7764.378849692025, 7993.640286187121, 8799.384043116992, 8830.86753698695, 8226.0, 8493.532855692934, 8539.146085391458, 8559.48643081414, 8588.312934965203, 2103.9900847593126, 2332.8483648562787, 2433.0, 2439.3657649011298, 2444.8655323957173, 2409.4217387826884, 2442.9755702442926, 2450.4363996280867, 2452.5830608796546, 2456.091246238894, 2381.8094552435764, 2386.224477044959, 2413.2036427978815, 2415.0339864054345, 2418.9758102419014, 2068.596623658387, 2241.7870302321253, 2385.9284221473386, 2410.650455683916, 2413.2880800163994, 2380.083667787897, 2409.8192635552405, 2422.563938491071, 2428.76926691964, 2432.221689059502, 8601.0, 8617.61220745068, 8628.82742345156, 8708.433951793113, 8710.651573937099, 4616.891945932985, 5350.545203657655, 5405.783768649249, 5413.810516631938, 5416.350037995427, 3189.856456459465, 3573.6247693992277, 3597.3524765542193, 3620.8913732588067, 3705.221903400289, 1166.5742004168503, 1190.1668831817763, 1200.2498438475952, 1302.648284963064, 1313.579654510557, 10039.096481316716, 10459.738506537322, 11192.888071119267, 11229.326240425518, 11240.887591124067, 3917.6082391760597, 4668.709513995832, 4821.63837712173, 4867.70793752376, 4902.338184345139, 8368.707095251637, 9799.951000244953, 9811.166050885611, 9838.0, 9845.655402060893, 5353.170258609922, 5426.321709786277, 5438.0, 5455.481729235717, 5457.2905522282645, 4423.955760442354, 4508.639308855284, 4907.509249075064, 4947.431045429822, 4976.178930476503, 3995.4006898965386, 4039.434479172918, 4091.7340372876265, 4119.876403707894, 4123.969007748063, 1317.637649646355, 1329.2224048931485, 1329.7407005633809, 1335.1922087137143, 1335.7528857161456, 933.6265493802533, 940.7601061729353, 954.2461455450256, 958.8705524754068, 999.980000399988, 5568.248286481355, 5808.88382232353, 5948.821535353946, 5959.374265702126, 6035.2637814481395, 589.964602123874, 593.7417223507788, 597.4205021129497, 597.4742226840352, 606.2512796696077, 3854.7494412863075, 3860.517435320585, 3923.2545816294814, 3944.6252606002386, 3966.1076257842333, 9930.404175749334, 10250.794984100276, 10266.486675666187, 10302.948485257675, 10351.016653417913, 10102.545385457672, 10223.846642300372, 10242.334248273839, 10258.12805911491, 10285.0, 7725.266099720518, 8016.559089250147, 8039.598020098972, 8045.718399855977, 8157.46976446541, 5920.851978700567, 5922.555808314308, 5951.256092988377, 6051.152838602688, 6108.694565271808, 9389.906100938902, 9510.667126650535, 9603.47180905029, 9622.711318660451, 9650.131488166098, 9284.907150928675, 9724.027597240502, 9825.656102036395, 9827.361221520578, 9877.950610246902, 6833.931660683528, 7042.0, 7250.927490725237, 7399.038125043709, 7527.1720110788865, 7985.840283194188, 8295.170482951657, 8297.626606802587, 8307.0, 8325.791855203426, 7202.207757146814, 7349.853002939804, 7392.778216653509, 7470.0, 7495.475316727777, 7121.608311542707, 7161.4270858330165, 7177.2463891292755, 7304.356519783219, 7304.780856574312, 5439.755211015435, 5441.238226648352, 6552.443042341454, 6662.267150613332, 6910.412614927787, 5033.144365457808, 5104.923426148685, 5157.690538567698, 5235.869103272448, 5248.2390053442805, 4271.914561708686, 5103.897922041464, 5257.710825904612, 5273.209018647233, 5400.1899715043055], "value": 4496.6593825803875, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.66435242994856, 379.26990543204323, 381.2888962085711, 382.7129652760429, 384.49438987731133, 4693.577578017977, 4743.8814029649275, 4983.426905905817, 5651.337646441687, 5685.516731077858, 5128.9230661540105, 5435.171208389604, 5583.720813959296, 5604.439556044394, 5630.648644325363, 3398.7281017518662, 4240.830366785325, 4364.476262848447, 4366.847160349388, 4420.452841505479, 4325.863748782139, 4425.8229670813125, 4426.313921342181, 4432.689711720181, 4438.400815889862, 3513.9297214055705, 3819.0, 4391.6486681065435, 4399.714018588797, 4426.490953540352, 4284.078923031548, 4326.459192600925, 4371.868843934687, 4394.8461803837035, 4420.690551661385, 3867.3038853006447, 3871.090293780959, 3871.412720784493, 3908.7850168240734, 3941.507311586052, 4586.472555656109, 4823.3729615149805, 5442.374126975369, 5536.280283563111, 5559.388467268597, 4161.812718427648, 5047.570956468705, 5064.366954130734, 5091.770870310808, 5103.673045008288, 4875.122477953967, 5930.140129681172, 5948.40515948406, 6008.188894499274, 6067.938110830632, 4318.963448772303, 4319.719218250803, 4337.869863904088, 4348.304271316606, 4358.738475691437, 5328.66783304174, 5498.477644623755, 5961.731722072517, 6102.908456373158, 6310.274318453391, 4053.7365071270274, 4194.496660400771, 4271.23117838792, 4415.470143582791, 4428.446444194476, 4489.34904438861, 4493.123840851003, 4493.752843593568, 4500.842470513517, 4502.347159661831, 4119.8970025748995, 4667.509911459248, 5084.3898732152375, 5119.87200319995, 5162.5611822994715, 5241.0, 5975.462208401178, 5990.9101363479585, 5990.940090599125, 6061.605995610359, 1268.8540817805886, 1472.3521650473758, 1475.0854470228312, 1475.8155230596176, 1490.972277702324, 954.3319676226669, 1017.4505766885947, 1020.4438580973388, 1021.9846702299471, 1032.695354870315, 5058.570021548209, 5148.4079330876675, 5207.244949482304, 5356.892862142813, 5432.071614576847, 4950.529699678525, 5239.607029472805, 5391.56867450603, 5991.670458124758, 5993.880122397528, 4838.153323168432, 4838.363092114806, 4865.7860673393525, 4999.350344317518, 5363.0, 2485.9751402486104, 3051.71008754168, 3069.677683843209, 3110.4401207782817, 3116.2988327626103, 5476.205950137288, 5650.74571644277, 5733.31200255972, 5954.451842520975, 6138.7237574309265, 4620.198122732138, 5162.354705661793, 5842.88985092831, 6257.2804127525915, 6328.71520781566, 5300.734963251822, 6354.682265886687, 6367.745290188341, 6411.487081033506, 6456.999999999906, 4699.130660827758, 5122.692638441706, 5470.124780035176, 6090.462605358859, 6198.380161983766, 5475.342958844964, 5622.437756224344, 6076.058210977306, 6091.908621370594, 6169.259688837368, 5335.706536140549, 5501.982133305191, 5604.467575580314, 6285.811425657238, 6436.549441539235, 4077.8776636700945, 4108.2334596122755, 4110.46563946697, 4113.629773320416, 4128.752274863517, 5936.63959506294, 6142.846428839315, 6185.597936134137, 6188.752449901954, 6219.906701399392, 5919.260092488439, 5960.493358064613, 5978.252718410199, 5978.491828194478, 5995.16067750524, 5315.813946512008, 5944.335586035917, 5950.642961422329, 5963.3142188647125, 5981.222441082806, 4862.878428039327, 5566.91649625264, 5753.338366087954, 5769.105788602773, 5827.737751801264, 5960.940390596039, 5964.165016897725, 5967.076132695035, 5982.1584747244715, 5982.910256346071, 5471.151971444432, 5539.750711218086, 5700.515456186271, 5860.912086318624, 5907.4683278505145], "value": 4360.606218960851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.2170681637684, 757.4016526943715, 792.8414317136574, 816.3713940265994, 886.8758373827666, 14264.0, 16197.0, 18355.449336519894, 18642.53393665159, 18709.251629934803, 15715.764263536028, 17445.21496532656, 17833.286668533274, 17909.28362865487, 17941.461756147335, 887.9511626860503, 904.8552231642939, 908.1236606674557, 911.1162172692477, 911.4713466189594, 697.6232834269489, 717.7559629725893, 736.2416710787898, 882.9690960816373, 905.7826121730803, 943.8301105800953, 952.4808979106369, 953.4803532075035, 954.2556805691572, 957.0238356876017, 798.5448294472153, 939.567798812547, 946.5456580841166, 947.5262368815593, 948.6063283737241, 682.3722175598461, 692.1935944624506, 698.5075521757149, 706.7349743846057, 709.1383968478272, 15735.606609834731, 16289.941153824964, 16333.509994700178, 16676.999380037236, 16739.581510462212, 15074.698506029818, 15088.24558772068, 15146.924265378713, 15190.544283671508, 15304.852136089838, 11710.707232319175, 11836.349000804952, 11870.703232419171, 11880.465379057876, 11946.940265298705, 3806.0, 3901.7247476131197, 3904.3557812960826, 3946.565877753445, 4075.0, 92002.07997920002, 108037.9775314602, 109203.45398272958, 110149.0, 111091.0, 11390.601328953448, 11447.942760286145, 11708.00481959026, 12105.757884842254, 12310.076744244217, 24648.507029859302, 25114.121005765075, 25262.494750105263, 25266.11568595127, 25326.366840829127, 8085.231902969209, 8165.755027349189, 8173.060098088677, 8259.49272249584, 8422.452540584842, 4314.266574682249, 4320.524742278347, 4392.407025051641, 4480.059187570647, 4614.423197100363, 3744.045268456526, 3773.6792372648633, 3844.942325865114, 3864.3430616795213, 3870.3807390817333, 690.147667630476, 698.7135274537416, 709.4253654539839, 711.8327193109615, 714.5855403865745, 604.1179877378988, 687.8658661561047, 701.2671758012889, 704.8555046215514, 712.1276436365514, 10519.105876000473, 10631.84052239217, 10847.620333288298, 10975.83536246957, 11035.282706624204, 590.9438603332677, 623.0840664223584, 625.8529245627274, 652.7617419641891, 663.6250518457057, 5084.669496482717, 5201.713905735221, 5228.63399562027, 5239.47605239473, 5252.264682944391, 111220.0, 112815.43592281986, 115135.84864151418, 115870.0, 117295.0, 95373.5231323839, 96817.0, 97309.0, 98222.0, 100788.0, 60147.39852601418, 66626.66686666536, 77810.6109469449, 85252.14747852566, 86310.0, 8115.75652730419, 9253.491057991874, 10123.79752404933, 10252.0, 10270.794584108426, 47003.76498117488, 53190.46809531855, 54432.727836360566, 55587.0, 56751.14873276822, 72981.0, 74749.6262518684, 75492.0, 76899.0, 77793.61103194449, 11993.820092698443, 12088.879111208775, 12113.273203607812, 12140.33228172459, 12216.389180541115, 12875.935620321838, 13281.601551953458, 13669.726605468033, 13724.245166515937, 14198.219097949712, 12218.511259549874, 12637.0, 12824.679383015498, 12863.935680321913, 13165.868341316464, 12645.304508252135, 12730.490780368682, 12839.614811555668, 12990.610281691565, 13102.0, 12113.394330283627, 12467.5012999479, 12530.624081277576, 12702.237865727717, 12842.807357889826, 9664.806703866025, 9795.559199836167, 9863.0, 10117.949410252902, 10143.34068285559, 8162.265396114378, 8366.958165209378, 8493.660253589787, 8951.73144805657, 8975.102489751234], "value": 7706.305719260962, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.6000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 118.0, 117.0, 118.0, 116.0, 116.0, 118.0, 117.0, 120.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 120.0, 127.0, 153.0, 132.0, 99.0, 126.0, 146.0, 162.0, 147.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [280.0, 270.0, 192.0, 195.0, 196.0, 197.0, 196.0, 194.0, 193.0, 192.0], "value": 210.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 68.0, 109.0, 82.0, 77.0, 59.0, 60.0, 75.0, 57.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 71.0, 83.0, 72.0, 69.0, 70.0, 80.0, 71.0, 72.0, 83.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 96.0, 89.0, 95.0, 130.0, 79.0, 74.0, 108.0, 121.0], "value": 97.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 97.0, 94.0, 153.0, 152.0, 100.0, 97.0, 96.0, 97.0, 98.0], "value": 108.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 113.0, 74.0, 89.0, 146.0, 148.0, 83.0, 155.0, 75.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 63.0, 90.0, 89.0, 89.0, 61.0, 63.0, 62.0, 63.0, 62.0], "value": 69.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 72.0, 74.0, 69.0, 68.0, 75.0, 61.0, 89.0, 98.0], "value": 74.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 85.0, 91.0, 103.0, 102.0, 107.0, 87.0, 104.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 133.0, 155.0, 147.0, 138.0, 125.0, 147.0, 150.0, 169.0, 137.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 168.0, 161.0, 162.0, 177.0, 220.0, 164.0, 166.0, 161.0, 162.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 55.0, 77.0, 88.0, 85.0, 85.0, 83.0], "value": 72.8, "unit": "score"}]}]} 04:44:55 INFO - Return code: 0 04:44:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:44:55 ERROR - # TBPL SUCCESS # 04:44:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:55 INFO - 2017-03-21 04:44:55.996 screenresolution[1656:10362] starting screenresolution argv=screenresolution get 04:44:56 INFO - 2017-03-21 04:44:56.000 screenresolution[1656:10362] Display 0: 1600x1200x32@60 04:44:56 INFO - 2017-03-21 04:44:56.006 screenresolution[1657:10365] starting screenresolution argv=screenresolution list 04:44:56 INFO - Available Modes on Display 0 04:44:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:56 INFO - Intel Iris: 04:44:56 INFO - Chipset Model: Intel Iris 04:44:56 INFO - Type: GPU 04:44:56 INFO - Bus: Built-In 04:44:56 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:56 INFO - Vendor: Intel (0x8086) 04:44:56 INFO - Device ID: 0x0a2e 04:44:56 INFO - Revision ID: 0x0009 04:44:56 INFO - Displays: 04:44:56 INFO - Display: 04:44:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:56 INFO - Display Serial Number: 1600x1200 60 04:44:56 INFO - Main Display: Yes 04:44:56 INFO - Mirror: Off 04:44:56 INFO - Online: Yes 04:44:56 INFO - Rotation: Supported 04:44:56 INFO - Return code: 0 04:44:56 INFO - Running post-action listener: _resource_record_post_action 04:44:56 INFO - [mozharness: 2017-03-21 11:44:56.239901Z] Finished run-tests step (success) 04:44:56 INFO - Running post-run listener: _resource_record_post_run 04:44:56 INFO - Total resource usage - Wall time: 1189s; CPU: 54.0%; Read bytes: 44517888; Write bytes: 423619584; Read time: 451; Write time: 1652 04:44:56 INFO - TinderboxPrint: CPU usage
54.3% 04:44:56 INFO - TinderboxPrint: I/O read bytes / time
44,517,888 / 451 04:44:56 INFO - TinderboxPrint: I/O write bytes / time
423,619,584 / 1,652 04:44:56 INFO - TinderboxPrint: CPU idle
2,172.1 (45.7%) 04:44:56 INFO - TinderboxPrint: CPU system
958.0 (20.1%) 04:44:56 INFO - TinderboxPrint: CPU user
1,627.5 (34.2%) 04:44:56 INFO - TinderboxPrint: Swap in / out
174,526,464 / 0 04:44:56 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121672192; Write bytes: 114008064; Read time: 11205; Write time: 218 04:44:56 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 42134016; Write bytes: 299555840; Read time: 424; Write time: 1399 04:44:56 INFO - Running post-run listener: _upload_blobber_files 04:44:56 INFO - Blob upload gear active. 04:44:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:56 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 04:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:44:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:57 INFO - (blobuploader) - INFO - Done attempting. 04:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:44:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:58 INFO - (blobuploader) - INFO - Done attempting. 04:44:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:44:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:59 INFO - (blobuploader) - INFO - Done attempting. 04:44:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:44:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:45:01 INFO - (blobuploader) - INFO - Done attempting. 04:45:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:45:01 INFO - Return code: 0 04:45:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:45:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:45:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebb55edef37412880da70a9c50e65e42b52425c7bb219d9a440c983cb1009e648cf7e8d6935f20c73b77c51f1775c80a0c219ccb40dee5b25a900c6bd6c3b17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebd81bd1d9aedcafc339210a533f0bdd92ea0acc9d039a68f9c9cbb0554f93073b1e83c8fa61cb0142fbd78a7b152ab4adcdc56914a81293ac6afe87bcc2613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8dd74dd5eae46e48c0fb194a2d14299c0e2a6f06bda27836c1b903dd8156464c7c0e058f82cfbe07c67f9b1f856b38ea537c736cdf86c4d01d11ecfda7dfd997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd2f324147e4a7f4093fae6c330837ac2236b5b747b7e70bef9b813e2312f93048fcd7d1452f65d103e6a981d88925107ef66a0e014c298435c11edc07027b1f"} 04:45:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:45:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:45:01 INFO - Contents: 04:45:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebb55edef37412880da70a9c50e65e42b52425c7bb219d9a440c983cb1009e648cf7e8d6935f20c73b77c51f1775c80a0c219ccb40dee5b25a900c6bd6c3b17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebd81bd1d9aedcafc339210a533f0bdd92ea0acc9d039a68f9c9cbb0554f93073b1e83c8fa61cb0142fbd78a7b152ab4adcdc56914a81293ac6afe87bcc2613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8dd74dd5eae46e48c0fb194a2d14299c0e2a6f06bda27836c1b903dd8156464c7c0e058f82cfbe07c67f9b1f856b38ea537c736cdf86c4d01d11ecfda7dfd997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd2f324147e4a7f4093fae6c330837ac2236b5b747b7e70bef9b813e2312f93048fcd7d1452f65d103e6a981d88925107ef66a0e014c298435c11edc07027b1f"} 04:45:01 INFO - Running post-run listener: copy_logs_to_upload_dir 04:45:01 INFO - Copying logs to upload dir... 04:45:01 INFO - mkdir: /builds/slave/test/build/upload/logs 04:45:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.216409 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-03-21 04:45:01.742420) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:45:01.746022) ========= 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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebb55edef37412880da70a9c50e65e42b52425c7bb219d9a440c983cb1009e648cf7e8d6935f20c73b77c51f1775c80a0c219ccb40dee5b25a900c6bd6c3b17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebd81bd1d9aedcafc339210a533f0bdd92ea0acc9d039a68f9c9cbb0554f93073b1e83c8fa61cb0142fbd78a7b152ab4adcdc56914a81293ac6afe87bcc2613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8dd74dd5eae46e48c0fb194a2d14299c0e2a6f06bda27836c1b903dd8156464c7c0e058f82cfbe07c67f9b1f856b38ea537c736cdf86c4d01d11ecfda7dfd997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd2f324147e4a7f4093fae6c330837ac2236b5b747b7e70bef9b813e2312f93048fcd7d1452f65d103e6a981d88925107ef66a0e014c298435c11edc07027b1f"} build_url:https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/X3RlT0v8Sp2zUFHJL_XoTg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebb55edef37412880da70a9c50e65e42b52425c7bb219d9a440c983cb1009e648cf7e8d6935f20c73b77c51f1775c80a0c219ccb40dee5b25a900c6bd6c3b17", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3ebd81bd1d9aedcafc339210a533f0bdd92ea0acc9d039a68f9c9cbb0554f93073b1e83c8fa61cb0142fbd78a7b152ab4adcdc56914a81293ac6afe87bcc2613", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8dd74dd5eae46e48c0fb194a2d14299c0e2a6f06bda27836c1b903dd8156464c7c0e058f82cfbe07c67f9b1f856b38ea537c736cdf86c4d01d11ecfda7dfd997", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fd2f324147e4a7f4093fae6c330837ac2236b5b747b7e70bef9b813e2312f93048fcd7d1452f65d103e6a981d88925107ef66a0e014c298435c11edc07027b1f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-21 04:45:01.781148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:45:01.781482) ========= 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.3X4BDHJ2PS/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.ce24LJg7kd/Listeners TMPDIR=/var/folders/qh/93_3f_b14gq9ntzfk8d43zvw00000w/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.004805 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-21 04:45:01.829320) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:45:01.829659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-21 04:45:01.829990) ========= ========= Total master_lag: 0.18 =========