builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0317 starttime: 1492443834.11 results: success (0) buildid: 20170417072206 builduid: 4aa4b5f50a554583ad19e628f0c4e512 revision: 05c212a94183838f12feebb2c3fd483a6eec18c2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.108132) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.108615) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.108914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.134245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.134517) ========= 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.WVipUNJY1v/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.SVYxAXxAp9/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-17 08:43:54-- 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% 161M=0s 2017-04-17 08:43:54 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144955 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.302552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.302918) ========= 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.WVipUNJY1v/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.SVYxAXxAp9/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.022094 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:54.351309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-17 08:43:54.351626) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05c212a94183838f12feebb2c3fd483a6eec18c2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 05c212a94183838f12feebb2c3fd483a6eec18c2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WVipUNJY1v/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.SVYxAXxAp9/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-17 08:43:54,442 truncating revision to first 12 chars 2017-04-17 08:43:54,442 Setting DEBUG logging. 2017-04-17 08:43:54,442 attempt 1/10 2017-04-17 08:43:54,442 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05c212a94183?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-17 08:43:56,191 unpacking tar archive at: mozilla-central-05c212a94183/testing/mozharness/ program finished with exit code 0 elapsedTime=2.032695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-17 08:43:56.409086) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:56.409502) ========= script_repo_revision: 05c212a94183838f12feebb2c3fd483a6eec18c2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:56.410021) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:56.410370) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-17 08:43:56.430829) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-17 08:43:56.431186) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.WVipUNJY1v/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.SVYxAXxAp9/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:43:56 INFO - MultiFileLogger online at 20170417 08:43:56 in /builds/slave/test 08:43:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:43:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:56 INFO - {'append_to_log': False, 08:43:56 INFO - 'base_work_dir': '/builds/slave/test', 08:43:56 INFO - 'blob_upload_branch': 'Firefox', 08:43:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:56 INFO - 'branch': 'Firefox', 08:43:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:56 INFO - 'config_files': ('talos/mac_config.py',), 08:43:56 INFO - 'default_actions': ('clobber', 08:43:56 INFO - 'read-buildbot-config', 08:43:56 INFO - 'download-and-extract', 08:43:56 INFO - 'populate-webroot', 08:43:56 INFO - 'create-virtualenv', 08:43:56 INFO - 'install', 08:43:56 INFO - 'run-tests'), 08:43:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:56 INFO - 'download_minidump_stackwalk': True, 08:43:56 INFO - 'download_symbols': 'ondemand', 08:43:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:56 INFO - 'gecko_profile': False, 08:43:56 INFO - 'gecko_profile_interval': 0, 08:43:56 INFO - 'installer_path': 'installer.exe', 08:43:56 INFO - 'log_level': 'info', 08:43:56 INFO - 'log_name': 'talos', 08:43:56 INFO - 'log_to_console': True, 08:43:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:43:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:43:56 INFO - 'opt_config_files': (), 08:43:56 INFO - 'pip_index': False, 08:43:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:56 INFO - 'cmd': ('bash', 08:43:56 INFO - '-c', 08:43:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:56 INFO - 'enabled': True, 08:43:56 INFO - 'halt_on_failure': False, 08:43:56 INFO - 'name': 'check_screen_resolution'},), 08:43:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:43:56 INFO - 'cmd': ('bash', 08:43:56 INFO - '-c', 08:43:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:43:56 INFO - 'enabled': True, 08:43:56 INFO - 'halt_on_failure': False, 08:43:56 INFO - 'name': 'check_screen_resolution'},), 08:43:56 INFO - 'run_cmd_checks_enabled': True, 08:43:56 INFO - 'suite': 'dromaeojs', 08:43:56 INFO - 'system_bits': '32', 08:43:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:56 INFO - 'title': 't-yosemite-r7-0317', 08:43:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:56 INFO - 'use_talos_json': True, 08:43:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:56 INFO - 'work_dir': 'build'} 08:43:56 INFO - [mozharness: 2017-04-17 15:43:56.642049Z] Running clobber step. 08:43:56 INFO - Running pre-action listener: _resource_record_pre_action 08:43:56 INFO - Running main action method: clobber 08:43:56 INFO - rmtree: /builds/slave/test/build 08:43:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:56 INFO - Running post-action listener: _resource_record_post_action 08:43:56 INFO - [mozharness: 2017-04-17 15:43:56.811296Z] Finished clobber step (success) 08:43:56 INFO - [mozharness: 2017-04-17 15:43:56.811460Z] Running read-buildbot-config step. 08:43:56 INFO - Running pre-action listener: _resource_record_pre_action 08:43:56 INFO - Running main action method: read_buildbot_config 08:43:56 INFO - Using buildbot properties: 08:43:56 INFO - { 08:43:56 INFO - "project": "", 08:43:56 INFO - "product": "firefox", 08:43:56 INFO - "script_repo_revision": "production", 08:43:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:43:56 INFO - "repository": "", 08:43:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:43:56 INFO - "buildid": "20170417072206", 08:43:56 INFO - "pgo_build": "False", 08:43:56 INFO - "basedir": "/builds/slave/test", 08:43:56 INFO - "buildnumber": 12, 08:43:56 INFO - "slavename": "t-yosemite-r7-0317", 08:43:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:43:56 INFO - "platform": "yosemite_r7", 08:43:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:43:56 INFO - "branch": "mozilla-central", 08:43:56 INFO - "repo_path": "mozilla-central", 08:43:56 INFO - "revision": "05c212a94183838f12feebb2c3fd483a6eec18c2", 08:43:56 INFO - "stage_platform": "macosx64", 08:43:56 INFO - "builduid": "4aa4b5f50a554583ad19e628f0c4e512", 08:43:56 INFO - "slavebuilddir": "test" 08:43:56 INFO - } 08:43:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:43:56 INFO - Running post-action listener: _resource_record_post_action 08:43:56 INFO - [mozharness: 2017-04-17 15:43:56.814870Z] Finished read-buildbot-config step (success) 08:43:56 INFO - [mozharness: 2017-04-17 15:43:56.814937Z] Running download-and-extract step. 08:43:56 INFO - Running pre-action listener: _resource_record_pre_action 08:43:56 INFO - Running main action method: download_and_extract 08:43:56 INFO - mkdir: /builds/slave/test/build/tests 08:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:56 INFO - trying https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:43:56 INFO - Downloading https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:43:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 08:43:58 INFO - Downloaded 1325 bytes. 08:43:58 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:43:58 INFO - Using the following test package requirements: 08:43:58 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 08:43:58 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:43:58 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:43:58 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:43:58 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'jsshell-mac.zip'], 08:43:58 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:43:58 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:43:58 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:43:58 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:43:58 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:43:58 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:43:58 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:43:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:43:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:43:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:43:58 INFO - Fetch https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:43:59 INFO - Expected file size: 52663783 08:43:59 INFO - Obtained file size: 52663783 08:44:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:44:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:44:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:44:16 INFO - Fetch https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:44:18 INFO - Expected file size: 52663783 08:44:18 INFO - Obtained file size: 52663783 08:44:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:44:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:44:33 INFO - Fetch https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:44:34 INFO - Expected file size: 14408802 08:44:34 INFO - Obtained file size: 14408802 08:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:34 INFO - trying https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:44:34 INFO - Downloading https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 08:44:36 INFO - Downloaded 71429249 bytes. 08:44:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:44:36 INFO - mkdir: /builds/slave/test/properties 08:44:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:44:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:44:36 INFO - Contents: 08:44:36 INFO - build_url:https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:44:37 INFO - Running post-action listener: _resource_record_post_action 08:44:37 INFO - Running post-action listener: set_extra_try_arguments 08:44:37 INFO - [mozharness: 2017-04-17 15:44:37.419868Z] Finished download-and-extract step (success) 08:44:37 INFO - [mozharness: 2017-04-17 15:44:37.419999Z] Running populate-webroot step. 08:44:37 INFO - Running pre-action listener: _resource_record_pre_action 08:44:37 INFO - Running main action method: populate_webroot 08:44:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:44:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:44:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:44:37 INFO - '--tppagecycles', 08:44:37 INFO - '7'], 08:44:37 INFO - 'tests': ['tsvgm']}}, 08:44:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:44:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:44:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:44:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:44:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:44:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['damp', 'tps']}, 08:44:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'tests': ['damp', 'tps']}, 08:44:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['dromaeo_dom']}, 08:44:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:44:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:44:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:44:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other-e10s': {'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['a11yr', 08:44:37 INFO - 'ts_paint', 08:44:37 INFO - 'tpaint', 08:44:37 INFO - 'sessionrestore', 08:44:37 INFO - 'sessionrestore_no_auto_restore', 08:44:37 INFO - 'tabpaint']}, 08:44:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:44:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:44:37 INFO - 'bloom_basic_ref']}, 08:44:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tsvgx', 08:44:37 INFO - 'tsvgr_opacity', 08:44:37 INFO - 'tart', 08:44:37 INFO - 'tscrollx', 08:44:37 INFO - 'cart', 08:44:37 INFO - 'tsvg_static']}, 08:44:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:44:37 INFO - 'tsvgr_opacity', 08:44:37 INFO - 'tart', 08:44:37 INFO - 'tscrollx', 08:44:37 INFO - 'cart', 08:44:37 INFO - 'tsvg_static']}, 08:44:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s'], 08:44:37 INFO - 'tests': ['tp5o']}, 08:44:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:44:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--disable-e10s', 08:44:37 INFO - '--xperf_path', 08:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:37 INFO - 'tests': ['tp5n']}, 08:44:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:44:37 INFO - 'talos_options': ['--xperf_path', 08:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:44:37 INFO - 'tests': ['tp5n']}}, 08:44:37 INFO - 'talos.zip': {'path': '', 08:44:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:44:37 INFO - Running post-action listener: _resource_record_post_action 08:44:37 INFO - [mozharness: 2017-04-17 15:44:37.438755Z] Finished populate-webroot step (success) 08:44:37 INFO - [mozharness: 2017-04-17 15:44:37.438861Z] Running create-virtualenv step. 08:44:37 INFO - Running pre-action listener: _resource_record_pre_action 08:44:37 INFO - Running main action method: create_virtualenv 08:44:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:44:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:44:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:44:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:44:37 INFO - Using real prefix '/tools/python27' 08:44:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:44:38 INFO - Installing distribute.............................................................................................................................................................................................done. 08:44:41 INFO - Installing pip.................done. 08:44:41 INFO - Return code: 0 08:44:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:44:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:44:41 INFO - Reading from file tmpfile_stdout 08:44:41 INFO - Output received: 08:44:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:44:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:44: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', 'pip>=1.5'] in /builds/slave/test/build 08:44: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 pip>=1.5 08:44:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:44:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:41 INFO - 'HOME': '/Users/cltbld', 08:44:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:41 INFO - 'LOGNAME': 'cltbld', 08:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:41 INFO - 'MOZ_NO_REMOTE': '1', 08:44:41 INFO - 'NO_EM_RESTART': '1', 08:44:41 INFO - 'PAGER': '/bin/cat', 08:44:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:41 INFO - 'PWD': '/builds/slave/test', 08:44:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:41 INFO - 'SHELL': '/bin/bash', 08:44:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:44:41 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:44:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:41 INFO - 'USER': 'cltbld', 08:44:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:41 INFO - 'XPC_FLAGS': '0x0', 08:44:41 INFO - 'XPC_SERVICE_NAME': '0', 08:44:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:44:41 INFO - Cleaning up... 08:44:41 INFO - Return code: 0 08:44:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', '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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:44: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:44: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 psutil>=3.1.1 08:44:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:44:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:41 INFO - 'HOME': '/Users/cltbld', 08:44:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:41 INFO - 'LOGNAME': 'cltbld', 08:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:41 INFO - 'MOZ_NO_REMOTE': '1', 08:44:41 INFO - 'NO_EM_RESTART': '1', 08:44:41 INFO - 'PAGER': '/bin/cat', 08:44:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:41 INFO - 'PWD': '/builds/slave/test', 08:44:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:41 INFO - 'SHELL': '/bin/bash', 08:44:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:44:41 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:44:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:41 INFO - 'USER': 'cltbld', 08:44:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:41 INFO - 'XPC_FLAGS': '0x0', 08:44:41 INFO - 'XPC_SERVICE_NAME': '0', 08:44:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:41 INFO - Downloading/unpacking psutil>=3.1.1 08:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:44:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:45 INFO - Installing collected packages: psutil 08:44:45 INFO - Running setup.py install for psutil 08:44:45 INFO - building 'psutil._psutil_osx' extension 08:44:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:44:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:44:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:44:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:44:46 INFO - building 'psutil._psutil_posix' extension 08:44:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:44:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:44:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:44:46 INFO - ^ 08:44:46 INFO - 1 warning generated. 08:44:46 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:44:46 INFO - Successfully installed psutil 08:44:46 INFO - Cleaning up... 08:44:46 INFO - Return code: 0 08:44:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:46 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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:44:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:44:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:44:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:44:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:46 INFO - 'HOME': '/Users/cltbld', 08:44:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:46 INFO - 'LOGNAME': 'cltbld', 08:44:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:46 INFO - 'MOZ_NO_REMOTE': '1', 08:44:46 INFO - 'NO_EM_RESTART': '1', 08:44:46 INFO - 'PAGER': '/bin/cat', 08:44:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:46 INFO - 'PWD': '/builds/slave/test', 08:44:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:46 INFO - 'SHELL': '/bin/bash', 08:44:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:44:46 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:44:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:46 INFO - 'USER': 'cltbld', 08:44:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:46 INFO - 'XPC_FLAGS': '0x0', 08:44:46 INFO - 'XPC_SERVICE_NAME': '0', 08:44:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:44:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:44:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:44:49 INFO - Installing collected packages: mozsystemmonitor 08:44:49 INFO - Running setup.py install for mozsystemmonitor 08:44:49 INFO - Successfully installed mozsystemmonitor 08:44:49 INFO - Cleaning up... 08:44:49 INFO - Return code: 0 08:44:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:44: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')]} 08:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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')]} 08:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44: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', '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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:44: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:44: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 jsonschema==2.5.1 08:44:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:44:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:49 INFO - 'HOME': '/Users/cltbld', 08:44:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:49 INFO - 'LOGNAME': 'cltbld', 08:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:49 INFO - 'MOZ_NO_REMOTE': '1', 08:44:49 INFO - 'NO_EM_RESTART': '1', 08:44:49 INFO - 'PAGER': '/bin/cat', 08:44:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:49 INFO - 'PWD': '/builds/slave/test', 08:44:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:49 INFO - 'SHELL': '/bin/bash', 08:44:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:44:49 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:44:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:49 INFO - 'USER': 'cltbld', 08:44:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:49 INFO - 'XPC_FLAGS': '0x0', 08:44:49 INFO - 'XPC_SERVICE_NAME': '0', 08:44:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:44:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44: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 08:44:52 INFO - Downloading functools32-3.2.3-2.tar.gz 08:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:44:53 INFO - warning: no files found matching '*.txt' 08:44:53 INFO - no previously-included directories found matching 'build' 08:44:53 INFO - no previously-included directories found matching 'dist' 08:44:53 INFO - no previously-included directories found matching '.git*' 08:44:53 INFO - Installing collected packages: jsonschema, functools32 08:44:53 INFO - Running setup.py install for functools32 08:44:53 INFO - warning: no files found matching '*.txt' 08:44:53 INFO - no previously-included directories found matching 'build' 08:44:53 INFO - no previously-included directories found matching 'dist' 08:44:53 INFO - no previously-included directories found matching '.git*' 08:44:53 INFO - Successfully installed jsonschema functools32 08:44:53 INFO - Cleaning up... 08:44:53 INFO - Return code: 0 08:44:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:54 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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:54 INFO - 'HOME': '/Users/cltbld', 08:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:54 INFO - 'LOGNAME': 'cltbld', 08:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:54 INFO - 'MOZ_NO_REMOTE': '1', 08:44:54 INFO - 'NO_EM_RESTART': '1', 08:44:54 INFO - 'PAGER': '/bin/cat', 08:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:54 INFO - 'PWD': '/builds/slave/test', 08:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:54 INFO - 'SHELL': '/bin/bash', 08:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:44:54 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:54 INFO - 'USER': 'cltbld', 08:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:54 INFO - 'XPC_FLAGS': '0x0', 08:44:54 INFO - 'XPC_SERVICE_NAME': '0', 08:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:44:54 INFO - Cleaning up... 08:44:54 INFO - Return code: 0 08:44:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:44:54 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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:44:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:54 INFO - 'HOME': '/Users/cltbld', 08:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:54 INFO - 'LOGNAME': 'cltbld', 08:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:54 INFO - 'MOZ_NO_REMOTE': '1', 08:44:54 INFO - 'NO_EM_RESTART': '1', 08:44:54 INFO - 'PAGER': '/bin/cat', 08:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:54 INFO - 'PWD': '/builds/slave/test', 08:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:54 INFO - 'SHELL': '/bin/bash', 08:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:44:54 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:54 INFO - 'USER': 'cltbld', 08:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:54 INFO - 'XPC_FLAGS': '0x0', 08:44:54 INFO - 'XPC_SERVICE_NAME': '0', 08:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:44:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:44:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:44:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:44:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:44:59 INFO - Downloading docopt-0.6.1.tar.gz 08:44:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:44:59 INFO - Installing collected packages: blobuploader, requests, docopt 08:44:59 INFO - Running setup.py install for blobuploader 08:44:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:44:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:44:59 INFO - Running setup.py install for requests 08:44:59 INFO - Running setup.py install for docopt 08:45:00 INFO - Successfully installed blobuploader requests docopt 08:45:00 INFO - Cleaning up... 08:45:00 INFO - Return code: 0 08:45:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:00 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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:00 INFO - 'HOME': '/Users/cltbld', 08:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:00 INFO - 'LOGNAME': 'cltbld', 08:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:00 INFO - 'MOZ_NO_REMOTE': '1', 08:45:00 INFO - 'NO_EM_RESTART': '1', 08:45:00 INFO - 'PAGER': '/bin/cat', 08:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:00 INFO - 'PWD': '/builds/slave/test', 08:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:00 INFO - 'SHELL': '/bin/bash', 08:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:45:00 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:00 INFO - 'USER': 'cltbld', 08:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:00 INFO - 'XPC_FLAGS': '0x0', 08:45:00 INFO - 'XPC_SERVICE_NAME': '0', 08:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:00 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9jyT3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:00 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-AIxrBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:00 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-OwD6h9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:00 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fZUQhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:00 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-E07OuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:00 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-F0G64W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-OuN3Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-R5Ye8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-WYxuFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-l9YRwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-yFkcDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-2RJkMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-i19N23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-rd0cPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:01 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-nx9Ez4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-PhcNAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:02 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-vIDIIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:02 INFO - Running setup.py install for manifestparser 08:45:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:02 INFO - Running setup.py install for mozcrash 08:45:02 INFO - Running setup.py install for mozdebug 08:45:02 INFO - Running setup.py install for mozdevice 08:45:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:02 INFO - Running setup.py install for mozfile 08:45:02 INFO - Running setup.py install for mozhttpd 08:45:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Running setup.py install for mozinfo 08:45:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Running setup.py install for mozInstall 08:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Running setup.py install for mozleak 08:45:03 INFO - Running setup.py install for mozlog 08:45:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Running setup.py install for moznetwork 08:45:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:03 INFO - Running setup.py install for mozprocess 08:45:04 INFO - Running setup.py install for mozprofile 08:45:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:04 INFO - Running setup.py install for mozrunner 08:45:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:04 INFO - Running setup.py install for mozscreenshot 08:45:04 INFO - Running setup.py install for moztest 08:45:04 INFO - Running setup.py install for mozversion 08:45:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:04 INFO - Cleaning up... 08:45:04 INFO - Return code: 0 08:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:04 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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:04 INFO - 'HOME': '/Users/cltbld', 08:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:04 INFO - 'LOGNAME': 'cltbld', 08:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:04 INFO - 'MOZ_NO_REMOTE': '1', 08:45:04 INFO - 'NO_EM_RESTART': '1', 08:45:04 INFO - 'PAGER': '/bin/cat', 08:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:04 INFO - 'PWD': '/builds/slave/test', 08:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:04 INFO - 'SHELL': '/bin/bash', 08:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:45:04 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:04 INFO - 'USER': 'cltbld', 08:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:04 INFO - 'XPC_FLAGS': '0x0', 08:45:04 INFO - 'XPC_SERVICE_NAME': '0', 08:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4it_c_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-y6WIX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-FFm8Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wUf6fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-WTVrWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-TI38eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9TVKTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-xYkl1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:05 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-w1U9W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-lABr4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-JrMFTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-47Cmvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-cSaypc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-tcoBDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-eV1igN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-bz_kXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:06 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-m7aEbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:09 INFO - Downloading blessings-1.6.tar.gz 08:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:09 INFO - Installing collected packages: blessings 08:45:09 INFO - Running setup.py install for blessings 08:45:09 INFO - Successfully installed blessings 08:45:09 INFO - Cleaning up... 08:45:09 INFO - Return code: 0 08:45:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:10 INFO - Reading from file tmpfile_stdout 08:45:10 INFO - Current package versions: 08:45:10 INFO - blessings == 1.6 08:45:10 INFO - blobuploader == 1.2.4 08:45:10 INFO - docopt == 0.6.1 08:45:10 INFO - functools32 == 3.2.3-2 08:45:10 INFO - jsonschema == 2.5.1 08:45:10 INFO - manifestparser == 1.1 08:45:10 INFO - mozInstall == 1.12 08:45:10 INFO - mozcrash == 1.0 08:45:10 INFO - mozdebug == 0.1 08:45:10 INFO - mozdevice == 0.50 08:45:10 INFO - mozfile == 1.2 08:45:10 INFO - mozhttpd == 0.7 08:45:10 INFO - mozinfo == 0.9 08:45:10 INFO - mozleak == 0.1 08:45:10 INFO - mozlog == 3.4 08:45:10 INFO - moznetwork == 0.27 08:45:10 INFO - mozprocess == 0.25 08:45:10 INFO - mozprofile == 0.28 08:45:10 INFO - mozrunner == 6.13 08:45:10 INFO - mozscreenshot == 0.1 08:45:10 INFO - mozsystemmonitor == 0.3 08:45:10 INFO - moztest == 0.8 08:45:10 INFO - mozversion == 1.4 08:45:10 INFO - psutil == 3.1.1 08:45:10 INFO - requests == 1.2.3 08:45:10 INFO - wsgiref == 0.1.2 08:45:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:10 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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:10 INFO - 'HOME': '/Users/cltbld', 08:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:10 INFO - 'LOGNAME': 'cltbld', 08:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:10 INFO - 'MOZ_NO_REMOTE': '1', 08:45:10 INFO - 'NO_EM_RESTART': '1', 08:45:10 INFO - 'PAGER': '/bin/cat', 08:45:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:10 INFO - 'PWD': '/builds/slave/test', 08:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:10 INFO - 'SHELL': '/bin/bash', 08:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:45:10 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:10 INFO - 'USER': 'cltbld', 08:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:10 INFO - 'XPC_FLAGS': '0x0', 08:45:10 INFO - 'XPC_SERVICE_NAME': '0', 08:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:45:10 INFO - Cleaning up... 08:45:10 INFO - Return code: 0 08:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:10 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 0x106304b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106307768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bd8c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, '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.WVipUNJY1v/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.SVYxAXxAp9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:10 INFO - 'HOME': '/Users/cltbld', 08:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:10 INFO - 'LOGNAME': 'cltbld', 08:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:10 INFO - 'MOZ_NO_REMOTE': '1', 08:45:10 INFO - 'NO_EM_RESTART': '1', 08:45:10 INFO - 'PAGER': '/bin/cat', 08:45:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:10 INFO - 'PWD': '/builds/slave/test', 08:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:10 INFO - 'SHELL': '/bin/bash', 08:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:45:10 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:10 INFO - 'USER': 'cltbld', 08:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:10 INFO - 'XPC_FLAGS': '0x0', 08:45:10 INFO - 'XPC_SERVICE_NAME': '0', 08:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:10 INFO - Cleaning up... 08:45:10 INFO - Return code: 0 08:45:10 INFO - Running post-action listener: _resource_record_post_action 08:45:10 INFO - Running post-action listener: _start_resource_monitoring 08:45:10 INFO - Starting resource monitoring. 08:45:10 INFO - [mozharness: 2017-04-17 15:45:10.809438Z] Finished create-virtualenv step (success) 08:45:10 INFO - [mozharness: 2017-04-17 15:45:10.810455Z] Running install step. 08:45:10 INFO - Running pre-action listener: _resource_record_pre_action 08:45:10 INFO - Running main action method: install 08:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:11 INFO - Reading from file tmpfile_stdout 08:45:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:11 INFO - Reading from file tmpfile_stdout 08:45:11 INFO - Output received: 08:45:11 INFO - Usage: mozinstall [options] installer 08:45:11 INFO - Options: 08:45:11 INFO - -h, --help show this help message and exit 08:45:11 INFO - -d DEST, --destination=DEST 08:45:11 INFO - Directory to install application into. [default: 08:45:11 INFO - "/builds/slave/test"] 08:45:11 INFO - --app=APP Application being installed. [default: firefox] 08:45:11 INFO - mkdir: /builds/slave/test/build/application 08:45:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:45:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:45:30 INFO - Reading from file tmpfile_stdout 08:45:30 INFO - Output received: 08:45:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:45:30 INFO - Running post-action listener: _resource_record_post_action 08:45:30 INFO - [mozharness: 2017-04-17 15:45:30.756874Z] Finished install step (success) 08:45:30 INFO - [mozharness: 2017-04-17 15:45:30.757025Z] Running run-tests step. 08:45:30 INFO - Running pre-action listener: _resource_record_pre_action 08:45:30 INFO - Running main action method: run_tests 08:45:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:45:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:45:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:45:30 INFO - 2017-04-17 08:45:30.771 screenresolution[2846:37630] starting screenresolution argv=screenresolution get 08:45:30 INFO - 2017-04-17 08:45:30.774 screenresolution[2846:37630] Display 0: 1600x1200x32@60 08:45:30 INFO - 2017-04-17 08:45:30.780 screenresolution[2847:37633] starting screenresolution argv=screenresolution list 08:45:30 INFO - Available Modes on Display 0 08:45:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:45:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:45:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:45:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:45:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:45:31 INFO - Intel Iris: 08:45:31 INFO - Chipset Model: Intel Iris 08:45:31 INFO - Type: GPU 08:45:31 INFO - Bus: Built-In 08:45:31 INFO - VRAM (Dynamic, Max): 1536 MB 08:45:31 INFO - Vendor: Intel (0x8086) 08:45:31 INFO - Device ID: 0x0a2e 08:45:31 INFO - Revision ID: 0x0009 08:45:31 INFO - Displays: 08:45:31 INFO - Display: 08:45:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:45:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:45:31 INFO - Display Serial Number: 1600x1200 60 08:45:31 INFO - Main Display: Yes 08:45:31 INFO - Mirror: Off 08:45:31 INFO - Online: Yes 08:45:31 INFO - Rotation: Supported 08:45:31 INFO - Return code: 0 08:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:31 INFO - Python 2.7.3 08:45:31 INFO - Return code: 0 08:45:31 INFO - grabbing minidump binary from tooltool 08:45:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:31 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 0x1060e2d30>, '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 0x106008db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060d7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:45:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:45:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:45:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:31 INFO - Return code: 0 08:45:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:45:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:31 INFO - ENV: RUST_BACKTRACE is now 1 08:45:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:45:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.WVipUNJY1v/Render', 08:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:45:31 INFO - 'HOME': '/Users/cltbld', 08:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:45:31 INFO - 'LOGNAME': 'cltbld', 08:45:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:31 INFO - 'MOZ_NO_REMOTE': '1', 08:45:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:31 INFO - 'NO_EM_RESTART': '1', 08:45:31 INFO - 'PAGER': '/bin/cat', 08:45:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:31 INFO - 'PWD': '/builds/slave/test', 08:45:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:45:31 INFO - 'RUST_BACKTRACE': '1', 08:45:31 INFO - 'SHELL': '/bin/bash', 08:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SVYxAXxAp9/Listeners', 08:45:31 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 08:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:45:31 INFO - 'USER': 'cltbld', 08:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:31 INFO - 'XPC_FLAGS': '0x0', 08:45:31 INFO - 'XPC_SERVICE_NAME': '0', 08:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:45:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:45:31 INFO - mozversion application_buildid: 20170417072206 08:45:31 INFO - mozversion application_changeset: 05c212a94183838f12feebb2c3fd483a6eec18c2 08:45:31 INFO - mozversion application_display_name: Nightly 08:45:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:31 INFO - mozversion application_name: Firefox 08:45:31 INFO - mozversion application_remotingname: firefox 08:45:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:45:31 INFO - mozversion application_vendor: Mozilla 08:45:31 INFO - mozversion application_version: 55.0a1 08:45:31 INFO - mozversion platform_buildid: 20170417072206 08:45:31 INFO - mozversion platform_changeset: 05c212a94183838f12feebb2c3fd483a6eec18c2 08:45:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:45:31 INFO - mozversion platform_version: 55.0a1 08:45:31 INFO - using testdate: 1492443931 08:45:31 INFO - actual date: 1492443931 08:45:31 INFO - starting webserver on 'localhost:61174' 08:45:31 INFO - SUITE-START | Running 2 tests 08:45:31 INFO - TEST-START | dromaeo_css 08:45:31 INFO - operating with platform_type : mac_ 08:45:31 INFO - Initialising browser for dromaeo_css test... 08:45:31 INFO - TEST-INFO | started process 2857 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpXS7ICj/profile http://localhost:61174/getInfo.html) 08:45:33 INFO - PID 2857 | __metrics Screen width/height:1600/1200 08:45:33 INFO - PID 2857 | colorDepth:24 08:45:33 INFO - PID 2857 | Browser inner width/height: 1024/689 08:45:33 INFO - PID 2857 | __metrics 08:45:33 INFO - PID 2857 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:45:33 INFO - PID 2857 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:34 INFO - TEST-INFO | 2857: exit 0 08:45:34 INFO - Browser initialized. 08:45:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:34 INFO - TEST-INFO | started process 2859 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpXS7ICj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:45:47 INFO - PID 2859 | RSS: Main: 241176576 08:45:47 INFO - PID 2859 | 08:48:52 INFO - PID 2859 | Cycle 1(1): loaded http://localhost:61174/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61174/tests/dromaeo/cssquery-ext.html) 08:48:54 INFO - PID 2859 | RSS: Main: 413331456 08:48:54 INFO - PID 2859 | 08:50:36 INFO - PID 2859 | ************************* 08:50:36 INFO - PID 2859 | A coding exception was thrown and uncaught in a Task. 08:50:36 INFO - PID 2859 | 08:50:36 ERROR - PID 2859 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:50:36 INFO - PID 2859 | Full stack: 08:50:36 INFO - PID 2859 | ************************* 08:50:36 INFO - PID 2859 | ************************* 08:50:36 INFO - PID 2859 | A coding exception was thrown and uncaught in a Task. 08:50:36 INFO - PID 2859 | 08:50:36 ERROR - PID 2859 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:50:36 INFO - PID 2859 | Full stack: 08:50:36 INFO - PID 2859 | ************************* 08:50:36 INFO - PID 2859 | ************************* 08:50:36 INFO - PID 2859 | A coding exception was thrown and uncaught in a Task. 08:50:36 INFO - PID 2859 | 08:50:36 ERROR - PID 2859 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:50:36 INFO - PID 2859 | Full stack: 08:50:36 INFO - PID 2859 | ************************* 08:50:36 INFO - PID 2859 | ************************* 08:50:36 INFO - PID 2859 | A coding exception was thrown and uncaught in a Task. 08:50:36 INFO - PID 2859 | 08:50:36 ERROR - PID 2859 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:50:36 INFO - PID 2859 | Full stack: 08:50:36 INFO - PID 2859 | ************************* 08:51:56 INFO - PID 2859 | Cycle 1(1): loaded http://localhost:61174/tests/dromaeo/cssquery-ext.html (next: http://localhost:61174/tests/dromaeo/cssquery-jquery.html) 08:51:57 INFO - PID 2859 | RSS: Main: 370442240 08:51:57 INFO - PID 2859 | 08:54:59 INFO - PID 2859 | Cycle 1(1): loaded http://localhost:61174/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61174/tests/dromaeo/cssquery-mootools.html) 08:55:00 INFO - PID 2859 | RSS: Main: 333078528 08:55:00 INFO - PID 2859 | 08:58:02 INFO - PID 2859 | Cycle 1(1): loaded http://localhost:61174/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61174/tests/dromaeo/cssquery-prototype.html) 08:58:03 INFO - PID 2859 | RSS: Main: 356229120 08:58:03 INFO - PID 2859 | 09:01:06 INFO - PID 2859 | Cycle 1(1): loaded http://localhost:61174/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61174/tests/dromaeo/cssquery-yui.html) 09:01:07 INFO - PID 2859 | RSS: Main: 324812800 09:01:07 INFO - PID 2859 | 09:04:09 INFO - PID 2859 | Cycle 1(1): loaded http://localhost:61174/tests/dromaeo/cssquery-yui.html (next: http://localhost:61174/tests/dromaeo/cssquery-dojo.html) 09:04:09 INFO - PID 2859 | RSS: Main: 374149120 09:04:09 INFO - PID 2859 | 09:04:09 INFO - PID 2859 | __start_tp_report 09:04:09 INFO - PID 2859 | _x_x_mozilla_page_load 09:04:09 INFO - PID 2859 | _x_x_mozilla_page_load_details 09:04:09 INFO - PID 2859 | |i|pagename|runs| 09:04:09 INFO - PID 2859 | |0;dojo.html;3491.127218195451;3509.8771542996;3510.333036723021;3533.929321413572;3576.606573276939;5856.121581762727;5966.642001479914;5988.161657367972;6213.782517611879;6218.689065546721;6098.916365657131;6124.289394097922;6205.875882482348;6212.130301757747;6228.937710622892;5174.637775355726;5370.221317908901;5376;5382.407935127133;5432.320959880015;5264.394594621629;5366.543843773265;5454.972725136368;5508.14623733322;5569.832905012856;5306.70813105279;5359.839204823861;5382.407935127133;5385.030694474993;5472.5621950244085;5397.487238712316;5408.945910540883;5419.187121931742;5472.890542189174;5507.03626865297;5311.787528498855;5347.572194224453;5361.973190134064;5363.839084827422;5430.755615997289;6025.8192254232445;6123.5407344448895;6189.071639254148;6206.782762603287;6226.346233645448;6418.469841587108;6521.282658907517;6568.343165683441;6586.242582103072;6595.274519802818;6629.635370054645;6643.93356066438;6659.600423974577;6661.100751398548;6665.733370665168;6164.260288765377;6282.434580887742;6285;6293.590916590407;6299.590526615755;6543.214814222324;6639.336066393419;6728.158980127484;6808.012838138442;6843.315668433117;6336.968315158395;6407.519436042316;6415.711292991827;6436.710348034349;6502.479801615859;6594.977778444349;6621.966890165519;6648.634325112165;6673.299303573152;6678.699458524378;6543.214814222324;6574.638394888231;6584.275729669733;6594.20869495654;6595.406413422815;6339.524535659844;6422.068800023971;6498.220213574401;6558.311377305409;6571.244306904767;5335.599830012765;5340.172273297645;5342.813001545005;5351.625386223005;5380.78476860929;4729.62163026957;4742.596879265232;4745.667803253739;4748.264019077049;4785.521447855256;6116.5718399711595;6139.3388173831;6171.84570385744;6289.496840252768;6309.495240380758;6580.341965803477;6614.603123812587;6631.071649969008;6655.567388119756;6669.566478178903;6287.559870808999;6287.968560157261;6300.30696623371;6300.968495157586;6308.3060863305;5631.887362252732;5827.504662103769;5833.212516310328;5834.737436815353;5838.357780644125;6644.7009884554345;6655.367740064686;6761;6823.147106611674;6846.110005699227;6654.866902661823;6668.233153187251;6668.933310666831;6680.866382672222;6697.162854643169;6742;6753.594784312957;6813.080234168324;6823.38589526945;6852.828679283058;6307.810765676853;6393.424591786761;6464.22429308486;6495.870082598416;6520.152380190545;6666.433353165035;6670.733170673118;6670.733170673118;6681.398674119353;6683.064370987969;6253.874922501615;6268.4671802897265;6332.11350410952;6377.553571249968;6449.355064493513;6333.1766870306565;6465.288818229897;6465.903011454926;6471.964485682268;6482.286948435574;6158.32258451561;6262.123302737529;6343.397377249154;6346;6347.206599175103;5726.055200891807;6061.575689701855;6305.527085468517;6348.460380867678;6364.64994425311;6249.437550620466;6259.1550140730415;6288.937110628835;6324.430801227728;6347.619142851444 09:04:09 INFO - PID 2859 | |1;ext.html;749.4716225061329;794.9125596184418;816.1838161838161;947.4978261521396;1131.45690068767;27990.300242493948;37310.62689373105;37861.62138378622;37959.05102372442;37967.05082372942;39900.80049599755;40282.39576406356;40283;40287.59712402883;40377.59622403775;6014.428629280212;8330.66677332906;8483.194096560817;8518.361122915776;8539.871901921477;6154.630722156685;8312.584370781467;8492.957535212347;8502.532360720157;8525.872111918326;8529.275011624019;8567.314614830799;8570.657173713043;8578.957105214497;8581;8451.873221901677;8515.57422128891;8527.488350698915;8536.189062039097;8708.956455217747;8339.916600833974;8391.244787969112;8401.663933442716;8402.285805706522;8405.285550728195;37587.43618845719;37832.351735378536;37864;37886.81056594727;37955.62044379549;3610.0433385152955;3638.3450978823803;3653.6711695947492;3656.4698118772894;3657.7073834093476;30711.846440767877;30743.38513229723;30785.8460707695;30834.074977750704;30845;3113.4395808754416;3151.511515715045;3169.9683003169903;3175;3183.4110689522513;299161;306995;309626.4518677415;310390;310828;50451.99096018059;50502.49497505051;50554.241686374735;50581;50645.74677126665;52706.73646631819;52717.736411317695;52739.472605274226;52781;52814.47185528096;13887.722245555033;14290.28548572588;14389.712205755826;14406.855931440761;14441.78337324941;10215.94892025535;11729.706757331134;11739.88260117405;11743.236689615147;11766.764664706829;10134.898651013396;10810.081143102767;11243;11320.886791131983;12656.303903285409;4538.931916021263;5287.783809723785;5296.537110243678;5391.762418596317;5395.4622932464845;982.8034393121404;1001.1640280365976;1008.9394636321845;1009.8788145422596;1039.1271332080937;24526.632100518505;24603.63094553583;24623.753762462504;24679.25962221136;24694;977.8464452141786;1049.228816819637;1115.1747706696985;1131.7057565033151;1139.2196345503357;10640.840387394195;10725.034746872663;12491.375431228402;12522.749545009048;12549.435275412628;318449;319002;320027;320315;320418;54257.728711356984;54258.728706357004;54302.913941720944;54388.728056360254;54471.72764136233;1474.8746356559598;1493.8356780754325;1539.9384024639114;1541.0599534284079;1544.4440001599414;20078.89960550188;23655.52688946177;23917.16289929844;23991.880040599684;24046.759532404452;38255.80872095733;38335.61664383321;38348.23303533858;38410.80794596121;38533.03667408337;296187;296429;296440.5177974096;296933;298518;28773.856130719214;35949.28101437904;35958.28083438264;36021.27957440889;36039;45471;46792.7660361696;46875.53124468712;46944.76527617477;46991;29971.55042674318;30798.538021930137;31048;31460;31863.362732745678;30993;31241.843790780902;31342.686573134888;31433.7996340254;31775.52336714905;37084.81457592695;37358.25283494369;37487.43768843524;37503.06242343963;37928.241435171694;31780.682193178698;31835.68164318327;32153.03540893777;32235.032949011566;32725.672743273215;22684.886575567678;23410.67911663807;24374.87812560926;24690.382740430916;24825.87587062053 09:04:09 INFO - PID 2859 | |2;jquery.html;393.15667892370845;419.8131831335055;430.5973914390046;430.91166310906266;446.69401459999904;16182.757258641115;21879;22398.880055997175;23137.421564460896;23427.41431464214;22719.20482783103;23124.190653327136;23220.303390898258;23420.063197472122;23782.40543986401;4737.289406589005;5996.79011234608;6049.364541930414;6173.259208894917;6260.937390626081;6088.482478989291;6204.937950620481;6212.968935155318;6213;6214.285357183914;5890.145928840316;6115.235595550556;6156.076588511714;6168.814935551941;6186.195794546703;5124.974375128138;6064;6107.725152368154;6120.602160859552;6578.6381749003785;6733.629650369227;6816.182058153004;6832.385085342343;6834;6834.794956151323;30011.549826752616;30146.84926575375;30178.09465716032;30660.69339306623;30885.073447796603;2233.129079658934;2288.565172617214;2333.218371845434;2354.81161507079;2378.369732021016;18754.437366879014;18853.905730471397;19343.80656193434;19441.51396215092;19753.012349382472;2007.5282308657454;2251.110811229555;2299.1952816514254;2330.790228879392;2336.894839732216;159983;163008;171819;174718.12640936713;177206.99999999872;18116.818831811775;23479.41301467443;23594.410139746644;23941.64087538688;24369.51260974806;13420.46318147263;17119.65760684779;17169.828301717072;42768.78615606902;42990.35514467285;7854.567998760123;8998.515244984505;9163.58763855628;9189.586468608928;9341.953290233505;8775.517346546001;8781.868271975925;8823.470591764515;8938.597763100675;9040;7924.722634707758;8079.151689072681;8089.757307280791;8096.352291816641;8109.797255068671;1849.2140840142886;2022.4438279473263;2205.713257276576;2210;2220.3893929169285;837.7109897085496;913.6162811619135;927.3137877970254;970.2238209432426;973.5035132082688;20442;20943.790562094488;21568.784312156993;21742.91285435722;21835.344939651837;952.4521903907159;972.5137431284357;986.8569057486624;999.2156157416539;1008.5209525475341;10175.491225438698;11261.493232804543;11287.54849806015;11318.490667919963;11401.771964560663;579438;583354;591179;591625;600570;134279;137578;137803;139013.91479127822;139940.60059399277;975.253930742968;1123.4102096399456;1135.7614900870744;1159.4434671357797;1160.4487868262509;16407.261673224493;17316.65366692634;19175.712364314266;21659.891700541397;23106.191283305005;55654;56434.153487696894;56819;56912;57195;76746.61626691831;79349;79468.20531794608;81876.59061704653;83517.32965340781;9090.818203630948;13187.736245275233;13267.071305008556;13479.932600336935;13627.38676759568;14554.708905821613;14773.482928097896;14849.628759281104;15248.542543723706;15254.084754914296;11902.583409580624;12068.879311206776;12363.0837220231;12407.441665125272;12879.356032198166;11758.82361764557;11765.823512647488;11803.881961180621;11891.108166887345;12141.271523708605;12357.75284494323;12393.504259829506;12669.873301267238;12739;12753.744925101631;13469.855062319813;13496.32518374097;13837.515686950908;13865.861341386457;14096.929515352767;12086.51653933868;12335;12366.44351004189;12381;12468.563600273947 09:04:09 INFO - PID 2859 | |3;mootools.html;1128.887111288871;1455.1487379882767;1480.6742516646334;1484.1169504145034;1487.8288996765361;11331.320120792749;11772.411379431016;11784.175107742461;11787.351695656735;11796.410179491024;11391.715207119827;11859;11899.988500977406;11900.702482437944;11911.7617647647;2093.591749608827;2504.69943606767;2538.7207407185197;2555.501677172952;2556.2459074572953;2086.62440760663;2391.9043238270465;2486.2416962826333;2519.8488090714523;2527.0776166699115;2181.6509358502644;2209.801117899389;2442.7679370459778;2538.4542323400465;2547.3631592101974;2460.63090536421;2494.2018554062706;2503.1364179358093;2505.962410563843;2509.2095989763166;2431.027588964411;2436.8537887726793;2441.121196369306;2446.2538925627678;2447.3759191406257;11566.479508422057;11853.111016673784;11860;11894.464749086312;11904.464299106561;6559.278479367265;6815;6826.044353790473;6829.146356705412;6829.760958366433;3718.772804974379;3999.8400063997406;4119.814608342632;4337.891552711176;4339.891502712426;1176.688177632928;1247.5882958623722;1290.1291628151055;1302.7199152182327;1305.2233920817098;14309.427622895071;16030.35878564856;16558.337666493328;16699.08155051472;16700.498985030346;5525.171224316385;5565.916511252334;5647.6893770843;5750.482456578928;5818.44724751148;12396.256224626552;12439.626811195498;12458.501659933683;12459.875401245872;12478.376081195904;6697.028930805006;6706.597604143767;6708.262091169968;6709.127813384229;6723.058771771955;5996.640201587918;6205.720742566596;6277.874442511215;6300.716467758962;6301.054841773771;3605.9819700901853;4252.128313695685;4379.671524635602;4456.398386217884;4467.553244675506;1099.571167244775;1273.3951373097889;1289.1298373597783;1309.796981467874;1315.53298579005;635.465379393574;795.6499140378215;814.3444527155697;819.8114433680167;862.1593945902695;6559.147310849655;6717.16035495563;6924;6995.125609298838;7085.681144348517;596.0790578556141;606.3875485759414;606.4784285514454;617.9351168127372;725.1624373848214;4018.5378681452007;4203.348480985452;4316.589923957219;4332.1119170569955;4471.821127154943;14645.194514301817;15455.690886182214;15455.845441545665;15477.993930394714;15491.915565910278;14832.961692681409;15286.312115954808;15332.540023799304;15341.232938353038;15367.231638418034;8752.912470875337;8817.338699597427;8828.8675669865;8839.911600884037;8878.422902511316;6458.095866578777;6701.698423570853;6744.8651026978205;6935.549189302679;6942.826429339307;9540.570674319533;13565;13709.245991470565;13792.517261895786;13795.379207935466;11261.943690281496;13389.866101338863;13659.565745596568;13804.723905521632;13882.722345553235;9472.95263523678;9655;9659.71020869375;9662.420254784736;9681.177099946302;8573.699920502753;10557.41934193596;10924.836127458253;11052.281601695864;11109.277896936674;9150.130737580186;9192.632294708405;9264.073592640952;9326.813463730823;9489.905100948901;7582.165961744094;9017.368784185306;9046.547672616474;9090.681826136053;9221.123993220634;8099.392545559224;8139.959300203461;8212.301954333949;8219.630116644646;8231.588420578828;6056.152138700498;6090.908636370546;6191.690415479298;6231.40801623845;6341.207349081365;5965.552583556164;6186.969065154645;6301.527385446018;6302.779402720883;6307.400796924285 09:04:09 INFO - PID 2859 | |4;prototype.html;327.9540864279001;383.25265731822935;401.2656837986485;403.96364327210546;407.16531111221985;4830.73430961297;5628.240187574676;5828.377230246396;5984.192134061906;6004.759809607616;4521.937344723987;5277.182036784295;5635.126555383912;5677.347105082917;5809.7676092956335;3910.4720862683457;4082.428460015593;4285.250081235787;4512.729236245836;4539.4779600346055;4412.911741765162;4454.175977444167;4503.57216064475;4541.545845415449;4555.929356601196;4466.932996005063;4471.306947423154;4471.686981911267;4477.686561940665;4505.977470112662;3708.8331025103935;4215.903864995093;4454.621357184643;4458.554144585548;4474.024773525618;3891.9805400973096;3964.742291751027;4012.217617564576;4017.8593749218635;4059.411385349108;5678.233438485793;5687.658740475585;5738.196652468658;5744.569157313176;5751.712414379264;5098.521428785685;5325.973370133163;5385.461453854622;5411.2965314508865;5417.51242388183;4889.731064791435;5776.393478684719;6208.348123447018;6271.811845644638;6273.278572964122;3839.6352346527315;4482.834463039633;4525.592696657317;4534.229181039198;4561.1789877821975;5626.971865140689;6030.386519725315;6606;6611.140551728245;6622.801315960529;4352.642925582889;4383;4627.074585082997;4651.37206477128;4684.508126646721;3895.7467764595212;4741.241401375763;4767.547083027107;4769.76151192439;4783.258594917794;5391.757370918318;5407.70257635826;5411.458854114557;5414.864628384322;5431.076716958127;5425.430329815313;6112.235970503687;6197.721102550396;6213.565050446516;6322.9051564226575;1299.9740005199842;1499.0855578097353;1535.3474773221337;1550.8449155084402;1589.1259807106276;915.2860768600502;1060.5598676549146;1061.920355973305;1090.7164137324194;1095.4522738630685;4700.459447163552;5835.395266301801;5836.854078648068;5860.560457965669;5909.379515150933;6433.613983161025;6435.227772667216;6449.96775016122;6473.385028422293;6476.870462590816;5646.20953066571;5758.798442054592;5814.709264536757;5850.5904586678525;5851.244626612;2932.2376182192356;3232.997770691093;3301.3562355340478;3345.3142105868237;3362.2266878617565;5297.457220534166;5743.483086522233;6309.495240380758;6500.609963402211;6651.334866513407;5481.246001279632;6593.76921807744;6605.207375115017;6608.380946668001;6608.504362172856;5797.202797202797;5984.73068711909;6140.201773769381;6587.176602924635;6593.901091483535;4718.693284936468;6043.576949613484;6121.32665406796;6425.518086143465;6524.771632992823;5826.76692932278;5918.615290006136;6073.848153796191;6418.972964325685;6442.323556026549;5678.971605141948;6498.447631951148;6634.7489730030975;6653.600783952978;6678.666066696743;3894.9221015578964;3954.426608141746;4137.793110344411;4297;4302.311630139163;5625.440424606712;6174.44430001284;6491.740330386731;6514.315996820265;6528.640924749185;5415.864603384947;5773.191753154646;6230.283517395557;6281.1420803533365;6294.276158241678;6239.594426362453;6243.938530449744;6263.561550691408;6273.968630157003;6282.497400207881;5112.309838171799;5824.737886795019;6051.515878729779;6148.200733904564;6152.861720581706;5473.616846820843;6275.874482510416;6291.245050593958;6296.244450665949;6307.873842523032;5828.854278642898;6062.211912451353;6152.323244443018;6167;6366.6180029198395 09:04:09 INFO - PID 2859 | |5;yui.html;598.5839841310291;806.6894245715399;875.098648392156;881.603278524664;890.3322508118911;13421.261830599313;13892.861071389283;16878.987260764363;17809.109544522755;18580.44258672242;15777.842221577781;17280.395186168487;17284.30862765491;17290.740638890427;17308.48074557762;970.7670159161821;994.368575954267;997.8553109799075;998.0169533009979;1001.6093723447862;1007.2646967713573;1009.1775203209397;1024.3393011507574;1024.6260115058026;1027.573556973855;1085.8262677971527;1089.477051015513;1091.0998426298297;1092;1094.3488624268548;1080.2762149359949;1081.9729506762394;1082.691432941608;1082.9874067746682;1087.526925787285;804.4770898915693;806.2340776262515;808.5795386399099;808.8867558541809;810;16677.583060423465;16878;16886.40897568579;17185.140742962925;17252.309907603805;16773.66452670952;16941.83058169415;17142.914285428495;17363.479095627026;17373.47879563615;13952.93023534886;14080.647983800385;14362.64093397663;14521.709565808731;14575;3575.463680447928;3602.441621548664;3606.675399214057;3609.620989796086;3609.8375573099274;127985;129100.35449822784;131237.4227890321;132050.3397483016;132245;11327.490262938187;13065;13309.46762129504;13507.797383039262;13528.323583820966;19642.508937276398;22340.77659223387;24848.627270590954;25106.24681259565;25847.61228581573;7869.606519674108;8054.154313796967;8065.39509536787;8079;8079.272865442138;3837.76973381598;3867.7292589519025;3922.490076290064;3965.6034396560112;4026.275270451347;4374.671899607542;4486.192485352668;4488.236999710057;4490.753008584559;4494.640428765691;927.9350445468888;949.349695458613;967.970960871175;974.9415035097917;982.1160955140288;578.8581797459565;632.105570617571;656.4092316914815;673.4847841401332;682.4403988729194;10734.73163170927;10844.403557804397;11386.373749443861;11548.422578871023;11970.341631210193;644.3942693867749;647.6243778608396;659.6174218952996;685.6914388525183;689.1144878830678;5317.282166907418;5362.302900622972;5498;5609.382967873531;5642.7178641067785;90708;92133;92655.07344926464;92824;94009.05990940004;82382.58808706039;84804;84933.57533212294;85111.87220319417;86117;55823.72088139615;73660;74238.25761742421;74683;75971;9706.611735530782;10539.548248064417;10919.563217471212;11000.174986876176;11268.549258029587;38133.77341233529;38889.416658750706;39033.43866245318;39088;39570.60429395669;49863.75068124636;50076.984970546924;50728.731781705756;51057.23414148716;51070.74464627653;13848.169109853441;13998.300084995506;14193.361298741374;14202.50291239843;14309.499167529502;15157.469488567847;15330.00354976923;15343.46297879569;15359.001664891746;15432.614184645474;16281.918590406973;17147.914260428617;17165.055921923915;17178.742318865476;17388;13296.335183240606;16354.01875887403;16881.66236675235;17004.65990680204;17300.307987680353;14346.56960291193;14587.34356953961;16186.595335116244;16692.916535417244;16792.496225113267;11745.177837551631;11966.162368634112;12066.879331206575;12140.210886292363;12142.939285303517;12309.630711078682;12966.740665186831;12970.935145324212;13780.862191377957;13885.72228555403 09:04:09 INFO - PID 2859 | __end_tp_report 09:04:09 INFO - PID 2859 | __start_cc_report 09:04:09 INFO - PID 2859 | _x_x_mozilla_cycle_collect,1906 09:04:09 INFO - PID 2859 | __end_cc_report 09:04:09 INFO - PID 2859 | __startTimestamp1492445049980__endTimestamp 09:04:09 INFO - PID 2859 | 09:04:09 INFO - PID 2859 | ------- Summary: start ------- 09:04:09 INFO - PID 2859 | Number of tests: 6 09:04:09 INFO - PID 2859 | 09:04:09 INFO - PID 2859 | [#0] dojo.html Cycles:165 Average:6091.95 Median:6305.53 stddev:692.80 (11.0%) stddev-sans-first:664.20 09:04:09 INFO - PID 2859 | Values: 3491.1 3509.9 3510.3 3533.9 3576.6 5856.1 5966.6 5988.2 6213.8 6218.7 6098.9 6124.3 6205.9 6212.1 6228.9 5174.6 5370.2 5376.0 5382.4 5432.3 5264.4 5366.5 5455.0 5508.1 5569.8 5306.7 5359.8 5382.4 5385.0 5472.6 5397.5 5408.9 5419.2 5472.9 5507.0 5311.8 5347.6 5362.0 5363.8 5430.8 6025.8 6123.5 6189.1 6206.8 6226.3 6418.5 6521.3 6568.3 6586.2 6595.3 6629.6 6643.9 6659.6 6661.1 6665.7 6164.3 6282.4 6285.0 6293.6 6299.6 6543.2 6639.3 6728.2 6808.0 6843.3 6337.0 6407.5 6415.7 6436.7 6502.5 6595.0 6622.0 6648.6 6673.3 6678.7 6543.2 6574.6 6584.3 6594.2 6595.4 6339.5 6422.1 6498.2 6558.3 6571.2 5335.6 5340.2 5342.8 5351.6 5380.8 4729.6 4742.6 4745.7 4748.3 4785.5 6116.6 6139.3 6171.8 6289.5 6309.5 6580.3 6614.6 6631.1 6655.6 6669.6 6287.6 6288.0 6300.3 6301.0 6308.3 5631.9 5827.5 5833.2 5834.7 5838.4 6644.7 6655.4 6761.0 6823.1 6846.1 6654.9 6668.2 6668.9 6680.9 6697.2 6742.0 6753.6 6813.1 6823.4 6852.8 6307.8 6393.4 6464.2 6495.9 6520.2 6666.4 6670.7 6670.7 6681.4 6683.1 6253.9 6268.5 6332.1 6377.6 6449.4 6333.2 6465.3 6465.9 6472.0 6482.3 6158.3 6262.1 6343.4 6346.0 6347.2 5726.1 6061.6 6305.5 6348.5 6364.6 6249.4 6259.2 6288.9 6324.4 6347.6 09:04:09 INFO - PID 2859 | 09:04:09 INFO - PID 2859 | [#1] ext.html Cycles:180 Average:46006.57 Median:34337.48 stddev:80878.62 (235.5%) stddev-sans-first:81034.12 09:04:09 INFO - PID 2859 | Values: 749.5 794.9 816.2 947.5 1131.5 27990.3 37310.6 37861.6 37959.1 37967.1 39900.8 40282.4 40283.0 40287.6 40377.6 6014.4 8330.7 8483.2 8518.4 8539.9 6154.6 8312.6 8493.0 8502.5 8525.9 8529.3 8567.3 8570.7 8579.0 8581.0 8451.9 8515.6 8527.5 8536.2 8709.0 8339.9 8391.2 8401.7 8402.3 8405.3 37587.4 37832.4 37864.0 37886.8 37955.6 3610.0 3638.3 3653.7 3656.5 3657.7 30711.8 30743.4 30785.8 30834.1 30845.0 3113.4 3151.5 3170.0 3175.0 3183.4 299161.0 306995.0 309626.5 310390.0 310828.0 50452.0 50502.5 50554.2 50581.0 50645.7 52706.7 52717.7 52739.5 52781.0 52814.5 13887.7 14290.3 14389.7 14406.9 14441.8 10215.9 11729.7 11739.9 11743.2 11766.8 10134.9 10810.1 11243.0 11320.9 12656.3 4538.9 5287.8 5296.5 5391.8 5395.5 982.8 1001.2 1008.9 1009.9 1039.1 24526.6 24603.6 24623.8 24679.3 24694.0 977.8 1049.2 1115.2 1131.7 1139.2 10640.8 10725.0 12491.4 12522.7 12549.4 318449.0 319002.0 320027.0 320315.0 320418.0 54257.7 54258.7 54302.9 54388.7 54471.7 1474.9 1493.8 1539.9 1541.1 1544.4 20078.9 23655.5 23917.2 23991.9 24046.8 38255.8 38335.6 38348.2 38410.8 38533.0 296187.0 296429.0 296440.5 296933.0 298518.0 28773.9 35949.3 35958.3 36021.3 36039.0 45471.0 46792.8 46875.5 46944.8 46991.0 29971.6 30798.5 31048.0 31460.0 31863.4 30993.0 31241.8 31342.7 31433.8 31775.5 37084.8 37358.3 37487.4 37503.1 37928.2 31780.7 31835.7 32153.0 32235.0 32725.7 22684.9 23410.7 24374.9 24690.4 24825.9 09:04:09 INFO - PID 2859 | 09:04:09 INFO - PID 2859 | [#2] jquery.html Cycles:180 Average:38497.32 Median:2332.00 stddev:99932.17 (4285.2%) stddev-sans-first:100171.56 09:04:09 INFO - PID 2859 | Values: 393.2 419.8 430.6 430.9 446.7 16182.8 21879.0 22398.9 23137.4 23427.4 22719.2 23124.2 23220.3 23420.1 23782.4 4737.3 5996.8 6049.4 6173.3 6260.9 6088.5 6204.9 6213.0 6213.0 6214.3 5890.1 6115.2 6156.1 6168.8 6186.2 5125.0 6064.0 6107.7 6120.6 6578.6 6733.6 6816.2 6832.4 6834.0 6834.8 30011.5 30146.8 30178.1 30660.7 30885.1 2233.1 2288.6 2333.2 2354.8 2378.4 18754.4 18853.9 19343.8 19441.5 19753.0 2007.5 2251.1 2299.2 2330.8 2336.9 159983.0 163008.0 171819.0 174718.1 177207.0 18116.8 23479.4 23594.4 23941.6 24369.5 13420.5 17119.7 17169.8 42768.8 42990.4 7854.6 8998.5 9163.6 9189.6 9342.0 8775.5 8781.9 8823.5 8938.6 9040.0 7924.7 8079.2 8089.8 8096.4 8109.8 1849.2 2022.4 2205.7 2210.0 2220.4 837.7 913.6 927.3 970.2 973.5 20442.0 20943.8 21568.8 21742.9 21835.3 952.5 972.5 986.9 999.2 1008.5 10175.5 11261.5 11287.5 11318.5 11401.8 579438.0 583354.0 591179.0 591625.0 600570.0 134279.0 137578.0 137803.0 139013.9 139940.6 975.3 1123.4 1135.8 1159.4 1160.4 16407.3 17316.7 19175.7 21659.9 23106.2 55654.0 56434.2 56819.0 56912.0 57195.0 76746.6 79349.0 79468.2 81876.6 83517.3 9090.8 13187.7 13267.1 13479.9 13627.4 14554.7 14773.5 14849.6 15248.5 15254.1 11902.6 12068.9 12363.1 12407.4 12879.4 11758.8 11765.8 11803.9 11891.1 12141.3 12357.8 12393.5 12669.9 12739.0 12753.7 13469.9 13496.3 13837.5 13865.9 14096.9 12086.5 12335.0 12366.4 12381.0 12468.6 09:04:09 INFO - PID 2859 | 09:04:09 INFO - PID 2859 | [#3] mootools.html Cycles:180 Average:7140.66 Median:4009.19 stddev:4532.52 (113.1%) stddev-sans-first:4522.72 09:04:10 INFO - PID 2859 | Values: 1128.9 1455.1 1480.7 1484.1 1487.8 11331.3 11772.4 11784.2 11787.4 11796.4 11391.7 11859.0 11900.0 11900.7 11911.8 2093.6 2504.7 2538.7 2555.5 2556.2 2086.6 2391.9 2486.2 2519.8 2527.1 2181.7 2209.8 2442.8 2538.5 2547.4 2460.6 2494.2 2503.1 2506.0 2509.2 2431.0 2436.9 2441.1 2446.3 2447.4 11566.5 11853.1 11860.0 11894.5 11904.5 6559.3 6815.0 6826.0 6829.1 6829.8 3718.8 3999.8 4119.8 4337.9 4339.9 1176.7 1247.6 1290.1 1302.7 1305.2 14309.4 16030.4 16558.3 16699.1 16700.5 5525.2 5565.9 5647.7 5750.5 5818.4 12396.3 12439.6 12458.5 12459.9 12478.4 6697.0 6706.6 6708.3 6709.1 6723.1 5996.6 6205.7 6277.9 6300.7 6301.1 3606.0 4252.1 4379.7 4456.4 4467.6 1099.6 1273.4 1289.1 1309.8 1315.5 635.5 795.6 814.3 819.8 862.2 6559.1 6717.2 6924.0 6995.1 7085.7 596.1 606.4 606.5 617.9 725.2 4018.5 4203.3 4316.6 4332.1 4471.8 14645.2 15455.7 15455.8 15478.0 15491.9 14833.0 15286.3 15332.5 15341.2 15367.2 8752.9 8817.3 8828.9 8839.9 8878.4 6458.1 6701.7 6744.9 6935.5 6942.8 9540.6 13565.0 13709.2 13792.5 13795.4 11261.9 13389.9 13659.6 13804.7 13882.7 9473.0 9655.0 9659.7 9662.4 9681.2 8573.7 10557.4 10924.8 11052.3 11109.3 9150.1 9192.6 9264.1 9326.8 9489.9 7582.2 9017.4 9046.5 9090.7 9221.1 8099.4 8140.0 8212.3 8219.6 8231.6 6056.2 6090.9 6191.7 6231.4 6341.2 5965.6 6187.0 6301.5 6302.8 6307.4 09:04:10 INFO - PID 2859 | 09:04:10 INFO - PID 2859 | [#4] prototype.html Cycles:180 Average:5076.41 Median:5661.78 stddev:1532.24 (27.1%) stddev-sans-first:1494.51 09:04:10 INFO - PID 2859 | Values: 328.0 383.3 401.3 404.0 407.2 4830.7 5628.2 5828.4 5984.2 6004.8 4521.9 5277.2 5635.1 5677.3 5809.8 3910.5 4082.4 4285.3 4512.7 4539.5 4412.9 4454.2 4503.6 4541.5 4555.9 4466.9 4471.3 4471.7 4477.7 4506.0 3708.8 4215.9 4454.6 4458.6 4474.0 3892.0 3964.7 4012.2 4017.9 4059.4 5678.2 5687.7 5738.2 5744.6 5751.7 5098.5 5326.0 5385.5 5411.3 5417.5 4889.7 5776.4 6208.3 6271.8 6273.3 3839.6 4482.8 4525.6 4534.2 4561.2 5627.0 6030.4 6606.0 6611.1 6622.8 4352.6 4383.0 4627.1 4651.4 4684.5 3895.7 4741.2 4767.5 4769.8 4783.3 5391.8 5407.7 5411.5 5414.9 5431.1 5425.4 6112.2 6197.7 6213.6 6322.9 1300.0 1499.1 1535.3 1550.8 1589.1 915.3 1060.6 1061.9 1090.7 1095.5 4700.5 5835.4 5836.9 5860.6 5909.4 6433.6 6435.2 6450.0 6473.4 6476.9 5646.2 5758.8 5814.7 5850.6 5851.2 2932.2 3233.0 3301.4 3345.3 3362.2 5297.5 5743.5 6309.5 6500.6 6651.3 5481.2 6593.8 6605.2 6608.4 6608.5 5797.2 5984.7 6140.2 6587.2 6593.9 4718.7 6043.6 6121.3 6425.5 6524.8 5826.8 5918.6 6073.8 6419.0 6442.3 5679.0 6498.4 6634.7 6653.6 6678.7 3894.9 3954.4 4137.8 4297.0 4302.3 5625.4 6174.4 6491.7 6514.3 6528.6 5415.9 5773.2 6230.3 6281.1 6294.3 6239.6 6243.9 6263.6 6274.0 6282.5 5112.3 5824.7 6051.5 6148.2 6152.9 5473.6 6275.9 6291.2 6296.2 6307.9 5828.9 6062.2 6152.3 6167.0 6366.6 09:04:10 INFO - PID 2859 | 09:04:10 INFO - PID 2859 | [#5] yui.html Cycles:180 Average:20698.75 Median:17368.48 stddev:29190.89 (168.1%) stddev-sans-first:29233.76 09:04:10 INFO - PID 2859 | Values: 598.6 806.7 875.1 881.6 890.3 13421.3 13892.9 16879.0 17809.1 18580.4 15777.8 17280.4 17284.3 17290.7 17308.5 970.8 994.4 997.9 998.0 1001.6 1007.3 1009.2 1024.3 1024.6 1027.6 1085.8 1089.5 1091.1 1092.0 1094.3 1080.3 1082.0 1082.7 1083.0 1087.5 804.5 806.2 808.6 808.9 810.0 16677.6 16878.0 16886.4 17185.1 17252.3 16773.7 16941.8 17142.9 17363.5 17373.5 13952.9 14080.6 14362.6 14521.7 14575.0 3575.5 3602.4 3606.7 3609.6 3609.8 127985.0 129100.4 131237.4 132050.3 132245.0 11327.5 13065.0 13309.5 13507.8 13528.3 19642.5 22340.8 24848.6 25106.2 25847.6 7869.6 8054.2 8065.4 8079.0 8079.3 3837.8 3867.7 3922.5 3965.6 4026.3 4374.7 4486.2 4488.2 4490.8 4494.6 927.9 949.3 968.0 974.9 982.1 578.9 632.1 656.4 673.5 682.4 10734.7 10844.4 11386.4 11548.4 11970.3 644.4 647.6 659.6 685.7 689.1 5317.3 5362.3 5498.0 5609.4 5642.7 90708.0 92133.0 92655.1 92824.0 94009.1 82382.6 84804.0 84933.6 85111.9 86117.0 55823.7 73660.0 74238.3 74683.0 75971.0 9706.6 10539.5 10919.6 11000.2 11268.5 38133.8 38889.4 39033.4 39088.0 39570.6 49863.8 50077.0 50728.7 51057.2 51070.7 13848.2 13998.3 14193.4 14202.5 14309.5 15157.5 15330.0 15343.5 15359.0 15432.6 16281.9 17147.9 17165.1 17178.7 17388.0 13296.3 16354.0 16881.7 17004.7 17300.3 14346.6 14587.3 16186.6 16692.9 16792.5 11745.2 11966.2 12066.9 12140.2 12142.9 12309.6 12966.7 12970.9 13780.9 13885.7 09:04:10 INFO - PID 2859 | -------- Summary: end -------- 09:04:10 INFO - PID 2859 | 09:04:10 INFO - TEST-INFO | 2859: exit 0 09:04:10 INFO - TEST-OK | dromaeo_css | took 1119381ms 09:04:10 INFO - TEST-START | kraken 09:04:10 INFO - operating with platform_type : mac_ 09:04:10 INFO - Initialising browser for kraken test... 09:04:10 INFO - TEST-INFO | started process 2864 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpG8457K/profile http://localhost:61174/getInfo.html) 09:04:13 INFO - PID 2864 | __metrics Screen width/height:1600/1200 09:04:13 INFO - PID 2864 | colorDepth:24 09:04:13 INFO - PID 2864 | Browser inner width/height: 1024/689 09:04:13 INFO - PID 2864 | __metrics 09:04:13 INFO - PID 2864 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:04:13 INFO - PID 2864 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:14 INFO - TEST-INFO | 2864: exit 0 09:04:14 INFO - Browser initialized. 09:04:14 INFO - Running cycle 1/1 for kraken test... 09:04:14 INFO - TEST-INFO | started process 2865 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpG8457K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:27 INFO - PID 2865 | RSS: Main: 241233920 09:04:27 INFO - PID 2865 | 09:04:29 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61174/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:30 INFO - PID 2865 | RSS: Main: 312094720 09:04:30 INFO - PID 2865 | 09:04:33 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61174/tests/kraken/driver.html?testName=audio-dft) 09:04:34 INFO - PID 2865 | RSS: Main: 293797888 09:04:34 INFO - PID 2865 | 09:04:37 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61174/tests/kraken/driver.html?testName=audio-fft) 09:04:37 INFO - PID 2865 | RSS: Main: 387735552 09:04:37 INFO - PID 2865 | 09:04:40 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61174/tests/kraken/driver.html?testName=audio-oscillator) 09:04:40 INFO - PID 2865 | RSS: Main: 286334976 09:04:40 INFO - PID 2865 | 09:04:42 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61174/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:43 INFO - PID 2865 | RSS: Main: 288497664 09:04:43 INFO - PID 2865 | 09:04:46 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61174/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:46 INFO - PID 2865 | RSS: Main: 353431552 09:04:46 INFO - PID 2865 | 09:04:49 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61174/tests/kraken/driver.html?testName=imaging-desaturate) 09:04:50 INFO - PID 2865 | RSS: Main: 373440512 09:04:50 INFO - PID 2865 | 09:04:53 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61174/tests/kraken/driver.html?testName=json-parse-financial) 09:04:53 INFO - PID 2865 | RSS: Main: 386318336 09:04:53 INFO - PID 2865 | 09:04:55 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61174/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:04:55 INFO - PID 2865 | RSS: Main: 333131776 09:04:55 INFO - PID 2865 | 09:04:57 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:04:58 INFO - PID 2865 | RSS: Main: 332578816 09:04:58 INFO - PID 2865 | 09:05:00 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:01 INFO - PID 2865 | RSS: Main: 317227008 09:05:01 INFO - PID 2865 | 09:05:03 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:04 INFO - PID 2865 | RSS: Main: 333000704 09:05:04 INFO - PID 2865 | 09:05:07 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:08 INFO - PID 2865 | RSS: Main: 343261184 09:05:08 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | Cycle 1(1): loaded http://localhost:61174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61174/tests/kraken/driver.html?testName=ai-astar) 09:05:10 INFO - PID 2865 | RSS: Main: 385925120 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | __start_tp_report 09:05:10 INFO - PID 2865 | _x_x_mozilla_page_load 09:05:10 INFO - PID 2865 | _x_x_mozilla_page_load_details 09:05:10 INFO - PID 2865 | |i|pagename|runs| 09:05:10 INFO - PID 2865 | |0;ai-astar;120;164;148;111;112;110;111;110;111;111 09:05:10 INFO - PID 2865 | |1;audio-beat-detection;146;109;109;154;110;110;111;105;138;110 09:05:10 INFO - PID 2865 | |2;audio-dft;183;185;186;184;188;181;184;184;180;182 09:05:10 INFO - PID 2865 | |3;audio-fft;80;63;64;116;92;84;58;58;81;57 09:05:10 INFO - PID 2865 | |4;audio-oscillator;91;71;84;69;69;69;90;67;69;87 09:05:10 INFO - PID 2865 | |5;imaging-gaussian-blur;87;87;88;86;87;87;88;87;87;86 09:05:10 INFO - PID 2865 | |6;imaging-darkroom;95;95;96;96;96;96;96;95;95;94 09:05:10 INFO - PID 2865 | |7;imaging-desaturate;87;87;84;95;128;91;85;87;88;84 09:05:10 INFO - PID 2865 | |8;json-parse-financial;50;51;48;48;50;50;49;51;48;49 09:05:10 INFO - PID 2865 | |9;json-stringify-tinderbox;54;54;59;64;63;56;58;57;57;59 09:05:10 INFO - PID 2865 | |10;stanford-crypto-aes;83;83;83;83;82;82;82;81;82;82 09:05:10 INFO - PID 2865 | |11;stanford-crypto-ccm;143;138;146;158;134;141;136;135;174;145 09:05:10 INFO - PID 2865 | |12;stanford-crypto-pbkdf2;195;226;187;185;185;184;218;183;185;183 09:05:10 INFO - PID 2865 | |13;stanford-crypto-sha256-iterative;68;67;67;70;74;92;99;96;73;66 09:05:10 INFO - PID 2865 | __end_tp_report 09:05:10 INFO - PID 2865 | __start_cc_report 09:05:10 INFO - PID 2865 | _x_x_mozilla_cycle_collect,2177 09:05:10 INFO - PID 2865 | __end_cc_report 09:05:10 INFO - PID 2865 | __startTimestamp1492445110721__endTimestamp 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | ------- Summary: start ------- 09:05:10 INFO - PID 2865 | Number of tests: 14 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#0] ai-astar Cycles:10 Average:120.80 Median:111.50 stddev:19.15 (17.2%) stddev-sans-first:20.31 09:05:10 INFO - PID 2865 | Values: 120.0 164.0 148.0 111.0 112.0 110.0 111.0 110.0 111.0 111.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#1] audio-beat-detection Cycles:10 Average:120.20 Median:110.50 stddev:18.27 (16.5%) stddev-sans-first:16.82 09:05:10 INFO - PID 2865 | Values: 146.0 109.0 109.0 154.0 110.0 110.0 111.0 105.0 138.0 110.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:2.36 (1.3%) stddev-sans-first:2.49 09:05:10 INFO - PID 2865 | Values: 183.0 185.0 186.0 184.0 188.0 181.0 184.0 184.0 180.0 182.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#3] audio-fft Cycles:10 Average:75.30 Median:72.00 stddev:19.08 (26.5%) stddev-sans-first:20.17 09:05:10 INFO - PID 2865 | Values: 80.0 63.0 64.0 116.0 92.0 84.0 58.0 58.0 81.0 57.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.50 stddev:10.02 (12.9%) stddev-sans-first:9.18 09:05:10 INFO - PID 2865 | Values: 91.0 71.0 84.0 69.0 69.0 69.0 90.0 67.0 69.0 87.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 09:05:10 INFO - PID 2865 | Values: 87.0 87.0 88.0 86.0 87.0 87.0 88.0 87.0 87.0 86.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 09:05:10 INFO - PID 2865 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 94.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:87.00 stddev:13.22 (15.2%) stddev-sans-first:13.91 09:05:10 INFO - PID 2865 | Values: 87.0 87.0 84.0 95.0 128.0 91.0 85.0 87.0 88.0 84.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:50.00 stddev:1.17 (2.3%) stddev-sans-first:1.22 09:05:10 INFO - PID 2865 | Values: 50.0 51.0 48.0 48.0 50.0 50.0 49.0 51.0 48.0 49.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.50 stddev:3.35 (5.7%) stddev-sans-first:3.21 09:05:10 INFO - PID 2865 | Values: 54.0 54.0 59.0 64.0 63.0 56.0 58.0 57.0 57.0 59.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:0.67 (0.8%) stddev-sans-first:0.67 09:05:10 INFO - PID 2865 | Values: 83.0 83.0 83.0 83.0 82.0 82.0 82.0 81.0 82.0 82.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:144.00 stddev:12.39 (8.6%) stddev-sans-first:13.12 09:05:10 INFO - PID 2865 | Values: 143.0 138.0 146.0 158.0 134.0 141.0 136.0 135.0 174.0 145.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.10 Median:186.00 stddev:15.73 (8.5%) stddev-sans-first:16.67 09:05:10 INFO - PID 2865 | Values: 195.0 226.0 187.0 185.0 185.0 184.0 218.0 183.0 185.0 183.0 09:05:10 INFO - PID 2865 | 09:05:10 INFO - PID 2865 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.20 Median:73.50 stddev:13.10 (17.8%) stddev-sans-first:13.47 09:05:10 INFO - PID 2865 | Values: 68.0 67.0 67.0 70.0 74.0 92.0 99.0 96.0 73.0 66.0 09:05:10 INFO - PID 2865 | -------- Summary: end -------- 09:05:10 INFO - PID 2865 | 09:05:11 INFO - TEST-INFO | 2865: exit 0 09:05:11 INFO - TEST-OK | kraken | took 61150ms 09:05:11 INFO - SUITE-END | took 1180s 09:05:12 INFO - Completed test suite (00:19:41) 09:05:12 INFO - javascript benchmark 09:05:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7885.830093532213, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3491.127218195451, 3509.8771542996, 3510.333036723021, 3533.929321413572, 3576.606573276939, 5856.121581762727, 5966.642001479914, 5988.161657367972, 6213.782517611879, 6218.689065546721, 6098.916365657131, 6124.289394097922, 6205.875882482348, 6212.130301757747, 6228.937710622892, 5174.637775355726, 5370.221317908901, 5376.0, 5382.407935127133, 5432.320959880015, 5264.394594621629, 5366.543843773265, 5454.972725136368, 5508.14623733322, 5569.832905012856, 5306.70813105279, 5359.839204823861, 5382.407935127133, 5385.030694474993, 5472.5621950244085, 5397.487238712316, 5408.945910540883, 5419.187121931742, 5472.890542189174, 5507.03626865297, 5311.787528498855, 5347.572194224453, 5361.973190134064, 5363.839084827422, 5430.755615997289, 6025.8192254232445, 6123.5407344448895, 6189.071639254148, 6206.782762603287, 6226.346233645448, 6418.469841587108, 6521.282658907517, 6568.343165683441, 6586.242582103072, 6595.274519802818, 6629.635370054645, 6643.93356066438, 6659.600423974577, 6661.100751398548, 6665.733370665168, 6164.260288765377, 6282.434580887742, 6285.0, 6293.590916590407, 6299.590526615755, 6543.214814222324, 6639.336066393419, 6728.158980127484, 6808.012838138442, 6843.315668433117, 6336.968315158395, 6407.519436042316, 6415.711292991827, 6436.710348034349, 6502.479801615859, 6594.977778444349, 6621.966890165519, 6648.634325112165, 6673.299303573152, 6678.699458524378, 6543.214814222324, 6574.638394888231, 6584.275729669733, 6594.20869495654, 6595.406413422815, 6339.524535659844, 6422.068800023971, 6498.220213574401, 6558.311377305409, 6571.244306904767, 5335.599830012765, 5340.172273297645, 5342.813001545005, 5351.625386223005, 5380.78476860929, 4729.62163026957, 4742.596879265232, 4745.667803253739, 4748.264019077049, 4785.521447855256, 6116.5718399711595, 6139.3388173831, 6171.84570385744, 6289.496840252768, 6309.495240380758, 6580.341965803477, 6614.603123812587, 6631.071649969008, 6655.567388119756, 6669.566478178903, 6287.559870808999, 6287.968560157261, 6300.30696623371, 6300.968495157586, 6308.3060863305, 5631.887362252732, 5827.504662103769, 5833.212516310328, 5834.737436815353, 5838.357780644125, 6644.7009884554345, 6655.367740064686, 6761.0, 6823.147106611674, 6846.110005699227, 6654.866902661823, 6668.233153187251, 6668.933310666831, 6680.866382672222, 6697.162854643169, 6742.0, 6753.594784312957, 6813.080234168324, 6823.38589526945, 6852.828679283058, 6307.810765676853, 6393.424591786761, 6464.22429308486, 6495.870082598416, 6520.152380190545, 6666.433353165035, 6670.733170673118, 6670.733170673118, 6681.398674119353, 6683.064370987969, 6253.874922501615, 6268.4671802897265, 6332.11350410952, 6377.553571249968, 6449.355064493513, 6333.1766870306565, 6465.288818229897, 6465.903011454926, 6471.964485682268, 6482.286948435574, 6158.32258451561, 6262.123302737529, 6343.397377249154, 6346.0, 6347.206599175103, 5726.055200891807, 6061.575689701855, 6305.527085468517, 6348.460380867678, 6364.64994425311, 6249.437550620466, 6259.1550140730415, 6288.937110628835, 6324.430801227728, 6347.619142851444], "value": 6045.756012109352, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.4716225061329, 794.9125596184418, 816.1838161838161, 947.4978261521396, 1131.45690068767, 27990.300242493948, 37310.62689373105, 37861.62138378622, 37959.05102372442, 37967.05082372942, 39900.80049599755, 40282.39576406356, 40283.0, 40287.59712402883, 40377.59622403775, 6014.428629280212, 8330.66677332906, 8483.194096560817, 8518.361122915776, 8539.871901921477, 6154.630722156685, 8312.584370781467, 8492.957535212347, 8502.532360720157, 8525.872111918326, 8529.275011624019, 8567.314614830799, 8570.657173713043, 8578.957105214497, 8581.0, 8451.873221901677, 8515.57422128891, 8527.488350698915, 8536.189062039097, 8708.956455217747, 8339.916600833974, 8391.244787969112, 8401.663933442716, 8402.285805706522, 8405.285550728195, 37587.43618845719, 37832.351735378536, 37864.0, 37886.81056594727, 37955.62044379549, 3610.0433385152955, 3638.3450978823803, 3653.6711695947492, 3656.4698118772894, 3657.7073834093476, 30711.846440767877, 30743.38513229723, 30785.8460707695, 30834.074977750704, 30845.0, 3113.4395808754416, 3151.511515715045, 3169.9683003169903, 3175.0, 3183.4110689522513, 299161.0, 306995.0, 309626.4518677415, 310390.0, 310828.0, 50451.99096018059, 50502.49497505051, 50554.241686374735, 50581.0, 50645.74677126665, 52706.73646631819, 52717.736411317695, 52739.472605274226, 52781.0, 52814.47185528096, 13887.722245555033, 14290.28548572588, 14389.712205755826, 14406.855931440761, 14441.78337324941, 10215.94892025535, 11729.706757331134, 11739.88260117405, 11743.236689615147, 11766.764664706829, 10134.898651013396, 10810.081143102767, 11243.0, 11320.886791131983, 12656.303903285409, 4538.931916021263, 5287.783809723785, 5296.537110243678, 5391.762418596317, 5395.4622932464845, 982.8034393121404, 1001.1640280365976, 1008.9394636321845, 1009.8788145422596, 1039.1271332080937, 24526.632100518505, 24603.63094553583, 24623.753762462504, 24679.25962221136, 24694.0, 977.8464452141786, 1049.228816819637, 1115.1747706696985, 1131.7057565033151, 1139.2196345503357, 10640.840387394195, 10725.034746872663, 12491.375431228402, 12522.749545009048, 12549.435275412628, 318449.0, 319002.0, 320027.0, 320315.0, 320418.0, 54257.728711356984, 54258.728706357004, 54302.913941720944, 54388.728056360254, 54471.72764136233, 1474.8746356559598, 1493.8356780754325, 1539.9384024639114, 1541.0599534284079, 1544.4440001599414, 20078.89960550188, 23655.52688946177, 23917.16289929844, 23991.880040599684, 24046.759532404452, 38255.80872095733, 38335.61664383321, 38348.23303533858, 38410.80794596121, 38533.03667408337, 296187.0, 296429.0, 296440.5177974096, 296933.0, 298518.0, 28773.856130719214, 35949.28101437904, 35958.28083438264, 36021.27957440889, 36039.0, 45471.0, 46792.7660361696, 46875.53124468712, 46944.76527617477, 46991.0, 29971.55042674318, 30798.538021930137, 31048.0, 31460.0, 31863.362732745678, 30993.0, 31241.843790780902, 31342.686573134888, 31433.7996340254, 31775.52336714905, 37084.81457592695, 37358.25283494369, 37487.43768843524, 37503.06242343963, 37928.241435171694, 31780.682193178698, 31835.68164318327, 32153.03540893777, 32235.032949011566, 32725.672743273215, 22684.886575567678, 23410.67911663807, 24374.87812560926, 24690.382740430916, 24825.87587062053], "value": 17467.026208275227, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.15667892370845, 419.8131831335055, 430.5973914390046, 430.91166310906266, 446.69401459999904, 16182.757258641115, 21879.0, 22398.880055997175, 23137.421564460896, 23427.41431464214, 22719.20482783103, 23124.190653327136, 23220.303390898258, 23420.063197472122, 23782.40543986401, 4737.289406589005, 5996.79011234608, 6049.364541930414, 6173.259208894917, 6260.937390626081, 6088.482478989291, 6204.937950620481, 6212.968935155318, 6213.0, 6214.285357183914, 5890.145928840316, 6115.235595550556, 6156.076588511714, 6168.814935551941, 6186.195794546703, 5124.974375128138, 6064.0, 6107.725152368154, 6120.602160859552, 6578.6381749003785, 6733.629650369227, 6816.182058153004, 6832.385085342343, 6834.0, 6834.794956151323, 30011.549826752616, 30146.84926575375, 30178.09465716032, 30660.69339306623, 30885.073447796603, 2233.129079658934, 2288.565172617214, 2333.218371845434, 2354.81161507079, 2378.369732021016, 18754.437366879014, 18853.905730471397, 19343.80656193434, 19441.51396215092, 19753.012349382472, 2007.5282308657454, 2251.110811229555, 2299.1952816514254, 2330.790228879392, 2336.894839732216, 159983.0, 163008.0, 171819.0, 174718.12640936713, 177206.99999999872, 18116.818831811775, 23479.41301467443, 23594.410139746644, 23941.64087538688, 24369.51260974806, 13420.46318147263, 17119.65760684779, 17169.828301717072, 42768.78615606902, 42990.35514467285, 7854.567998760123, 8998.515244984505, 9163.58763855628, 9189.586468608928, 9341.953290233505, 8775.517346546001, 8781.868271975925, 8823.470591764515, 8938.597763100675, 9040.0, 7924.722634707758, 8079.151689072681, 8089.757307280791, 8096.352291816641, 8109.797255068671, 1849.2140840142886, 2022.4438279473263, 2205.713257276576, 2210.0, 2220.3893929169285, 837.7109897085496, 913.6162811619135, 927.3137877970254, 970.2238209432426, 973.5035132082688, 20442.0, 20943.790562094488, 21568.784312156993, 21742.91285435722, 21835.344939651837, 952.4521903907159, 972.5137431284357, 986.8569057486624, 999.2156157416539, 1008.5209525475341, 10175.491225438698, 11261.493232804543, 11287.54849806015, 11318.490667919963, 11401.771964560663, 579438.0, 583354.0, 591179.0, 591625.0, 600570.0, 134279.0, 137578.0, 137803.0, 139013.91479127822, 139940.60059399277, 975.253930742968, 1123.4102096399456, 1135.7614900870744, 1159.4434671357797, 1160.4487868262509, 16407.261673224493, 17316.65366692634, 19175.712364314266, 21659.891700541397, 23106.191283305005, 55654.0, 56434.153487696894, 56819.0, 56912.0, 57195.0, 76746.61626691831, 79349.0, 79468.20531794608, 81876.59061704653, 83517.32965340781, 9090.818203630948, 13187.736245275233, 13267.071305008556, 13479.932600336935, 13627.38676759568, 14554.708905821613, 14773.482928097896, 14849.628759281104, 15248.542543723706, 15254.084754914296, 11902.583409580624, 12068.879311206776, 12363.0837220231, 12407.441665125272, 12879.356032198166, 11758.82361764557, 11765.823512647488, 11803.881961180621, 11891.108166887345, 12141.271523708605, 12357.75284494323, 12393.504259829506, 12669.873301267238, 12739.0, 12753.744925101631, 13469.855062319813, 13496.32518374097, 13837.515686950908, 13865.861341386457, 14096.929515352767, 12086.51653933868, 12335.0, 12366.44351004189, 12381.0, 12468.563600273947], "value": 11295.283100425844, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1128.887111288871, 1455.1487379882767, 1480.6742516646334, 1484.1169504145034, 1487.8288996765361, 11331.320120792749, 11772.411379431016, 11784.175107742461, 11787.351695656735, 11796.410179491024, 11391.715207119827, 11859.0, 11899.988500977406, 11900.702482437944, 11911.7617647647, 2093.591749608827, 2504.69943606767, 2538.7207407185197, 2555.501677172952, 2556.2459074572953, 2086.62440760663, 2391.9043238270465, 2486.2416962826333, 2519.8488090714523, 2527.0776166699115, 2181.6509358502644, 2209.801117899389, 2442.7679370459778, 2538.4542323400465, 2547.3631592101974, 2460.63090536421, 2494.2018554062706, 2503.1364179358093, 2505.962410563843, 2509.2095989763166, 2431.027588964411, 2436.8537887726793, 2441.121196369306, 2446.2538925627678, 2447.3759191406257, 11566.479508422057, 11853.111016673784, 11860.0, 11894.464749086312, 11904.464299106561, 6559.278479367265, 6815.0, 6826.044353790473, 6829.146356705412, 6829.760958366433, 3718.772804974379, 3999.8400063997406, 4119.814608342632, 4337.891552711176, 4339.891502712426, 1176.688177632928, 1247.5882958623722, 1290.1291628151055, 1302.7199152182327, 1305.2233920817098, 14309.427622895071, 16030.35878564856, 16558.337666493328, 16699.08155051472, 16700.498985030346, 5525.171224316385, 5565.916511252334, 5647.6893770843, 5750.482456578928, 5818.44724751148, 12396.256224626552, 12439.626811195498, 12458.501659933683, 12459.875401245872, 12478.376081195904, 6697.028930805006, 6706.597604143767, 6708.262091169968, 6709.127813384229, 6723.058771771955, 5996.640201587918, 6205.720742566596, 6277.874442511215, 6300.716467758962, 6301.054841773771, 3605.9819700901853, 4252.128313695685, 4379.671524635602, 4456.398386217884, 4467.553244675506, 1099.571167244775, 1273.3951373097889, 1289.1298373597783, 1309.796981467874, 1315.53298579005, 635.465379393574, 795.6499140378215, 814.3444527155697, 819.8114433680167, 862.1593945902695, 6559.147310849655, 6717.16035495563, 6924.0, 6995.125609298838, 7085.681144348517, 596.0790578556141, 606.3875485759414, 606.4784285514454, 617.9351168127372, 725.1624373848214, 4018.5378681452007, 4203.348480985452, 4316.589923957219, 4332.1119170569955, 4471.821127154943, 14645.194514301817, 15455.690886182214, 15455.845441545665, 15477.993930394714, 15491.915565910278, 14832.961692681409, 15286.312115954808, 15332.540023799304, 15341.232938353038, 15367.231638418034, 8752.912470875337, 8817.338699597427, 8828.8675669865, 8839.911600884037, 8878.422902511316, 6458.095866578777, 6701.698423570853, 6744.8651026978205, 6935.549189302679, 6942.826429339307, 9540.570674319533, 13565.0, 13709.245991470565, 13792.517261895786, 13795.379207935466, 11261.943690281496, 13389.866101338863, 13659.565745596568, 13804.723905521632, 13882.722345553235, 9472.95263523678, 9655.0, 9659.71020869375, 9662.420254784736, 9681.177099946302, 8573.699920502753, 10557.41934193596, 10924.836127458253, 11052.281601695864, 11109.277896936674, 9150.130737580186, 9192.632294708405, 9264.073592640952, 9326.813463730823, 9489.905100948901, 7582.165961744094, 9017.368784185306, 9046.547672616474, 9090.681826136053, 9221.123993220634, 8099.392545559224, 8139.959300203461, 8212.301954333949, 8219.630116644646, 8231.588420578828, 6056.152138700498, 6090.908636370546, 6191.690415479298, 6231.40801623845, 6341.207349081365, 5965.552583556164, 6186.969065154645, 6301.527385446018, 6302.779402720883, 6307.400796924285], "value": 5337.891269822183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.9540864279001, 383.25265731822935, 401.2656837986485, 403.96364327210546, 407.16531111221985, 4830.73430961297, 5628.240187574676, 5828.377230246396, 5984.192134061906, 6004.759809607616, 4521.937344723987, 5277.182036784295, 5635.126555383912, 5677.347105082917, 5809.7676092956335, 3910.4720862683457, 4082.428460015593, 4285.250081235787, 4512.729236245836, 4539.4779600346055, 4412.911741765162, 4454.175977444167, 4503.57216064475, 4541.545845415449, 4555.929356601196, 4466.932996005063, 4471.306947423154, 4471.686981911267, 4477.686561940665, 4505.977470112662, 3708.8331025103935, 4215.903864995093, 4454.621357184643, 4458.554144585548, 4474.024773525618, 3891.9805400973096, 3964.742291751027, 4012.217617564576, 4017.8593749218635, 4059.411385349108, 5678.233438485793, 5687.658740475585, 5738.196652468658, 5744.569157313176, 5751.712414379264, 5098.521428785685, 5325.973370133163, 5385.461453854622, 5411.2965314508865, 5417.51242388183, 4889.731064791435, 5776.393478684719, 6208.348123447018, 6271.811845644638, 6273.278572964122, 3839.6352346527315, 4482.834463039633, 4525.592696657317, 4534.229181039198, 4561.1789877821975, 5626.971865140689, 6030.386519725315, 6606.0, 6611.140551728245, 6622.801315960529, 4352.642925582889, 4383.0, 4627.074585082997, 4651.37206477128, 4684.508126646721, 3895.7467764595212, 4741.241401375763, 4767.547083027107, 4769.76151192439, 4783.258594917794, 5391.757370918318, 5407.70257635826, 5411.458854114557, 5414.864628384322, 5431.076716958127, 5425.430329815313, 6112.235970503687, 6197.721102550396, 6213.565050446516, 6322.9051564226575, 1299.9740005199842, 1499.0855578097353, 1535.3474773221337, 1550.8449155084402, 1589.1259807106276, 915.2860768600502, 1060.5598676549146, 1061.920355973305, 1090.7164137324194, 1095.4522738630685, 4700.459447163552, 5835.395266301801, 5836.854078648068, 5860.560457965669, 5909.379515150933, 6433.613983161025, 6435.227772667216, 6449.96775016122, 6473.385028422293, 6476.870462590816, 5646.20953066571, 5758.798442054592, 5814.709264536757, 5850.5904586678525, 5851.244626612, 2932.2376182192356, 3232.997770691093, 3301.3562355340478, 3345.3142105868237, 3362.2266878617565, 5297.457220534166, 5743.483086522233, 6309.495240380758, 6500.609963402211, 6651.334866513407, 5481.246001279632, 6593.76921807744, 6605.207375115017, 6608.380946668001, 6608.504362172856, 5797.202797202797, 5984.73068711909, 6140.201773769381, 6587.176602924635, 6593.901091483535, 4718.693284936468, 6043.576949613484, 6121.32665406796, 6425.518086143465, 6524.771632992823, 5826.76692932278, 5918.615290006136, 6073.848153796191, 6418.972964325685, 6442.323556026549, 5678.971605141948, 6498.447631951148, 6634.7489730030975, 6653.600783952978, 6678.666066696743, 3894.9221015578964, 3954.426608141746, 4137.793110344411, 4297.0, 4302.311630139163, 5625.440424606712, 6174.44430001284, 6491.740330386731, 6514.315996820265, 6528.640924749185, 5415.864603384947, 5773.191753154646, 6230.283517395557, 6281.1420803533365, 6294.276158241678, 6239.594426362453, 6243.938530449744, 6263.561550691408, 6273.968630157003, 6282.497400207881, 5112.309838171799, 5824.737886795019, 6051.515878729779, 6148.200733904564, 6152.861720581706, 5473.616846820843, 6275.874482510416, 6291.245050593958, 6296.244450665949, 6307.873842523032, 5828.854278642898, 6062.211912451353, 6152.323244443018, 6167.0, 6366.6180029198395], "value": 4604.162806117182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.5839841310291, 806.6894245715399, 875.098648392156, 881.603278524664, 890.3322508118911, 13421.261830599313, 13892.861071389283, 16878.987260764363, 17809.109544522755, 18580.44258672242, 15777.842221577781, 17280.395186168487, 17284.30862765491, 17290.740638890427, 17308.48074557762, 970.7670159161821, 994.368575954267, 997.8553109799075, 998.0169533009979, 1001.6093723447862, 1007.2646967713573, 1009.1775203209397, 1024.3393011507574, 1024.6260115058026, 1027.573556973855, 1085.8262677971527, 1089.477051015513, 1091.0998426298297, 1092.0, 1094.3488624268548, 1080.2762149359949, 1081.9729506762394, 1082.691432941608, 1082.9874067746682, 1087.526925787285, 804.4770898915693, 806.2340776262515, 808.5795386399099, 808.8867558541809, 810.0, 16677.583060423465, 16878.0, 16886.40897568579, 17185.140742962925, 17252.309907603805, 16773.66452670952, 16941.83058169415, 17142.914285428495, 17363.479095627026, 17373.47879563615, 13952.93023534886, 14080.647983800385, 14362.64093397663, 14521.709565808731, 14575.0, 3575.463680447928, 3602.441621548664, 3606.675399214057, 3609.620989796086, 3609.8375573099274, 127985.0, 129100.35449822784, 131237.4227890321, 132050.3397483016, 132245.0, 11327.490262938187, 13065.0, 13309.46762129504, 13507.797383039262, 13528.323583820966, 19642.508937276398, 22340.77659223387, 24848.627270590954, 25106.24681259565, 25847.61228581573, 7869.606519674108, 8054.154313796967, 8065.39509536787, 8079.0, 8079.272865442138, 3837.76973381598, 3867.7292589519025, 3922.490076290064, 3965.6034396560112, 4026.275270451347, 4374.671899607542, 4486.192485352668, 4488.236999710057, 4490.753008584559, 4494.640428765691, 927.9350445468888, 949.349695458613, 967.970960871175, 974.9415035097917, 982.1160955140288, 578.8581797459565, 632.105570617571, 656.4092316914815, 673.4847841401332, 682.4403988729194, 10734.73163170927, 10844.403557804397, 11386.373749443861, 11548.422578871023, 11970.341631210193, 644.3942693867749, 647.6243778608396, 659.6174218952996, 685.6914388525183, 689.1144878830678, 5317.282166907418, 5362.302900622972, 5498.0, 5609.382967873531, 5642.7178641067785, 90708.0, 92133.0, 92655.07344926464, 92824.0, 94009.05990940004, 82382.58808706039, 84804.0, 84933.57533212294, 85111.87220319417, 86117.0, 55823.72088139615, 73660.0, 74238.25761742421, 74683.0, 75971.0, 9706.611735530782, 10539.548248064417, 10919.563217471212, 11000.174986876176, 11268.549258029587, 38133.77341233529, 38889.416658750706, 39033.43866245318, 39088.0, 39570.60429395669, 49863.75068124636, 50076.984970546924, 50728.731781705756, 51057.23414148716, 51070.74464627653, 13848.169109853441, 13998.300084995506, 14193.361298741374, 14202.50291239843, 14309.499167529502, 15157.469488567847, 15330.00354976923, 15343.46297879569, 15359.001664891746, 15432.614184645474, 16281.918590406973, 17147.914260428617, 17165.055921923915, 17178.742318865476, 17388.0, 13296.335183240606, 16354.01875887403, 16881.66236675235, 17004.65990680204, 17300.307987680353, 14346.56960291193, 14587.34356953961, 16186.595335116244, 16692.916535417244, 16792.496225113267, 11745.177837551631, 11966.162368634112, 12066.879331206575, 12140.210886292363, 12142.939285303517, 12309.630711078682, 12966.740665186831, 12970.935145324212, 13780.862191377957, 13885.72228555403], "value": 8202.83650953563, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1455.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 164.0, 148.0, 111.0, 112.0, 110.0, 111.0, 110.0, 111.0, 111.0], "value": 120.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 109.0, 109.0, 154.0, 110.0, 110.0, 111.0, 105.0, 138.0, 110.0], "value": 120.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 186.0, 184.0, 188.0, 181.0, 184.0, 184.0, 180.0, 182.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 63.0, 64.0, 116.0, 92.0, 84.0, 58.0, 58.0, 81.0, 57.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 84.0, 69.0, 69.0, 69.0, 90.0, 67.0, 69.0, 87.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 86.0, 87.0, 87.0, 88.0, 87.0, 87.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 84.0, 95.0, 128.0, 91.0, 85.0, 87.0, 88.0, 84.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 48.0, 48.0, 50.0, 50.0, 49.0, 51.0, 48.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 59.0, 64.0, 63.0, 56.0, 58.0, 57.0, 57.0, 59.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 83.0, 82.0, 82.0, 82.0, 81.0, 82.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 138.0, 146.0, 158.0, 134.0, 141.0, 136.0, 135.0, 174.0, 145.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 226.0, 187.0, 185.0, 185.0, 184.0, 218.0, 183.0, 185.0, 183.0], "value": 193.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 70.0, 74.0, 92.0, 99.0, 96.0, 73.0, 66.0], "value": 77.2, "unit": "score"}]}]} 09:05:12 INFO - Return code: 0 09:05:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:12 ERROR - # TBPL SUCCESS # 09:05:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:05:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:05:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:05:12 INFO - 2017-04-17 09:05:12.549 screenresolution[2870:39903] starting screenresolution argv=screenresolution get 09:05:12 INFO - 2017-04-17 09:05:12.551 screenresolution[2870:39903] Display 0: 1600x1200x32@60 09:05:12 INFO - 2017-04-17 09:05:12.557 screenresolution[2871:39906] starting screenresolution argv=screenresolution list 09:05:12 INFO - Available Modes on Display 0 09:05:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:05:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:05:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:05:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:05:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:05:12 INFO - Intel Iris: 09:05:12 INFO - Chipset Model: Intel Iris 09:05:12 INFO - Type: GPU 09:05:12 INFO - Bus: Built-In 09:05:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:05:12 INFO - Vendor: Intel (0x8086) 09:05:12 INFO - Device ID: 0x0a2e 09:05:12 INFO - Revision ID: 0x0009 09:05:12 INFO - Displays: 09:05:12 INFO - Display: 09:05:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:05:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:05:12 INFO - Display Serial Number: 1600x1200 60 09:05:12 INFO - Main Display: Yes 09:05:12 INFO - Mirror: Off 09:05:12 INFO - Online: Yes 09:05:12 INFO - Rotation: Supported 09:05:12 INFO - Return code: 0 09:05:12 INFO - Running post-action listener: _resource_record_post_action 09:05:12 INFO - [mozharness: 2017-04-17 16:05:12.792976Z] Finished run-tests step (success) 09:05:12 INFO - Running post-run listener: _resource_record_post_run 09:05:12 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 1123328; Write bytes: 517509120; Read time: 6; Write time: 1672 09:05:12 INFO - TinderboxPrint: CPU usage
53.2% 09:05:12 INFO - TinderboxPrint: I/O read bytes / time
1,123,328 / 6 09:05:12 INFO - TinderboxPrint: I/O write bytes / time
517,509,120 / 1,672 09:05:12 INFO - TinderboxPrint: CPU idle
2,249.6 (46.8%) 09:05:12 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 09:05:12 INFO - TinderboxPrint: CPU user
1,600.0 (33.3%) 09:05:12 INFO - TinderboxPrint: Swap in / out
209,235,968 / 0 09:05:12 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194726400; Write bytes: 195405824; Read time: 15081; Write time: 434 09:05:12 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 1122816; Write bytes: 305260544; Read time: 5; Write time: 1189 09:05:13 INFO - Running post-run listener: _upload_blobber_files 09:05:13 INFO - Blob upload gear active. 09:05:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:13 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 09:05:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:13 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:14 INFO - (blobuploader) - INFO - Done attempting. 09:05:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:05:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:05:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:15 INFO - (blobuploader) - INFO - Done attempting. 09:05:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:05:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:05:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:16 INFO - (blobuploader) - INFO - Done attempting. 09:05:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:18 INFO - (blobuploader) - INFO - Done attempting. 09:05:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:18 INFO - Return code: 0 09:05:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f4ca34108e48e0f99e3d5ce8df75b87adb37c58a32813cf5b7e6b9d8e98133048ab037890c4d8beb53f905f67cadfaefa896a5ff5612d7ceadb78cae18579f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91bb8787574be148638176fddd630ff09e6b2dd48325219195c0467fc5c8aa65b2f0af89c4b4ecdaaa494f63a1a0c4c587910cea783943e9ef7bc5faffaa8dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097f2598471428139f228d5df98f5ed58872e5aae33a614d5f1efa8425a9275cf5d087811b70edb70e1df72fa90ada3ee55b5faeced2fe2ea7c05cafa2826f96", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b85eb48d1b866e1ccc1c997c0ad1ddab15cea63c074a222e6995479f65daa0a7f6b584a4d73cf38aac63a61ec7b6b69b2d9057b8e26cd3da518c02ed7d040a8d"} 09:05:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:18 INFO - Contents: 09:05:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f4ca34108e48e0f99e3d5ce8df75b87adb37c58a32813cf5b7e6b9d8e98133048ab037890c4d8beb53f905f67cadfaefa896a5ff5612d7ceadb78cae18579f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91bb8787574be148638176fddd630ff09e6b2dd48325219195c0467fc5c8aa65b2f0af89c4b4ecdaaa494f63a1a0c4c587910cea783943e9ef7bc5faffaa8dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097f2598471428139f228d5df98f5ed58872e5aae33a614d5f1efa8425a9275cf5d087811b70edb70e1df72fa90ada3ee55b5faeced2fe2ea7c05cafa2826f96", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b85eb48d1b866e1ccc1c997c0ad1ddab15cea63c074a222e6995479f65daa0a7f6b584a4d73cf38aac63a61ec7b6b69b2d9057b8e26cd3da518c02ed7d040a8d"} 09:05:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:18 INFO - Copying logs to upload dir... 09:05:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.341726 ========= master_lag: 1.85 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-17 09:05:20.625934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 09:05:20.629165) ========= 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.WVipUNJY1v/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.SVYxAXxAp9/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f4ca34108e48e0f99e3d5ce8df75b87adb37c58a32813cf5b7e6b9d8e98133048ab037890c4d8beb53f905f67cadfaefa896a5ff5612d7ceadb78cae18579f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91bb8787574be148638176fddd630ff09e6b2dd48325219195c0467fc5c8aa65b2f0af89c4b4ecdaaa494f63a1a0c4c587910cea783943e9ef7bc5faffaa8dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097f2598471428139f228d5df98f5ed58872e5aae33a614d5f1efa8425a9275cf5d087811b70edb70e1df72fa90ada3ee55b5faeced2fe2ea7c05cafa2826f96", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b85eb48d1b866e1ccc1c997c0ad1ddab15cea63c074a222e6995479f65daa0a7f6b584a4d73cf38aac63a61ec7b6b69b2d9057b8e26cd3da518c02ed7d040a8d"} build_url:https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/RCv59c4yRm-UHuZb9uSSug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0f4ca34108e48e0f99e3d5ce8df75b87adb37c58a32813cf5b7e6b9d8e98133048ab037890c4d8beb53f905f67cadfaefa896a5ff5612d7ceadb78cae18579f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91bb8787574be148638176fddd630ff09e6b2dd48325219195c0467fc5c8aa65b2f0af89c4b4ecdaaa494f63a1a0c4c587910cea783943e9ef7bc5faffaa8dd9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/097f2598471428139f228d5df98f5ed58872e5aae33a614d5f1efa8425a9275cf5d087811b70edb70e1df72fa90ada3ee55b5faeced2fe2ea7c05cafa2826f96", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b85eb48d1b866e1ccc1c997c0ad1ddab15cea63c074a222e6995479f65daa0a7f6b584a4d73cf38aac63a61ec7b6b69b2d9057b8e26cd3da518c02ed7d040a8d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-17 09:05:20.669178) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:05:20.669503) ========= 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.WVipUNJY1v/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.SVYxAXxAp9/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.005110 ========= master_lag: 0.77 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-17 09:05:21.440079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 09:05:21.440390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-17 09:05:21.441241) ========= ========= Total master_lag: 2.72 =========