builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0196 starttime: 1481812887.59 results: success (0) buildid: 20161215051701 builduid: 93be0286cd2f4226aa4ef92d70346df4 revision: f14683f7fad599fe1982c7d530281092b47fbcf4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:27.592972) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:27.593413) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:27.593697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:27.622763) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:27.623166) ========= 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.5qHJpNhWrR/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.ElLz90XBY6/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 --2016-12-15 06:41:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.3M=0.001s 2016-12-15 06:41:28 (14.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.498906 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:28.146945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:28.147262) ========= 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.5qHJpNhWrR/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.ElLz90XBY6/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.025861 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:28.195841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 06:41:28.196214) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f14683f7fad599fe1982c7d530281092b47fbcf4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f14683f7fad599fe1982c7d530281092b47fbcf4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5qHJpNhWrR/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.ElLz90XBY6/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 2016-12-15 06:41:28,290 truncating revision to first 12 chars 2016-12-15 06:41:28,290 Setting DEBUG logging. 2016-12-15 06:41:28,290 attempt 1/10 2016-12-15 06:41:28,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f14683f7fad5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 06:41:29,291 unpacking tar archive at: mozilla-central-f14683f7fad5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264147 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-15 06:41:29.483672) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:29.483991) ========= script_repo_revision: f14683f7fad599fe1982c7d530281092b47fbcf4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:29.484369) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:29.484632) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 06:41:29.504162) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-15 06:41:29.504505) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5qHJpNhWrR/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.ElLz90XBY6/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:41:29 INFO - MultiFileLogger online at 20161215 06:41:29 in /builds/slave/test 06:41:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:41:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:41:29 INFO - {'append_to_log': False, 06:41:29 INFO - 'base_work_dir': '/builds/slave/test', 06:41:29 INFO - 'blob_upload_branch': 'Firefox', 06:41:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:41:29 INFO - 'branch': 'Firefox', 06:41:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:41:29 INFO - 'config_files': ('talos/mac_config.py',), 06:41:29 INFO - 'default_actions': ('clobber', 06:41:29 INFO - 'read-buildbot-config', 06:41:29 INFO - 'download-and-extract', 06:41:29 INFO - 'populate-webroot', 06:41:29 INFO - 'create-virtualenv', 06:41:29 INFO - 'install', 06:41:29 INFO - 'run-tests'), 06:41:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:41:29 INFO - 'download_minidump_stackwalk': True, 06:41:29 INFO - 'download_symbols': 'ondemand', 06:41:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:41:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:41:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:41:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:41:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:41:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:41:29 INFO - 'installer_path': 'installer.exe', 06:41:29 INFO - 'log_level': 'info', 06:41:29 INFO - 'log_name': 'talos', 06:41:29 INFO - 'log_to_console': True, 06:41:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:41:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:41:29 INFO - 'opt_config_files': (), 06:41:29 INFO - 'pip_index': False, 06:41:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:41:29 INFO - 'cmd': ('bash', 06:41:29 INFO - '-c', 06:41:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:41:29 INFO - 'enabled': True, 06:41:29 INFO - 'halt_on_failure': False, 06:41:29 INFO - 'name': 'check_screen_resolution'},), 06:41:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:41:29 INFO - 'cmd': ('bash', 06:41:29 INFO - '-c', 06:41:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:41:29 INFO - 'enabled': True, 06:41:29 INFO - 'halt_on_failure': False, 06:41:29 INFO - 'name': 'check_screen_resolution'},), 06:41:29 INFO - 'run_cmd_checks_enabled': True, 06:41:29 INFO - 'sps_profile': False, 06:41:29 INFO - 'sps_profile_interval': 0, 06:41:29 INFO - 'suite': 'dromaeojs', 06:41:29 INFO - 'system_bits': '32', 06:41:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:41:29 INFO - 'title': 't-yosemite-r7-0196', 06:41:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:41:29 INFO - 'use_talos_json': True, 06:41:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:41:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:41:29 INFO - 'work_dir': 'build'} 06:41:29 INFO - [mozharness: 2016-12-15 14:41:29.713127Z] Running clobber step. 06:41:29 INFO - Running pre-action listener: _resource_record_pre_action 06:41:29 INFO - Running main action method: clobber 06:41:29 INFO - rmtree: /builds/slave/test/build 06:41:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:41:32 INFO - Running post-action listener: _resource_record_post_action 06:41:32 INFO - [mozharness: 2016-12-15 14:41:32.226865Z] Finished clobber step (success) 06:41:32 INFO - [mozharness: 2016-12-15 14:41:32.227002Z] Running read-buildbot-config step. 06:41:32 INFO - Running pre-action listener: _resource_record_pre_action 06:41:32 INFO - Running main action method: read_buildbot_config 06:41:32 INFO - Using buildbot properties: 06:41:32 INFO - { 06:41:32 INFO - "project": "", 06:41:32 INFO - "product": "firefox", 06:41:32 INFO - "script_repo_revision": "production", 06:41:32 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:41:32 INFO - "repository": "", 06:41:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:41:32 INFO - "buildid": "20161215051701", 06:41:32 INFO - "pgo_build": "False", 06:41:32 INFO - "basedir": "/builds/slave/test", 06:41:32 INFO - "buildnumber": 6, 06:41:32 INFO - "slavename": "t-yosemite-r7-0196", 06:41:32 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 06:41:32 INFO - "platform": "yosemite_r7", 06:41:32 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:41:32 INFO - "branch": "mozilla-central", 06:41:32 INFO - "repo_path": "mozilla-central", 06:41:32 INFO - "revision": "f14683f7fad599fe1982c7d530281092b47fbcf4", 06:41:32 INFO - "stage_platform": "macosx64", 06:41:32 INFO - "builduid": "93be0286cd2f4226aa4ef92d70346df4", 06:41:32 INFO - "slavebuilddir": "test" 06:41:32 INFO - } 06:41:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 06:41:32 INFO - Running post-action listener: _resource_record_post_action 06:41:32 INFO - [mozharness: 2016-12-15 14:41:32.230547Z] Finished read-buildbot-config step (success) 06:41:32 INFO - [mozharness: 2016-12-15 14:41:32.230675Z] Running download-and-extract step. 06:41:32 INFO - Running pre-action listener: _resource_record_pre_action 06:41:32 INFO - Running main action method: download_and_extract 06:41:32 INFO - mkdir: /builds/slave/test/build/tests 06:41:32 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')]} 06:41:32 INFO - trying https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 06:41:32 INFO - Downloading https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:41:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 06:41:33 INFO - Downloaded 1199 bytes. 06:41:33 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 06:41:33 INFO - Using the following test package requirements: 06:41:33 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:41:33 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 06:41:33 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 06:41:33 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'jsshell-mac.zip'], 06:41:33 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 06:41:33 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 06:41:33 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 06:41:33 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 06:41:33 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 06:41:33 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 06:41:33 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 06:41:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:41:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:41:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:41:33 INFO - Fetch https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:41:34 INFO - Expected file size: 16276010 06:41:34 INFO - Obtained file size: 16276010 06:41:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:41:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 06:41:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:41:41 INFO - Fetch https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 06:41:42 INFO - Expected file size: 16276010 06:41:42 INFO - Obtained file size: 16276010 06:41:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 06:41:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:41:48 INFO - Fetch https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 06:41:49 INFO - Expected file size: 14409734 06:41:49 INFO - Obtained file size: 14409734 06:41:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:41:49 INFO - trying https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:41:49 INFO - Downloading https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 06:41:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 06:41:51 INFO - Downloaded 69728051 bytes. 06:41:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:41:51 INFO - mkdir: /builds/slave/test/properties 06:41:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:41:51 INFO - Writing to file /builds/slave/test/properties/build_url 06:41:51 INFO - Contents: 06:41:51 INFO - build_url:https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 06:41:52 INFO - Running post-action listener: _resource_record_post_action 06:41:52 INFO - Running post-action listener: set_extra_try_arguments 06:41:52 INFO - [mozharness: 2016-12-15 14:41:52.292623Z] Finished download-and-extract step (success) 06:41:52 INFO - [mozharness: 2016-12-15 14:41:52.292753Z] Running populate-webroot step. 06:41:52 INFO - Running pre-action listener: _resource_record_pre_action 06:41:52 INFO - Running main action method: populate_webroot 06:41:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:41:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:41:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:41:52 INFO - '--tppagecycles', 06:41:52 INFO - '7'], 06:41:52 INFO - 'tests': ['tsvgm']}}, 06:41:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:41:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:41:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:41:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:41:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:41:52 INFO - 'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:41:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:41:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:41:52 INFO - 'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['damp', 'tps']}, 06:41:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:41:52 INFO - 'tests': ['damp', 'tps']}, 06:41:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['dromaeo_dom']}, 06:41:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:41:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['basic_compositor_video']}, 06:41:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:41:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['a11yr', 06:41:52 INFO - 'ts_paint', 06:41:52 INFO - 'tpaint', 06:41:52 INFO - 'sessionrestore', 06:41:52 INFO - 'sessionrestore_no_auto_restore', 06:41:52 INFO - 'tabpaint']}, 06:41:52 INFO - 'other-e10s': {'tests': ['a11yr', 06:41:52 INFO - 'ts_paint', 06:41:52 INFO - 'tpaint', 06:41:52 INFO - 'sessionrestore', 06:41:52 INFO - 'sessionrestore_no_auto_restore', 06:41:52 INFO - 'tabpaint']}, 06:41:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:41:52 INFO - 'ts_paint', 06:41:52 INFO - 'tpaint', 06:41:52 INFO - 'sessionrestore', 06:41:52 INFO - 'sessionrestore_no_auto_restore', 06:41:52 INFO - 'tabpaint']}, 06:41:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:41:52 INFO - 'ts_paint', 06:41:52 INFO - 'tpaint', 06:41:52 INFO - 'sessionrestore', 06:41:52 INFO - 'sessionrestore_no_auto_restore', 06:41:52 INFO - 'tabpaint']}, 06:41:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['a11yr', 06:41:52 INFO - 'ts_paint', 06:41:52 INFO - 'tpaint', 06:41:52 INFO - 'sessionrestore', 06:41:52 INFO - 'sessionrestore_no_auto_restore', 06:41:52 INFO - 'tabpaint']}, 06:41:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['a11yr', 06:41:52 INFO - 'ts_paint', 06:41:52 INFO - 'tpaint', 06:41:52 INFO - 'sessionrestore', 06:41:52 INFO - 'sessionrestore_no_auto_restore', 06:41:52 INFO - 'tabpaint']}, 06:41:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['tsvgx', 06:41:52 INFO - 'tsvgr_opacity', 06:41:52 INFO - 'tart', 06:41:52 INFO - 'tscrollx', 06:41:52 INFO - 'cart', 06:41:52 INFO - 'tsvg_static']}, 06:41:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:41:52 INFO - 'tsvgr_opacity', 06:41:52 INFO - 'tart', 06:41:52 INFO - 'tscrollx', 06:41:52 INFO - 'cart', 06:41:52 INFO - 'tsvg_static']}, 06:41:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:41:52 INFO - 'talos_options': ['--disable-e10s'], 06:41:52 INFO - 'tests': ['tp5o']}, 06:41:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:41:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:41:52 INFO - 'talos_options': ['--disable-e10s', 06:41:52 INFO - '--xperf_path', 06:41:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:52 INFO - 'tests': ['tp5n']}, 06:41:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:41:52 INFO - 'talos_options': ['--xperf_path', 06:41:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:41:52 INFO - 'tests': ['tp5n']}}, 06:41:52 INFO - 'talos.zip': {'path': '', 06:41:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:41:52 INFO - Running post-action listener: _resource_record_post_action 06:41:52 INFO - [mozharness: 2016-12-15 14:41:52.311123Z] Finished populate-webroot step (success) 06:41:52 INFO - [mozharness: 2016-12-15 14:41:52.311211Z] Running create-virtualenv step. 06:41:52 INFO - Running pre-action listener: _resource_record_pre_action 06:41:52 INFO - Running main action method: create_virtualenv 06:41:52 INFO - Creating virtualenv /builds/slave/test/build/venv 06:41:52 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 06:41:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:41:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:41:52 INFO - Using real prefix '/tools/python27' 06:41:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:41:53 INFO - Installing distribute.............................................................................................................................................................................................done. 06:41:56 INFO - Installing pip.................done. 06:41:56 INFO - Return code: 0 06:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:41:56 INFO - Reading from file tmpfile_stdout 06:41:56 INFO - Output received: 06:41:56 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) 06:41:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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')]} 06:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:41: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', 'pip>=1.5'] in /builds/slave/test/build 06:41: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 pip>=1.5 06:41:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:41:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:56 INFO - 'HOME': '/Users/cltbld', 06:41:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:56 INFO - 'LOGNAME': 'cltbld', 06:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:56 INFO - 'MOZ_NO_REMOTE': '1', 06:41:56 INFO - 'NO_EM_RESTART': '1', 06:41:56 INFO - 'PAGER': '/bin/cat', 06:41:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:56 INFO - 'PWD': '/builds/slave/test', 06:41:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:56 INFO - 'SHELL': '/bin/bash', 06:41:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:41:56 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:41:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:56 INFO - 'USER': 'cltbld', 06:41:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:56 INFO - 'XPC_FLAGS': '0x0', 06:41:56 INFO - 'XPC_SERVICE_NAME': '0', 06:41:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:56 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 06:41:56 INFO - Cleaning up... 06:41:56 INFO - Return code: 0 06:41:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:41: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')]} 06:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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')]} 06:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:41: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', '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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:41: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 psutil>=3.1.1 06:41:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:41:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:41:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:41:56 INFO - 'HOME': '/Users/cltbld', 06:41:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:41:56 INFO - 'LOGNAME': 'cltbld', 06:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:41:56 INFO - 'MOZ_NO_REMOTE': '1', 06:41:56 INFO - 'NO_EM_RESTART': '1', 06:41:56 INFO - 'PAGER': '/bin/cat', 06:41:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:41:56 INFO - 'PWD': '/builds/slave/test', 06:41:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:41:56 INFO - 'SHELL': '/bin/bash', 06:41:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:41:56 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:41:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:41:56 INFO - 'USER': 'cltbld', 06:41:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:41:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:41:56 INFO - 'XPC_FLAGS': '0x0', 06:41:56 INFO - 'XPC_SERVICE_NAME': '0', 06:41:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:41:56 INFO - Downloading/unpacking psutil>=3.1.1 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:41: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 06:42:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:42:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:00 INFO - Installing collected packages: psutil 06:42:00 INFO - Running setup.py install for psutil 06:42:00 INFO - building 'psutil._psutil_osx' extension 06:42:00 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 06:42:01 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 06:42:01 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 06:42:01 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 06:42:01 INFO - building 'psutil._psutil_posix' extension 06:42:01 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 06:42:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:42:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:42:01 INFO - ^ 06:42:01 INFO - 1 warning generated. 06:42:01 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 06:42:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:02 INFO - Successfully installed psutil 06:42:02 INFO - Cleaning up... 06:42:02 INFO - Return code: 0 06:42:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:42:02 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')]} 06:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:02 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')]} 06:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:02 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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:02 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 06:42:02 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 06:42:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:02 INFO - 'HOME': '/Users/cltbld', 06:42:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:02 INFO - 'LOGNAME': 'cltbld', 06:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:02 INFO - 'MOZ_NO_REMOTE': '1', 06:42:02 INFO - 'NO_EM_RESTART': '1', 06:42:02 INFO - 'PAGER': '/bin/cat', 06:42:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:02 INFO - 'PWD': '/builds/slave/test', 06:42:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:02 INFO - 'SHELL': '/bin/bash', 06:42:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:02 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:02 INFO - 'USER': 'cltbld', 06:42:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:02 INFO - 'XPC_FLAGS': '0x0', 06:42:02 INFO - 'XPC_SERVICE_NAME': '0', 06:42:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:42: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 06:42: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 06:42: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 06:42: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 06:42: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 06:42: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 06:42:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:42:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:42:04 INFO - Installing collected packages: mozsystemmonitor 06:42:04 INFO - Running setup.py install for mozsystemmonitor 06:42:05 INFO - Successfully installed mozsystemmonitor 06:42:05 INFO - Cleaning up... 06:42:05 INFO - Return code: 0 06:42:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:42:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:05 INFO - 'HOME': '/Users/cltbld', 06:42:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:05 INFO - 'LOGNAME': 'cltbld', 06:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:05 INFO - 'MOZ_NO_REMOTE': '1', 06:42:05 INFO - 'NO_EM_RESTART': '1', 06:42:05 INFO - 'PAGER': '/bin/cat', 06:42:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:05 INFO - 'PWD': '/builds/slave/test', 06:42:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:05 INFO - 'SHELL': '/bin/bash', 06:42:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:05 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:05 INFO - 'USER': 'cltbld', 06:42:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:05 INFO - 'XPC_FLAGS': '0x0', 06:42:05 INFO - 'XPC_SERVICE_NAME': '0', 06:42:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:05 INFO - Downloading/unpacking jsonschema==2.5.1 06:42:05 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 06:42:05 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 06:42:05 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 06:42:05 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 06:42:05 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 06:42:05 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 06:42:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:42:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:42:08 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 06:42:08 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 06:42:08 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 06:42:08 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 06:42:08 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 06:42:08 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 06:42:08 INFO - Downloading functools32-3.2.3-2.tar.gz 06:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:42:08 INFO - warning: no files found matching '*.txt' 06:42:08 INFO - no previously-included directories found matching 'build' 06:42:08 INFO - no previously-included directories found matching 'dist' 06:42:08 INFO - no previously-included directories found matching '.git*' 06:42:08 INFO - Installing collected packages: jsonschema, functools32 06:42:08 INFO - Running setup.py install for functools32 06:42:08 INFO - warning: no files found matching '*.txt' 06:42:08 INFO - no previously-included directories found matching 'build' 06:42:08 INFO - no previously-included directories found matching 'dist' 06:42:08 INFO - no previously-included directories found matching '.git*' 06:42:08 INFO - Successfully installed jsonschema functools32 06:42:08 INFO - Cleaning up... 06:42:08 INFO - Return code: 0 06:42:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:42:08 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')]} 06:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:08 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')]} 06:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:08 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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:08 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 06:42:08 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 06:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:08 INFO - 'HOME': '/Users/cltbld', 06:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:08 INFO - 'LOGNAME': 'cltbld', 06:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:08 INFO - 'MOZ_NO_REMOTE': '1', 06:42:08 INFO - 'NO_EM_RESTART': '1', 06:42:08 INFO - 'PAGER': '/bin/cat', 06:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:08 INFO - 'PWD': '/builds/slave/test', 06:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:08 INFO - 'SHELL': '/bin/bash', 06:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:08 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:08 INFO - 'USER': 'cltbld', 06:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:08 INFO - 'XPC_FLAGS': '0x0', 06:42:08 INFO - 'XPC_SERVICE_NAME': '0', 06:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:42:09 INFO - Cleaning up... 06:42:09 INFO - Return code: 0 06:42:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42: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')]} 06:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:42:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:09 INFO - 'HOME': '/Users/cltbld', 06:42:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:09 INFO - 'LOGNAME': 'cltbld', 06:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:09 INFO - 'MOZ_NO_REMOTE': '1', 06:42:09 INFO - 'NO_EM_RESTART': '1', 06:42:09 INFO - 'PAGER': '/bin/cat', 06:42:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:09 INFO - 'PWD': '/builds/slave/test', 06:42:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:09 INFO - 'SHELL': '/bin/bash', 06:42:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:09 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:09 INFO - 'USER': 'cltbld', 06:42:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:09 INFO - 'XPC_FLAGS': '0x0', 06:42:09 INFO - 'XPC_SERVICE_NAME': '0', 06:42:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:09 INFO - Downloading/unpacking blobuploader==1.2.4 06:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:11 INFO - Downloading blobuploader-1.2.4.tar.gz 06:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:42:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:42:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:42:13 INFO - Downloading docopt-0.6.1.tar.gz 06:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:42:13 INFO - Installing collected packages: blobuploader, requests, docopt 06:42:13 INFO - Running setup.py install for blobuploader 06:42:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:42:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:42:13 INFO - Running setup.py install for requests 06:42:13 INFO - Running setup.py install for docopt 06:42:14 INFO - Successfully installed blobuploader requests docopt 06:42:14 INFO - Cleaning up... 06:42:14 INFO - Return code: 0 06:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:14 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')]} 06:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:14 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')]} 06:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:14 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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:14 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 06:42:14 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 06:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:14 INFO - 'HOME': '/Users/cltbld', 06:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:14 INFO - 'LOGNAME': 'cltbld', 06:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:14 INFO - 'MOZ_NO_REMOTE': '1', 06:42:14 INFO - 'NO_EM_RESTART': '1', 06:42:14 INFO - 'PAGER': '/bin/cat', 06:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:14 INFO - 'PWD': '/builds/slave/test', 06:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:14 INFO - 'SHELL': '/bin/bash', 06:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:14 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:14 INFO - 'USER': 'cltbld', 06:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:14 INFO - 'XPC_FLAGS': '0x0', 06:42:14 INFO - 'XPC_SERVICE_NAME': '0', 06:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-oS9zQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-5QZTLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-5DsgPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-TDgPLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:14 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-DBAAuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-LunLws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-iqYxGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-nkEAxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-2Ep5ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-YMClE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-OafbAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-8Y8pjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-YLcmCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-kCybbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:15 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-uDX69y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-LWMsql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:16 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-8zFkJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:42:16 INFO - Running setup.py install for manifestparser 06:42:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:42:16 INFO - Running setup.py install for mozcrash 06:42:16 INFO - Running setup.py install for mozdebug 06:42:16 INFO - Running setup.py install for mozdevice 06:42:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:42:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:42:16 INFO - Running setup.py install for mozfile 06:42:17 INFO - Running setup.py install for mozhttpd 06:42:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Running setup.py install for mozinfo 06:42:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Running setup.py install for mozInstall 06:42:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Running setup.py install for mozleak 06:42:17 INFO - Running setup.py install for mozlog 06:42:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Running setup.py install for moznetwork 06:42:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:42:17 INFO - Running setup.py install for mozprocess 06:42:18 INFO - Running setup.py install for mozprofile 06:42:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:42:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:42:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:42:18 INFO - Running setup.py install for mozrunner 06:42:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:42:18 INFO - Running setup.py install for mozscreenshot 06:42:18 INFO - Running setup.py install for moztest 06:42:18 INFO - Running setup.py install for mozversion 06:42:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:42:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:42:18 INFO - Cleaning up... 06:42:18 INFO - Return code: 0 06:42:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:18 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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:18 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 06:42:18 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 06:42:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:18 INFO - 'HOME': '/Users/cltbld', 06:42:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:18 INFO - 'LOGNAME': 'cltbld', 06:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:18 INFO - 'MOZ_NO_REMOTE': '1', 06:42:18 INFO - 'NO_EM_RESTART': '1', 06:42:18 INFO - 'PAGER': '/bin/cat', 06:42:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:18 INFO - 'PWD': '/builds/slave/test', 06:42:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:18 INFO - 'SHELL': '/bin/bash', 06:42:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:18 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:18 INFO - 'USER': 'cltbld', 06:42:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:18 INFO - 'XPC_FLAGS': '0x0', 06:42:18 INFO - 'XPC_SERVICE_NAME': '0', 06:42:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-JVUN7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-g4oCh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-WO7hKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-s5sTe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-OX0ebh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-sVEegK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-09bNND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-jYNeyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:19 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)) 06:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:19 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-sBp0Wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-x4sMLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-FPsMwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-HcTFW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-n10r2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-j65whQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-sLmt78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:20 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-Cn3XHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 06:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:20 INFO - Running setup.py (path:/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/pip-FkyFEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:20 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)) 06:42:20 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)) 06:42:20 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)) 06:42:20 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)) 06:42:20 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)) 06:42:20 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)) 06:42:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:42:20 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 06:42:20 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 06:42:20 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 06:42:20 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 06:42:20 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 06:42:20 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 06:42:23 INFO - Downloading blessings-1.6.tar.gz 06:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:42:23 INFO - Installing collected packages: blessings 06:42:23 INFO - Running setup.py install for blessings 06:42:23 INFO - Successfully installed blessings 06:42:23 INFO - Cleaning up... 06:42:23 INFO - Return code: 0 06:42:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:24 INFO - Reading from file tmpfile_stdout 06:42:24 INFO - Current package versions: 06:42:24 INFO - blessings == 1.6 06:42:24 INFO - blobuploader == 1.2.4 06:42:24 INFO - docopt == 0.6.1 06:42:24 INFO - functools32 == 3.2.3-2 06:42:24 INFO - jsonschema == 2.5.1 06:42:24 INFO - manifestparser == 1.1 06:42:24 INFO - mozInstall == 1.12 06:42:24 INFO - mozcrash == 1.0 06:42:24 INFO - mozdebug == 0.1 06:42:24 INFO - mozdevice == 0.49 06:42:24 INFO - mozfile == 1.2 06:42:24 INFO - mozhttpd == 0.7 06:42:24 INFO - mozinfo == 0.9 06:42:24 INFO - mozleak == 0.1 06:42:24 INFO - mozlog == 3.4 06:42:24 INFO - moznetwork == 0.27 06:42:24 INFO - mozprocess == 0.23 06:42:24 INFO - mozprofile == 0.28 06:42:24 INFO - mozrunner == 6.13 06:42:24 INFO - mozscreenshot == 0.1 06:42:24 INFO - mozsystemmonitor == 0.3 06:42:24 INFO - moztest == 0.7 06:42:24 INFO - mozversion == 1.4 06:42:24 INFO - psutil == 3.1.1 06:42:24 INFO - requests == 1.2.3 06:42:24 INFO - wsgiref == 0.1.2 06:42:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:24 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')]} 06:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:24 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')]} 06:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:24 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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:24 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 06:42:24 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 06:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:24 INFO - 'HOME': '/Users/cltbld', 06:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:24 INFO - 'LOGNAME': 'cltbld', 06:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:24 INFO - 'MOZ_NO_REMOTE': '1', 06:42:24 INFO - 'NO_EM_RESTART': '1', 06:42:24 INFO - 'PAGER': '/bin/cat', 06:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:24 INFO - 'PWD': '/builds/slave/test', 06:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:24 INFO - 'SHELL': '/bin/bash', 06:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:24 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:24 INFO - 'USER': 'cltbld', 06:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:24 INFO - 'XPC_FLAGS': '0x0', 06:42:24 INFO - 'XPC_SERVICE_NAME': '0', 06:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 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)) 06:42:24 INFO - Cleaning up... 06:42:24 INFO - Return code: 0 06:42:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:42:24 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')]} 06:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:24 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')]} 06:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:42:24 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 0x10a95e3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a8d4570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ae9d89690>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, '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.5qHJpNhWrR/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.ElLz90XBY6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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 06:42:24 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 06:42:24 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 06:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:24 INFO - 'HOME': '/Users/cltbld', 06:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:24 INFO - 'LOGNAME': 'cltbld', 06:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:24 INFO - 'MOZ_NO_REMOTE': '1', 06:42:24 INFO - 'NO_EM_RESTART': '1', 06:42:24 INFO - 'PAGER': '/bin/cat', 06:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:24 INFO - 'PWD': '/builds/slave/test', 06:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:24 INFO - 'SHELL': '/bin/bash', 06:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:24 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:24 INFO - 'USER': 'cltbld', 06:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:24 INFO - 'XPC_FLAGS': '0x0', 06:42:24 INFO - 'XPC_SERVICE_NAME': '0', 06:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:42:24 INFO - Cleaning up... 06:42:24 INFO - Return code: 0 06:42:24 INFO - Running post-action listener: _resource_record_post_action 06:42:24 INFO - Running post-action listener: _start_resource_monitoring 06:42:24 INFO - Starting resource monitoring. 06:42:24 INFO - [mozharness: 2016-12-15 14:42:24.757429Z] Finished create-virtualenv step (success) 06:42:24 INFO - [mozharness: 2016-12-15 14:42:24.758395Z] Running install step. 06:42:24 INFO - Running pre-action listener: _resource_record_pre_action 06:42:24 INFO - Running main action method: install 06:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:25 INFO - Reading from file tmpfile_stdout 06:42:25 INFO - Detecting whether we're running mozinstall >=1.0... 06:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:42:25 INFO - Reading from file tmpfile_stdout 06:42:25 INFO - Output received: 06:42:25 INFO - Usage: mozinstall [options] installer 06:42:25 INFO - Options: 06:42:25 INFO - -h, --help show this help message and exit 06:42:25 INFO - -d DEST, --destination=DEST 06:42:25 INFO - Directory to install application into. [default: 06:42:25 INFO - "/builds/slave/test"] 06:42:25 INFO - --app=APP Application being installed. [default: firefox] 06:42:25 INFO - mkdir: /builds/slave/test/build/application 06:42:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:42:46 INFO - Reading from file tmpfile_stdout 06:42:46 INFO - Output received: 06:42:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:42:46 INFO - Running post-action listener: _resource_record_post_action 06:42:46 INFO - [mozharness: 2016-12-15 14:42:46.824219Z] Finished install step (success) 06:42:46 INFO - [mozharness: 2016-12-15 14:42:46.824415Z] Running run-tests step. 06:42:46 INFO - Running pre-action listener: _resource_record_pre_action 06:42:46 INFO - Running main action method: run_tests 06:42:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:42:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:42:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:42:46 INFO - 2016-12-15 06:42:46.839 screenresolution[1632:10678] starting screenresolution argv=screenresolution get 06:42:46 INFO - 2016-12-15 06:42:46.842 screenresolution[1632:10678] Display 0: 1600x1200x32@60 06:42:46 INFO - 2016-12-15 06:42:46.848 screenresolution[1633:10681] starting screenresolution argv=screenresolution list 06:42:46 INFO - Available Modes on Display 0 06:42:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:42:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:42:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:42:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:42:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:42:47 INFO - Intel Iris: 06:42:47 INFO - Chipset Model: Intel Iris 06:42:47 INFO - Type: GPU 06:42:47 INFO - Bus: Built-In 06:42:47 INFO - VRAM (Dynamic, Max): 1536 MB 06:42:47 INFO - Vendor: Intel (0x8086) 06:42:47 INFO - Device ID: 0x0a2e 06:42:47 INFO - Revision ID: 0x0009 06:42:47 INFO - Displays: 06:42:47 INFO - Display: 06:42:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:42:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:42:47 INFO - Display Serial Number: 1600x1200 60 06:42:47 INFO - Main Display: Yes 06:42:47 INFO - Mirror: Off 06:42:47 INFO - Online: Yes 06:42:47 INFO - Rotation: Supported 06:42:47 INFO - Return code: 0 06:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:42:47 INFO - Python 2.7.3 06:42:47 INFO - Return code: 0 06:42:47 INFO - grabbing minidump binary from tooltool 06:42: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')]} 06:42:47 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 0x10a773d30>, '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 0x10a5dadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a76bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:42:47 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 06:42:47 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 06:42:47 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 06:42:47 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:42:47 INFO - Return code: 0 06:42:47 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:42:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:42:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:42:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:42:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 06:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0196 --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 06:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5qHJpNhWrR/Render', 06:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:42:47 INFO - 'HOME': '/Users/cltbld', 06:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:42:47 INFO - 'LOGNAME': 'cltbld', 06:42:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:42:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:47 INFO - 'MOZ_NO_REMOTE': '1', 06:42:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:42:47 INFO - 'NO_EM_RESTART': '1', 06:42:47 INFO - 'PAGER': '/bin/cat', 06:42:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:47 INFO - 'PWD': '/builds/slave/test', 06:42:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:42:47 INFO - 'SHELL': '/bin/bash', 06:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ElLz90XBY6/Listeners', 06:42:47 INFO - 'TMPDIR': '/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/', 06:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:42:47 INFO - 'USER': 'cltbld', 06:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:47 INFO - 'XPC_FLAGS': '0x0', 06:42:47 INFO - 'XPC_SERVICE_NAME': '0', 06:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:42:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0196', '--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 06:42:47 INFO - mozversion application_buildid: 20161215051701 06:42:47 INFO - mozversion application_changeset: f14683f7fad599fe1982c7d530281092b47fbcf4 06:42:47 INFO - mozversion application_display_name: Nightly 06:42:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:42:47 INFO - mozversion application_name: Firefox 06:42:47 INFO - mozversion application_remotingname: firefox 06:42:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:42:47 INFO - mozversion application_vendor: Mozilla 06:42:47 INFO - mozversion application_version: 53.0a1 06:42:47 INFO - mozversion platform_buildid: 20161215051701 06:42:47 INFO - mozversion platform_changeset: f14683f7fad599fe1982c7d530281092b47fbcf4 06:42:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:42:47 INFO - mozversion platform_version: 53.0a1 06:42:47 INFO - using testdate: 1481812967 06:42:47 INFO - actual date: 1481812967 06:42:47 INFO - starting webserver on 'localhost:49236' 06:42:47 INFO - SUITE-START | Running 2 tests 06:42:47 INFO - TEST-START | dromaeo_css 06:42:47 INFO - operating with platform_type : mac_ 06:42:47 INFO - Initialising browser for dromaeo_css test... 06:42:47 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpYVeN12/profile http://localhost:49236/getInfo.html) 06:42:49 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 06:42:49 INFO - PROCESS | 1643 | colorDepth:24 06:42:49 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 06:42:49 INFO - PROCESS | 1643 | __metrics 06:42:49 INFO - PROCESS | 1643 | 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" 06:42:49 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:42:50 INFO - TEST-INFO | 1643: exit 0 06:42:50 INFO - Browser initialized. 06:42:50 INFO - Running cycle 1/1 for dromaeo_css test... 06:42:50 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmpYVeN12/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:43:02 INFO - PROCESS | 1646 | RSS: Main: 236806144 06:43:02 INFO - PROCESS | 1646 | 06:43:53 INFO - PROCESS | 1646 | 1481813033929 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:46:07 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 06:46:09 INFO - PROCESS | 1646 | RSS: Main: 394883072 06:46:09 INFO - PROCESS | 1646 | 06:49:12 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 06:49:12 INFO - PROCESS | 1646 | RSS: Main: 377937920 06:49:12 INFO - PROCESS | 1646 | 06:52:15 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 06:52:16 INFO - PROCESS | 1646 | RSS: Main: 370749440 06:52:16 INFO - PROCESS | 1646 | 06:55:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 06:55:19 INFO - PROCESS | 1646 | RSS: Main: 343224320 06:55:19 INFO - PROCESS | 1646 | 06:58:22 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 06:58:23 INFO - PROCESS | 1646 | RSS: Main: 341323776 06:58:23 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 07:01:27 INFO - PROCESS | 1646 | RSS: Main: 387411968 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | __start_tp_report 07:01:27 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 07:01:27 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 07:01:27 INFO - PROCESS | 1646 | |i|pagename|runs| 07:01:27 INFO - PROCESS | 1646 | |0;dojo.html;2776.6251556039933;3304.3060957198986;3322.9667703322966;3327.4177019021663;3355.3457075870215;5459.645123067008;5519.172124181375;5530.087535556633;5584.21820945068;5590.888182236353;5500.614956953015;5529.115341545344;5539.390667026624;5546.306711661043;5547.500724934755;5024.748762561866;5075.619328550355;5076.4415914249585;5097.974510127444;5154.510321519469;5069.619778516626;5159.922601160985;5160.948390516103;5172.2241663750365;5179.404368497614;4728.456227533843;5108.259302401149;5149.227615857614;5156.20078887773;5160.380754309488;5155.40712818027;5155.484451554852;5176.378834539879;5184.688918664892;5239.056969745444;4983.825566105169;5046.823361182378;5087.440381558025;5110;5135.998480296344;5535.529479994206;5540.695261760601;5544.334679838405;5603.3836278009385;5617.8033768817895;6089.8173054807985;6096.420840020191;6110.511159107261;6116.847078823021;6129.1419201311855;5930.584859059867;6120.265568131808;6172.537059720494;6173;6177.567570270083;5520.889582208373;5569.10894256921;5666.008448521492;5682.289713785777;5699.601027928088;6225.501959843202;6229.283632382334;6243.594166379171;6257.374262573706;6259.2488901332135;5891.469767720926;5975;5988.610740301867;5988.760449582055;5997.640141591519;5957.285125784933;5987.221661184105;5992.670403127782;6018.759249629966;6124.693765311717;5902.61632993854;5923.111533269957;5926.407359264039;5928.992071347881;5930.1994230779155;5941.108833674897;5955.7617695292565;5956.583039187302;5957.851053723605;5963.880722385615;4708.8116475341285;4768.165571025057;4770.022145460172;4777.092352453023;4778.235482322812;4306.870793876189;4344.196323680129;4361.978190109029;4376.518582955872;4380.2772542530765;5625.409332020161;5626.493615574618;5627.380988091307;5660.179274005246;5684.147377893267;5960.493358064613;5997.550183736237;6107.175531303217;6155;6172.753089876354;5510.090835012178;5559.249501317351;5566.526845218121;5617.831465056055;5628.549716022709;5267.499587539178;5277.419483856849;5316;5336.9859726652585;5340.946590534045;6230.844228894314;6244.250689917239;6252;6253.968730156502;6273.090401891609;6138.232720909887;6153.107799369156;6160.16837726919;6163.291221509405;6181.752729890754;6152.354002829638;6207.844803879939;6213.627182369072;6256.718447669775;6275.8117256480555;6049.274087109399;6052.818415447544;6064.666443345658;6067.453929146398;6111.511079113571;6085.148079268817;6109.572329937039;6119.3268740437625;6124.663143527148;6138.754449821957;5800.76796928135;5926.7925622603;5962.07587823888;5965.940340596712;5972.283326000907;4951.861071953543;5807.912881306868;5859.882802344015;5878.353381128158;5901.822945311647;5775.826725198251;5803.303603567599;5804.970975145097;5809.896119737236;5836.941630583639;5486.61593688438;5726.112452569859;5908.05471124618;5926.585139040226;5959.4934430573885;5627.465390787868;5696.174054762119;5699.857503562444;5716.685582293014;5746.339170995389 07:01:27 INFO - PROCESS | 1646 | |1;ext.html;428.90992891492783;465.72754938361055;494.73531660561605;498.7481321932425;541.4260883463527;29841;31588.842055789748;39007.219855602874;40350.79824600873;40736.59263407365;41668.79165604168;42230.7888460558;42279.154416911646;42293.36559951603;42491.78754106225;9193.218576420995;9408.247340212802;9420.434773913554;9422.764430889249;9445.905540944606;8301;8536.74389768308;10091.949540252288;11073.557057717722;11317.151213658968;10627.787444251111;11208.159388045888;11236.157288203418;11242.718932026724;11291.20961532693;11105.444727763619;11159.38623375714;11172.832407513893;11172.888271117266;11207.047400970887;8235.711750088718;8441.409101362908;9264.768380790467;10863.076638485738;11170.497327620194;39044.41433378502;39240.803795980835;39251.41122883159;39273.80363098166;39367.21265574701;3341.9498707519165;3364.327134573095;3420.675035871588;3591.515145455356;3621.619729928346;29671.851640741657;30110;30272.09183724492;30326.54510182349;30475;3146.590943177372;3147.6222853257755;3173.7778355515125;3278.246003419203;3303.157694787838;482679;483582;498029;502962;505218.47390763176;58441.123383148435;60489;60643.69678151669;60847;60877.69561152166;62087.6895615519;62520;62524.687376562826;62621.37378626246;62666.373336266966;15155.939084264217;15701.921490392704;15712.21438928049;15718;15733.292001859943;11079.446027698745;12225.633231003085;12268.32524211177;12282;12287.631371058882;14791.778123328158;16706.164691765363;17130.914345428442;17146.314147434212;17325.7401138983;5661.8393229387875;6156.78451254204;6240.937590624036;6261.186045814015;6298.716557754912;843.7806170395742;919.5815903763771;959.712086374085;966.1401352796017;1054.9525271362807;20762.688559671617;28149.296267593065;29567.556486652717;29861.701382986328;29986.55020174699;1061.3048453263125;1086.4893500054961;1110.7278716714457;1129.9604513841975;1187.7624475105013;15280.006799558216;16803.579910502336;16988;17145.485635430956;17237.310507579557;615773;631011;632864;633396;652753;52044.739776301634;55433.6251331094;62651.68674156691;62741.68629156916;62743.058854117226;1383.889288856889;1405.7048019915933;1432.2194404050026;1433.770596704543;1438.6691061056015;30058.459730507162;30971.69028309778;31019.224519387197;31507.52738708967;31546.211344716565;50823.745881270355;51586;51649;51706;51834.74082629563;612113;616905;617140;618501;620891;39305;40138.1972360557;40360.79819601001;40908;41435.585644143175;40884.386734198415;41208.204914411916;41840.95397615084;42253;42444;34045;34779.478307825906;34960.825195873855;34985.65014349824;36070.09824754402;28627.28431789222;34789;34867.65132348644;35898.28203435969;36134.819325903205;32608.34783304368;34133.65866341305;34141.975740727816;34369.484457733655;34436.65563344335;29346.55980160342;31006;31073.53389699111;31336.05991820249;31340.529892052095;22344.553108938057;23172;23401.41496462534;23664.290071297888;23827.285181444586 07:01:27 INFO - PROCESS | 1646 | |2;jquery.html;306.797513640997;344.2340791738384;370.5312779334142;377.8431950740443;390.97849618271;14602.269886505672;14862.77705834412;15575.688486230269;16340.264688089035;20432.591348173028;17854.910725446356;20111;20289.496351593505;21072.473188170305;21358.359249222547;5551.861203469905;5911.408859114097;5921.378255283198;5923.555733319997;5924.763009479637;4316.956830431703;5659.773609055654;5869.178315035899;6455.096286519891;6507.9023814642815;6285.088662143987;6410.358964103576;6418.679066046702;6459.51553633477;6476.384743449388;6267.4045965633195;6367.522435817332;6398.888366838932;6417.518686098561;6420.582662126947;5351.983123206578;5524.392316845144;5589.357223919261;5589.916151257735;5616.691081990489;25770.613440798403;25848.48303033929;25877.611835822478;26046;26212.281789277924;2171.35944896256;2380.7262164850918;2715.714849940767;2839.5172820620546;3058.3730335281216;15439.150846703427;15468.922655386763;15599.220038998119;15806.901098242563;16064.75902861458;1806.927722891096;1872.7659042619673;1906.6949288113835;1936.5255512399413;1940.7477027986413;110670.44664776705;112844;113743.43128284389;117804.41097794542;120681;10679.038886500251;10796.568137274578;10810.405427701551;11030.959272534606;11110.3337297977;13326.333683315795;13356.06507544482;13683.357997040419;13781.86218137826;13802.723945521033;8282;8421.578921054046;8430.367722420842;8433.114522975122;8603.440776349516;6954.3393377629045;8396.496210227406;8413.70552030676;8563.95718021406;8645;6545.803625891231;6712.563683360663;6733.259341472434;6737.258901520829;6752.493562982796;1727.5747508305699;1758.7273972534279;1770.0618672103806;1781.1361489677497;1787.1778981668317;836.1847198980945;900.7477906186278;923.8060007398387;976.6972238606055;979.6277414582413;18154.636907262044;22252.777472225393;22308.776912230995;22314.21900233484;22464.43838904008;944.5985456181232;972.844344904826;974.1962880623372;981.5043403081398;1029.9794004120026;10359.896401036043;10569.894301056891;11556.76886462266;11637.709057273467;11718.765624687629;553889;557179.2141039349;561213;562631;569875;95175.52412237895;105971;106570;126755;128009;981.6564202529057;1028.4138041316528;1041.7551875309296;1049.1659130990881;1054.9789004220027;16870.409535666193;19167.808321916604;19410.573678290213;19624.41126766199;19668.213271469554;41408;48632.5136748628;51753.7412312936;52160.73919630377;53191.46808531865;70678.58642827012;72917;74773;75440;80238;6478.546501744832;6816.216135144522;7249.311315425026;8019.679212831421;8063.637136328762;9803.901960980298;10333.689989300334;12107;12434.129610927148;12556.246625202517;10791.946040269748;10888.802231754658;10903.34579925207;10910.454477276264;10932.836007460053;10637;10655.25413221067;10671.893281067401;10938;11105.666829995112;10716.303440276357;10743.892561074603;10803.891961080602;10949.726256843642;11110.555577776799;7694;7782.299593036654;7955.9204407957495;8024.0772311184965;8082.232187942136;8165.38759593021;10579.523921423708;11085.501152447998;11350.978411942964;11444 07:01:27 INFO - PROCESS | 1646 | |3;mootools.html;1341.5846282172304;1482.0440815673887;1497.8427265137161;1702.1234064456808;1882.783479899812;7414.59219742914;7699;7833;8298.1701829817;8309.252167304941;8088.757337279891;8156.225158609937;8158;8178.877316840252;8194.713185038525;1956.9804301957013;2037.4193354893857;2259.017327462555;2295.047555264563;2298.287530865429;2245.8091062259728;2323.59337116004;2329.9650505242435;2330.382448651109;2336.310788317442;2271.432141964509;2284.794368506834;2294.6328587426015;2303.1248125712204;2314.7222333320024;2262.049939025613;2270.8864556772096;2271.3867255840914;2312.9653055204185;2314.0628045641456;2237.496563273267;2289.1530133850583;2295.8278129140213;2314.884255787204;2325.046730840347;8198.180181981814;8287.544185069819;8291.875621865676;8294.419390642657;8306.210909963544;5000.474950130257;5157.5616072633875;5165.9225111623355;5172.32759741235;5175.611829112794;3240.7731458797894;3335.332933413327;3551.786892786441;3556.893293201208;3558.87543935961;1031.9071283584512;1051.395447617623;1053.0364716284591;1072.7479042425025;1078.0297732041147;10584.523696433678;10633.255672102956;10737.355758654505;10780.353178809297;10817.56729730802;4411.205982923105;4473.821047158142;4627.167109920179;4628.884277893079;4650;9206.953965230132;9239.122283383067;9244.029376915461;9247.583858726373;9256.352055356061;5081.669691470042;5136.178211486219;5140.897182056413;5178.766955487012;5203.9219411708855;3903.6681882040343;4153.979230103891;4724.338592597039;4727.361806156194;4744.810207591727;3174.4603417419094;3691.077230692327;3699.7595156314756;3775.3959366501776;3785.356489396809;1088.3796236145322;1118.7749414391228;1151.4818331750746;1228.3612521488776;1230.698478872664;746.637880627895;840.8570543007703;883.8099808541194;896.1441823058963;935.9859602105973;5313.362396512366;5547.974989128938;5678.176664383641;5803.361630220672;6020.729701341725;905.7554460295684;913.1964370368602;942.599395257013;959.5010594490826;988.2933702402672;3658.378075727133;3684.5946945835935;3825.1967086911504;3829.272438236726;3927.6842257843373;9652.27607929408;9816.901830981742;9845;9869.950650246847;9888.505574721235;9205.263578913671;9559.996200398997;9579.856302155473;9625.663101791404;9907.80184396308;7543.924560754432;7612.619369031526;7652.196519365498;7737.226277372218;7741.148473667892;4727.172744769583;5383.815560576667;5830.4461076197695;5841.532677385884;5845.824625261249;8916.19754222123;8979.416337938013;9184.954075229582;9249;9296.581653825458;9219.539023048956;9336.906630933876;9357.672481463116;9415.387999779992;9439.669611563562;6075.210222671025;6487.351264873475;6671.666416679243;6979.651017449006;7149.678264478215;7731.961340193263;7822.687092516236;7879.803004924923;7883.408744344312;7904.170062143622;6906.309369063053;6982.615956122462;6988.05661235747;7075.787726368218;7131.643417829192;6426.839329016812;6446.387593178641;6817.693203805741;6860.622665753432;6917.757878474229;6327.530439029643;6454.354564543508;6491.415772580302;6553.901691474536;6561.245456772533;3955.228730397545;4716.127516409475;4745.406824146981;4762.452317983476;4903.8528844134735;4753.691010084333;4773.331733557236;4882.80468781259;4913.484084171254;5029.170186919117 07:01:27 INFO - PROCESS | 1646 | |4;prototype.html;293.3765747785955;346.1346633416458;346.40072674273506;348.1383575650264;353.8107112694708;5185.688858668478;5192.532672059514;5204.583633309336;5245.6132459730825;5265.367736001842;3946.506686664167;5198.45416231296;5224.14542837293;5253.395859476162;5307.389650190229;3407.50591164281;3486.477028445728;3547.9645203547957;3845.211976430959;3927.8428862845453;3914.7846868422225;3937.5865534118934;3978.9403158952496;3998.1004274038255;4018.7387819791766;3323.5679361682946;3970.8610198643055;3978.562358140602;3978.9602103978877;3984.2828290907623;3747.8688245911535;3997.9600203998025;4003.3994900764974;4005.5994400560003;4007;3196.7282780963415;3375.5105509700957;3450.5686789151355;3507.8421471033867;3509.894703158909;4552.294394368878;4727.479977202505;4858.562729354375;4868.099401610713;5154.819581314673;4025.677945764332;4167.74993500391;4537.98059863361;4547.636189104896;4576.633869290449;5075.492450754932;5108.169227813109;5176.404713457925;5410.377806552218;5412.323459567554;3873.98063009686;3880.708946828999;3887.5723670396233;3898.727089103764;3919.2553414851086;5120.052790233819;5516.9448305516835;5626.549876009909;5653.321601407857;5704.515116215085;3392.6268110507826;3491.493733408692;3873.8959396572404;3930.8034598269974;3990.4413382126527;3601.441776524643;3604.85580576774;3956.327424337812;4056.817443215062;4075.225707115698;3908.843646254175;3915.4909861717792;4030.6573941215324;4136.518089146488;4268.530461649216;5100.285959965608;5384.515393614515;5454.154606036071;5519.3652729936575;5601.899287767087;1161.1465572803982;1266.8923141533073;1302.5961951794784;1309.109805332383;1317.8732183982556;793.3137835772015;839.3243439031638;851.6337974670951;888.4136469929945;954.8472244440856;4631.675782695246;4822.903541929212;4848.369711937426;4886.462489126265;4948;4703.929441058387;4770.308305295713;5309.389420216725;5356.8660783479945;5362.812301569426;4492.910141797146;4636.824242188516;4856.68431551948;4910.852674419773;4936.963237720119;2286.759890211537;2498.400383907849;2612.712601613821;2817.9010186027467;2843.7440630343367;4823.831165909176;4838.975805120952;5065.949340506621;5231.555317797954;5611.9719401403545;4677.859664210079;4990.600751939836;5378.489043540857;5457.524829639658;5829.329627092854;5790.015697331548;5802.966937978149;5829.717462158318;5835.824925252249;5901.704914754245;4969.875753106056;5171.3018742469285;5626.971865140648;5704.80033198836;5713.886002078497;4274.025156604388;4770.570648641639;5393.460653934575;5533.418991005887;5556.277683901067;5067.949320506896;5093;5137.409197942135;5666.036773748555;5772.249607550992;3226.5644138041066;3380.915477113092;3565.983694647013;3871.206402687386;4134.607212314945;5607.327120745536;5647.350554686263;5696.772129114789;5727.914081288867;5730.218056082966;5292.5501332387175;5517.144842549411;5534.418886016911;5550.361708403585;5569.693666848362;4584.931226031679;5386.649867758583;5413.593980451403;5462.235287059735;5523.558115350682;5305.283786688902;5316.7075810830775;5333.226682130991;5415.59383046281;5417.729113544386;4326.447396036354;5478.233047373291;5479.808206712746;5531.695756733257;5546.417626149358;4170.165966806711;4560.771961401983;5023.7739301732245;5302.727345437144;5355.518003379714 07:01:27 INFO - PROCESS | 1646 | |5;yui.html;666.1007639686424;737.2664199121873;741.3142842870346;775.8637817647176;820.790698371915;15021.999999999985;15361.923190384061;15564;15576.766348504767;15617.40799616089;11724.296542207452;13792.172469651829;14077.648058798535;14108.082974606643;14183.219922904236;695.2282965907838;711.8327193109628;718.6514540447879;857.6998050682274;890;851.0765819086299;862.1550880137469;862.7196161247588;864.9264812490945;865.3899001204168;927;927.2535608834885;929.4051806843626;930.1721467893581;932.0958670090001;873.2359185712502;875.4834647557908;875.5053394831931;893.2452077994085;919.4896832258094;533.9038972984861;554.3763266325384;554.5425024354923;557.5734563059262;683.9213490448612;13711.040227184101;14253.358598862973;14265.215413152273;14534.927325363411;14585.70828583433;13747.518836840663;13915.23466209358;13959.302034898214;13987.440502379892;14000.649983750385;11497.540098396054;11692.707682307926;11762.705932351673;11804.527818887234;11994.760104797855;3594.982025089884;3647.854085836563;3829.9617003830163;3870.7096967727534;3871.748336358156;82488;104451.4777426108;104996.85009449729;107468.4626576862;108990.91009089886;10659.84010239847;10662.306950048222;10720.73198170052;10969.83545246822;11178.944105279421;21750.456238593844;22033;22127.889360553094;22324.55350892973;22362.217322393637;7676.424268179797;7701.576413297323;7715.884261736079;7739.419543534257;7987.640556174986;4249.97875010623;4315.417418648442;4374.825006999685;4450.376947227391;4498.887527811766;3445.2248244144866;3514;3531.346700860349;3550.396432606463;3553.4314509678843;576.7808232871482;632.6204277433595;648.2188962300417;661.9801405957829;663.9767608133692;577.431230238215;636.6371168434041;658.1969996604136;671.7111641993891;684.1721516964528;8760.167784060504;8799.868001979976;8943.121785241668;9012.233960113464;9203.217726493189;606.0848119339829;608.943483056896;625.1966223402906;653.4641593893057;669.1635455680399;3941.5467221269346;4314.935275970863;4395.846145384896;4509.458864936229;4513.758716353029;96582;98945;99488.00511994932;99735;102991.4850425758;67626.64746705137;82645.17354826495;86915.56542217248;88438;89117;70179.94730079053;72079.27920720831;73369;74347.62826185835;77831.22168778353;8616.741497755078;8632.956835216035;8661.090585488433;8685.522296273766;8792.780180495538;43148.352774709034;45668.8582785433;48421.03157936892;49086.75456622837;50594.49405505898;53362.73318633382;68547.97178042233;69161;69645.65177174081;72909;11509.712257193638;11511;11524;11797.646070617895;12001.459934302802;10772.86884877108;12415.317157556421;12697.80953285683;13053.543125990545;13193;11785.88214117848;11869.465874035517;11957.402129893644;12035.819462708241;12080.21478603888;11848.76302473963;11857.229280096766;12003.279803211835;12027.699307517381;12381.690457738629;11579.942100289445;11699.415029248674;11946.818991511394;12123.81814272769;12221.511139554319;9499;9666.565004574952;9686.225101991682;10202;10207.540660670436;9741.951290243504;10234.6417875374;10243.539040743035;10243.641472548425;10262.897371026194 07:01:27 INFO - PROCESS | 1646 | __end_tp_report 07:01:27 INFO - PROCESS | 1646 | __start_cc_report 07:01:27 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,2027 07:01:27 INFO - PROCESS | 1646 | __end_cc_report 07:01:27 INFO - PROCESS | 1646 | __startTimestamp1481814087266__endTimestamp 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | ------- Summary: start ------- 07:01:27 INFO - PROCESS | 1646 | Number of tests: 6 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:5600.27 Median:5746.34 stddev:630.89 (11.0%) stddev-sans-first:592.67 07:01:27 INFO - PROCESS | 1646 | Values: 2776.6 3304.3 3323.0 3327.4 3355.3 5459.6 5519.2 5530.1 5584.2 5590.9 5500.6 5529.1 5539.4 5546.3 5547.5 5024.7 5075.6 5076.4 5098.0 5154.5 5069.6 5159.9 5160.9 5172.2 5179.4 4728.5 5108.3 5149.2 5156.2 5160.4 5155.4 5155.5 5176.4 5184.7 5239.1 4983.8 5046.8 5087.4 5110.0 5136.0 5535.5 5540.7 5544.3 5603.4 5617.8 6089.8 6096.4 6110.5 6116.8 6129.1 5930.6 6120.3 6172.5 6173.0 6177.6 5520.9 5569.1 5666.0 5682.3 5699.6 6225.5 6229.3 6243.6 6257.4 6259.2 5891.5 5975.0 5988.6 5988.8 5997.6 5957.3 5987.2 5992.7 6018.8 6124.7 5902.6 5923.1 5926.4 5929.0 5930.2 5941.1 5955.8 5956.6 5957.9 5963.9 4708.8 4768.2 4770.0 4777.1 4778.2 4306.9 4344.2 4362.0 4376.5 4380.3 5625.4 5626.5 5627.4 5660.2 5684.1 5960.5 5997.6 6107.2 6155.0 6172.8 5510.1 5559.2 5566.5 5617.8 5628.5 5267.5 5277.4 5316.0 5337.0 5340.9 6230.8 6244.3 6252.0 6254.0 6273.1 6138.2 6153.1 6160.2 6163.3 6181.8 6152.4 6207.8 6213.6 6256.7 6275.8 6049.3 6052.8 6064.7 6067.5 6111.5 6085.1 6109.6 6119.3 6124.7 6138.8 5800.8 5926.8 5962.1 5965.9 5972.3 4951.9 5807.9 5859.9 5878.4 5901.8 5775.8 5803.3 5805.0 5809.9 5836.9 5486.6 5726.1 5908.1 5926.6 5959.5 5627.5 5696.2 5699.9 5716.7 5746.3 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:70911.25 Median:34914.24 stddev:156464.30 (448.1%) stddev-sans-first:156813.73 07:01:27 INFO - PROCESS | 1646 | Values: 428.9 465.7 494.7 498.7 541.4 29841.0 31588.8 39007.2 40350.8 40736.6 41668.8 42230.8 42279.2 42293.4 42491.8 9193.2 9408.2 9420.4 9422.8 9445.9 8301.0 8536.7 10091.9 11073.6 11317.2 10627.8 11208.2 11236.2 11242.7 11291.2 11105.4 11159.4 11172.8 11172.9 11207.0 8235.7 8441.4 9264.8 10863.1 11170.5 39044.4 39240.8 39251.4 39273.8 39367.2 3341.9 3364.3 3420.7 3591.5 3621.6 29671.9 30110.0 30272.1 30326.5 30475.0 3146.6 3147.6 3173.8 3278.2 3303.2 482679.0 483582.0 498029.0 502962.0 505218.5 58441.1 60489.0 60643.7 60847.0 60877.7 62087.7 62520.0 62524.7 62621.4 62666.4 15155.9 15701.9 15712.2 15718.0 15733.3 11079.4 12225.6 12268.3 12282.0 12287.6 14791.8 16706.2 17130.9 17146.3 17325.7 5661.8 6156.8 6240.9 6261.2 6298.7 843.8 919.6 959.7 966.1 1055.0 20762.7 28149.3 29567.6 29861.7 29986.6 1061.3 1086.5 1110.7 1130.0 1187.8 15280.0 16803.6 16988.0 17145.5 17237.3 615773.0 631011.0 632864.0 633396.0 652753.0 52044.7 55433.6 62651.7 62741.7 62743.1 1383.9 1405.7 1432.2 1433.8 1438.7 30058.5 30971.7 31019.2 31507.5 31546.2 50823.7 51586.0 51649.0 51706.0 51834.7 612113.0 616905.0 617140.0 618501.0 620891.0 39305.0 40138.2 40360.8 40908.0 41435.6 40884.4 41208.2 41841.0 42253.0 42444.0 34045.0 34779.5 34960.8 34985.7 36070.1 28627.3 34789.0 34867.7 35898.3 36134.8 32608.3 34133.7 34142.0 34369.5 34436.7 29346.6 31006.0 31073.5 31336.1 31340.5 22344.6 23172.0 23401.4 23664.3 23827.3 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:33323.68 Median:25863.05 stddev:93479.16 (361.4%) stddev-sans-first:93708.52 07:01:27 INFO - PROCESS | 1646 | Values: 306.8 344.2 370.5 377.8 391.0 14602.3 14862.8 15575.7 16340.3 20432.6 17854.9 20111.0 20289.5 21072.5 21358.4 5551.9 5911.4 5921.4 5923.6 5924.8 4317.0 5659.8 5869.2 6455.1 6507.9 6285.1 6410.4 6418.7 6459.5 6476.4 6267.4 6367.5 6398.9 6417.5 6420.6 5352.0 5524.4 5589.4 5589.9 5616.7 25770.6 25848.5 25877.6 26046.0 26212.3 2171.4 2380.7 2715.7 2839.5 3058.4 15439.2 15468.9 15599.2 15806.9 16064.8 1806.9 1872.8 1906.7 1936.5 1940.7 110670.4 112844.0 113743.4 117804.4 120681.0 10679.0 10796.6 10810.4 11031.0 11110.3 13326.3 13356.1 13683.4 13781.9 13802.7 8282.0 8421.6 8430.4 8433.1 8603.4 6954.3 8396.5 8413.7 8564.0 8645.0 6545.8 6712.6 6733.3 6737.3 6752.5 1727.6 1758.7 1770.1 1781.1 1787.2 836.2 900.7 923.8 976.7 979.6 18154.6 22252.8 22308.8 22314.2 22464.4 944.6 972.8 974.2 981.5 1030.0 10359.9 10569.9 11556.8 11637.7 11718.8 553889.0 557179.2 561213.0 562631.0 569875.0 95175.5 105971.0 106570.0 126755.0 128009.0 981.7 1028.4 1041.8 1049.2 1055.0 16870.4 19167.8 19410.6 19624.4 19668.2 41408.0 48632.5 51753.7 52160.7 53191.5 70678.6 72917.0 74773.0 75440.0 80238.0 6478.5 6816.2 7249.3 8019.7 8063.6 9803.9 10333.7 12107.0 12434.1 12556.2 10791.9 10888.8 10903.3 10910.5 10932.8 10637.0 10655.3 10671.9 10938.0 11105.7 10716.3 10743.9 10803.9 10949.7 11110.6 7694.0 7782.3 7955.9 8024.1 8082.2 8165.4 10579.5 11085.5 11351.0 11444.0 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:5342.21 Median:5258.64 stddev:2912.96 (55.4%) stddev-sans-first:2905.62 07:01:27 INFO - PROCESS | 1646 | Values: 1341.6 1482.0 1497.8 1702.1 1882.8 7414.6 7699.0 7833.0 8298.2 8309.3 8088.8 8156.2 8158.0 8178.9 8194.7 1957.0 2037.4 2259.0 2295.0 2298.3 2245.8 2323.6 2330.0 2330.4 2336.3 2271.4 2284.8 2294.6 2303.1 2314.7 2262.0 2270.9 2271.4 2313.0 2314.1 2237.5 2289.2 2295.8 2314.9 2325.0 8198.2 8287.5 8291.9 8294.4 8306.2 5000.5 5157.6 5165.9 5172.3 5175.6 3240.8 3335.3 3551.8 3556.9 3558.9 1031.9 1051.4 1053.0 1072.7 1078.0 10584.5 10633.3 10737.4 10780.4 10817.6 4411.2 4473.8 4627.2 4628.9 4650.0 9207.0 9239.1 9244.0 9247.6 9256.4 5081.7 5136.2 5140.9 5178.8 5203.9 3903.7 4154.0 4724.3 4727.4 4744.8 3174.5 3691.1 3699.8 3775.4 3785.4 1088.4 1118.8 1151.5 1228.4 1230.7 746.6 840.9 883.8 896.1 936.0 5313.4 5548.0 5678.2 5803.4 6020.7 905.8 913.2 942.6 959.5 988.3 3658.4 3684.6 3825.2 3829.3 3927.7 9652.3 9816.9 9845.0 9870.0 9888.5 9205.3 9560.0 9579.9 9625.7 9907.8 7543.9 7612.6 7652.2 7737.2 7741.1 4727.2 5383.8 5830.4 5841.5 5845.8 8916.2 8979.4 9185.0 9249.0 9296.6 9219.5 9336.9 9357.7 9415.4 9439.7 6075.2 6487.4 6671.7 6979.7 7149.7 7732.0 7822.7 7879.8 7883.4 7904.2 6906.3 6982.6 6988.1 7075.8 7131.6 6426.8 6446.4 6817.7 6860.6 6917.8 6327.5 6454.4 6491.4 6553.9 6561.2 3955.2 4716.1 4745.4 4762.5 4903.9 4753.7 4773.3 4882.8 4913.5 5029.2 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4372.86 Median:4863.33 stddev:1341.80 (27.6%) stddev-sans-first:1310.16 07:01:27 INFO - PROCESS | 1646 | Values: 293.4 346.1 346.4 348.1 353.8 5185.7 5192.5 5204.6 5245.6 5265.4 3946.5 5198.5 5224.1 5253.4 5307.4 3407.5 3486.5 3548.0 3845.2 3927.8 3914.8 3937.6 3978.9 3998.1 4018.7 3323.6 3970.9 3978.6 3979.0 3984.3 3747.9 3998.0 4003.4 4005.6 4007.0 3196.7 3375.5 3450.6 3507.8 3509.9 4552.3 4727.5 4858.6 4868.1 5154.8 4025.7 4167.7 4538.0 4547.6 4576.6 5075.5 5108.2 5176.4 5410.4 5412.3 3874.0 3880.7 3887.6 3898.7 3919.3 5120.1 5516.9 5626.5 5653.3 5704.5 3392.6 3491.5 3873.9 3930.8 3990.4 3601.4 3604.9 3956.3 4056.8 4075.2 3908.8 3915.5 4030.7 4136.5 4268.5 5100.3 5384.5 5454.2 5519.4 5601.9 1161.1 1266.9 1302.6 1309.1 1317.9 793.3 839.3 851.6 888.4 954.8 4631.7 4822.9 4848.4 4886.5 4948.0 4703.9 4770.3 5309.4 5356.9 5362.8 4492.9 4636.8 4856.7 4910.9 4937.0 2286.8 2498.4 2612.7 2817.9 2843.7 4823.8 4839.0 5065.9 5231.6 5612.0 4677.9 4990.6 5378.5 5457.5 5829.3 5790.0 5803.0 5829.7 5835.8 5901.7 4969.9 5171.3 5627.0 5704.8 5713.9 4274.0 4770.6 5393.5 5533.4 5556.3 5067.9 5093.0 5137.4 5666.0 5772.2 3226.6 3380.9 3566.0 3871.2 4134.6 5607.3 5647.4 5696.8 5727.9 5730.2 5292.6 5517.1 5534.4 5550.4 5569.7 4584.9 5386.6 5413.6 5462.2 5523.6 5305.3 5316.7 5333.2 5415.6 5417.7 4326.4 5478.2 5479.8 5531.7 5546.4 4170.2 4560.8 5023.8 5302.7 5355.5 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:19494.51 Median:4511.61 stddev:28240.58 (626.0%) stddev-sans-first:28284.42 07:01:27 INFO - PROCESS | 1646 | Values: 666.1 737.3 741.3 775.9 820.8 15022.0 15361.9 15564.0 15576.8 15617.4 11724.3 13792.2 14077.6 14108.1 14183.2 695.2 711.8 718.7 857.7 890.0 851.1 862.2 862.7 864.9 865.4 927.0 927.3 929.4 930.2 932.1 873.2 875.5 875.5 893.2 919.5 533.9 554.4 554.5 557.6 683.9 13711.0 14253.4 14265.2 14534.9 14585.7 13747.5 13915.2 13959.3 13987.4 14000.6 11497.5 11692.7 11762.7 11804.5 11994.8 3595.0 3647.9 3830.0 3870.7 3871.7 82488.0 104451.5 104996.9 107468.5 108990.9 10659.8 10662.3 10720.7 10969.8 11178.9 21750.5 22033.0 22127.9 22324.6 22362.2 7676.4 7701.6 7715.9 7739.4 7987.6 4250.0 4315.4 4374.8 4450.4 4498.9 3445.2 3514.0 3531.3 3550.4 3553.4 576.8 632.6 648.2 662.0 664.0 577.4 636.6 658.2 671.7 684.2 8760.2 8799.9 8943.1 9012.2 9203.2 606.1 608.9 625.2 653.5 669.2 3941.5 4314.9 4395.8 4509.5 4513.8 96582.0 98945.0 99488.0 99735.0 102991.5 67626.6 82645.2 86915.6 88438.0 89117.0 70179.9 72079.3 73369.0 74347.6 77831.2 8616.7 8633.0 8661.1 8685.5 8792.8 43148.4 45668.9 48421.0 49086.8 50594.5 53362.7 68548.0 69161.0 69645.7 72909.0 11509.7 11511.0 11524.0 11797.6 12001.5 10772.9 12415.3 12697.8 13053.5 13193.0 11785.9 11869.5 11957.4 12035.8 12080.2 11848.8 11857.2 12003.3 12027.7 12381.7 11579.9 11699.4 11946.8 12123.8 12221.5 9499.0 9666.6 9686.2 10202.0 10207.5 9742.0 10234.6 10243.5 10243.6 10262.9 07:01:27 INFO - PROCESS | 1646 | -------- Summary: end -------- 07:01:27 INFO - PROCESS | 1646 | 07:01:27 INFO - TEST-INFO | 1646: exit 0 07:01:27 INFO - TEST-OK | dromaeo_css | took 1120476ms 07:01:27 INFO - TEST-START | kraken 07:01:27 INFO - operating with platform_type : mac_ 07:01:27 INFO - Initialising browser for kraken test... 07:01:27 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmprjGBmr/profile http://localhost:49236/getInfo.html) 07:01:30 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 07:01:30 INFO - PROCESS | 1651 | colorDepth:24 07:01:30 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 07:01:30 INFO - PROCESS | 1651 | __metrics 07:01:30 INFO - PROCESS | 1651 | 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:01:30 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:01:31 INFO - TEST-INFO | 1651: exit 0 07:01:31 INFO - Browser initialized. 07:01:31 INFO - Running cycle 1/1 for kraken test... 07:01:31 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/tmprjGBmr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:01:43 INFO - PROCESS | 1652 | RSS: Main: 237162496 07:01:43 INFO - PROCESS | 1652 | 07:01:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 07:01:46 INFO - PROCESS | 1652 | RSS: Main: 289333248 07:01:46 INFO - PROCESS | 1652 | 07:01:49 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 07:01:49 INFO - PROCESS | 1652 | RSS: Main: 290627584 07:01:49 INFO - PROCESS | 1652 | 07:01:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 07:01:53 INFO - PROCESS | 1652 | RSS: Main: 382664704 07:01:53 INFO - PROCESS | 1652 | 07:01:55 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 07:01:56 INFO - PROCESS | 1652 | RSS: Main: 284762112 07:01:56 INFO - PROCESS | 1652 | 07:01:58 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:01:59 INFO - PROCESS | 1652 | RSS: Main: 288198656 07:01:59 INFO - PROCESS | 1652 | 07:02:02 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 07:02:02 INFO - PROCESS | 1652 | RSS: Main: 332423168 07:02:02 INFO - PROCESS | 1652 | 07:02:05 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 07:02:06 INFO - PROCESS | 1652 | RSS: Main: 333873152 07:02:06 INFO - PROCESS | 1652 | 07:02:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 07:02:10 INFO - PROCESS | 1652 | RSS: Main: 332963840 07:02:10 INFO - PROCESS | 1652 | 07:02:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:02:12 INFO - PROCESS | 1652 | RSS: Main: 305688576 07:02:12 INFO - PROCESS | 1652 | 07:02:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:02:14 INFO - PROCESS | 1652 | RSS: Main: 308326400 07:02:14 INFO - PROCESS | 1652 | 07:02:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:02:17 INFO - PROCESS | 1652 | RSS: Main: 309121024 07:02:17 INFO - PROCESS | 1652 | 07:02:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:02:21 INFO - PROCESS | 1652 | RSS: Main: 320139264 07:02:21 INFO - PROCESS | 1652 | 07:02:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:02:25 INFO - PROCESS | 1652 | RSS: Main: 319205376 07:02:25 INFO - PROCESS | 1652 | 07:02:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 07:02:27 INFO - PROCESS | 1652 | RSS: Main: 363307008 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | __start_tp_report 07:02:27 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 07:02:27 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 07:02:27 INFO - PROCESS | 1652 | |i|pagename|runs| 07:02:27 INFO - PROCESS | 1652 | |0;ai-astar;115;115;115;114;115;115;115;115;115;115 07:02:27 INFO - PROCESS | 1652 | |1;audio-beat-detection;152;115;115;150;116;114;113;116;135;114 07:02:27 INFO - PROCESS | 1652 | |2;audio-dft;186;184;183;185;194;249;179;185;182;183 07:02:27 INFO - PROCESS | 1652 | |3;audio-fft;79;59;58;89;62;60;60;74;68;58 07:02:27 INFO - PROCESS | 1652 | |4;audio-oscillator;91;73;88;69;67;91;68;70;89;116 07:02:27 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;109;110;109;111;108;111;108;112;108;110 07:02:27 INFO - PROCESS | 1652 | |6;imaging-darkroom;93;95;94;95;94;99;94;94;94;94 07:02:27 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;85;88;85;98;132;134;84;86;85 07:02:27 INFO - PROCESS | 1652 | |8;json-parse-financial;57;56;57;57;57;55;56;55;54;56 07:02:27 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;66;73;69;81;74;73;71;71;70;71 07:02:27 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;89;89;91;88;88;91;87;88;88;89 07:02:27 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;138;148;145;148;149;147;147;147;236;166 07:02:27 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;195;177;176;177;175;183;177;175;173;174 07:02:27 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;69;69;67;69;68;67;69;67;68;70 07:02:27 INFO - PROCESS | 1652 | __end_tp_report 07:02:27 INFO - PROCESS | 1652 | __start_cc_report 07:02:27 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2103 07:02:27 INFO - PROCESS | 1652 | __end_cc_report 07:02:27 INFO - PROCESS | 1652 | __startTimestamp1481814147119__endTimestamp 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | ------- Summary: start ------- 07:02:27 INFO - PROCESS | 1652 | Number of tests: 14 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:02:27 INFO - PROCESS | 1652 | Values: 115.0 115.0 115.0 114.0 115.0 115.0 115.0 115.0 115.0 115.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:116.00 stddev:15.61 (13.5%) stddev-sans-first:12.85 07:02:27 INFO - PROCESS | 1652 | Values: 152.0 115.0 115.0 150.0 116.0 114.0 113.0 116.0 135.0 114.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:191.00 Median:185.00 stddev:20.74 (11.2%) stddev-sans-first:21.92 07:02:27 INFO - PROCESS | 1652 | Values: 186.0 184.0 183.0 185.0 194.0 249.0 179.0 185.0 182.0 183.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:66.70 Median:65.00 stddev:10.68 (16.4%) stddev-sans-first:10.36 07:02:27 INFO - PROCESS | 1652 | Values: 79.0 59.0 58.0 89.0 62.0 60.0 60.0 74.0 68.0 58.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:82.20 Median:80.50 stddev:15.70 (19.5%) stddev-sans-first:16.32 07:02:27 INFO - PROCESS | 1652 | Values: 91.0 73.0 88.0 69.0 67.0 91.0 68.0 70.0 89.0 116.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:1.43 (1.3%) stddev-sans-first:1.50 07:02:27 INFO - PROCESS | 1652 | Values: 109.0 110.0 109.0 111.0 108.0 111.0 108.0 112.0 108.0 110.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.64 07:02:27 INFO - PROCESS | 1652 | Values: 93.0 95.0 94.0 95.0 94.0 99.0 94.0 94.0 94.0 94.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:85.50 stddev:19.76 (23.1%) stddev-sans-first:20.60 07:02:27 INFO - PROCESS | 1652 | Values: 86.0 85.0 88.0 85.0 98.0 132.0 134.0 84.0 86.0 85.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:1.05 (1.9%) stddev-sans-first:1.05 07:02:27 INFO - PROCESS | 1652 | Values: 57.0 56.0 57.0 57.0 57.0 55.0 56.0 55.0 54.0 56.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.00 stddev:3.93 (5.5%) stddev-sans-first:3.54 07:02:27 INFO - PROCESS | 1652 | Values: 66.0 73.0 69.0 81.0 74.0 73.0 71.0 71.0 70.0 71.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:89.00 stddev:1.32 (1.5%) stddev-sans-first:1.39 07:02:27 INFO - PROCESS | 1652 | Values: 89.0 89.0 91.0 88.0 88.0 91.0 87.0 88.0 88.0 89.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:157.10 Median:148.00 stddev:28.58 (19.3%) stddev-sans-first:29.47 07:02:27 INFO - PROCESS | 1652 | Values: 138.0 148.0 145.0 148.0 149.0 147.0 147.0 147.0 236.0 166.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.20 Median:177.00 stddev:6.49 (3.7%) stddev-sans-first:2.87 07:02:27 INFO - PROCESS | 1652 | Values: 195.0 177.0 176.0 177.0 175.0 183.0 177.0 175.0 173.0 174.0 07:02:27 INFO - PROCESS | 1652 | 07:02:27 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 07:02:27 INFO - PROCESS | 1652 | Values: 69.0 69.0 67.0 69.0 68.0 67.0 69.0 67.0 68.0 70.0 07:02:27 INFO - PROCESS | 1652 | -------- Summary: end -------- 07:02:27 INFO - PROCESS | 1652 | 07:02:28 INFO - TEST-INFO | 1652: exit 0 07:02:28 INFO - TEST-OK | kraken | took 60172ms 07:02:28 INFO - SUITE-END | took 1180s 07:02:28 INFO - Completed test suite (00:19:40) 07:02:28 INFO - javascript benchmark 07:02:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2776.6251556039933, 3304.3060957198986, 3322.9667703322966, 3327.4177019021663, 3355.3457075870215, 5459.645123067008, 5519.172124181375, 5530.087535556633, 5584.21820945068, 5590.888182236353, 5500.614956953015, 5529.115341545344, 5539.390667026624, 5546.306711661043, 5547.500724934755, 5024.748762561866, 5075.619328550355, 5076.4415914249585, 5097.974510127444, 5154.510321519469, 5069.619778516626, 5159.922601160985, 5160.948390516103, 5172.2241663750365, 5179.404368497614, 4728.456227533843, 5108.259302401149, 5149.227615857614, 5156.20078887773, 5160.380754309488, 5155.40712818027, 5155.484451554852, 5176.378834539879, 5184.688918664892, 5239.056969745444, 4983.825566105169, 5046.823361182378, 5087.440381558025, 5110.0, 5135.998480296344, 5535.529479994206, 5540.695261760601, 5544.334679838405, 5603.3836278009385, 5617.8033768817895, 6089.8173054807985, 6096.420840020191, 6110.511159107261, 6116.847078823021, 6129.1419201311855, 5930.584859059867, 6120.265568131808, 6172.537059720494, 6173.0, 6177.567570270083, 5520.889582208373, 5569.10894256921, 5666.008448521492, 5682.289713785777, 5699.601027928088, 6225.501959843202, 6229.283632382334, 6243.594166379171, 6257.374262573706, 6259.2488901332135, 5891.469767720926, 5975.0, 5988.610740301867, 5988.760449582055, 5997.640141591519, 5957.285125784933, 5987.221661184105, 5992.670403127782, 6018.759249629966, 6124.693765311717, 5902.61632993854, 5923.111533269957, 5926.407359264039, 5928.992071347881, 5930.1994230779155, 5941.108833674897, 5955.7617695292565, 5956.583039187302, 5957.851053723605, 5963.880722385615, 4708.8116475341285, 4768.165571025057, 4770.022145460172, 4777.092352453023, 4778.235482322812, 4306.870793876189, 4344.196323680129, 4361.978190109029, 4376.518582955872, 4380.2772542530765, 5625.409332020161, 5626.493615574618, 5627.380988091307, 5660.179274005246, 5684.147377893267, 5960.493358064613, 5997.550183736237, 6107.175531303217, 6155.0, 6172.753089876354, 5510.090835012178, 5559.249501317351, 5566.526845218121, 5617.831465056055, 5628.549716022709, 5267.499587539178, 5277.419483856849, 5316.0, 5336.9859726652585, 5340.946590534045, 6230.844228894314, 6244.250689917239, 6252.0, 6253.968730156502, 6273.090401891609, 6138.232720909887, 6153.107799369156, 6160.16837726919, 6163.291221509405, 6181.752729890754, 6152.354002829638, 6207.844803879939, 6213.627182369072, 6256.718447669775, 6275.8117256480555, 6049.274087109399, 6052.818415447544, 6064.666443345658, 6067.453929146398, 6111.511079113571, 6085.148079268817, 6109.572329937039, 6119.3268740437625, 6124.663143527148, 6138.754449821957, 5800.76796928135, 5926.7925622603, 5962.07587823888, 5965.940340596712, 5972.283326000907, 4951.861071953543, 5807.912881306868, 5859.882802344015, 5878.353381128158, 5901.822945311647, 5775.826725198251, 5803.303603567599, 5804.970975145097, 5809.896119737236, 5836.941630583639, 5486.61593688438, 5726.112452569859, 5908.05471124618, 5926.585139040226, 5959.4934430573885, 5627.465390787868, 5696.174054762119, 5699.857503562444, 5716.685582293014, 5746.339170995389], "value": 5558.782431200605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.90992891492783, 465.72754938361055, 494.73531660561605, 498.7481321932425, 541.4260883463527, 29841.0, 31588.842055789748, 39007.219855602874, 40350.79824600873, 40736.59263407365, 41668.79165604168, 42230.7888460558, 42279.154416911646, 42293.36559951603, 42491.78754106225, 9193.218576420995, 9408.247340212802, 9420.434773913554, 9422.764430889249, 9445.905540944606, 8301.0, 8536.74389768308, 10091.949540252288, 11073.557057717722, 11317.151213658968, 10627.787444251111, 11208.159388045888, 11236.157288203418, 11242.718932026724, 11291.20961532693, 11105.444727763619, 11159.38623375714, 11172.832407513893, 11172.888271117266, 11207.047400970887, 8235.711750088718, 8441.409101362908, 9264.768380790467, 10863.076638485738, 11170.497327620194, 39044.41433378502, 39240.803795980835, 39251.41122883159, 39273.80363098166, 39367.21265574701, 3341.9498707519165, 3364.327134573095, 3420.675035871588, 3591.515145455356, 3621.619729928346, 29671.851640741657, 30110.0, 30272.09183724492, 30326.54510182349, 30475.0, 3146.590943177372, 3147.6222853257755, 3173.7778355515125, 3278.246003419203, 3303.157694787838, 482679.0, 483582.0, 498029.0, 502962.0, 505218.47390763176, 58441.123383148435, 60489.0, 60643.69678151669, 60847.0, 60877.69561152166, 62087.6895615519, 62520.0, 62524.687376562826, 62621.37378626246, 62666.373336266966, 15155.939084264217, 15701.921490392704, 15712.21438928049, 15718.0, 15733.292001859943, 11079.446027698745, 12225.633231003085, 12268.32524211177, 12282.0, 12287.631371058882, 14791.778123328158, 16706.164691765363, 17130.914345428442, 17146.314147434212, 17325.7401138983, 5661.8393229387875, 6156.78451254204, 6240.937590624036, 6261.186045814015, 6298.716557754912, 843.7806170395742, 919.5815903763771, 959.712086374085, 966.1401352796017, 1054.9525271362807, 20762.688559671617, 28149.296267593065, 29567.556486652717, 29861.701382986328, 29986.55020174699, 1061.3048453263125, 1086.4893500054961, 1110.7278716714457, 1129.9604513841975, 1187.7624475105013, 15280.006799558216, 16803.579910502336, 16988.0, 17145.485635430956, 17237.310507579557, 615773.0, 631011.0, 632864.0, 633396.0, 652753.0, 52044.739776301634, 55433.6251331094, 62651.68674156691, 62741.68629156916, 62743.058854117226, 1383.889288856889, 1405.7048019915933, 1432.2194404050026, 1433.770596704543, 1438.6691061056015, 30058.459730507162, 30971.69028309778, 31019.224519387197, 31507.52738708967, 31546.211344716565, 50823.745881270355, 51586.0, 51649.0, 51706.0, 51834.74082629563, 612113.0, 616905.0, 617140.0, 618501.0, 620891.0, 39305.0, 40138.1972360557, 40360.79819601001, 40908.0, 41435.585644143175, 40884.386734198415, 41208.204914411916, 41840.95397615084, 42253.0, 42444.0, 34045.0, 34779.478307825906, 34960.825195873855, 34985.65014349824, 36070.09824754402, 28627.28431789222, 34789.0, 34867.65132348644, 35898.28203435969, 36134.819325903205, 32608.34783304368, 34133.65866341305, 34141.975740727816, 34369.484457733655, 34436.65563344335, 29346.55980160342, 31006.0, 31073.53389699111, 31336.05991820249, 31340.529892052095, 22344.553108938057, 23172.0, 23401.41496462534, 23664.290071297888, 23827.285181444586], "value": 19806.09530742077, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [306.797513640997, 344.2340791738384, 370.5312779334142, 377.8431950740443, 390.97849618271, 14602.269886505672, 14862.77705834412, 15575.688486230269, 16340.264688089035, 20432.591348173028, 17854.910725446356, 20111.0, 20289.496351593505, 21072.473188170305, 21358.359249222547, 5551.861203469905, 5911.408859114097, 5921.378255283198, 5923.555733319997, 5924.763009479637, 4316.956830431703, 5659.773609055654, 5869.178315035899, 6455.096286519891, 6507.9023814642815, 6285.088662143987, 6410.358964103576, 6418.679066046702, 6459.51553633477, 6476.384743449388, 6267.4045965633195, 6367.522435817332, 6398.888366838932, 6417.518686098561, 6420.582662126947, 5351.983123206578, 5524.392316845144, 5589.357223919261, 5589.916151257735, 5616.691081990489, 25770.613440798403, 25848.48303033929, 25877.611835822478, 26046.0, 26212.281789277924, 2171.35944896256, 2380.7262164850918, 2715.714849940767, 2839.5172820620546, 3058.3730335281216, 15439.150846703427, 15468.922655386763, 15599.220038998119, 15806.901098242563, 16064.75902861458, 1806.927722891096, 1872.7659042619673, 1906.6949288113835, 1936.5255512399413, 1940.7477027986413, 110670.44664776705, 112844.0, 113743.43128284389, 117804.41097794542, 120681.0, 10679.038886500251, 10796.568137274578, 10810.405427701551, 11030.959272534606, 11110.3337297977, 13326.333683315795, 13356.06507544482, 13683.357997040419, 13781.86218137826, 13802.723945521033, 8282.0, 8421.578921054046, 8430.367722420842, 8433.114522975122, 8603.440776349516, 6954.3393377629045, 8396.496210227406, 8413.70552030676, 8563.95718021406, 8645.0, 6545.803625891231, 6712.563683360663, 6733.259341472434, 6737.258901520829, 6752.493562982796, 1727.5747508305699, 1758.7273972534279, 1770.0618672103806, 1781.1361489677497, 1787.1778981668317, 836.1847198980945, 900.7477906186278, 923.8060007398387, 976.6972238606055, 979.6277414582413, 18154.636907262044, 22252.777472225393, 22308.776912230995, 22314.21900233484, 22464.43838904008, 944.5985456181232, 972.844344904826, 974.1962880623372, 981.5043403081398, 1029.9794004120026, 10359.896401036043, 10569.894301056891, 11556.76886462266, 11637.709057273467, 11718.765624687629, 553889.0, 557179.2141039349, 561213.0, 562631.0, 569875.0, 95175.52412237895, 105971.0, 106570.0, 126755.0, 128009.0, 981.6564202529057, 1028.4138041316528, 1041.7551875309296, 1049.1659130990881, 1054.9789004220027, 16870.409535666193, 19167.808321916604, 19410.573678290213, 19624.41126766199, 19668.213271469554, 41408.0, 48632.5136748628, 51753.7412312936, 52160.73919630377, 53191.46808531865, 70678.58642827012, 72917.0, 74773.0, 75440.0, 80238.0, 6478.546501744832, 6816.216135144522, 7249.311315425026, 8019.679212831421, 8063.637136328762, 9803.901960980298, 10333.689989300334, 12107.0, 12434.129610927148, 12556.246625202517, 10791.946040269748, 10888.802231754658, 10903.34579925207, 10910.454477276264, 10932.836007460053, 10637.0, 10655.25413221067, 10671.893281067401, 10938.0, 11105.666829995112, 10716.303440276357, 10743.892561074603, 10803.891961080602, 10949.726256843642, 11110.555577776799, 7694.0, 7782.299593036654, 7955.9204407957495, 8024.0772311184965, 8082.232187942136, 8165.38759593021, 10579.523921423708, 11085.501152447998, 11350.978411942964, 11444.0], "value": 9594.705070030872, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.5846282172304, 1482.0440815673887, 1497.8427265137161, 1702.1234064456808, 1882.783479899812, 7414.59219742914, 7699.0, 7833.0, 8298.1701829817, 8309.252167304941, 8088.757337279891, 8156.225158609937, 8158.0, 8178.877316840252, 8194.713185038525, 1956.9804301957013, 2037.4193354893857, 2259.017327462555, 2295.047555264563, 2298.287530865429, 2245.8091062259728, 2323.59337116004, 2329.9650505242435, 2330.382448651109, 2336.310788317442, 2271.432141964509, 2284.794368506834, 2294.6328587426015, 2303.1248125712204, 2314.7222333320024, 2262.049939025613, 2270.8864556772096, 2271.3867255840914, 2312.9653055204185, 2314.0628045641456, 2237.496563273267, 2289.1530133850583, 2295.8278129140213, 2314.884255787204, 2325.046730840347, 8198.180181981814, 8287.544185069819, 8291.875621865676, 8294.419390642657, 8306.210909963544, 5000.474950130257, 5157.5616072633875, 5165.9225111623355, 5172.32759741235, 5175.611829112794, 3240.7731458797894, 3335.332933413327, 3551.786892786441, 3556.893293201208, 3558.87543935961, 1031.9071283584512, 1051.395447617623, 1053.0364716284591, 1072.7479042425025, 1078.0297732041147, 10584.523696433678, 10633.255672102956, 10737.355758654505, 10780.353178809297, 10817.56729730802, 4411.205982923105, 4473.821047158142, 4627.167109920179, 4628.884277893079, 4650.0, 9206.953965230132, 9239.122283383067, 9244.029376915461, 9247.583858726373, 9256.352055356061, 5081.669691470042, 5136.178211486219, 5140.897182056413, 5178.766955487012, 5203.9219411708855, 3903.6681882040343, 4153.979230103891, 4724.338592597039, 4727.361806156194, 4744.810207591727, 3174.4603417419094, 3691.077230692327, 3699.7595156314756, 3775.3959366501776, 3785.356489396809, 1088.3796236145322, 1118.7749414391228, 1151.4818331750746, 1228.3612521488776, 1230.698478872664, 746.637880627895, 840.8570543007703, 883.8099808541194, 896.1441823058963, 935.9859602105973, 5313.362396512366, 5547.974989128938, 5678.176664383641, 5803.361630220672, 6020.729701341725, 905.7554460295684, 913.1964370368602, 942.599395257013, 959.5010594490826, 988.2933702402672, 3658.378075727133, 3684.5946945835935, 3825.1967086911504, 3829.272438236726, 3927.6842257843373, 9652.27607929408, 9816.901830981742, 9845.0, 9869.950650246847, 9888.505574721235, 9205.263578913671, 9559.996200398997, 9579.856302155473, 9625.663101791404, 9907.80184396308, 7543.924560754432, 7612.619369031526, 7652.196519365498, 7737.226277372218, 7741.148473667892, 4727.172744769583, 5383.815560576667, 5830.4461076197695, 5841.532677385884, 5845.824625261249, 8916.19754222123, 8979.416337938013, 9184.954075229582, 9249.0, 9296.581653825458, 9219.539023048956, 9336.906630933876, 9357.672481463116, 9415.387999779992, 9439.669611563562, 6075.210222671025, 6487.351264873475, 6671.666416679243, 6979.651017449006, 7149.678264478215, 7731.961340193263, 7822.687092516236, 7879.803004924923, 7883.408744344312, 7904.170062143622, 6906.309369063053, 6982.615956122462, 6988.05661235747, 7075.787726368218, 7131.643417829192, 6426.839329016812, 6446.387593178641, 6817.693203805741, 6860.622665753432, 6917.757878474229, 6327.530439029643, 6454.354564543508, 6491.415772580302, 6553.901691474536, 6561.245456772533, 3955.228730397545, 4716.127516409475, 4745.406824146981, 4762.452317983476, 4903.8528844134735, 4753.691010084333, 4773.331733557236, 4882.80468781259, 4913.484084171254, 5029.170186919117], "value": 4338.858714018145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.3765747785955, 346.1346633416458, 346.40072674273506, 348.1383575650264, 353.8107112694708, 5185.688858668478, 5192.532672059514, 5204.583633309336, 5245.6132459730825, 5265.367736001842, 3946.506686664167, 5198.45416231296, 5224.14542837293, 5253.395859476162, 5307.389650190229, 3407.50591164281, 3486.477028445728, 3547.9645203547957, 3845.211976430959, 3927.8428862845453, 3914.7846868422225, 3937.5865534118934, 3978.9403158952496, 3998.1004274038255, 4018.7387819791766, 3323.5679361682946, 3970.8610198643055, 3978.562358140602, 3978.9602103978877, 3984.2828290907623, 3747.8688245911535, 3997.9600203998025, 4003.3994900764974, 4005.5994400560003, 4007.0, 3196.7282780963415, 3375.5105509700957, 3450.5686789151355, 3507.8421471033867, 3509.894703158909, 4552.294394368878, 4727.479977202505, 4858.562729354375, 4868.099401610713, 5154.819581314673, 4025.677945764332, 4167.74993500391, 4537.98059863361, 4547.636189104896, 4576.633869290449, 5075.492450754932, 5108.169227813109, 5176.404713457925, 5410.377806552218, 5412.323459567554, 3873.98063009686, 3880.708946828999, 3887.5723670396233, 3898.727089103764, 3919.2553414851086, 5120.052790233819, 5516.9448305516835, 5626.549876009909, 5653.321601407857, 5704.515116215085, 3392.6268110507826, 3491.493733408692, 3873.8959396572404, 3930.8034598269974, 3990.4413382126527, 3601.441776524643, 3604.85580576774, 3956.327424337812, 4056.817443215062, 4075.225707115698, 3908.843646254175, 3915.4909861717792, 4030.6573941215324, 4136.518089146488, 4268.530461649216, 5100.285959965608, 5384.515393614515, 5454.154606036071, 5519.3652729936575, 5601.899287767087, 1161.1465572803982, 1266.8923141533073, 1302.5961951794784, 1309.109805332383, 1317.8732183982556, 793.3137835772015, 839.3243439031638, 851.6337974670951, 888.4136469929945, 954.8472244440856, 4631.675782695246, 4822.903541929212, 4848.369711937426, 4886.462489126265, 4948.0, 4703.929441058387, 4770.308305295713, 5309.389420216725, 5356.8660783479945, 5362.812301569426, 4492.910141797146, 4636.824242188516, 4856.68431551948, 4910.852674419773, 4936.963237720119, 2286.759890211537, 2498.400383907849, 2612.712601613821, 2817.9010186027467, 2843.7440630343367, 4823.831165909176, 4838.975805120952, 5065.949340506621, 5231.555317797954, 5611.9719401403545, 4677.859664210079, 4990.600751939836, 5378.489043540857, 5457.524829639658, 5829.329627092854, 5790.015697331548, 5802.966937978149, 5829.717462158318, 5835.824925252249, 5901.704914754245, 4969.875753106056, 5171.3018742469285, 5626.971865140648, 5704.80033198836, 5713.886002078497, 4274.025156604388, 4770.570648641639, 5393.460653934575, 5533.418991005887, 5556.277683901067, 5067.949320506896, 5093.0, 5137.409197942135, 5666.036773748555, 5772.249607550992, 3226.5644138041066, 3380.915477113092, 3565.983694647013, 3871.206402687386, 4134.607212314945, 5607.327120745536, 5647.350554686263, 5696.772129114789, 5727.914081288867, 5730.218056082966, 5292.5501332387175, 5517.144842549411, 5534.418886016911, 5550.361708403585, 5569.693666848362, 4584.931226031679, 5386.649867758583, 5413.593980451403, 5462.235287059735, 5523.558115350682, 5305.283786688902, 5316.7075810830775, 5333.226682130991, 5415.59383046281, 5417.729113544386, 4326.447396036354, 5478.233047373291, 5479.808206712746, 5531.695756733257, 5546.417626149358, 4170.165966806711, 4560.771961401983, 5023.7739301732245, 5302.727345437144, 5355.518003379714], "value": 3957.8270352008713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.1007639686424, 737.2664199121873, 741.3142842870346, 775.8637817647176, 820.790698371915, 15021.999999999985, 15361.923190384061, 15564.0, 15576.766348504767, 15617.40799616089, 11724.296542207452, 13792.172469651829, 14077.648058798535, 14108.082974606643, 14183.219922904236, 695.2282965907838, 711.8327193109628, 718.6514540447879, 857.6998050682274, 890.0, 851.0765819086299, 862.1550880137469, 862.7196161247588, 864.9264812490945, 865.3899001204168, 927.0, 927.2535608834885, 929.4051806843626, 930.1721467893581, 932.0958670090001, 873.2359185712502, 875.4834647557908, 875.5053394831931, 893.2452077994085, 919.4896832258094, 533.9038972984861, 554.3763266325384, 554.5425024354923, 557.5734563059262, 683.9213490448612, 13711.040227184101, 14253.358598862973, 14265.215413152273, 14534.927325363411, 14585.70828583433, 13747.518836840663, 13915.23466209358, 13959.302034898214, 13987.440502379892, 14000.649983750385, 11497.540098396054, 11692.707682307926, 11762.705932351673, 11804.527818887234, 11994.760104797855, 3594.982025089884, 3647.854085836563, 3829.9617003830163, 3870.7096967727534, 3871.748336358156, 82488.0, 104451.4777426108, 104996.85009449729, 107468.4626576862, 108990.91009089886, 10659.84010239847, 10662.306950048222, 10720.73198170052, 10969.83545246822, 11178.944105279421, 21750.456238593844, 22033.0, 22127.889360553094, 22324.55350892973, 22362.217322393637, 7676.424268179797, 7701.576413297323, 7715.884261736079, 7739.419543534257, 7987.640556174986, 4249.97875010623, 4315.417418648442, 4374.825006999685, 4450.376947227391, 4498.887527811766, 3445.2248244144866, 3514.0, 3531.346700860349, 3550.396432606463, 3553.4314509678843, 576.7808232871482, 632.6204277433595, 648.2188962300417, 661.9801405957829, 663.9767608133692, 577.431230238215, 636.6371168434041, 658.1969996604136, 671.7111641993891, 684.1721516964528, 8760.167784060504, 8799.868001979976, 8943.121785241668, 9012.233960113464, 9203.217726493189, 606.0848119339829, 608.943483056896, 625.1966223402906, 653.4641593893057, 669.1635455680399, 3941.5467221269346, 4314.935275970863, 4395.846145384896, 4509.458864936229, 4513.758716353029, 96582.0, 98945.0, 99488.00511994932, 99735.0, 102991.4850425758, 67626.64746705137, 82645.17354826495, 86915.56542217248, 88438.0, 89117.0, 70179.94730079053, 72079.27920720831, 73369.0, 74347.62826185835, 77831.22168778353, 8616.741497755078, 8632.956835216035, 8661.090585488433, 8685.522296273766, 8792.780180495538, 43148.352774709034, 45668.8582785433, 48421.03157936892, 49086.75456622837, 50594.49405505898, 53362.73318633382, 68547.97178042233, 69161.0, 69645.65177174081, 72909.0, 11509.712257193638, 11511.0, 11524.0, 11797.646070617895, 12001.459934302802, 10772.86884877108, 12415.317157556421, 12697.80953285683, 13053.543125990545, 13193.0, 11785.88214117848, 11869.465874035517, 11957.402129893644, 12035.819462708241, 12080.21478603888, 11848.76302473963, 11857.229280096766, 12003.279803211835, 12027.699307517381, 12381.690457738629, 11579.942100289445, 11699.415029248674, 11946.818991511394, 12123.81814272769, 12221.511139554319, 9499.0, 9666.565004574952, 9686.225101991682, 10202.0, 10207.540660670436, 9741.951290243504, 10234.6417875374, 10243.539040743035, 10243.641472548425, 10262.897371026194], "value": 7138.287824631752, "unit": "score"}], "name": "dromaeo_css", "value": 7112.9162518165895, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 115.0, 115.0, 150.0, 116.0, 114.0, 113.0, 116.0, 135.0, 114.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 183.0, 185.0, 194.0, 249.0, 179.0, 185.0, 182.0, 183.0], "value": 191.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 58.0, 89.0, 62.0, 60.0, 60.0, 74.0, 68.0, 58.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 73.0, 88.0, 69.0, 67.0, 91.0, 68.0, 70.0, 89.0, 116.0], "value": 82.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 109.0, 111.0, 108.0, 111.0, 108.0, 112.0, 108.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 94.0, 99.0, 94.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 88.0, 85.0, 98.0, 132.0, 134.0, 84.0, 86.0, 85.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 55.0, 56.0, 55.0, 54.0, 56.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 69.0, 81.0, 74.0, 73.0, 71.0, 71.0, 70.0, 71.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 91.0, 88.0, 88.0, 91.0, 87.0, 88.0, 88.0, 89.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 148.0, 145.0, 148.0, 149.0, 147.0, 147.0, 147.0, 236.0, 166.0], "value": 157.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 177.0, 176.0, 177.0, 175.0, 183.0, 177.0, 175.0, 173.0, 174.0], "value": 178.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 69.0, 68.0, 67.0, 69.0, 67.0, 68.0, 70.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1499.6, "alertThreshold": 2.0}]} 07:02:28 INFO - Return code: 0 07:02:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:02:28 INFO - # TBPL SUCCESS # 07:02:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:02:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:02:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:02:28 INFO - 2016-12-15 07:02:28.449 screenresolution[1656:12886] starting screenresolution argv=screenresolution get 07:02:28 INFO - 2016-12-15 07:02:28.451 screenresolution[1656:12886] Display 0: 1600x1200x32@60 07:02:28 INFO - 2016-12-15 07:02:28.458 screenresolution[1657:12889] starting screenresolution argv=screenresolution list 07:02:28 INFO - Available Modes on Display 0 07:02:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:02:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:02:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:02:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:02:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:02:28 INFO - Intel Iris: 07:02:28 INFO - Chipset Model: Intel Iris 07:02:28 INFO - Type: GPU 07:02:28 INFO - Bus: Built-In 07:02:28 INFO - VRAM (Dynamic, Max): 1536 MB 07:02:28 INFO - Vendor: Intel (0x8086) 07:02:28 INFO - Device ID: 0x0a2e 07:02:28 INFO - Revision ID: 0x0009 07:02:28 INFO - Displays: 07:02:28 INFO - Display: 07:02:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:02:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:02:28 INFO - Display Serial Number: 1600x1200 60 07:02:28 INFO - Main Display: Yes 07:02:28 INFO - Mirror: Off 07:02:28 INFO - Online: Yes 07:02:28 INFO - Rotation: Supported 07:02:28 INFO - Return code: 0 07:02:28 INFO - Running post-action listener: _resource_record_post_action 07:02:28 INFO - [mozharness: 2016-12-15 15:02:28.699593Z] Finished run-tests step (success) 07:02:28 INFO - Running post-run listener: _resource_record_post_run 07:02:28 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 32865280; Write bytes: 551657984; Read time: 313; Write time: 2276 07:02:28 INFO - TinderboxPrint: CPU usage
53.7% 07:02:28 INFO - TinderboxPrint: I/O read bytes / time
32,865,280 / 313 07:02:28 INFO - TinderboxPrint: I/O write bytes / time
551,657,984 / 2,276 07:02:28 INFO - TinderboxPrint: CPU idle
2,226.5 (46.3%) 07:02:28 INFO - TinderboxPrint: CPU system
962.5 (20.0%) 07:02:28 INFO - TinderboxPrint: CPU user
1,624.7 (33.8%) 07:02:28 INFO - TinderboxPrint: Swap in / out
278,130,688 / 0 07:02:28 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250577408; Write bytes: 250294272; Read time: 18131; Write time: 461 07:02:28 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 28969984; Write bytes: 295152128; Read time: 278; Write time: 1782 07:02:29 INFO - Running post-run listener: _upload_blobber_files 07:02:29 INFO - Blob upload gear active. 07:02:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:02:29 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 07:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:02:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:02:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:02:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:02:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:30 INFO - (blobuploader) - INFO - Done attempting. 07:02:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:02:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:02:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:31 INFO - (blobuploader) - INFO - Done attempting. 07:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:02:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:02:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:02:33 INFO - (blobuploader) - INFO - Done attempting. 07:02:33 INFO - (blobuploader) - INFO - Iteration through files over. 07:02:33 INFO - Return code: 0 07:02:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:02:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:02:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b663a51cbbdc749a313c44b4fd44f1efe8c299424be8eb114d2d6918b32864b6ba43d078027c0a9fa0e738e03bde2c207bed5e1d7488d3c83b95ba58640147f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faf134234bdc96c14f86ae7af443b3dc1a7e06df9aabde970100618fb7708c1da34c1cd608db304c4d95017686346465ce361346f84cd62146e0ed4d4cdbcd30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6f547c7d4267d64ef8c0cbfefe69a36bc5e7436e04f9611e19c681521ce659a0c5141bac3e91507519b501f15171d45c4a18890f8f687fe6abdc8dbafa4e6b"} 07:02:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:02:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:02:33 INFO - Contents: 07:02:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b663a51cbbdc749a313c44b4fd44f1efe8c299424be8eb114d2d6918b32864b6ba43d078027c0a9fa0e738e03bde2c207bed5e1d7488d3c83b95ba58640147f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faf134234bdc96c14f86ae7af443b3dc1a7e06df9aabde970100618fb7708c1da34c1cd608db304c4d95017686346465ce361346f84cd62146e0ed4d4cdbcd30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6f547c7d4267d64ef8c0cbfefe69a36bc5e7436e04f9611e19c681521ce659a0c5141bac3e91507519b501f15171d45c4a18890f8f687fe6abdc8dbafa4e6b"} 07:02:33 INFO - Running post-run listener: copy_logs_to_upload_dir 07:02:33 INFO - Copying logs to upload dir... 07:02:33 INFO - mkdir: /builds/slave/test/build/upload/logs 07:02:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.508645 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-12-15 07:02:34.052099) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 07:02:34.055337) ========= 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.5qHJpNhWrR/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.ElLz90XBY6/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b663a51cbbdc749a313c44b4fd44f1efe8c299424be8eb114d2d6918b32864b6ba43d078027c0a9fa0e738e03bde2c207bed5e1d7488d3c83b95ba58640147f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faf134234bdc96c14f86ae7af443b3dc1a7e06df9aabde970100618fb7708c1da34c1cd608db304c4d95017686346465ce361346f84cd62146e0ed4d4cdbcd30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6f547c7d4267d64ef8c0cbfefe69a36bc5e7436e04f9611e19c681521ce659a0c5141bac3e91507519b501f15171d45c4a18890f8f687fe6abdc8dbafa4e6b"} build_url:https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/QkrDm4uATQaTz3CxjeZLKw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b663a51cbbdc749a313c44b4fd44f1efe8c299424be8eb114d2d6918b32864b6ba43d078027c0a9fa0e738e03bde2c207bed5e1d7488d3c83b95ba58640147f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/faf134234bdc96c14f86ae7af443b3dc1a7e06df9aabde970100618fb7708c1da34c1cd608db304c4d95017686346465ce361346f84cd62146e0ed4d4cdbcd30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc6f547c7d4267d64ef8c0cbfefe69a36bc5e7436e04f9611e19c681521ce659a0c5141bac3e91507519b501f15171d45c4a18890f8f687fe6abdc8dbafa4e6b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 07:02:34.094291) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:02:34.094626) ========= 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.5qHJpNhWrR/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.ElLz90XBY6/Listeners TMPDIR=/var/folders/x6/sw5m1xh120z8118jjdxnyt0800000w/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.005351 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 07:02:34.142996) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 07:02:34.143309) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 07:02:34.143655) ========= ========= Total master_lag: 0.18 =========