builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0128 starttime: 1488383777.39 results: success (0) buildid: 20170301065222 builduid: be78747dd9bd46d9b165551816d70a3a revision: 95d5cceb04c19391e691937194f25baaf0ee4dcf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.393236) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.393753) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.394073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.421714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:17.422353) ========= 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.ybst9jEyhn/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.x9MovjtfyI/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-01 07:56:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-03-01 07:56:18 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.653971 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:18.105843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:18.106315) ========= 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.ybst9jEyhn/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.x9MovjtfyI/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.028297 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:18.157145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:56:18.157557) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 95d5cceb04c19391e691937194f25baaf0ee4dcf --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 95d5cceb04c19391e691937194f25baaf0ee4dcf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ybst9jEyhn/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.x9MovjtfyI/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-01 07:56:18,267 truncating revision to first 12 chars 2017-03-01 07:56:18,267 Setting DEBUG logging. 2017-03-01 07:56:18,267 attempt 1/10 2017-03-01 07:56:18,267 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/95d5cceb04c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-01 07:56:19,632 unpacking tar archive at: mozilla-aurora-95d5cceb04c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.643549 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 07:56:19.829016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.829704) ========= script_repo_revision: 95d5cceb04c19391e691937194f25baaf0ee4dcf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.830679) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.831347) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 07:56:19.852678) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-01 07:56:19.853379) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ybst9jEyhn/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.x9MovjtfyI/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:56:20 INFO - MultiFileLogger online at 20170301 07:56:20 in /builds/slave/test 07:56:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:56:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:20 INFO - {'append_to_log': False, 07:56:20 INFO - 'base_work_dir': '/builds/slave/test', 07:56:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:56:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:20 INFO - 'branch': 'Mozilla-Aurora', 07:56:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:20 INFO - 'config_files': ('talos/mac_config.py',), 07:56:20 INFO - 'default_actions': ('clobber', 07:56:20 INFO - 'read-buildbot-config', 07:56:20 INFO - 'download-and-extract', 07:56:20 INFO - 'populate-webroot', 07:56:20 INFO - 'create-virtualenv', 07:56:20 INFO - 'install', 07:56:20 INFO - 'run-tests'), 07:56:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:20 INFO - 'download_minidump_stackwalk': True, 07:56:20 INFO - 'download_symbols': 'ondemand', 07:56:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:20 INFO - 'installer_path': 'installer.exe', 07:56:20 INFO - 'log_level': 'info', 07:56:20 INFO - 'log_name': 'talos', 07:56:20 INFO - 'log_to_console': True, 07:56:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:56:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:56:20 INFO - 'opt_config_files': (), 07:56:20 INFO - 'pip_index': False, 07:56:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:20 INFO - 'cmd': ('bash', 07:56:20 INFO - '-c', 07:56:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:20 INFO - 'enabled': True, 07:56:20 INFO - 'halt_on_failure': False, 07:56:20 INFO - 'name': 'check_screen_resolution'},), 07:56:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:20 INFO - 'cmd': ('bash', 07:56:20 INFO - '-c', 07:56:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:20 INFO - 'enabled': True, 07:56:20 INFO - 'halt_on_failure': False, 07:56:20 INFO - 'name': 'check_screen_resolution'},), 07:56:20 INFO - 'run_cmd_checks_enabled': True, 07:56:20 INFO - 'sps_profile': False, 07:56:20 INFO - 'sps_profile_interval': 0, 07:56:20 INFO - 'suite': 'dromaeojs', 07:56:20 INFO - 'system_bits': '32', 07:56:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:20 INFO - 'title': 't-yosemite-r7-0128', 07:56:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:20 INFO - 'use_talos_json': True, 07:56:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:20 INFO - 'work_dir': 'build'} 07:56:20 INFO - [mozharness: 2017-03-01 15:56:20.072887Z] Running clobber step. 07:56:20 INFO - Running pre-action listener: _resource_record_pre_action 07:56:20 INFO - Running main action method: clobber 07:56:20 INFO - rmtree: /builds/slave/test/build 07:56:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:22 INFO - Running post-action listener: _resource_record_post_action 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.699194Z] Finished clobber step (success) 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.699384Z] Running read-buildbot-config step. 07:56:22 INFO - Running pre-action listener: _resource_record_pre_action 07:56:22 INFO - Running main action method: read_buildbot_config 07:56:22 INFO - Using buildbot properties: 07:56:22 INFO - { 07:56:22 INFO - "project": "", 07:56:22 INFO - "product": "firefox", 07:56:22 INFO - "script_repo_revision": "production", 07:56:22 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:56:22 INFO - "repository": "", 07:56:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:56:22 INFO - "buildid": "20170301065222", 07:56:22 INFO - "pgo_build": "False", 07:56:22 INFO - "basedir": "/builds/slave/test", 07:56:22 INFO - "buildnumber": 5, 07:56:22 INFO - "slavename": "t-yosemite-r7-0128", 07:56:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:56:22 INFO - "platform": "yosemite_r7", 07:56:22 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:56:22 INFO - "branch": "mozilla-aurora", 07:56:22 INFO - "repo_path": "releases/mozilla-aurora", 07:56:22 INFO - "revision": "95d5cceb04c19391e691937194f25baaf0ee4dcf", 07:56:22 INFO - "stage_platform": "macosx64", 07:56:22 INFO - "builduid": "be78747dd9bd46d9b165551816d70a3a", 07:56:22 INFO - "slavebuilddir": "test" 07:56:22 INFO - } 07:56:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 07:56:22 INFO - Running post-action listener: _resource_record_post_action 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.702840Z] Finished read-buildbot-config step (success) 07:56:22 INFO - [mozharness: 2017-03-01 15:56:22.702975Z] Running download-and-extract step. 07:56:22 INFO - Running pre-action listener: _resource_record_pre_action 07:56:22 INFO - Running main action method: download_and_extract 07:56:22 INFO - mkdir: /builds/slave/test/build/tests 07:56:22 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')]} 07:56:22 INFO - trying https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 07:56:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 07:56:24 INFO - Downloaded 1199 bytes. 07:56:24 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 07:56:24 INFO - Using the following test package requirements: 07:56:24 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:56:24 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 07:56:24 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 07:56:24 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'jsshell-mac.zip'], 07:56:24 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 07:56:24 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 07:56:24 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 07:56:24 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 07:56:24 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 07:56:24 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 07:56:24 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 07:56:24 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:56:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:56:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:56:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:56:25 INFO - Expected file size: 16357790 07:56:25 INFO - Obtained file size: 16357790 07:56:31 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:56:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 07:56:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:56:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 07:56:32 INFO - Expected file size: 16357790 07:56:32 INFO - Obtained file size: 16357790 07:56:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 07:56:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:56:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 07:56:40 INFO - Expected file size: 14403472 07:56:40 INFO - Obtained file size: 14403472 07:56:40 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')]} 07:56:40 INFO - trying https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:56:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 07:56:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 07:56:42 INFO - Downloaded 73900891 bytes. 07:56:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:56:42 INFO - mkdir: /builds/slave/test/properties 07:56:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:56:42 INFO - Writing to file /builds/slave/test/properties/build_url 07:56:42 INFO - Contents: 07:56:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 07:56:43 INFO - Running post-action listener: _resource_record_post_action 07:56:43 INFO - Running post-action listener: set_extra_try_arguments 07:56:43 INFO - [mozharness: 2017-03-01 15:56:43.275649Z] Finished download-and-extract step (success) 07:56:43 INFO - [mozharness: 2017-03-01 15:56:43.275797Z] Running populate-webroot step. 07:56:43 INFO - Running pre-action listener: _resource_record_pre_action 07:56:43 INFO - Running main action method: populate_webroot 07:56:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:56:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:56:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:56:43 INFO - '--tppagecycles', 07:56:43 INFO - '7'], 07:56:43 INFO - 'tests': ['tsvgm']}}, 07:56:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:56:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:56:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:56:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:56:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:56:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['damp', 'tps']}, 07:56:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'tests': ['damp', 'tps']}, 07:56:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['dromaeo_dom']}, 07:56:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:56:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['basic_compositor_video']}, 07:56:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:56:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other-e10s': {'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['a11yr', 07:56:43 INFO - 'ts_paint', 07:56:43 INFO - 'tpaint', 07:56:43 INFO - 'sessionrestore', 07:56:43 INFO - 'sessionrestore_no_auto_restore', 07:56:43 INFO - 'tabpaint']}, 07:56:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tsvgx', 07:56:43 INFO - 'tsvgr_opacity', 07:56:43 INFO - 'tart', 07:56:43 INFO - 'tscrollx', 07:56:43 INFO - 'cart', 07:56:43 INFO - 'tsvg_static']}, 07:56:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:56:43 INFO - 'tsvgr_opacity', 07:56:43 INFO - 'tart', 07:56:43 INFO - 'tscrollx', 07:56:43 INFO - 'cart', 07:56:43 INFO - 'tsvg_static']}, 07:56:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s'], 07:56:43 INFO - 'tests': ['tp5o']}, 07:56:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:56:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--disable-e10s', 07:56:43 INFO - '--xperf_path', 07:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:43 INFO - 'tests': ['tp5n']}, 07:56:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:56:43 INFO - 'talos_options': ['--xperf_path', 07:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:56:43 INFO - 'tests': ['tp5n']}}, 07:56:43 INFO - 'talos.zip': {'path': '', 07:56:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:56:43 INFO - Running post-action listener: _resource_record_post_action 07:56:43 INFO - [mozharness: 2017-03-01 15:56:43.294373Z] Finished populate-webroot step (success) 07:56:43 INFO - [mozharness: 2017-03-01 15:56:43.294507Z] Running create-virtualenv step. 07:56:43 INFO - Running pre-action listener: _resource_record_pre_action 07:56:43 INFO - Running main action method: create_virtualenv 07:56:43 INFO - Creating virtualenv /builds/slave/test/build/venv 07:56:43 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 07:56:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:56:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:56:43 INFO - Using real prefix '/tools/python27' 07:56:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:56:44 INFO - Installing distribute.............................................................................................................................................................................................done. 07:56:46 INFO - Installing pip.................done. 07:56:46 INFO - Return code: 0 07:56:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:56:47 INFO - Reading from file tmpfile_stdout 07:56:47 INFO - Output received: 07:56:47 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) 07:56:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:56:47 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')]} 07:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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')]} 07:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:56:47 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 07:56:47 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 07:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:47 INFO - 'HOME': '/Users/cltbld', 07:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:47 INFO - 'LOGNAME': 'cltbld', 07:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:47 INFO - 'MOZ_NO_REMOTE': '1', 07:56:47 INFO - 'NO_EM_RESTART': '1', 07:56:47 INFO - 'PAGER': '/bin/cat', 07:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:47 INFO - 'PWD': '/builds/slave/test', 07:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:47 INFO - 'SHELL': '/bin/bash', 07:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:56:47 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:47 INFO - 'USER': 'cltbld', 07:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:47 INFO - 'XPC_FLAGS': '0x0', 07:56:47 INFO - 'XPC_SERVICE_NAME': '0', 07:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:47 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 07:56:47 INFO - Cleaning up... 07:56:47 INFO - Return code: 0 07:56:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:56:47 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')]} 07:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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')]} 07:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:47 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:56:47 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 07:56:47 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 07:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:47 INFO - 'HOME': '/Users/cltbld', 07:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:47 INFO - 'LOGNAME': 'cltbld', 07:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:47 INFO - 'MOZ_NO_REMOTE': '1', 07:56:47 INFO - 'NO_EM_RESTART': '1', 07:56:47 INFO - 'PAGER': '/bin/cat', 07:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:47 INFO - 'PWD': '/builds/slave/test', 07:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:47 INFO - 'SHELL': '/bin/bash', 07:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:56:47 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:47 INFO - 'USER': 'cltbld', 07:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:47 INFO - 'XPC_FLAGS': '0x0', 07:56:47 INFO - 'XPC_SERVICE_NAME': '0', 07:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:47 INFO - Downloading/unpacking psutil>=3.1.1 07:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:56:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:51 INFO - Installing collected packages: psutil 07:56:51 INFO - Running setup.py install for psutil 07:56:51 INFO - building 'psutil._psutil_osx' extension 07:56:51 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 07:56:52 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 07:56:52 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 07:56:52 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 07:56:52 INFO - building 'psutil._psutil_posix' extension 07:56:52 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 07:56:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:56:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:56:52 INFO - ^ 07:56:52 INFO - 1 warning generated. 07:56:52 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 07:56:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:56:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:56:52 INFO - Successfully installed psutil 07:56:52 INFO - Cleaning up... 07:56:52 INFO - Return code: 0 07:56:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:56:52 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')]} 07:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:52 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')]} 07:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:52 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:56:52 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 07:56:52 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 07:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:52 INFO - 'HOME': '/Users/cltbld', 07:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:52 INFO - 'LOGNAME': 'cltbld', 07:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:52 INFO - 'MOZ_NO_REMOTE': '1', 07:56:52 INFO - 'NO_EM_RESTART': '1', 07:56:52 INFO - 'PAGER': '/bin/cat', 07:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:52 INFO - 'PWD': '/builds/slave/test', 07:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:52 INFO - 'SHELL': '/bin/bash', 07:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:56:52 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:52 INFO - 'USER': 'cltbld', 07:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:52 INFO - 'XPC_FLAGS': '0x0', 07:56:52 INFO - 'XPC_SERVICE_NAME': '0', 07:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:56:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:56:55 INFO - Installing collected packages: mozsystemmonitor 07:56:55 INFO - Running setup.py install for mozsystemmonitor 07:56:55 INFO - Successfully installed mozsystemmonitor 07:56:55 INFO - Cleaning up... 07:56:56 INFO - Return code: 0 07:56:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:56: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')]} 07:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56: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')]} 07:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:56 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:56:56 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 07:56:56 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 07:56:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:56:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:56 INFO - 'HOME': '/Users/cltbld', 07:56:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:56 INFO - 'LOGNAME': 'cltbld', 07:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:56 INFO - 'MOZ_NO_REMOTE': '1', 07:56:56 INFO - 'NO_EM_RESTART': '1', 07:56:56 INFO - 'PAGER': '/bin/cat', 07:56:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:56 INFO - 'PWD': '/builds/slave/test', 07:56:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:56 INFO - 'SHELL': '/bin/bash', 07:56:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:56:56 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:56:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:56 INFO - 'USER': 'cltbld', 07:56:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:56 INFO - 'XPC_FLAGS': '0x0', 07:56:56 INFO - 'XPC_SERVICE_NAME': '0', 07:56:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:56 INFO - Downloading/unpacking jsonschema==2.5.1 07:56:56 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 07:56:56 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 07:56:56 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 07:56:56 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 07:56:56 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 07:56:56 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 07:56:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:56:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56: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 07:56:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:56:59 INFO - warning: no files found matching '*.txt' 07:56:59 INFO - no previously-included directories found matching 'build' 07:56:59 INFO - no previously-included directories found matching 'dist' 07:56:59 INFO - no previously-included directories found matching '.git*' 07:56:59 INFO - Installing collected packages: jsonschema, functools32 07:56:59 INFO - Running setup.py install for functools32 07:56:59 INFO - warning: no files found matching '*.txt' 07:56:59 INFO - no previously-included directories found matching 'build' 07:56:59 INFO - no previously-included directories found matching 'dist' 07:56:59 INFO - no previously-included directories found matching '.git*' 07:56:59 INFO - Successfully installed jsonschema functools32 07:56:59 INFO - Cleaning up... 07:56:59 INFO - Return code: 0 07:56:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:56:59 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')]} 07:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:59 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')]} 07:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:59 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:56:59 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 07:56:59 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 07:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:59 INFO - 'HOME': '/Users/cltbld', 07:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:59 INFO - 'LOGNAME': 'cltbld', 07:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:59 INFO - 'MOZ_NO_REMOTE': '1', 07:56:59 INFO - 'NO_EM_RESTART': '1', 07:56:59 INFO - 'PAGER': '/bin/cat', 07:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:59 INFO - 'PWD': '/builds/slave/test', 07:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:59 INFO - 'SHELL': '/bin/bash', 07:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:56:59 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:59 INFO - 'USER': 'cltbld', 07:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:59 INFO - 'XPC_FLAGS': '0x0', 07:56:59 INFO - 'XPC_SERVICE_NAME': '0', 07:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:56:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:56:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:56:59 INFO - Cleaning up... 07:56:59 INFO - Return code: 0 07:56:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:56:59 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')]} 07:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:56:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:59 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')]} 07:56:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:56:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:56:59 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:56:59 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 07:56:59 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 07:56:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:56:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:56:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:56:59 INFO - 'HOME': '/Users/cltbld', 07:56:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:56:59 INFO - 'LOGNAME': 'cltbld', 07:56:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:56:59 INFO - 'MOZ_NO_REMOTE': '1', 07:56:59 INFO - 'NO_EM_RESTART': '1', 07:56:59 INFO - 'PAGER': '/bin/cat', 07:56:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:56:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:56:59 INFO - 'PWD': '/builds/slave/test', 07:56:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:56:59 INFO - 'SHELL': '/bin/bash', 07:56:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:56:59 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:56:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:56:59 INFO - 'USER': 'cltbld', 07:56:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:56:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:56:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:56:59 INFO - 'XPC_FLAGS': '0x0', 07:56:59 INFO - 'XPC_SERVICE_NAME': '0', 07:56:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:57:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:57:02 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 07:57:02 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 07:57:02 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 07:57:02 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 07:57:02 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 07:57:02 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 07:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:57:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:57:03 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 07:57:03 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 07:57:03 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 07:57:03 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 07:57:03 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 07:57:03 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 07:57:03 INFO - Downloading docopt-0.6.1.tar.gz 07:57:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:57:04 INFO - Installing collected packages: blobuploader, requests, docopt 07:57:04 INFO - Running setup.py install for blobuploader 07:57:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:57:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:57:04 INFO - Running setup.py install for requests 07:57:04 INFO - Running setup.py install for docopt 07:57:04 INFO - Successfully installed blobuploader requests docopt 07:57:04 INFO - Cleaning up... 07:57:04 INFO - Return code: 0 07:57:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57: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')]} 07:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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')]} 07:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:04 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:57:04 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 07:57:04 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 07:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:04 INFO - 'HOME': '/Users/cltbld', 07:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:04 INFO - 'LOGNAME': 'cltbld', 07:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:04 INFO - 'MOZ_NO_REMOTE': '1', 07:57:04 INFO - 'NO_EM_RESTART': '1', 07:57:05 INFO - 'PAGER': '/bin/cat', 07:57:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:05 INFO - 'PWD': '/builds/slave/test', 07:57:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:05 INFO - 'SHELL': '/bin/bash', 07:57:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:57:05 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:57:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:05 INFO - 'USER': 'cltbld', 07:57:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:05 INFO - 'XPC_FLAGS': '0x0', 07:57:05 INFO - 'XPC_SERVICE_NAME': '0', 07:57:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-O3QpJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-Bm5QAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-kcLzBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-ZOnKqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-l6fj0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-vP0Ctp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-5_oRFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:05 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-nJvo5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-RRZ4DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-FsILgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-MC_C93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-W4Ynob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-tNaUSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-rsiiwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-lTDWK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-sVJhMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:06 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-cjOSx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:57:07 INFO - Running setup.py install for manifestparser 07:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozcrash 07:57:07 INFO - Running setup.py install for mozdebug 07:57:07 INFO - Running setup.py install for mozdevice 07:57:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozfile 07:57:07 INFO - Running setup.py install for mozhttpd 07:57:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:57:07 INFO - Running setup.py install for mozinfo 07:57:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for mozInstall 07:57:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for mozleak 07:57:08 INFO - Running setup.py install for mozlog 07:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for moznetwork 07:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:57:08 INFO - Running setup.py install for mozprocess 07:57:08 INFO - Running setup.py install for mozprofile 07:57:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Running setup.py install for mozrunner 07:57:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Running setup.py install for mozscreenshot 07:57:09 INFO - Running setup.py install for moztest 07:57:09 INFO - Running setup.py install for mozversion 07:57:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:57:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:57:09 INFO - Cleaning up... 07:57:09 INFO - Return code: 0 07:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:09 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:57:09 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 07:57:09 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 07:57:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:57:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:09 INFO - 'HOME': '/Users/cltbld', 07:57:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:09 INFO - 'LOGNAME': 'cltbld', 07:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:09 INFO - 'MOZ_NO_REMOTE': '1', 07:57:09 INFO - 'NO_EM_RESTART': '1', 07:57:09 INFO - 'PAGER': '/bin/cat', 07:57:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:09 INFO - 'PWD': '/builds/slave/test', 07:57:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:09 INFO - 'SHELL': '/bin/bash', 07:57:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:57:09 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:57:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:09 INFO - 'USER': 'cltbld', 07:57:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:09 INFO - 'XPC_FLAGS': '0x0', 07:57:09 INFO - 'XPC_SERVICE_NAME': '0', 07:57:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:09 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-tCIwnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-7NOLTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-hmyH7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-Av9bz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-ITK0bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-l2FJXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-GD0P3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-x2DS2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-hEeG3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:10 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)) 07:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:10 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-CdT24b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-WFEGh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-3zV78i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-o6U4cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-NFnggj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-ruNBI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-QMdiqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:11 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)) 07:57:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:11 INFO - Running setup.py (path:/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/pip-INhKfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:11 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)) 07:57:11 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)) 07:57:11 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)) 07:57:11 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)) 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:57:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57:11 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 07:57:11 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 07:57:11 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 07:57:11 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 07:57:11 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 07:57:11 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 07:57:14 INFO - Downloading blessings-1.6.tar.gz 07:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:57:14 INFO - Installing collected packages: blessings 07:57:14 INFO - Running setup.py install for blessings 07:57:14 INFO - Successfully installed blessings 07:57:14 INFO - Cleaning up... 07:57:14 INFO - Return code: 0 07:57:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:15 INFO - Reading from file tmpfile_stdout 07:57:15 INFO - Current package versions: 07:57:15 INFO - blessings == 1.6 07:57:15 INFO - blobuploader == 1.2.4 07:57:15 INFO - docopt == 0.6.1 07:57:15 INFO - functools32 == 3.2.3-2 07:57:15 INFO - jsonschema == 2.5.1 07:57:15 INFO - manifestparser == 1.1 07:57:15 INFO - mozInstall == 1.12 07:57:15 INFO - mozcrash == 1.0 07:57:15 INFO - mozdebug == 0.1 07:57:15 INFO - mozdevice == 0.49 07:57:15 INFO - mozfile == 1.2 07:57:15 INFO - mozhttpd == 0.7 07:57:15 INFO - mozinfo == 0.9 07:57:15 INFO - mozleak == 0.1 07:57:15 INFO - mozlog == 3.4 07:57:15 INFO - moznetwork == 0.27 07:57:15 INFO - mozprocess == 0.24 07:57:15 INFO - mozprofile == 0.28 07:57:15 INFO - mozrunner == 6.13 07:57:15 INFO - mozscreenshot == 0.1 07:57:15 INFO - mozsystemmonitor == 0.3 07:57:15 INFO - moztest == 0.8 07:57:15 INFO - mozversion == 1.4 07:57:15 INFO - psutil == 3.1.1 07:57:15 INFO - requests == 1.2.3 07:57:15 INFO - wsgiref == 0.1.2 07:57:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:15 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')]} 07:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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')]} 07:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:57:15 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 07:57:15 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 07:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:15 INFO - 'HOME': '/Users/cltbld', 07:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:15 INFO - 'LOGNAME': 'cltbld', 07:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:15 INFO - 'MOZ_NO_REMOTE': '1', 07:57:15 INFO - 'NO_EM_RESTART': '1', 07:57:15 INFO - 'PAGER': '/bin/cat', 07:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:15 INFO - 'PWD': '/builds/slave/test', 07:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:15 INFO - 'SHELL': '/bin/bash', 07:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:57:15 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:15 INFO - 'USER': 'cltbld', 07:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:15 INFO - 'XPC_FLAGS': '0x0', 07:57:15 INFO - 'XPC_SERVICE_NAME': '0', 07:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 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)) 07:57:15 INFO - Cleaning up... 07:57:15 INFO - Return code: 0 07:57:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:57:15 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')]} 07:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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')]} 07:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:15 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 0x110001b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110004768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc72057e9b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, '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.ybst9jEyhn/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.x9MovjtfyI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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 07:57:15 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 07:57:15 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 07:57:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:57:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:15 INFO - 'HOME': '/Users/cltbld', 07:57:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:15 INFO - 'LOGNAME': 'cltbld', 07:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:15 INFO - 'MOZ_NO_REMOTE': '1', 07:57:15 INFO - 'NO_EM_RESTART': '1', 07:57:15 INFO - 'PAGER': '/bin/cat', 07:57:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:15 INFO - 'PWD': '/builds/slave/test', 07:57:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:15 INFO - 'SHELL': '/bin/bash', 07:57:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:57:15 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:57:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:15 INFO - 'USER': 'cltbld', 07:57:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:15 INFO - 'XPC_FLAGS': '0x0', 07:57:15 INFO - 'XPC_SERVICE_NAME': '0', 07:57:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:57:15 INFO - Cleaning up... 07:57:15 INFO - Return code: 0 07:57:15 INFO - Running post-action listener: _resource_record_post_action 07:57:15 INFO - Running post-action listener: _start_resource_monitoring 07:57:15 INFO - Starting resource monitoring. 07:57:15 INFO - [mozharness: 2017-03-01 15:57:15.658695Z] Finished create-virtualenv step (success) 07:57:15 INFO - [mozharness: 2017-03-01 15:57:15.659664Z] Running install step. 07:57:15 INFO - Running pre-action listener: _resource_record_pre_action 07:57:15 INFO - Running main action method: install 07:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:15 INFO - Reading from file tmpfile_stdout 07:57:15 INFO - Detecting whether we're running mozinstall >=1.0... 07:57:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:57:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:57:16 INFO - Reading from file tmpfile_stdout 07:57:16 INFO - Output received: 07:57:16 INFO - Usage: mozinstall [options] installer 07:57:16 INFO - Options: 07:57:16 INFO - -h, --help show this help message and exit 07:57:16 INFO - -d DEST, --destination=DEST 07:57:16 INFO - Directory to install application into. [default: 07:57:16 INFO - "/builds/slave/test"] 07:57:16 INFO - --app=APP Application being installed. [default: firefox] 07:57:16 INFO - mkdir: /builds/slave/test/build/application 07:57:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:57:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:57:35 INFO - Reading from file tmpfile_stdout 07:57:35 INFO - Output received: 07:57:35 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:57:35 INFO - Running post-action listener: _resource_record_post_action 07:57:35 INFO - [mozharness: 2017-03-01 15:57:35.927696Z] Finished install step (success) 07:57:35 INFO - [mozharness: 2017-03-01 15:57:35.927854Z] Running run-tests step. 07:57:35 INFO - Running pre-action listener: _resource_record_pre_action 07:57:35 INFO - Running main action method: run_tests 07:57:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:57:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:57:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:57:35 INFO - 2017-03-01 07:57:35.942 screenresolution[1631:7898] starting screenresolution argv=screenresolution get 07:57:35 INFO - 2017-03-01 07:57:35.945 screenresolution[1631:7898] Display 0: 1600x1200x32@60 07:57:35 INFO - 2017-03-01 07:57:35.951 screenresolution[1632:7901] starting screenresolution argv=screenresolution list 07:57:35 INFO - Available Modes on Display 0 07:57:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:57:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:57:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:57:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:57:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:57:36 INFO - Intel Iris: 07:57:36 INFO - Chipset Model: Intel Iris 07:57:36 INFO - Type: GPU 07:57:36 INFO - Bus: Built-In 07:57:36 INFO - VRAM (Dynamic, Max): 1536 MB 07:57:36 INFO - Vendor: Intel (0x8086) 07:57:36 INFO - Device ID: 0x0a2e 07:57:36 INFO - Revision ID: 0x0009 07:57:36 INFO - Displays: 07:57:36 INFO - Display: 07:57:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:57:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:57:36 INFO - Display Serial Number: 1600x1200 60 07:57:36 INFO - Main Display: Yes 07:57:36 INFO - Mirror: Off 07:57:36 INFO - Online: Yes 07:57:36 INFO - Rotation: Supported 07:57:36 INFO - Return code: 0 07:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:57:36 INFO - Python 2.7.3 07:57:36 INFO - Return code: 0 07:57:36 INFO - grabbing minidump binary from tooltool 07:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:36 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 0x10fddfd30>, '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 0x10fd06db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fdd4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:57:36 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 07:57:36 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 07:57:36 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 07:57:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:57:36 INFO - Return code: 0 07:57:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:57:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:57:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:57:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:57:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 07:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0128 --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 07:57:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybst9jEyhn/Render', 07:57:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:36 INFO - 'HOME': '/Users/cltbld', 07:57:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:36 INFO - 'LOGNAME': 'cltbld', 07:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:36 INFO - 'MOZ_NO_REMOTE': '1', 07:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:57:36 INFO - 'NO_EM_RESTART': '1', 07:57:36 INFO - 'PAGER': '/bin/cat', 07:57:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:36 INFO - 'PWD': '/builds/slave/test', 07:57:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:57:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:36 INFO - 'SHELL': '/bin/bash', 07:57:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x9MovjtfyI/Listeners', 07:57:36 INFO - 'TMPDIR': '/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/', 07:57:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:36 INFO - 'USER': 'cltbld', 07:57:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:36 INFO - 'XPC_FLAGS': '0x0', 07:57:36 INFO - 'XPC_SERVICE_NAME': '0', 07:57:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0128', '--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 07:57:36 INFO - mozversion application_buildid: 20170301065222 07:57:36 INFO - mozversion application_changeset: 95d5cceb04c19391e691937194f25baaf0ee4dcf 07:57:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:57:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:57:36 INFO - mozversion application_name: Firefox 07:57:36 INFO - mozversion application_remotingname: firefox-dev 07:57:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:57:36 INFO - mozversion application_vendor: Mozilla 07:57:36 INFO - mozversion application_version: 53.0a2 07:57:36 INFO - mozversion platform_buildid: 20170301065222 07:57:36 INFO - mozversion platform_changeset: 95d5cceb04c19391e691937194f25baaf0ee4dcf 07:57:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:57:36 INFO - mozversion platform_version: 53.0a2 07:57:36 INFO - using testdate: 1488383856 07:57:36 INFO - actual date: 1488383856 07:57:36 INFO - starting webserver on 'localhost:49250' 07:57:36 INFO - SUITE-START | Running 2 tests 07:57:36 INFO - TEST-START | dromaeo_css 07:57:36 INFO - operating with platform_type : mac_ 07:57:36 INFO - Initialising browser for dromaeo_css test... 07:57:36 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpyu93rQ/profile http://localhost:49250/getInfo.html) 07:57:37 INFO - PROCESS | 1642 | 1488383857071 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:57:37 INFO - PROCESS | 1642 | 1488383857072 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 07:57:37 INFO - PROCESS | 1642 | 1488383857108 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:57:39 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 07:57:39 INFO - PROCESS | 1642 | colorDepth:24 07:57:39 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 07:57:39 INFO - PROCESS | 1642 | __metrics 07:57:39 INFO - PROCESS | 1642 | 1488383859191 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 07:57:39 INFO - PROCESS | 1642 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:57:39 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:57:39 INFO - TEST-INFO | 1642: exit 0 07:57:39 INFO - Browser initialized. 07:57:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:57:39 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpyu93rQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:40 INFO - PROCESS | 1645 | 1488383860252 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 07:57:40 INFO - PROCESS | 1645 | 1488383860253 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 07:57:51 INFO - PROCESS | 1645 | RSS: Main: 212848640 07:57:51 INFO - PROCESS | 1645 | 08:00:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 08:00:57 INFO - PROCESS | 1645 | RSS: Main: 386985984 08:00:57 INFO - PROCESS | 1645 | 08:02:41 INFO - PROCESS | 1645 | ************************* 08:02:41 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 08:02:41 INFO - PROCESS | 1645 | 08:02:41 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:02:41 INFO - PROCESS | 1645 | Full stack: 08:02:41 INFO - PROCESS | 1645 | ************************* 08:04:00 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 08:04:01 INFO - PROCESS | 1645 | RSS: Main: 363839488 08:04:01 INFO - PROCESS | 1645 | 08:07:03 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 08:07:04 INFO - PROCESS | 1645 | RSS: Main: 331350016 08:07:04 INFO - PROCESS | 1645 | 08:10:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 08:10:07 INFO - PROCESS | 1645 | RSS: Main: 315895808 08:10:07 INFO - PROCESS | 1645 | 08:13:10 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 08:13:11 INFO - PROCESS | 1645 | RSS: Main: 312729600 08:13:11 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 08:16:14 INFO - PROCESS | 1645 | RSS: Main: 469188608 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | __start_tp_report 08:16:14 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 08:16:14 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 08:16:14 INFO - PROCESS | 1645 | |i|pagename|runs| 08:16:14 INFO - PROCESS | 1645 | |0;dojo.html;3082.7225549700524;3343.0305211488662;3354.9329013419733;3362.377960077384;3403.3193361327726;5742.339630942438;5757.712114394284;5760.683162426065;5774.162746401769;5788.5369170466365;5646.322441307049;5750.453706897849;5753.050746626812;5756.654600723949;5766.654000759947;5159.432462429139;5191.195364718475;5219.217117432378;5234.7120908350025;5267.55225805807;5193.16909294513;5196.220566914974;5217.58259339252;5272.156454967206;5308.920366194491;5266.499682530172;5285;5293.100172970604;5298.708571028592;5323;5319.468053194688;5329.653572517774;5329.840104796862;5333.959877823826;5339.6262261641505;5166.328377310925;5266.762995665166;5274.367075950872;5283.815066472694;5307.071262529081;5592.804251851166;5662.490375866192;5853.47318741311;5853.912191317134;5926.822195334147;6089.878202435971;6129.233845769279;6152.892479353714;6154.384561543855;6283.905741413882;5229.633925625208;6237.656928868911;6244.781432649881;6254.280757712876;6262.530310226751;5817.243758311435;5916.112583112525;5944.138099975479;5948.434898684618;5957.702114894281;6174.25908890927;6199.535034872402;6232.034034724625;6249.312575616678;6278.277998030285;6212.751489940442;6216.564840461215;6219.191505104308;6230.314665386803;6232;6211.16149319845;6233.875322493524;6245.156903817927;6246.781362652286;6262.3111457739615;6125.937554509019;6131.080337949344;6150.446459818638;6157.291911430243;6169.753209871645;6181.7527298908435;6220;6231.345708700612;6233.563650544418;6252.3122456529745;5034.597232221414;5039.97480012605;5043.52086551777;5047.4447810740785;5070.391553013588;4402.8679139625865;4458.6878918475395;4465.709728867613;4511.390962220124;4522.909541809211;5689.800856969986;5739.426057394311;5764.452377024176;5774.364819869811;5812.622179558315;6086.573939824259;6210.813675589739;6230.096635987847;6232.501399888089;6241.313455519889;5655.830325090254;5709.25779648643;5713;5716.657000579979;5730.283714535683;5373.301470808769;5434.565234781208;5438.102713052302;5445.37378201504;5446.700431476307;6248.593841400295;6256.5307601930945;6258.092576576371;6259.655718935411;6262.060690896402;6177.505799535937;6216.316205217332;6217.036359364125;6222.937770622417;6226.59527130735;6195.938040619536;6227.750889964351;6242.188515492957;6336.841578960563;6342;6144.41628045335;6176.69116544162;6207.224096987877;6208.50331973432;6219.222597175353;5299.205119232146;6127.632342059491;6209.0686397039;6231.4391704746795;6231.532635052298;5784.595078344475;6076.90884636722;6092.634441933498;6151.5386346025125;6171.6297022178815;6093.268807743099;6110.953680641605;6117.877642447215;6129.540284478771;6132.2947860996555;5897.616654917417;5988;6015.879682406415;6017.879642407215;6062.636241825505;6116.724747386289;6139.2325959255095;6143.262808463013;6159.907601385893;6160.291566469913;5805.941940580709;5878.29460464747;6016.308124565556;6032.276126864805;6037.45662890342 08:16:14 INFO - PROCESS | 1645 | |1;ext.html;472.6455158631027;524.0907026309353;532.8854296326289;533.4905165566884;540.1492649077701;30426.391472170544;33300.50049249263;41972.58027419725;42116.36825447613;44789.7760511197;44633.77683111588;44937.55062449374;45081.77459112708;45117.09765804682;45326.32010519845;8314.210150035768;9176.8623470648;9341.719748407559;9385.296102792283;9390.06099390059;8305.003399592057;11058.778824423507;11282.943585282062;11297.604583839568;11513.942430287836;11302.378369189692;11354.71613209668;11386.37374944382;11403.3728144952;11404.828927566094;8350.415470917038;11153.275037122601;11217.326960382403;11272.887271127265;11283.210175287733;8345.582720863933;11132.16508761838;11441.970222679916;11465.369404682739;11468.885311146865;41878.371824422655;42205.78897105495;42361;42375.36436953448;42375.78812105951;3939.803009849496;3973.304671682444;3977.7016723745833;3991.4611527444004;4030.838766449368;29671.554926676115;30815.845920770476;31170.376592468252;31517;31941.72233110696;3065.4941934580766;3136.40408322418;3154.2587491939375;3161.9051428457183;3173.1591128350774;474422;474617.6269118667;476376;477154;478939;67607;68025.63948720998;68065.65967170232;68176.31823681798;68260.6586967062;72077.6396118016;72201;72201.66789992618;72270;72331.63834180795;14959.177245251616;15513.069215847085;15517;15542.689146217012;15571.532854014398;10516.57933682644;10774.46127693628;11287.209895307415;11520.884791152148;11632.88367116318;19335.323263685703;19469.221231150594;19548.51128721765;19998.800011999694;20202.494937626678;5724.627899186539;5743.310802703619;6001.099835024781;6760.492963027694;6817.5568588041615;873.4497266721925;876.7812740291;882.2633101360308;900.1403659505288;911.8495448251097;29305;30322.090337289916;30422;30435;30549.23626909345;1051.4322265976286;1054.3568423261804;1089.6022951622601;1097.9560817567208;1176.3294921894437;15517.267114120565;15634.06195628266;15799.605009874846;15902.76145857813;16431.5892102696;243082;243958;244723;246176;602278;63054;63237.683811580646;63275.68362158252;63453;63706;1385.1965859801492;1418.5035237666941;1439.8560143985517;1445.5663301009656;1447.4933773179514;28954.565681515214;29145.70854291515;29470.821167153932;29576.55635165431;30417.39165216639;52633.7368313156;52944;53094.46905530895;53114.73442632917;53202.73398632982;533794;533878;535060;536180;536790;34846.825765871006;41902.16195676009;42383.576164239195;42859;42970.78514607407;45926.31110533411;46009.30986035279;48267.5173248263;48323.516764831904;48529.75735121302;35465.82267088648;37023;39324.803375982934;40742.18515629612;40878.59121408748;35784.821075894455;36106.09734756652;37192.628073718915;37626.81186594049;38532.807335964266;35840.10399739923;35949;36328;36730.081747956516;36763.26473470569;30197.547036794906;30462.695373046874;32367.676323237407;32580.674193257764;32601;24200.878995604908;24277;24433.75566244315;24605.50788984246;24979.750202497744 08:16:14 INFO - PROCESS | 1645 | |2;jquery.html;338.4719837054196;364.8194143898767;384.8191350065469;384.84990853567115;413.8137837972911;13738.725225495484;14794.408223671053;15143.469978550753;20411.979401029963;21227.257046003393;20625.587488250265;21001.789982100174;21100.366988990354;21218.46953826155;22286.219982300623;5067.315912351841;5689.345725241588;5930.584859059867;5932.733027013774;5954.583179177459;5919.437653422918;6082.087686846964;6087.482563982045;6099.81700548982;6101.572889897709;3848.42273658952;4039.474868267121;4045.7167998240134;4051.0885050863467;4278.5935336143175;4356.128774245148;6604.339566043405;6675.232348279961;6680.7661731839635;6682.599044057372;5309.150535914274;5372.758225879845;5765.971170144165;5947.524198064188;5967.671778052206;13028;13264.86735132646;13330.933345333307;13349.132306400053;25056.874715626487;2514.635377870217;2563.090103013422;2579.1746641074865;2620.855852928088;2668.519666460036;10076.69769906904;10097.697069087939;10245.948770256102;10597.523111460003;10682.985116413929;1809.7556829827936;1833.651606194832;1853.2772218834666;1874.3346112130134;1876.1276006656833;114810;134176;143028.28485857608;143644;145997;11394.886051139549;11832.585859494877;11886;11928.403579821148;11943.940280298542;15885.126318052387;15911.443099491693;15913.443029493912;15932.840671593367;15969.44106956251;8177.386695997824;8355;8413.368997325102;8479.448835825775;8495.617697203517;7702.1912699166905;7874.960625196837;7900.723474678359;7970.402219833536;8143.982002249719;4682.6253899687945;4774.976125119421;4780.235162374003;4876.5854902332985;4880.463149053601;1990.7511561054869;2034.959300814005;2047.7133201351824;2053.5071582820315;2058.5882823435372;868.5830801215452;886.822635472908;891.5675897189858;919.6229545886155;929.697848199338;21420.678689819666;21858.562828743336;21920.561588768134;21991.560168796535;22025.449363766034;896.408370475483;906.7053207707389;911.1253196930888;914.3919293669635;938.2306508662967;10793.892061079447;11398.373089480157;11484.138689598314;11487.540498380138;11620.941895290469;763569;770622;779318;780833;791865;92052;145495.81756273666;155385;164275;165439;970.2238209432567;974.4202199691173;1013.1995723378595;1014.9898501015043;1015.7155996321042;19293.8070619292;19294.421167365002;19899.612046554506;20815.271465498634;20847.583048338645;52052;59547.80904381975;60773.39226607677;60888.69555652193;61399.079013815724;75594.62202688951;78616.60691696504;84613.7307940369;86206;87678.56160719156;7024.824379390556;7164.391026762783;8349.457285276438;8707.345604335156;8753.124687531195;11751.353675547927;13237.271950042456;13300.201987880759;13548.932255338661;13791.862081379059;11239;11324.773504529698;11452.656420307405;11456.656300311004;11609.593664221711;11330.60342887995;11558.30650160993;11619.128565357802;11700.414979251174;11793.528258869892;11329.886701132884;11674.883251167379;11778.82331765007;11856;11992.64022079339;7114.395276401357;7201;8421.073681894864;8671.956640216758;8698.60856261457;5534.944650553604;9786.75533111678;9959.555864399477;11469.139814513777;11780.52877884875 08:16:14 INFO - PROCESS | 1645 | |3;mootools.html;1402.0746307437087;1438.7122575484902;1448.7754398068303;1456.3155317001006;1456.5557504960982;8119;8504.829903401927;8529.701460448885;8532.018817835951;8548.871766923485;7562.697492100309;7774.611269436534;7801.687932482708;8086.757397278091;8348.540830254333;2109.52535679472;2166.7183266175375;2173.913043478259;2174.7281589801273;2180.4548862784304;2319.246244970391;2326.395137264315;2357.964630530543;2358.0332063853825;2361.362432143329;2046.7850875658064;2130.147940823675;2233.530958498717;2305.4351683837485;2330.731965823935;2316.895739691718;2327.5344931013697;2333.49829786595;2333.789958903707;2339.87130707811;2281.327008532487;2336.240721765433;2350.6826578411865;2370.4073981504625;2381.416552944522;8356.415050946436;8415.074341822394;8415.326773858076;8416.2004609562;8446.873296900552;5094.108531007059;5239.580833533309;5242;5247.790088396459;5247.921281180786;3169.6671849455706;3432.090496018557;3438.415469370188;3470.5661792275964;3549.8757543486113;1137.732632831284;1193.2601786892096;1194.5580135349976;1218.3116539155349;1220.5666988219143;10933.343999360064;10947.726306842313;10957.01386875177;10958.342499449978;11056.778864422748;4548.249538826057;4787.305840653085;4792.209285467929;4801.735904525215;4825.769428795705;8732.519711415933;8812.471251724917;8814.427062240933;8815.779605509786;8839.646414143363;5169.39748677911;5177.430482646906;5177.4822517747925;5179.974100129551;5185.455527169668;4605.838795642204;4722.858314250578;4813.518648135158;4813.855584332476;4835.081334546425;3874.1864208516527;3906.8046597670004;4003.4195041718785;4039.1315867088715;4048.4332193492933;1279.8848103670528;1295.779717448036;1301.4924179569975;1315.526410492222;1318.8394213092417;874.8233625773324;878.1087196495562;882.7219425880827;892.3842548641417;903.6024149374255;4457.952381190417;5746.569007324468;5751.194832723422;5813.360530341659;5995.340512543617;817.264461984219;957.1146689312498;990.7225976726528;1006.8288390973552;1034.1933292032227;3504.491848681927;3599.5140656011104;3705.518282623296;3726.8695595654563;3793.981030094832;7943.126256111823;9713.805723885484;9937.155341795884;9954.203663706887;9962;9670.274729395323;9853.852192217122;9899;9909.702708918743;9933.80132397348;6926.861462770717;6935.751564718298;7894.05271367451;7900;7922.970013898272;5197.558207552401;5294.258803767552;5319.38827034896;5512.779488820403;5626.2685850839125;8262.669493220204;9047.502387368759;9075.183233509017;9205.631774728936;9271.953640231755;8008.27925486709;8551.871721924052;9139.634414623606;9353.625854965725;9464.290178236522;6368.840778980562;7322.414206863332;7324.487285889936;7326.9267307326245;7332.890006649798;7591.278828511283;7745.535267883945;7810.648520816463;7813.296803287732;7818.413618978486;6931.272216417204;7051.5063945523325;7056.470764692566;7095.3968912643;7114.679839407343;7036.155661320674;7052.400545953651;7057.894131587927;7092.432605391453;7095.503314767917;6310.84222894413;6400.807975760735;6432.163818703539;6472.996685513753;6477.77327793525;4768.237082066853;4843.200871856246;4864.124457597525;4979.601631869514;5096.923546146885;4871.014420438159;4911.7298548580175;4917.827876024322;5034.647574669738;5073.949260507496 08:16:14 INFO - PROCESS | 1645 | |4;prototype.html;354.56034517198674;357.4013527341702;362.92741451709657;374.91939233064886;375.95488541375005;4658.277966915125;4668.299755036742;5151.162384023898;5439.700816455093;5452.127659574468;4143;4852.980874016461;5109.974450127754;5133.306009017025;5296.788128474856;3523.6476352364816;3899.6295351941662;4116.547179810218;4172.499300083987;4218.578142185787;3622.6739593436587;3716.2381711749163;4123.752574845504;4173.373993900909;4181.310083836179;4029.1740193260457;4100.8722601284735;4115.929858236865;4146.668266538685;4172.791360431981;3655.8978587312267;3957.445957565943;3991.92218101114;4129.669626429878;4138.213739389522;3076.384723055398;3336.7664263501565;3437.6764945495916;3626;3632.4188129899353;4542.409486766732;4762.261849413312;4863.659543831933;5050.318207042039;5131.794728210867;3920.803959802027;4400.911981760379;4721.834735784231;4757.739199112238;4828.372311599504;4696.862927368039;5131.5881535678545;5575.442455754433;5581.944180558183;5600.103983362643;4094.549599544048;4106.178764247133;4106.548279689232;4110.260153172428;4120.91758164835;5395.352557693062;5776.59563830532;5782.710864456761;5819.447152520546;5850.327212370589;3844.519435070616;3847.8653247136217;3851.480050193244;3854.3062248795486;3860.4595356650093;3910.921781564353;3932.508436445444;3945.8027098645525;3952.4268980998168;3956.2878681837547;4290.635295999812;4445.644348452116;4466.57567531084;4520.553422904704;4600;4644.95355046452;4947.356843610308;5238.4237733850005;5558.916616250759;5566.4990150886615;1092.415557676639;1185.6798664360574;1193.4927655746274;1201.225209739713;1269.9840127897644;827.7930517370658;836.5068352989883;879.2658130461009;880.0407555764248;911.6900253913568;4775.71345719251;4829.348038014893;4847.939625659081;4868.6649644993295;4908.889177653643;4828.975855120702;4872.781804548863;5282.947170528246;5399.487048730364;5466.594698332721;4165.66674666026;4511.436070491189;4604.562566556172;4850.975745121323;4865.416150061945;2669.8119336895284;2683.8529176658594;2850.688683205707;2864.8567571621334;2870.971290287112;4838.467768545457;5017.67385119966;5034.622403319766;5649.051077378298;5665.9716701417055;4907.509249075135;5106.540411362995;5107.67200527858;5168.914527949098;5210.114280572236;4846.806127754991;5143.459936706741;5500.697461639568;5534.889302214014;5540.448674371182;4417.980013429742;4664;5400.459954004726;5405.78376864921;5413.891722165614;4581.587657110876;5190.716084922622;5375.08623534008;5402.51644580743;5410.621256512164;4891.4347408828835;4946.653734238569;5656.64240582249;5661;5717.625432093819;3593.8203089845924;3788.2234142001375;3977.8607748728655;4004.4382690751213;4005.91988160241;4631.675782695179;4953.603711702983;5371.785128594813;5410.513053825174;5413.648112872651;4719.764011799465;4889.608831293559;5223.268742375994;5236.39781425141;5246.580273578028;3978.1905296798063;4703.717776933395;4840.7337596432535;5057.544820966131;5307.336582927134;4460.665450091321;4571.834182283496;4902.803887844446;5004.77478513475;5301.6818990860675;5424.294841670558;5433.3867977794325;5439.864003399946;5448.700321482356;5454.263829276958;4739.289106634033;5048.671836330626;5217.739113044408;5294.835136270014;5379.865503362447 08:16:14 INFO - PROCESS | 1645 | |5;yui.html;670.7015378156722;689.8827199376105;745.716627681481;767.5778321922943;786.9685212591495;14557.272136393178;15402.84597154028;15408.460703875367;15418.074915505063;15424.922875385635;10486.737831554196;12471.314077725721;12477.563285285018;12479.064070194749;12483;673.5588189735706;693.7329128285621;698.9899595085104;846.2299307630058;865.8225063861925;838.6603425612636;863.6588547523725;868.1492137705053;873.930085593151;880.2737741363369;926.5182105305237;927.3369540778342;928.1368327455464;928.6610387208653;929.5352323838081;713.1157364867527;921.0651189043126;923.3813345058827;924.2652091587238;927;541.0477559495278;658.0359772932677;680.4454369688688;685.0341019163006;685.4790359326897;14501.347439365149;14717.92641036788;14727;14739.263036848115;14743.262836858114;12878.484860605564;12948.611541653765;13008.479660813557;13018.153820001764;13062.477500899953;11386.772264554662;11605.941970290094;11649;11763.941180294043;12312.938435307766;3990.660793832528;4055;4173.6661067114865;4180.916381672349;4238.3430568261965;88417.78955526098;96342.036579634;100143;104262;105124;9720.319577629498;9806.215502759762;9873.160781333667;9959.900400996043;9965.850512242178;20031.298904538562;20047.599048018958;20067.397978060682;20613.278535251193;20676.793232067786;6737.663116844138;6779.457643388517;7183.497155199086;7264.309890560388;7268.273172682795;3701.4262789267705;3739.6634302912325;3770.490983717163;3790.77255364679;3881.650651441327;3386.1365351835125;3431.1765176357994;3462.6191118976894;3485.72114230866;3486.8430920608635;490.52419153421124;615.2371059885799;620.6276234259408;625.2621906150695;629.5089829932659;538.3324677400074;580.5732786401991;607.7265230646227;624.2166081567603;642.8714257148496;9070;9570.856437153448;9801.460919649488;9864.95067524672;10202.540885660163;552.7236381809096;570.6490508337342;570.7910386803098;629.9464545513682;671.8051764988196;4620.838270660511;4769.403824521934;4792.536359989865;4821.7589120544535;4878;72037;72474;74864.25135748682;76191.61904190555;78984;67520.66239668771;68205.65897170582;68751;69074;70830;61724.382756171864;61931.380686193464;62546.12361629158;62680.68659656764;63823.36176638267;10185.541650625888;10392.907435689178;10539;10615.31000484966;10661.573537058432;42286.36570451384;45176.77411612921;45515;46049.76975115103;48479.757601213176;56344.43655563392;59542;62779.6861015692;62817;63386.366136338045;12207.90706687267;12332.383380830743;12683.556075537312;13096.869031309565;13317.733645327233;13560;14226.644333891736;14268.42926282937;14396.280185990869;14606;12930.935345323212;13035.15271507349;13740.587782366545;13812.1022133561;14041.789373159616;13006.674833129247;13688.863111369157;14044.929775351058;14134.78797818013;14422.421386308039;12412.937935310627;12626.36868156607;13063.673408164872;13262.27057511846;13589.835504042712;10456.372617642966;10477.214208934512;10839.945800270949;10860.837087443537;11305.773884522428;9398.34211605181;10383.273170877967;11154;11311.886881131084;11348.829767553329 08:16:14 INFO - PROCESS | 1645 | __end_tp_report 08:16:14 INFO - PROCESS | 1645 | __start_cc_report 08:16:14 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1766 08:16:14 INFO - PROCESS | 1645 | __end_cc_report 08:16:14 INFO - PROCESS | 1645 | __startTimestamp1488384974811__endTimestamp 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | ------- Summary: start ------- 08:16:14 INFO - PROCESS | 1645 | Number of tests: 6 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5755.46 Median:6015.88 stddev:624.86 (10.4%) stddev-sans-first:590.56 08:16:14 INFO - PROCESS | 1645 | Values: 3082.7 3343.0 3354.9 3362.4 3403.3 5742.3 5757.7 5760.7 5774.2 5788.5 5646.3 5750.5 5753.1 5756.7 5766.7 5159.4 5191.2 5219.2 5234.7 5267.6 5193.2 5196.2 5217.6 5272.2 5308.9 5266.5 5285.0 5293.1 5298.7 5323.0 5319.5 5329.7 5329.8 5334.0 5339.6 5166.3 5266.8 5274.4 5283.8 5307.1 5592.8 5662.5 5853.5 5853.9 5926.8 6089.9 6129.2 6152.9 6154.4 6283.9 5229.6 6237.7 6244.8 6254.3 6262.5 5817.2 5916.1 5944.1 5948.4 5957.7 6174.3 6199.5 6232.0 6249.3 6278.3 6212.8 6216.6 6219.2 6230.3 6232.0 6211.2 6233.9 6245.2 6246.8 6262.3 6125.9 6131.1 6150.4 6157.3 6169.8 6181.8 6220.0 6231.3 6233.6 6252.3 5034.6 5040.0 5043.5 5047.4 5070.4 4402.9 4458.7 4465.7 4511.4 4522.9 5689.8 5739.4 5764.5 5774.4 5812.6 6086.6 6210.8 6230.1 6232.5 6241.3 5655.8 5709.3 5713.0 5716.7 5730.3 5373.3 5434.6 5438.1 5445.4 5446.7 6248.6 6256.5 6258.1 6259.7 6262.1 6177.5 6216.3 6217.0 6222.9 6226.6 6195.9 6227.8 6242.2 6336.8 6342.0 6144.4 6176.7 6207.2 6208.5 6219.2 5299.2 6127.6 6209.1 6231.4 6231.5 5784.6 6076.9 6092.6 6151.5 6171.6 6093.3 6111.0 6117.9 6129.5 6132.3 5897.6 5988.0 6015.9 6017.9 6062.6 6116.7 6139.2 6143.3 6159.9 6160.3 5805.9 5878.3 6016.3 6032.3 6037.5 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:60811.21 Median:36746.67 stddev:122427.44 (333.2%) stddev-sans-first:122687.07 08:16:14 INFO - PROCESS | 1645 | Values: 472.6 524.1 532.9 533.5 540.1 30426.4 33300.5 41972.6 42116.4 44789.8 44633.8 44937.6 45081.8 45117.1 45326.3 8314.2 9176.9 9341.7 9385.3 9390.1 8305.0 11058.8 11282.9 11297.6 11513.9 11302.4 11354.7 11386.4 11403.4 11404.8 8350.4 11153.3 11217.3 11272.9 11283.2 8345.6 11132.2 11442.0 11465.4 11468.9 41878.4 42205.8 42361.0 42375.4 42375.8 3939.8 3973.3 3977.7 3991.5 4030.8 29671.6 30815.8 31170.4 31517.0 31941.7 3065.5 3136.4 3154.3 3161.9 3173.2 474422.0 474617.6 476376.0 477154.0 478939.0 67607.0 68025.6 68065.7 68176.3 68260.7 72077.6 72201.0 72201.7 72270.0 72331.6 14959.2 15513.1 15517.0 15542.7 15571.5 10516.6 10774.5 11287.2 11520.9 11632.9 19335.3 19469.2 19548.5 19998.8 20202.5 5724.6 5743.3 6001.1 6760.5 6817.6 873.4 876.8 882.3 900.1 911.8 29305.0 30322.1 30422.0 30435.0 30549.2 1051.4 1054.4 1089.6 1098.0 1176.3 15517.3 15634.1 15799.6 15902.8 16431.6 243082.0 243958.0 244723.0 246176.0 602278.0 63054.0 63237.7 63275.7 63453.0 63706.0 1385.2 1418.5 1439.9 1445.6 1447.5 28954.6 29145.7 29470.8 29576.6 30417.4 52633.7 52944.0 53094.5 53114.7 53202.7 533794.0 533878.0 535060.0 536180.0 536790.0 34846.8 41902.2 42383.6 42859.0 42970.8 45926.3 46009.3 48267.5 48323.5 48529.8 35465.8 37023.0 39324.8 40742.2 40878.6 35784.8 36106.1 37192.6 37626.8 38532.8 35840.1 35949.0 36328.0 36730.1 36763.3 30197.5 30462.7 32367.7 32580.7 32601.0 24200.9 24277.0 24433.8 24605.5 24979.8 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:41023.38 Median:2571.13 stddev:129237.00 (5026.5%) stddev-sans-first:129563.43 08:16:14 INFO - PROCESS | 1645 | Values: 338.5 364.8 384.8 384.8 413.8 13738.7 14794.4 15143.5 20412.0 21227.3 20625.6 21001.8 21100.4 21218.5 22286.2 5067.3 5689.3 5930.6 5932.7 5954.6 5919.4 6082.1 6087.5 6099.8 6101.6 3848.4 4039.5 4045.7 4051.1 4278.6 4356.1 6604.3 6675.2 6680.8 6682.6 5309.2 5372.8 5766.0 5947.5 5967.7 13028.0 13264.9 13330.9 13349.1 25056.9 2514.6 2563.1 2579.2 2620.9 2668.5 10076.7 10097.7 10245.9 10597.5 10683.0 1809.8 1833.7 1853.3 1874.3 1876.1 114810.0 134176.0 143028.3 143644.0 145997.0 11394.9 11832.6 11886.0 11928.4 11943.9 15885.1 15911.4 15913.4 15932.8 15969.4 8177.4 8355.0 8413.4 8479.4 8495.6 7702.2 7875.0 7900.7 7970.4 8144.0 4682.6 4775.0 4780.2 4876.6 4880.5 1990.8 2035.0 2047.7 2053.5 2058.6 868.6 886.8 891.6 919.6 929.7 21420.7 21858.6 21920.6 21991.6 22025.4 896.4 906.7 911.1 914.4 938.2 10793.9 11398.4 11484.1 11487.5 11620.9 763569.0 770622.0 779318.0 780833.0 791865.0 92052.0 145495.8 155385.0 164275.0 165439.0 970.2 974.4 1013.2 1015.0 1015.7 19293.8 19294.4 19899.6 20815.3 20847.6 52052.0 59547.8 60773.4 60888.7 61399.1 75594.6 78616.6 84613.7 86206.0 87678.6 7024.8 7164.4 8349.5 8707.3 8753.1 11751.4 13237.3 13300.2 13548.9 13791.9 11239.0 11324.8 11452.7 11456.7 11609.6 11330.6 11558.3 11619.1 11700.4 11793.5 11329.9 11674.9 11778.8 11856.0 11992.6 7114.4 7201.0 8421.1 8672.0 8698.6 5534.9 9786.8 9959.6 11469.1 11780.5 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5379.48 Median:5240.79 stddev:2894.30 (55.2%) stddev-sans-first:2886.98 08:16:14 INFO - PROCESS | 1645 | Values: 1402.1 1438.7 1448.8 1456.3 1456.6 8119.0 8504.8 8529.7 8532.0 8548.9 7562.7 7774.6 7801.7 8086.8 8348.5 2109.5 2166.7 2173.9 2174.7 2180.5 2319.2 2326.4 2358.0 2358.0 2361.4 2046.8 2130.1 2233.5 2305.4 2330.7 2316.9 2327.5 2333.5 2333.8 2339.9 2281.3 2336.2 2350.7 2370.4 2381.4 8356.4 8415.1 8415.3 8416.2 8446.9 5094.1 5239.6 5242.0 5247.8 5247.9 3169.7 3432.1 3438.4 3470.6 3549.9 1137.7 1193.3 1194.6 1218.3 1220.6 10933.3 10947.7 10957.0 10958.3 11056.8 4548.2 4787.3 4792.2 4801.7 4825.8 8732.5 8812.5 8814.4 8815.8 8839.6 5169.4 5177.4 5177.5 5180.0 5185.5 4605.8 4722.9 4813.5 4813.9 4835.1 3874.2 3906.8 4003.4 4039.1 4048.4 1279.9 1295.8 1301.5 1315.5 1318.8 874.8 878.1 882.7 892.4 903.6 4458.0 5746.6 5751.2 5813.4 5995.3 817.3 957.1 990.7 1006.8 1034.2 3504.5 3599.5 3705.5 3726.9 3794.0 7943.1 9713.8 9937.2 9954.2 9962.0 9670.3 9853.9 9899.0 9909.7 9933.8 6926.9 6935.8 7894.1 7900.0 7923.0 5197.6 5294.3 5319.4 5512.8 5626.3 8262.7 9047.5 9075.2 9205.6 9272.0 8008.3 8551.9 9139.6 9353.6 9464.3 6368.8 7322.4 7324.5 7326.9 7332.9 7591.3 7745.5 7810.6 7813.3 7818.4 6931.3 7051.5 7056.5 7095.4 7114.7 7036.2 7052.4 7057.9 7092.4 7095.5 6310.8 6400.8 6432.2 6473.0 6477.8 4768.2 4843.2 4864.1 4979.6 5096.9 4871.0 4911.7 4917.8 5034.6 5073.9 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4356.54 Median:4828.67 stddev:1276.51 (26.4%) stddev-sans-first:1244.25 08:16:14 INFO - PROCESS | 1645 | Values: 354.6 357.4 362.9 374.9 376.0 4658.3 4668.3 5151.2 5439.7 5452.1 4143.0 4853.0 5110.0 5133.3 5296.8 3523.6 3899.6 4116.5 4172.5 4218.6 3622.7 3716.2 4123.8 4173.4 4181.3 4029.2 4100.9 4115.9 4146.7 4172.8 3655.9 3957.4 3991.9 4129.7 4138.2 3076.4 3336.8 3437.7 3626.0 3632.4 4542.4 4762.3 4863.7 5050.3 5131.8 3920.8 4400.9 4721.8 4757.7 4828.4 4696.9 5131.6 5575.4 5581.9 5600.1 4094.5 4106.2 4106.5 4110.3 4120.9 5395.4 5776.6 5782.7 5819.4 5850.3 3844.5 3847.9 3851.5 3854.3 3860.5 3910.9 3932.5 3945.8 3952.4 3956.3 4290.6 4445.6 4466.6 4520.6 4600.0 4645.0 4947.4 5238.4 5558.9 5566.5 1092.4 1185.7 1193.5 1201.2 1270.0 827.8 836.5 879.3 880.0 911.7 4775.7 4829.3 4847.9 4868.7 4908.9 4829.0 4872.8 5282.9 5399.5 5466.6 4165.7 4511.4 4604.6 4851.0 4865.4 2669.8 2683.9 2850.7 2864.9 2871.0 4838.5 5017.7 5034.6 5649.1 5666.0 4907.5 5106.5 5107.7 5168.9 5210.1 4846.8 5143.5 5500.7 5534.9 5540.4 4418.0 4664.0 5400.5 5405.8 5413.9 4581.6 5190.7 5375.1 5402.5 5410.6 4891.4 4946.7 5656.6 5661.0 5717.6 3593.8 3788.2 3977.9 4004.4 4005.9 4631.7 4953.6 5371.8 5410.5 5413.6 4719.8 4889.6 5223.3 5236.4 5246.6 3978.2 4703.7 4840.7 5057.5 5307.3 4460.7 4571.8 4902.8 5004.8 5301.7 5424.3 5433.4 5439.9 5448.7 5454.3 4739.3 5048.7 5217.7 5294.8 5379.9 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:17981.18 Median:45782.38 stddev:24288.85 (53.1%) stddev-sans-first:24322.20 08:16:14 INFO - PROCESS | 1645 | Values: 670.7 689.9 745.7 767.6 787.0 14557.3 15402.8 15408.5 15418.1 15424.9 10486.7 12471.3 12477.6 12479.1 12483.0 673.6 693.7 699.0 846.2 865.8 838.7 863.7 868.1 873.9 880.3 926.5 927.3 928.1 928.7 929.5 713.1 921.1 923.4 924.3 927.0 541.0 658.0 680.4 685.0 685.5 14501.3 14717.9 14727.0 14739.3 14743.3 12878.5 12948.6 13008.5 13018.2 13062.5 11386.8 11605.9 11649.0 11763.9 12312.9 3990.7 4055.0 4173.7 4180.9 4238.3 88417.8 96342.0 100143.0 104262.0 105124.0 9720.3 9806.2 9873.2 9959.9 9965.9 20031.3 20047.6 20067.4 20613.3 20676.8 6737.7 6779.5 7183.5 7264.3 7268.3 3701.4 3739.7 3770.5 3790.8 3881.7 3386.1 3431.2 3462.6 3485.7 3486.8 490.5 615.2 620.6 625.3 629.5 538.3 580.6 607.7 624.2 642.9 9070.0 9570.9 9801.5 9865.0 10202.5 552.7 570.6 570.8 629.9 671.8 4620.8 4769.4 4792.5 4821.8 4878.0 72037.0 72474.0 74864.3 76191.6 78984.0 67520.7 68205.7 68751.0 69074.0 70830.0 61724.4 61931.4 62546.1 62680.7 63823.4 10185.5 10392.9 10539.0 10615.3 10661.6 42286.4 45176.8 45515.0 46049.8 48479.8 56344.4 59542.0 62779.7 62817.0 63386.4 12207.9 12332.4 12683.6 13096.9 13317.7 13560.0 14226.6 14268.4 14396.3 14606.0 12930.9 13035.2 13740.6 13812.1 14041.8 13006.7 13688.9 14044.9 14134.8 14422.4 12412.9 12626.4 13063.7 13262.3 13589.8 10456.4 10477.2 10839.9 10860.8 11305.8 9398.3 10383.3 11154.0 11311.9 11348.8 08:16:14 INFO - PROCESS | 1645 | -------- Summary: end -------- 08:16:14 INFO - PROCESS | 1645 | 08:16:14 INFO - PROCESS | 1645 | 1488384974834 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:16:15 INFO - TEST-INFO | 1645: exit 0 08:16:15 INFO - TEST-OK | dromaeo_css | took 1118934ms 08:16:15 INFO - TEST-START | kraken 08:16:15 INFO - operating with platform_type : mac_ 08:16:15 INFO - Initialising browser for kraken test... 08:16:15 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpQdUZag/profile http://localhost:49250/getInfo.html) 08:16:15 INFO - PROCESS | 1650 | 1488384975963 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:16:15 INFO - PROCESS | 1650 | 1488384975963 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 08:16:16 INFO - PROCESS | 1650 | 1488384975999 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:16:17 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 08:16:17 INFO - PROCESS | 1650 | colorDepth:24 08:16:17 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 08:16:17 INFO - PROCESS | 1650 | __metrics 08:16:17 INFO - PROCESS | 1650 | 1488384977844 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:16:17 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:16:17 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:18 INFO - TEST-INFO | 1650: exit 0 08:16:18 INFO - Browser initialized. 08:16:18 INFO - Running cycle 1/1 for kraken test... 08:16:18 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/T/tmpQdUZag/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:16:18 INFO - PROCESS | 1651 | 1488384978930 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 08:16:18 INFO - PROCESS | 1651 | 1488384978931 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 08:16:30 INFO - PROCESS | 1651 | RSS: Main: 213159936 08:16:30 INFO - PROCESS | 1651 | 08:16:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 08:16:34 INFO - PROCESS | 1651 | RSS: Main: 266186752 08:16:34 INFO - PROCESS | 1651 | 08:16:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 08:16:37 INFO - PROCESS | 1651 | RSS: Main: 275099648 08:16:37 INFO - PROCESS | 1651 | 08:16:40 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 08:16:41 INFO - PROCESS | 1651 | RSS: Main: 372301824 08:16:41 INFO - PROCESS | 1651 | 08:16:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 08:16:44 INFO - PROCESS | 1651 | RSS: Main: 275001344 08:16:44 INFO - PROCESS | 1651 | 08:16:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:16:46 INFO - PROCESS | 1651 | RSS: Main: 276328448 08:16:46 INFO - PROCESS | 1651 | 08:16:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 08:16:50 INFO - PROCESS | 1651 | RSS: Main: 316473344 08:16:50 INFO - PROCESS | 1651 | 08:16:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 08:16:53 INFO - PROCESS | 1651 | RSS: Main: 317198336 08:16:53 INFO - PROCESS | 1651 | 08:16:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 08:16:57 INFO - PROCESS | 1651 | RSS: Main: 318210048 08:16:57 INFO - PROCESS | 1651 | 08:16:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:16:59 INFO - PROCESS | 1651 | RSS: Main: 295186432 08:16:59 INFO - PROCESS | 1651 | 08:17:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:17:02 INFO - PROCESS | 1651 | RSS: Main: 297566208 08:17:02 INFO - PROCESS | 1651 | 08:17:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:17:05 INFO - PROCESS | 1651 | RSS: Main: 299671552 08:17:05 INFO - PROCESS | 1651 | 08:17:07 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:17:08 INFO - PROCESS | 1651 | RSS: Main: 314916864 08:17:08 INFO - PROCESS | 1651 | 08:17:11 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:17:12 INFO - PROCESS | 1651 | RSS: Main: 308219904 08:17:12 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 08:17:14 INFO - PROCESS | 1651 | RSS: Main: 353329152 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | __start_tp_report 08:17:14 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:17:14 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:17:14 INFO - PROCESS | 1651 | |i|pagename|runs| 08:17:14 INFO - PROCESS | 1651 | |0;ai-astar;118;116;116;116;114;115;114;115;115;117 08:17:14 INFO - PROCESS | 1651 | |1;audio-beat-detection;146;111;108;144;114;111;108;111;127;111 08:17:14 INFO - PROCESS | 1651 | |2;audio-dft;182;184;183;190;259;221;184;185;183;183 08:17:14 INFO - PROCESS | 1651 | |3;audio-fft;81;64;62;109;84;82;82;58;74;62 08:17:14 INFO - PROCESS | 1651 | |4;audio-oscillator;88;70;85;70;69;67;83;67;69;82 08:17:14 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;90;87;91;88;90;86;91;88;89;86 08:17:14 INFO - PROCESS | 1651 | |6;imaging-darkroom;97;96;98;96;97;97;103;148;120;95 08:17:14 INFO - PROCESS | 1651 | |7;imaging-desaturate;130;131;87;85;84;87;87;87;87;84 08:17:14 INFO - PROCESS | 1651 | |8;json-parse-financial;56;51;49;75;82;83;83;55;56;56 08:17:14 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;69;74;64;76;72;69;68;69;74;69 08:17:14 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;85;86;86;87;82;81;81;82;81;83 08:17:14 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;139;150;149;143;140;144;148;137;172;142 08:17:14 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;168;164;166;167;167;167;163;167;165;188 08:17:14 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;67;66;66;65;65;65;64;64;65;65 08:17:14 INFO - PROCESS | 1651 | __end_tp_report 08:17:14 INFO - PROCESS | 1651 | __start_cc_report 08:17:14 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2133 08:17:14 INFO - PROCESS | 1651 | __end_cc_report 08:17:14 INFO - PROCESS | 1651 | __startTimestamp1488385034312__endTimestamp 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:17:14 INFO - PROCESS | 1651 | Number of tests: 14 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.00 stddev:1.26 (1.1%) stddev-sans-first:1.00 08:17:14 INFO - PROCESS | 1651 | Values: 118.0 116.0 116.0 116.0 114.0 115.0 114.0 115.0 115.0 117.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:119.10 Median:112.50 stddev:14.69 (13.1%) stddev-sans-first:11.92 08:17:14 INFO - PROCESS | 1651 | Values: 146.0 111.0 108.0 144.0 114.0 111.0 108.0 111.0 127.0 111.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:195.40 Median:184.50 stddev:25.25 (13.7%) stddev-sans-first:26.31 08:17:14 INFO - PROCESS | 1651 | Values: 182.0 184.0 183.0 190.0 259.0 221.0 184.0 185.0 183.0 183.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:75.80 Median:77.50 stddev:15.32 (19.8%) stddev-sans-first:16.14 08:17:14 INFO - PROCESS | 1651 | Values: 81.0 64.0 62.0 109.0 84.0 82.0 82.0 58.0 74.0 62.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:76.00 stddev:8.38 (11.0%) stddev-sans-first:7.45 08:17:14 INFO - PROCESS | 1651 | Values: 88.0 70.0 85.0 70.0 69.0 67.0 83.0 67.0 69.0 82.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.50 stddev:1.90 (2.1%) stddev-sans-first:1.94 08:17:14 INFO - PROCESS | 1651 | Values: 90.0 87.0 91.0 88.0 90.0 86.0 91.0 88.0 89.0 86.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:104.70 Median:96.50 stddev:16.93 (17.5%) stddev-sans-first:17.73 08:17:14 INFO - PROCESS | 1651 | Values: 97.0 96.0 98.0 96.0 97.0 97.0 103.0 148.0 120.0 95.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:87.00 stddev:18.81 (21.6%) stddev-sans-first:15.06 08:17:14 INFO - PROCESS | 1651 | Values: 130.0 131.0 87.0 85.0 84.0 87.0 87.0 87.0 87.0 84.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.50 stddev:14.26 (21.8%) stddev-sans-first:14.78 08:17:14 INFO - PROCESS | 1651 | Values: 56.0 51.0 49.0 75.0 82.0 83.0 83.0 55.0 56.0 56.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:3.57 (5.1%) stddev-sans-first:3.75 08:17:14 INFO - PROCESS | 1651 | Values: 69.0 74.0 64.0 76.0 72.0 69.0 68.0 69.0 74.0 69.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:84.00 stddev:2.37 (2.8%) stddev-sans-first:2.44 08:17:14 INFO - PROCESS | 1651 | Values: 85.0 86.0 86.0 87.0 82.0 81.0 81.0 82.0 81.0 83.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:146.00 stddev:9.99 (6.8%) stddev-sans-first:10.23 08:17:14 INFO - PROCESS | 1651 | Values: 139.0 150.0 149.0 143.0 140.0 144.0 148.0 137.0 172.0 142.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:167.00 stddev:7.13 (4.3%) stddev-sans-first:7.56 08:17:14 INFO - PROCESS | 1651 | Values: 168.0 164.0 166.0 167.0 167.0 167.0 163.0 167.0 165.0 188.0 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.71 08:17:14 INFO - PROCESS | 1651 | Values: 67.0 66.0 66.0 65.0 65.0 65.0 64.0 64.0 65.0 65.0 08:17:14 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:17:14 INFO - PROCESS | 1651 | 08:17:14 INFO - PROCESS | 1651 | 1488385034333 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 08:17:15 INFO - TEST-INFO | 1651: exit 0 08:17:15 INFO - TEST-OK | kraken | took 59748ms 08:17:15 INFO - SUITE-END | took 1178s 08:17:15 INFO - Completed test suite (00:19:38) 08:17:15 INFO - javascript benchmark 08:17:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.7225549700524, 3343.0305211488662, 3354.9329013419733, 3362.377960077384, 3403.3193361327726, 5742.339630942438, 5757.712114394284, 5760.683162426065, 5774.162746401769, 5788.5369170466365, 5646.322441307049, 5750.453706897849, 5753.050746626812, 5756.654600723949, 5766.654000759947, 5159.432462429139, 5191.195364718475, 5219.217117432378, 5234.7120908350025, 5267.55225805807, 5193.16909294513, 5196.220566914974, 5217.58259339252, 5272.156454967206, 5308.920366194491, 5266.499682530172, 5285.0, 5293.100172970604, 5298.708571028592, 5323.0, 5319.468053194688, 5329.653572517774, 5329.840104796862, 5333.959877823826, 5339.6262261641505, 5166.328377310925, 5266.762995665166, 5274.367075950872, 5283.815066472694, 5307.071262529081, 5592.804251851166, 5662.490375866192, 5853.47318741311, 5853.912191317134, 5926.822195334147, 6089.878202435971, 6129.233845769279, 6152.892479353714, 6154.384561543855, 6283.905741413882, 5229.633925625208, 6237.656928868911, 6244.781432649881, 6254.280757712876, 6262.530310226751, 5817.243758311435, 5916.112583112525, 5944.138099975479, 5948.434898684618, 5957.702114894281, 6174.25908890927, 6199.535034872402, 6232.034034724625, 6249.312575616678, 6278.277998030285, 6212.751489940442, 6216.564840461215, 6219.191505104308, 6230.314665386803, 6232.0, 6211.16149319845, 6233.875322493524, 6245.156903817927, 6246.781362652286, 6262.3111457739615, 6125.937554509019, 6131.080337949344, 6150.446459818638, 6157.291911430243, 6169.753209871645, 6181.7527298908435, 6220.0, 6231.345708700612, 6233.563650544418, 6252.3122456529745, 5034.597232221414, 5039.97480012605, 5043.52086551777, 5047.4447810740785, 5070.391553013588, 4402.8679139625865, 4458.6878918475395, 4465.709728867613, 4511.390962220124, 4522.909541809211, 5689.800856969986, 5739.426057394311, 5764.452377024176, 5774.364819869811, 5812.622179558315, 6086.573939824259, 6210.813675589739, 6230.096635987847, 6232.501399888089, 6241.313455519889, 5655.830325090254, 5709.25779648643, 5713.0, 5716.657000579979, 5730.283714535683, 5373.301470808769, 5434.565234781208, 5438.102713052302, 5445.37378201504, 5446.700431476307, 6248.593841400295, 6256.5307601930945, 6258.092576576371, 6259.655718935411, 6262.060690896402, 6177.505799535937, 6216.316205217332, 6217.036359364125, 6222.937770622417, 6226.59527130735, 6195.938040619536, 6227.750889964351, 6242.188515492957, 6336.841578960563, 6342.0, 6144.41628045335, 6176.69116544162, 6207.224096987877, 6208.50331973432, 6219.222597175353, 5299.205119232146, 6127.632342059491, 6209.0686397039, 6231.4391704746795, 6231.532635052298, 5784.595078344475, 6076.90884636722, 6092.634441933498, 6151.5386346025125, 6171.6297022178815, 6093.268807743099, 6110.953680641605, 6117.877642447215, 6129.540284478771, 6132.2947860996555, 5897.616654917417, 5988.0, 6015.879682406415, 6017.879642407215, 6062.636241825505, 6116.724747386289, 6139.2325959255095, 6143.262808463013, 6159.907601385893, 6160.291566469913, 5805.941940580709, 5878.29460464747, 6016.308124565556, 6032.276126864805, 6037.45662890342], "value": 5715.542588230257, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.6455158631027, 524.0907026309353, 532.8854296326289, 533.4905165566884, 540.1492649077701, 30426.391472170544, 33300.50049249263, 41972.58027419725, 42116.36825447613, 44789.7760511197, 44633.77683111588, 44937.55062449374, 45081.77459112708, 45117.09765804682, 45326.32010519845, 8314.210150035768, 9176.8623470648, 9341.719748407559, 9385.296102792283, 9390.06099390059, 8305.003399592057, 11058.778824423507, 11282.943585282062, 11297.604583839568, 11513.942430287836, 11302.378369189692, 11354.71613209668, 11386.37374944382, 11403.3728144952, 11404.828927566094, 8350.415470917038, 11153.275037122601, 11217.326960382403, 11272.887271127265, 11283.210175287733, 8345.582720863933, 11132.16508761838, 11441.970222679916, 11465.369404682739, 11468.885311146865, 41878.371824422655, 42205.78897105495, 42361.0, 42375.36436953448, 42375.78812105951, 3939.803009849496, 3973.304671682444, 3977.7016723745833, 3991.4611527444004, 4030.838766449368, 29671.554926676115, 30815.845920770476, 31170.376592468252, 31517.0, 31941.72233110696, 3065.4941934580766, 3136.40408322418, 3154.2587491939375, 3161.9051428457183, 3173.1591128350774, 474422.0, 474617.6269118667, 476376.0, 477154.0, 478939.0, 67607.0, 68025.63948720998, 68065.65967170232, 68176.31823681798, 68260.6586967062, 72077.6396118016, 72201.0, 72201.66789992618, 72270.0, 72331.63834180795, 14959.177245251616, 15513.069215847085, 15517.0, 15542.689146217012, 15571.532854014398, 10516.57933682644, 10774.46127693628, 11287.209895307415, 11520.884791152148, 11632.88367116318, 19335.323263685703, 19469.221231150594, 19548.51128721765, 19998.800011999694, 20202.494937626678, 5724.627899186539, 5743.310802703619, 6001.099835024781, 6760.492963027694, 6817.5568588041615, 873.4497266721925, 876.7812740291, 882.2633101360308, 900.1403659505288, 911.8495448251097, 29305.0, 30322.090337289916, 30422.0, 30435.0, 30549.23626909345, 1051.4322265976286, 1054.3568423261804, 1089.6022951622601, 1097.9560817567208, 1176.3294921894437, 15517.267114120565, 15634.06195628266, 15799.605009874846, 15902.76145857813, 16431.5892102696, 243082.0, 243958.0, 244723.0, 246176.0, 602278.0, 63054.0, 63237.683811580646, 63275.68362158252, 63453.0, 63706.0, 1385.1965859801492, 1418.5035237666941, 1439.8560143985517, 1445.5663301009656, 1447.4933773179514, 28954.565681515214, 29145.70854291515, 29470.821167153932, 29576.55635165431, 30417.39165216639, 52633.7368313156, 52944.0, 53094.46905530895, 53114.73442632917, 53202.73398632982, 533794.0, 533878.0, 535060.0, 536180.0, 536790.0, 34846.825765871006, 41902.16195676009, 42383.576164239195, 42859.0, 42970.78514607407, 45926.31110533411, 46009.30986035279, 48267.5173248263, 48323.516764831904, 48529.75735121302, 35465.82267088648, 37023.0, 39324.803375982934, 40742.18515629612, 40878.59121408748, 35784.821075894455, 36106.09734756652, 37192.628073718915, 37626.81186594049, 38532.807335964266, 35840.10399739923, 35949.0, 36328.0, 36730.081747956516, 36763.26473470569, 30197.547036794906, 30462.695373046874, 32367.676323237407, 32580.674193257764, 32601.0, 24200.878995604908, 24277.0, 24433.75566244315, 24605.50788984246, 24979.750202497744], "value": 20093.869422732427, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.4719837054196, 364.8194143898767, 384.8191350065469, 384.84990853567115, 413.8137837972911, 13738.725225495484, 14794.408223671053, 15143.469978550753, 20411.979401029963, 21227.257046003393, 20625.587488250265, 21001.789982100174, 21100.366988990354, 21218.46953826155, 22286.219982300623, 5067.315912351841, 5689.345725241588, 5930.584859059867, 5932.733027013774, 5954.583179177459, 5919.437653422918, 6082.087686846964, 6087.482563982045, 6099.81700548982, 6101.572889897709, 3848.42273658952, 4039.474868267121, 4045.7167998240134, 4051.0885050863467, 4278.5935336143175, 4356.128774245148, 6604.339566043405, 6675.232348279961, 6680.7661731839635, 6682.599044057372, 5309.150535914274, 5372.758225879845, 5765.971170144165, 5947.524198064188, 5967.671778052206, 13028.0, 13264.86735132646, 13330.933345333307, 13349.132306400053, 25056.874715626487, 2514.635377870217, 2563.090103013422, 2579.1746641074865, 2620.855852928088, 2668.519666460036, 10076.69769906904, 10097.697069087939, 10245.948770256102, 10597.523111460003, 10682.985116413929, 1809.7556829827936, 1833.651606194832, 1853.2772218834666, 1874.3346112130134, 1876.1276006656833, 114810.0, 134176.0, 143028.28485857608, 143644.0, 145997.0, 11394.886051139549, 11832.585859494877, 11886.0, 11928.403579821148, 11943.940280298542, 15885.126318052387, 15911.443099491693, 15913.443029493912, 15932.840671593367, 15969.44106956251, 8177.386695997824, 8355.0, 8413.368997325102, 8479.448835825775, 8495.617697203517, 7702.1912699166905, 7874.960625196837, 7900.723474678359, 7970.402219833536, 8143.982002249719, 4682.6253899687945, 4774.976125119421, 4780.235162374003, 4876.5854902332985, 4880.463149053601, 1990.7511561054869, 2034.959300814005, 2047.7133201351824, 2053.5071582820315, 2058.5882823435372, 868.5830801215452, 886.822635472908, 891.5675897189858, 919.6229545886155, 929.697848199338, 21420.678689819666, 21858.562828743336, 21920.561588768134, 21991.560168796535, 22025.449363766034, 896.408370475483, 906.7053207707389, 911.1253196930888, 914.3919293669635, 938.2306508662967, 10793.892061079447, 11398.373089480157, 11484.138689598314, 11487.540498380138, 11620.941895290469, 763569.0, 770622.0, 779318.0, 780833.0, 791865.0, 92052.0, 145495.81756273666, 155385.0, 164275.0, 165439.0, 970.2238209432567, 974.4202199691173, 1013.1995723378595, 1014.9898501015043, 1015.7155996321042, 19293.8070619292, 19294.421167365002, 19899.612046554506, 20815.271465498634, 20847.583048338645, 52052.0, 59547.80904381975, 60773.39226607677, 60888.69555652193, 61399.079013815724, 75594.62202688951, 78616.60691696504, 84613.7307940369, 86206.0, 87678.56160719156, 7024.824379390556, 7164.391026762783, 8349.457285276438, 8707.345604335156, 8753.124687531195, 11751.353675547927, 13237.271950042456, 13300.201987880759, 13548.932255338661, 13791.862081379059, 11239.0, 11324.773504529698, 11452.656420307405, 11456.656300311004, 11609.593664221711, 11330.60342887995, 11558.30650160993, 11619.128565357802, 11700.414979251174, 11793.528258869892, 11329.886701132884, 11674.883251167379, 11778.82331765007, 11856.0, 11992.64022079339, 7114.395276401357, 7201.0, 8421.073681894864, 8671.956640216758, 8698.60856261457, 5534.944650553604, 9786.75533111678, 9959.555864399477, 11469.139814513777, 11780.52877884875], "value": 9618.431243611089, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.0746307437087, 1438.7122575484902, 1448.7754398068303, 1456.3155317001006, 1456.5557504960982, 8119.0, 8504.829903401927, 8529.701460448885, 8532.018817835951, 8548.871766923485, 7562.697492100309, 7774.611269436534, 7801.687932482708, 8086.757397278091, 8348.540830254333, 2109.52535679472, 2166.7183266175375, 2173.913043478259, 2174.7281589801273, 2180.4548862784304, 2319.246244970391, 2326.395137264315, 2357.964630530543, 2358.0332063853825, 2361.362432143329, 2046.7850875658064, 2130.147940823675, 2233.530958498717, 2305.4351683837485, 2330.731965823935, 2316.895739691718, 2327.5344931013697, 2333.49829786595, 2333.789958903707, 2339.87130707811, 2281.327008532487, 2336.240721765433, 2350.6826578411865, 2370.4073981504625, 2381.416552944522, 8356.415050946436, 8415.074341822394, 8415.326773858076, 8416.2004609562, 8446.873296900552, 5094.108531007059, 5239.580833533309, 5242.0, 5247.790088396459, 5247.921281180786, 3169.6671849455706, 3432.090496018557, 3438.415469370188, 3470.5661792275964, 3549.8757543486113, 1137.732632831284, 1193.2601786892096, 1194.5580135349976, 1218.3116539155349, 1220.5666988219143, 10933.343999360064, 10947.726306842313, 10957.01386875177, 10958.342499449978, 11056.778864422748, 4548.249538826057, 4787.305840653085, 4792.209285467929, 4801.735904525215, 4825.769428795705, 8732.519711415933, 8812.471251724917, 8814.427062240933, 8815.779605509786, 8839.646414143363, 5169.39748677911, 5177.430482646906, 5177.4822517747925, 5179.974100129551, 5185.455527169668, 4605.838795642204, 4722.858314250578, 4813.518648135158, 4813.855584332476, 4835.081334546425, 3874.1864208516527, 3906.8046597670004, 4003.4195041718785, 4039.1315867088715, 4048.4332193492933, 1279.8848103670528, 1295.779717448036, 1301.4924179569975, 1315.526410492222, 1318.8394213092417, 874.8233625773324, 878.1087196495562, 882.7219425880827, 892.3842548641417, 903.6024149374255, 4457.952381190417, 5746.569007324468, 5751.194832723422, 5813.360530341659, 5995.340512543617, 817.264461984219, 957.1146689312498, 990.7225976726528, 1006.8288390973552, 1034.1933292032227, 3504.491848681927, 3599.5140656011104, 3705.518282623296, 3726.8695595654563, 3793.981030094832, 7943.126256111823, 9713.805723885484, 9937.155341795884, 9954.203663706887, 9962.0, 9670.274729395323, 9853.852192217122, 9899.0, 9909.702708918743, 9933.80132397348, 6926.861462770717, 6935.751564718298, 7894.05271367451, 7900.0, 7922.970013898272, 5197.558207552401, 5294.258803767552, 5319.38827034896, 5512.779488820403, 5626.2685850839125, 8262.669493220204, 9047.502387368759, 9075.183233509017, 9205.631774728936, 9271.953640231755, 8008.27925486709, 8551.871721924052, 9139.634414623606, 9353.625854965725, 9464.290178236522, 6368.840778980562, 7322.414206863332, 7324.487285889936, 7326.9267307326245, 7332.890006649798, 7591.278828511283, 7745.535267883945, 7810.648520816463, 7813.296803287732, 7818.413618978486, 6931.272216417204, 7051.5063945523325, 7056.470764692566, 7095.3968912643, 7114.679839407343, 7036.155661320674, 7052.400545953651, 7057.894131587927, 7092.432605391453, 7095.503314767917, 6310.84222894413, 6400.807975760735, 6432.163818703539, 6472.996685513753, 6477.77327793525, 4768.237082066853, 4843.200871856246, 4864.124457597525, 4979.601631869514, 5096.923546146885, 4871.014420438159, 4911.7298548580175, 4917.827876024322, 5034.647574669738, 5073.949260507496], "value": 4394.65820554279, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.56034517198674, 357.4013527341702, 362.92741451709657, 374.91939233064886, 375.95488541375005, 4658.277966915125, 4668.299755036742, 5151.162384023898, 5439.700816455093, 5452.127659574468, 4143.0, 4852.980874016461, 5109.974450127754, 5133.306009017025, 5296.788128474856, 3523.6476352364816, 3899.6295351941662, 4116.547179810218, 4172.499300083987, 4218.578142185787, 3622.6739593436587, 3716.2381711749163, 4123.752574845504, 4173.373993900909, 4181.310083836179, 4029.1740193260457, 4100.8722601284735, 4115.929858236865, 4146.668266538685, 4172.791360431981, 3655.8978587312267, 3957.445957565943, 3991.92218101114, 4129.669626429878, 4138.213739389522, 3076.384723055398, 3336.7664263501565, 3437.6764945495916, 3626.0, 3632.4188129899353, 4542.409486766732, 4762.261849413312, 4863.659543831933, 5050.318207042039, 5131.794728210867, 3920.803959802027, 4400.911981760379, 4721.834735784231, 4757.739199112238, 4828.372311599504, 4696.862927368039, 5131.5881535678545, 5575.442455754433, 5581.944180558183, 5600.103983362643, 4094.549599544048, 4106.178764247133, 4106.548279689232, 4110.260153172428, 4120.91758164835, 5395.352557693062, 5776.59563830532, 5782.710864456761, 5819.447152520546, 5850.327212370589, 3844.519435070616, 3847.8653247136217, 3851.480050193244, 3854.3062248795486, 3860.4595356650093, 3910.921781564353, 3932.508436445444, 3945.8027098645525, 3952.4268980998168, 3956.2878681837547, 4290.635295999812, 4445.644348452116, 4466.57567531084, 4520.553422904704, 4600.0, 4644.95355046452, 4947.356843610308, 5238.4237733850005, 5558.916616250759, 5566.4990150886615, 1092.415557676639, 1185.6798664360574, 1193.4927655746274, 1201.225209739713, 1269.9840127897644, 827.7930517370658, 836.5068352989883, 879.2658130461009, 880.0407555764248, 911.6900253913568, 4775.71345719251, 4829.348038014893, 4847.939625659081, 4868.6649644993295, 4908.889177653643, 4828.975855120702, 4872.781804548863, 5282.947170528246, 5399.487048730364, 5466.594698332721, 4165.66674666026, 4511.436070491189, 4604.562566556172, 4850.975745121323, 4865.416150061945, 2669.8119336895284, 2683.8529176658594, 2850.688683205707, 2864.8567571621334, 2870.971290287112, 4838.467768545457, 5017.67385119966, 5034.622403319766, 5649.051077378298, 5665.9716701417055, 4907.509249075135, 5106.540411362995, 5107.67200527858, 5168.914527949098, 5210.114280572236, 4846.806127754991, 5143.459936706741, 5500.697461639568, 5534.889302214014, 5540.448674371182, 4417.980013429742, 4664.0, 5400.459954004726, 5405.78376864921, 5413.891722165614, 4581.587657110876, 5190.716084922622, 5375.08623534008, 5402.51644580743, 5410.621256512164, 4891.4347408828835, 4946.653734238569, 5656.64240582249, 5661.0, 5717.625432093819, 3593.8203089845924, 3788.2234142001375, 3977.8607748728655, 4004.4382690751213, 4005.91988160241, 4631.675782695179, 4953.603711702983, 5371.785128594813, 5410.513053825174, 5413.648112872651, 4719.764011799465, 4889.608831293559, 5223.268742375994, 5236.39781425141, 5246.580273578028, 3978.1905296798063, 4703.717776933395, 4840.7337596432535, 5057.544820966131, 5307.336582927134, 4460.665450091321, 4571.834182283496, 4902.803887844446, 5004.77478513475, 5301.6818990860675, 5424.294841670558, 5433.3867977794325, 5439.864003399946, 5448.700321482356, 5454.263829276958, 4739.289106634033, 5048.671836330626, 5217.739113044408, 5294.835136270014, 5379.865503362447], "value": 3963.5172738780593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.7015378156722, 689.8827199376105, 745.716627681481, 767.5778321922943, 786.9685212591495, 14557.272136393178, 15402.84597154028, 15408.460703875367, 15418.074915505063, 15424.922875385635, 10486.737831554196, 12471.314077725721, 12477.563285285018, 12479.064070194749, 12483.0, 673.5588189735706, 693.7329128285621, 698.9899595085104, 846.2299307630058, 865.8225063861925, 838.6603425612636, 863.6588547523725, 868.1492137705053, 873.930085593151, 880.2737741363369, 926.5182105305237, 927.3369540778342, 928.1368327455464, 928.6610387208653, 929.5352323838081, 713.1157364867527, 921.0651189043126, 923.3813345058827, 924.2652091587238, 927.0, 541.0477559495278, 658.0359772932677, 680.4454369688688, 685.0341019163006, 685.4790359326897, 14501.347439365149, 14717.92641036788, 14727.0, 14739.263036848115, 14743.262836858114, 12878.484860605564, 12948.611541653765, 13008.479660813557, 13018.153820001764, 13062.477500899953, 11386.772264554662, 11605.941970290094, 11649.0, 11763.941180294043, 12312.938435307766, 3990.660793832528, 4055.0, 4173.6661067114865, 4180.916381672349, 4238.3430568261965, 88417.78955526098, 96342.036579634, 100143.0, 104262.0, 105124.0, 9720.319577629498, 9806.215502759762, 9873.160781333667, 9959.900400996043, 9965.850512242178, 20031.298904538562, 20047.599048018958, 20067.397978060682, 20613.278535251193, 20676.793232067786, 6737.663116844138, 6779.457643388517, 7183.497155199086, 7264.309890560388, 7268.273172682795, 3701.4262789267705, 3739.6634302912325, 3770.490983717163, 3790.77255364679, 3881.650651441327, 3386.1365351835125, 3431.1765176357994, 3462.6191118976894, 3485.72114230866, 3486.8430920608635, 490.52419153421124, 615.2371059885799, 620.6276234259408, 625.2621906150695, 629.5089829932659, 538.3324677400074, 580.5732786401991, 607.7265230646227, 624.2166081567603, 642.8714257148496, 9070.0, 9570.856437153448, 9801.460919649488, 9864.95067524672, 10202.540885660163, 552.7236381809096, 570.6490508337342, 570.7910386803098, 629.9464545513682, 671.8051764988196, 4620.838270660511, 4769.403824521934, 4792.536359989865, 4821.7589120544535, 4878.0, 72037.0, 72474.0, 74864.25135748682, 76191.61904190555, 78984.0, 67520.66239668771, 68205.65897170582, 68751.0, 69074.0, 70830.0, 61724.382756171864, 61931.380686193464, 62546.12361629158, 62680.68659656764, 63823.36176638267, 10185.541650625888, 10392.907435689178, 10539.0, 10615.31000484966, 10661.573537058432, 42286.36570451384, 45176.77411612921, 45515.0, 46049.76975115103, 48479.757601213176, 56344.43655563392, 59542.0, 62779.6861015692, 62817.0, 63386.366136338045, 12207.90706687267, 12332.383380830743, 12683.556075537312, 13096.869031309565, 13317.733645327233, 13560.0, 14226.644333891736, 14268.42926282937, 14396.280185990869, 14606.0, 12930.935345323212, 13035.15271507349, 13740.587782366545, 13812.1022133561, 14041.789373159616, 13006.674833129247, 13688.863111369157, 14044.929775351058, 14134.78797818013, 14422.421386308039, 12412.937935310627, 12626.36868156607, 13063.673408164872, 13262.27057511846, 13589.835504042712, 10456.372617642966, 10477.214208934512, 10839.945800270949, 10860.837087443537, 11305.773884522428, 9398.34211605181, 10383.273170877967, 11154.0, 11311.886881131084, 11348.829767553329], "value": 7068.327156550815, "unit": "score"}], "name": "dromaeo_css", "value": 7171.326579442644, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 116.0, 116.0, 114.0, 115.0, 114.0, 115.0, 115.0, 117.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 108.0, 144.0, 114.0, 111.0, 108.0, 111.0, 127.0, 111.0], "value": 119.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 190.0, 259.0, 221.0, 184.0, 185.0, 183.0, 183.0], "value": 195.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 64.0, 62.0, 109.0, 84.0, 82.0, 82.0, 58.0, 74.0, 62.0], "value": 75.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 70.0, 69.0, 67.0, 83.0, 67.0, 69.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 91.0, 88.0, 90.0, 86.0, 91.0, 88.0, 89.0, 86.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 98.0, 96.0, 97.0, 97.0, 103.0, 148.0, 120.0, 95.0], "value": 104.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 131.0, 87.0, 85.0, 84.0, 87.0, 87.0, 87.0, 87.0, 84.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 51.0, 49.0, 75.0, 82.0, 83.0, 83.0, 55.0, 56.0, 56.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 64.0, 76.0, 72.0, 69.0, 68.0, 69.0, 74.0, 69.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 87.0, 82.0, 81.0, 81.0, 82.0, 81.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 150.0, 149.0, 143.0, 140.0, 144.0, 148.0, 137.0, 172.0, 142.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 166.0, 167.0, 167.0, 167.0, 163.0, 167.0, 165.0, 188.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 65.0, 65.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1467.3000000000004, "alertThreshold": 2.0}]} 08:17:15 INFO - Return code: 0 08:17:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:17:15 ERROR - # TBPL SUCCESS # 08:17:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:17:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:17:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:17:15 INFO - 2017-03-01 08:17:15.633 screenresolution[1655:10187] starting screenresolution argv=screenresolution get 08:17:15 INFO - 2017-03-01 08:17:15.636 screenresolution[1655:10187] Display 0: 1600x1200x32@60 08:17:15 INFO - 2017-03-01 08:17:15.642 screenresolution[1656:10190] starting screenresolution argv=screenresolution list 08:17:15 INFO - Available Modes on Display 0 08:17:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:17:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:17:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:17:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:17:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:17:15 INFO - Intel Iris: 08:17:15 INFO - Chipset Model: Intel Iris 08:17:15 INFO - Type: GPU 08:17:15 INFO - Bus: Built-In 08:17:15 INFO - VRAM (Dynamic, Max): 1536 MB 08:17:15 INFO - Vendor: Intel (0x8086) 08:17:15 INFO - Device ID: 0x0a2e 08:17:15 INFO - Revision ID: 0x0009 08:17:15 INFO - Displays: 08:17:15 INFO - Display: 08:17:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:17:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:17:15 INFO - Display Serial Number: 1600x1200 60 08:17:15 INFO - Main Display: Yes 08:17:15 INFO - Mirror: Off 08:17:15 INFO - Online: Yes 08:17:15 INFO - Rotation: Supported 08:17:15 INFO - Return code: 0 08:17:15 INFO - Running post-action listener: _resource_record_post_action 08:17:15 INFO - [mozharness: 2017-03-01 16:17:15.883787Z] Finished run-tests step (success) 08:17:15 INFO - Running post-run listener: _resource_record_post_run 08:17:15 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 31857664; Write bytes: 508379648; Read time: 355; Write time: 1818 08:17:15 INFO - TinderboxPrint: CPU usage
53.9% 08:17:15 INFO - TinderboxPrint: I/O read bytes / time
31,857,664 / 355 08:17:15 INFO - TinderboxPrint: I/O write bytes / time
508,379,648 / 1,818 08:17:15 INFO - TinderboxPrint: CPU idle
2,211.8 (46.1%) 08:17:15 INFO - TinderboxPrint: CPU system
959.5 (20.0%) 08:17:15 INFO - TinderboxPrint: CPU user
1,626.4 (33.9%) 08:17:15 INFO - TinderboxPrint: Swap in / out
235,298,816 / 0 08:17:15 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205593088; Write bytes: 199008256; Read time: 15690; Write time: 368 08:17:15 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 28978176; Write bytes: 298275328; Read time: 329; Write time: 1414 08:17:16 INFO - Running post-run listener: _upload_blobber_files 08:17:16 INFO - Blob upload gear active. 08:17:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:17:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:17:16 INFO - (blobuploader) - INFO - Open directory for files ... 08:17:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:17:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:18 INFO - (blobuploader) - INFO - Done attempting. 08:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:19 INFO - (blobuploader) - INFO - Done attempting. 08:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:20 INFO - (blobuploader) - INFO - Done attempting. 08:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:17:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:17:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:17:22 INFO - (blobuploader) - INFO - Done attempting. 08:17:22 INFO - (blobuploader) - INFO - Iteration through files over. 08:17:22 INFO - Return code: 0 08:17:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:17:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:17:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8898d5701da989e1dc6fc0cfef761124f29f12bf05534ca9b6391a7126c5ec2ed505c210de6c255718b6b37920b53479b9110acdda887685f91aca654dbc90f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26c4f3cb4af8df45f9a2cc6b43a1d4bc720ad78311c1452575f1a611389747fe9fbfe81eae035e63c138581ebb5a5316e586bc2f158c0ae8e768efae6725ef2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80569159162f28b56a391159e8d706d2952df37b6bd0b6eb958fddcb8f1a21ae90fcc1ab466dde144ab11c30e3931ff2cde934265bf89ec343b92e7c2c13f6b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b82bbd78358fa3b9dba136a2356690a2fd330e09ebd2b0cf5eb9ad08909f76a019ca8218edae203f8ce05885a364c428b140aa3373526917beed7a632cf7d64"} 08:17:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:17:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:17:22 INFO - Contents: 08:17:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8898d5701da989e1dc6fc0cfef761124f29f12bf05534ca9b6391a7126c5ec2ed505c210de6c255718b6b37920b53479b9110acdda887685f91aca654dbc90f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26c4f3cb4af8df45f9a2cc6b43a1d4bc720ad78311c1452575f1a611389747fe9fbfe81eae035e63c138581ebb5a5316e586bc2f158c0ae8e768efae6725ef2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80569159162f28b56a391159e8d706d2952df37b6bd0b6eb958fddcb8f1a21ae90fcc1ab466dde144ab11c30e3931ff2cde934265bf89ec343b92e7c2c13f6b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b82bbd78358fa3b9dba136a2356690a2fd330e09ebd2b0cf5eb9ad08909f76a019ca8218edae203f8ce05885a364c428b140aa3373526917beed7a632cf7d64"} 08:17:22 INFO - Running post-run listener: copy_logs_to_upload_dir 08:17:22 INFO - Copying logs to upload dir... 08:17:22 INFO - mkdir: /builds/slave/test/build/upload/logs 08:17:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.462164 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-01 08:17:22.357243) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:22.363137) ========= 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.ybst9jEyhn/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.x9MovjtfyI/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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/Mozilla-Aurora/sha512/8898d5701da989e1dc6fc0cfef761124f29f12bf05534ca9b6391a7126c5ec2ed505c210de6c255718b6b37920b53479b9110acdda887685f91aca654dbc90f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26c4f3cb4af8df45f9a2cc6b43a1d4bc720ad78311c1452575f1a611389747fe9fbfe81eae035e63c138581ebb5a5316e586bc2f158c0ae8e768efae6725ef2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80569159162f28b56a391159e8d706d2952df37b6bd0b6eb958fddcb8f1a21ae90fcc1ab466dde144ab11c30e3931ff2cde934265bf89ec343b92e7c2c13f6b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b82bbd78358fa3b9dba136a2356690a2fd330e09ebd2b0cf5eb9ad08909f76a019ca8218edae203f8ce05885a364c428b140aa3373526917beed7a632cf7d64"} build_url:https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/Hw17T2AnR7u_R7g45fiO_w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8898d5701da989e1dc6fc0cfef761124f29f12bf05534ca9b6391a7126c5ec2ed505c210de6c255718b6b37920b53479b9110acdda887685f91aca654dbc90f3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/26c4f3cb4af8df45f9a2cc6b43a1d4bc720ad78311c1452575f1a611389747fe9fbfe81eae035e63c138581ebb5a5316e586bc2f158c0ae8e768efae6725ef2f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80569159162f28b56a391159e8d706d2952df37b6bd0b6eb958fddcb8f1a21ae90fcc1ab466dde144ab11c30e3931ff2cde934265bf89ec343b92e7c2c13f6b1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b82bbd78358fa3b9dba136a2356690a2fd330e09ebd2b0cf5eb9ad08909f76a019ca8218edae203f8ce05885a364c428b140aa3373526917beed7a632cf7d64"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:22.396748) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:22.397052) ========= 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.ybst9jEyhn/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.x9MovjtfyI/Listeners TMPDIR=/var/folders/fh/gqfg3vms4y13dn0t_fnkbgy000000w/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.005184 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 08:17:22.445318) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 08:17:22.445634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 08:17:22.446032) ========= ========= Total master_lag: 0.19 =========