builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0379 starttime: 1481459026.78 results: success (0) buildid: 20161211030209 builduid: 637896eb2435441cad910568e9f81552 revision: c51e7406d7b2e2246a1ece0d8989282ca752039f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:46.776188) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:46.782731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:46.783088) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:46.810625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:46.810984) ========= 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.tEWtvH91pI/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.nuziKcIOrS/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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-11 04:23:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 73.5M=0s 2016-12-11 04:23:47 (73.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.593701 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:47.428588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:47.428918) ========= 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.tEWtvH91pI/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.nuziKcIOrS/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.024303 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:47.479815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 04:23:47.480737) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c51e7406d7b2e2246a1ece0d8989282ca752039f --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 c51e7406d7b2e2246a1ece0d8989282ca752039f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tEWtvH91pI/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.nuziKcIOrS/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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-11 04:23:47,583 truncating revision to first 12 chars 2016-12-11 04:23:47,583 Setting DEBUG logging. 2016-12-11 04:23:47,583 attempt 1/10 2016-12-11 04:23:47,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c51e7406d7b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-11 04:23:48,779 unpacking tar archive at: mozilla-central-c51e7406d7b2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.478689 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-11 04:23:48.987031) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:48.987484) ========= script_repo_revision: c51e7406d7b2e2246a1ece0d8989282ca752039f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:48.988113) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:48.988535) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-11 04:23:49.008523) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-11 04:23:49.008906) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.tEWtvH91pI/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.nuziKcIOrS/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:23:49 INFO - MultiFileLogger online at 20161211 04:23:49 in /builds/slave/test 04:23:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:23:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:49 INFO - {'append_to_log': False, 04:23:49 INFO - 'base_work_dir': '/builds/slave/test', 04:23:49 INFO - 'blob_upload_branch': 'Firefox', 04:23:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:49 INFO - 'branch': 'Firefox', 04:23:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:49 INFO - 'config_files': ('talos/mac_config.py',), 04:23:49 INFO - 'default_actions': ('clobber', 04:23:49 INFO - 'read-buildbot-config', 04:23:49 INFO - 'download-and-extract', 04:23:49 INFO - 'populate-webroot', 04:23:49 INFO - 'create-virtualenv', 04:23:49 INFO - 'install', 04:23:49 INFO - 'run-tests'), 04:23:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:49 INFO - 'download_minidump_stackwalk': True, 04:23:49 INFO - 'download_symbols': 'ondemand', 04:23:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:49 INFO - 'installer_path': 'installer.exe', 04:23:49 INFO - 'log_level': 'info', 04:23:49 INFO - 'log_name': 'talos', 04:23:49 INFO - 'log_to_console': True, 04:23:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:23:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:23:49 INFO - 'opt_config_files': (), 04:23:49 INFO - 'pip_index': False, 04:23:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:49 INFO - 'cmd': ('bash', 04:23:49 INFO - '-c', 04:23:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:49 INFO - 'enabled': True, 04:23:49 INFO - 'halt_on_failure': False, 04:23:49 INFO - 'name': 'check_screen_resolution'},), 04:23:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:23:49 INFO - 'cmd': ('bash', 04:23:49 INFO - '-c', 04:23:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:23:49 INFO - 'enabled': True, 04:23:49 INFO - 'halt_on_failure': False, 04:23:49 INFO - 'name': 'check_screen_resolution'},), 04:23:49 INFO - 'run_cmd_checks_enabled': True, 04:23:49 INFO - 'sps_profile': False, 04:23:49 INFO - 'sps_profile_interval': 0, 04:23:49 INFO - 'suite': 'dromaeojs-e10s', 04:23:49 INFO - 'system_bits': '32', 04:23:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:49 INFO - 'title': 't-yosemite-r7-0379', 04:23:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:49 INFO - 'use_talos_json': True, 04:23:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:49 INFO - 'work_dir': 'build'} 04:23:49 INFO - [mozharness: 2016-12-11 12:23:49.213880Z] Running clobber step. 04:23:49 INFO - Running pre-action listener: _resource_record_pre_action 04:23:49 INFO - Running main action method: clobber 04:23:49 INFO - rmtree: /builds/slave/test/build 04:23:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:51 INFO - Running post-action listener: _resource_record_post_action 04:23:51 INFO - [mozharness: 2016-12-11 12:23:51.588407Z] Finished clobber step (success) 04:23:51 INFO - [mozharness: 2016-12-11 12:23:51.588532Z] Running read-buildbot-config step. 04:23:51 INFO - Running pre-action listener: _resource_record_pre_action 04:23:51 INFO - Running main action method: read_buildbot_config 04:23:51 INFO - Using buildbot properties: 04:23:51 INFO - { 04:23:51 INFO - "project": "", 04:23:51 INFO - "product": "firefox", 04:23:51 INFO - "script_repo_revision": "production", 04:23:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:23:51 INFO - "repository": "", 04:23:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:23:51 INFO - "buildid": "20161211030209", 04:23:51 INFO - "stage_platform": "macosx64", 04:23:51 INFO - "basedir": "/builds/slave/test", 04:23:51 INFO - "nightly_build": "True", 04:23:51 INFO - "buildnumber": 23, 04:23:51 INFO - "slavename": "t-yosemite-r7-0379", 04:23:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:23:51 INFO - "platform": "yosemite_r7", 04:23:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:23:51 INFO - "branch": "mozilla-central", 04:23:51 INFO - "repo_path": "mozilla-central", 04:23:51 INFO - "revision": "c51e7406d7b2e2246a1ece0d8989282ca752039f", 04:23:51 INFO - "pgo_build": "False", 04:23:51 INFO - "builduid": "637896eb2435441cad910568e9f81552", 04:23:51 INFO - "slavebuilddir": "test" 04:23:51 INFO - } 04:23:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg. 04:23:51 INFO - Running post-action listener: _resource_record_post_action 04:23:51 INFO - [mozharness: 2016-12-11 12:23:51.591880Z] Finished read-buildbot-config step (success) 04:23:51 INFO - [mozharness: 2016-12-11 12:23:51.591985Z] Running download-and-extract step. 04:23:51 INFO - Running pre-action listener: _resource_record_pre_action 04:23:51 INFO - Running main action method: download_and_extract 04:23:51 INFO - mkdir: /builds/slave/test/build/tests 04:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:51 INFO - trying https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json 04:23:51 INFO - Downloading https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 04:23:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json'}, attempt #1 04:23:52 INFO - Downloaded 1235 bytes. 04:23:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac64.test_packages.json 04:23:52 INFO - Using the following test package requirements: 04:23:52 INFO - {u'common': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 04:23:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'firefox-53.0a1.en-US.mac64.cppunittest.tests.zip'], 04:23:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'firefox-53.0a1.en-US.mac64.gtest.tests.zip'], 04:23:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'jsshell-mac64.zip'], 04:23:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'firefox-53.0a1.en-US.mac64.mochitest.tests.zip'], 04:23:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac64.common.tests.zip'], 04:23:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'firefox-53.0a1.en-US.mac64.reftest.tests.zip'], 04:23:52 INFO - u'talos': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'firefox-53.0a1.en-US.mac64.talos.tests.zip'], 04:23:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'firefox-53.0a1.en-US.mac64.web-platform.tests.zip'], 04:23:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac64.common.tests.zip', 04:23:52 INFO - u'firefox-53.0a1.en-US.mac64.xpcshell.tests.zip']} 04:23:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip'] for test suite category: common 04:23:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 04:23:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 04:23:52 INFO - Fetch https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 04:23:53 INFO - Expected file size: 16288969 04:23:53 INFO - Obtained file size: 16288969 04:24:00 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac64.common.tests.zip', u'firefox-53.0a1.en-US.mac64.talos.tests.zip'] for test suite category: talos 04:24:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip 04:24:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip'}, attempt #1 04:24:00 INFO - Fetch https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.common.tests.zip into memory 04:24:01 INFO - Expected file size: 16288969 04:24:01 INFO - Obtained file size: 16288969 04:24:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip 04:24:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip'}, attempt #1 04:24:07 INFO - Fetch https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.talos.tests.zip into memory 04:24:09 INFO - Expected file size: 14409734 04:24:09 INFO - Obtained file size: 14409734 04:24: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')]} 04:24:09 INFO - trying https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 04:24:09 INFO - Downloading https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg 04:24:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg'}, attempt #1 04:24:11 INFO - Downloaded 69772447 bytes. 04:24:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 04:24:11 INFO - mkdir: /builds/slave/test/properties 04:24:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:11 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:11 INFO - Contents: 04:24:11 INFO - build_url:https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg 04:24:12 INFO - Running post-action listener: _resource_record_post_action 04:24:12 INFO - Running post-action listener: set_extra_try_arguments 04:24:12 INFO - [mozharness: 2016-12-11 12:24:12.414475Z] Finished download-and-extract step (success) 04:24:12 INFO - [mozharness: 2016-12-11 12:24:12.414609Z] Running populate-webroot step. 04:24:12 INFO - Running pre-action listener: _resource_record_pre_action 04:24:12 INFO - Running main action method: populate_webroot 04:24:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:12 INFO - '--tppagecycles', 04:24:12 INFO - '7'], 04:24:12 INFO - 'tests': ['tsvgm']}}, 04:24:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:24:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:24:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:24:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:24:12 INFO - 'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:24:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:24:12 INFO - 'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['damp', 'tps']}, 04:24:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:24:12 INFO - 'tests': ['damp', 'tps']}, 04:24:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['dromaeo_dom']}, 04:24:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['basic_compositor_video']}, 04:24:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:24:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['a11yr', 04:24:12 INFO - 'ts_paint', 04:24:12 INFO - 'tpaint', 04:24:12 INFO - 'sessionrestore', 04:24:12 INFO - 'sessionrestore_no_auto_restore', 04:24:12 INFO - 'tabpaint']}, 04:24:12 INFO - 'other-e10s': {'tests': ['a11yr', 04:24:12 INFO - 'ts_paint', 04:24:12 INFO - 'tpaint', 04:24:12 INFO - 'sessionrestore', 04:24:12 INFO - 'sessionrestore_no_auto_restore', 04:24:12 INFO - 'tabpaint']}, 04:24:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:24:12 INFO - 'ts_paint', 04:24:12 INFO - 'tpaint', 04:24:12 INFO - 'sessionrestore', 04:24:12 INFO - 'sessionrestore_no_auto_restore', 04:24:12 INFO - 'tabpaint']}, 04:24:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:24:12 INFO - 'ts_paint', 04:24:12 INFO - 'tpaint', 04:24:12 INFO - 'sessionrestore', 04:24:12 INFO - 'sessionrestore_no_auto_restore', 04:24:12 INFO - 'tabpaint']}, 04:24:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['a11yr', 04:24:12 INFO - 'ts_paint', 04:24:12 INFO - 'tpaint', 04:24:12 INFO - 'sessionrestore', 04:24:12 INFO - 'sessionrestore_no_auto_restore', 04:24:12 INFO - 'tabpaint']}, 04:24:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['a11yr', 04:24:12 INFO - 'ts_paint', 04:24:12 INFO - 'tpaint', 04:24:12 INFO - 'sessionrestore', 04:24:12 INFO - 'sessionrestore_no_auto_restore', 04:24:12 INFO - 'tabpaint']}, 04:24:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['tsvgx', 04:24:12 INFO - 'tsvgr_opacity', 04:24:12 INFO - 'tart', 04:24:12 INFO - 'tscrollx', 04:24:12 INFO - 'cart', 04:24:12 INFO - 'tsvg_static']}, 04:24:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:24:12 INFO - 'tsvgr_opacity', 04:24:12 INFO - 'tart', 04:24:12 INFO - 'tscrollx', 04:24:12 INFO - 'cart', 04:24:12 INFO - 'tsvg_static']}, 04:24:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:24:12 INFO - 'talos_options': ['--disable-e10s'], 04:24:12 INFO - 'tests': ['tp5o']}, 04:24:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:24:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:24:12 INFO - 'talos_options': ['--disable-e10s', 04:24:12 INFO - '--xperf_path', 04:24:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:12 INFO - 'tests': ['tp5n']}, 04:24:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:24:12 INFO - 'talos_options': ['--xperf_path', 04:24:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:12 INFO - 'tests': ['tp5n']}}, 04:24:12 INFO - 'talos.zip': {'path': '', 04:24:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:12 INFO - Running post-action listener: _resource_record_post_action 04:24:12 INFO - [mozharness: 2016-12-11 12:24:12.432731Z] Finished populate-webroot step (success) 04:24:12 INFO - [mozharness: 2016-12-11 12:24:12.432836Z] Running create-virtualenv step. 04:24:12 INFO - Running pre-action listener: _resource_record_pre_action 04:24:12 INFO - Running main action method: create_virtualenv 04:24:12 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:24:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:12 INFO - Using real prefix '/tools/python27' 04:24:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:13 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:16 INFO - Installing pip.................done. 04:24:16 INFO - Return code: 0 04:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:24:16 INFO - Reading from file tmpfile_stdout 04:24:16 INFO - Output received: 04:24:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:24:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:16 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:16 INFO - 'HOME': '/Users/cltbld', 04:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:16 INFO - 'LOGNAME': 'cltbld', 04:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:16 INFO - 'MOZ_NO_REMOTE': '1', 04:24:16 INFO - 'NO_EM_RESTART': '1', 04:24:16 INFO - 'PAGER': '/bin/cat', 04:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:16 INFO - 'PWD': '/builds/slave/test', 04:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:16 INFO - 'SHELL': '/bin/bash', 04:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:16 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:16 INFO - 'USER': 'cltbld', 04:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:16 INFO - 'XPC_FLAGS': '0x0', 04:24:16 INFO - 'XPC_SERVICE_NAME': '0', 04:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:24:16 INFO - Cleaning up... 04:24:16 INFO - Return code: 0 04:24:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:16 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:16 INFO - 'HOME': '/Users/cltbld', 04:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:16 INFO - 'LOGNAME': 'cltbld', 04:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:16 INFO - 'MOZ_NO_REMOTE': '1', 04:24:16 INFO - 'NO_EM_RESTART': '1', 04:24:16 INFO - 'PAGER': '/bin/cat', 04:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:16 INFO - 'PWD': '/builds/slave/test', 04:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:16 INFO - 'SHELL': '/bin/bash', 04:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:16 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:16 INFO - 'USER': 'cltbld', 04:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:16 INFO - 'XPC_FLAGS': '0x0', 04:24:16 INFO - 'XPC_SERVICE_NAME': '0', 04:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:16 INFO - Downloading/unpacking psutil>=3.1.1 04:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:24:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:21 INFO - Installing collected packages: psutil 04:24:21 INFO - Running setup.py install for psutil 04:24:21 INFO - building 'psutil._psutil_osx' extension 04:24:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:24:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:24:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:24:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:24:21 INFO - building 'psutil._psutil_posix' extension 04:24:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:24:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:24:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:24:21 INFO - ^ 04:24:21 INFO - 1 warning generated. 04:24:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:24:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:24:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:24:22 INFO - Successfully installed psutil 04:24:22 INFO - Cleaning up... 04:24:22 INFO - Return code: 0 04:24:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:22 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:22 INFO - 'HOME': '/Users/cltbld', 04:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:22 INFO - 'LOGNAME': 'cltbld', 04:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:22 INFO - 'MOZ_NO_REMOTE': '1', 04:24:22 INFO - 'NO_EM_RESTART': '1', 04:24:22 INFO - 'PAGER': '/bin/cat', 04:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:22 INFO - 'PWD': '/builds/slave/test', 04:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:22 INFO - 'SHELL': '/bin/bash', 04:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:22 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:22 INFO - 'USER': 'cltbld', 04:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:22 INFO - 'XPC_FLAGS': '0x0', 04:24:22 INFO - 'XPC_SERVICE_NAME': '0', 04:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:24:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:24:25 INFO - Installing collected packages: mozsystemmonitor 04:24:25 INFO - Running setup.py install for mozsystemmonitor 04:24:25 INFO - Successfully installed mozsystemmonitor 04:24:25 INFO - Cleaning up... 04:24:25 INFO - Return code: 0 04:24:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:25 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:24:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:24:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:25 INFO - 'HOME': '/Users/cltbld', 04:24:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:25 INFO - 'LOGNAME': 'cltbld', 04:24:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:25 INFO - 'MOZ_NO_REMOTE': '1', 04:24:25 INFO - 'NO_EM_RESTART': '1', 04:24:25 INFO - 'PAGER': '/bin/cat', 04:24:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:25 INFO - 'PWD': '/builds/slave/test', 04:24:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:25 INFO - 'SHELL': '/bin/bash', 04:24:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:25 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:25 INFO - 'USER': 'cltbld', 04:24:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:25 INFO - 'XPC_FLAGS': '0x0', 04:24:25 INFO - 'XPC_SERVICE_NAME': '0', 04:24:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:28 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:28 INFO - warning: no files found matching '*.txt' 04:24:28 INFO - no previously-included directories found matching 'build' 04:24:28 INFO - no previously-included directories found matching 'dist' 04:24:28 INFO - no previously-included directories found matching '.git*' 04:24:28 INFO - Installing collected packages: jsonschema, functools32 04:24:28 INFO - Running setup.py install for functools32 04:24:28 INFO - warning: no files found matching '*.txt' 04:24:28 INFO - no previously-included directories found matching 'build' 04:24:28 INFO - no previously-included directories found matching 'dist' 04:24:28 INFO - no previously-included directories found matching '.git*' 04:24:28 INFO - Successfully installed jsonschema functools32 04:24:28 INFO - Cleaning up... 04:24:28 INFO - Return code: 0 04:24:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:28 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:24:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:28 INFO - 'HOME': '/Users/cltbld', 04:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:28 INFO - 'LOGNAME': 'cltbld', 04:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:28 INFO - 'MOZ_NO_REMOTE': '1', 04:24:28 INFO - 'NO_EM_RESTART': '1', 04:24:28 INFO - 'PAGER': '/bin/cat', 04:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:28 INFO - 'PWD': '/builds/slave/test', 04:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:28 INFO - 'SHELL': '/bin/bash', 04:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:28 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:28 INFO - 'USER': 'cltbld', 04:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:28 INFO - 'XPC_FLAGS': '0x0', 04:24:28 INFO - 'XPC_SERVICE_NAME': '0', 04:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:24:29 INFO - Cleaning up... 04:24:29 INFO - Return code: 0 04:24:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:24:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:29 INFO - 'HOME': '/Users/cltbld', 04:24:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:29 INFO - 'LOGNAME': 'cltbld', 04:24:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:29 INFO - 'MOZ_NO_REMOTE': '1', 04:24:29 INFO - 'NO_EM_RESTART': '1', 04:24:29 INFO - 'PAGER': '/bin/cat', 04:24:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:29 INFO - 'PWD': '/builds/slave/test', 04:24:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:29 INFO - 'SHELL': '/bin/bash', 04:24:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:29 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:29 INFO - 'USER': 'cltbld', 04:24:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:29 INFO - 'XPC_FLAGS': '0x0', 04:24:29 INFO - 'XPC_SERVICE_NAME': '0', 04:24:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:29 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:32 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:33 INFO - Downloading docopt-0.6.1.tar.gz 04:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:33 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:33 INFO - Running setup.py install for blobuploader 04:24:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:33 INFO - Running setup.py install for requests 04:24:33 INFO - Running setup.py install for docopt 04:24:34 INFO - Successfully installed blobuploader requests docopt 04:24:34 INFO - Cleaning up... 04:24:34 INFO - Return code: 0 04:24:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:34 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:34 INFO - 'HOME': '/Users/cltbld', 04:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:34 INFO - 'LOGNAME': 'cltbld', 04:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:34 INFO - 'MOZ_NO_REMOTE': '1', 04:24:34 INFO - 'NO_EM_RESTART': '1', 04:24:34 INFO - 'PAGER': '/bin/cat', 04:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:34 INFO - 'PWD': '/builds/slave/test', 04:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:34 INFO - 'SHELL': '/bin/bash', 04:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:34 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:34 INFO - 'USER': 'cltbld', 04:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:34 INFO - 'XPC_FLAGS': '0x0', 04:24:34 INFO - 'XPC_SERVICE_NAME': '0', 04:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-H4dVBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-MqWfzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-jp2m6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-sJddK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-C52Grv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:34 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-XfbyRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-QGtKnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-IYyk7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-aiEIt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-MJQZ_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-sqSbGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-eImSNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-7WzCre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-bBvhQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:35 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-1OJt73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:36 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-n44HpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:36 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-VhaCnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:36 INFO - Running setup.py install for manifestparser 04:24:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:36 INFO - Running setup.py install for mozcrash 04:24:36 INFO - Running setup.py install for mozdebug 04:24:36 INFO - Running setup.py install for mozdevice 04:24:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:36 INFO - Running setup.py install for mozfile 04:24:36 INFO - Running setup.py install for mozhttpd 04:24:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Running setup.py install for mozinfo 04:24:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Running setup.py install for mozInstall 04:24:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Running setup.py install for mozleak 04:24:37 INFO - Running setup.py install for mozlog 04:24:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Running setup.py install for moznetwork 04:24:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:37 INFO - Running setup.py install for mozprocess 04:24:38 INFO - Running setup.py install for mozprofile 04:24:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:38 INFO - Running setup.py install for mozrunner 04:24:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:38 INFO - Running setup.py install for mozscreenshot 04:24:38 INFO - Running setup.py install for moztest 04:24:38 INFO - Running setup.py install for mozversion 04:24:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:38 INFO - Cleaning up... 04:24:38 INFO - Return code: 0 04:24:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:38 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:38 INFO - 'HOME': '/Users/cltbld', 04:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:38 INFO - 'LOGNAME': 'cltbld', 04:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:38 INFO - 'MOZ_NO_REMOTE': '1', 04:24:38 INFO - 'NO_EM_RESTART': '1', 04:24:38 INFO - 'PAGER': '/bin/cat', 04:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:38 INFO - 'PWD': '/builds/slave/test', 04:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:38 INFO - 'SHELL': '/bin/bash', 04:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:38 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:38 INFO - 'USER': 'cltbld', 04:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:38 INFO - 'XPC_FLAGS': '0x0', 04:24:38 INFO - 'XPC_SERVICE_NAME': '0', 04:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Ckgn4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-YuHrjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-ql8WlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-_BCzjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-4xEZkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-X38yCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-_eRdAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-o3Thtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:39 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-XcwTVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-7m7B5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-41LFGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-zjVcxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:40 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)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-oRhp2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-wef6zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-iWkdHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-bGO7a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:40 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)) 04:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:40 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-3wYriK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:24:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:43 INFO - Downloading blessings-1.6.tar.gz 04:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:43 INFO - Installing collected packages: blessings 04:24:43 INFO - Running setup.py install for blessings 04:24:43 INFO - Successfully installed blessings 04:24:43 INFO - Cleaning up... 04:24:43 INFO - Return code: 0 04:24:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:44 INFO - Reading from file tmpfile_stdout 04:24:44 INFO - Current package versions: 04:24:44 INFO - blessings == 1.6 04:24:44 INFO - blobuploader == 1.2.4 04:24:44 INFO - docopt == 0.6.1 04:24:44 INFO - functools32 == 3.2.3-2 04:24:44 INFO - jsonschema == 2.5.1 04:24:44 INFO - manifestparser == 1.1 04:24:44 INFO - mozInstall == 1.12 04:24:44 INFO - mozcrash == 1.0 04:24:44 INFO - mozdebug == 0.1 04:24:44 INFO - mozdevice == 0.49 04:24:44 INFO - mozfile == 1.2 04:24:44 INFO - mozhttpd == 0.7 04:24:44 INFO - mozinfo == 0.9 04:24:44 INFO - mozleak == 0.1 04:24:44 INFO - mozlog == 3.4 04:24:44 INFO - moznetwork == 0.27 04:24:44 INFO - mozprocess == 0.23 04:24:44 INFO - mozprofile == 0.28 04:24:44 INFO - mozrunner == 6.13 04:24:44 INFO - mozscreenshot == 0.1 04:24:44 INFO - mozsystemmonitor == 0.3 04:24:44 INFO - moztest == 0.7 04:24:44 INFO - mozversion == 1.4 04:24:44 INFO - psutil == 3.1.1 04:24:44 INFO - requests == 1.2.3 04:24:44 INFO - wsgiref == 0.1.2 04:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:44 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:44 INFO - 'HOME': '/Users/cltbld', 04:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:44 INFO - 'LOGNAME': 'cltbld', 04:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:44 INFO - 'MOZ_NO_REMOTE': '1', 04:24:44 INFO - 'NO_EM_RESTART': '1', 04:24:44 INFO - 'PAGER': '/bin/cat', 04:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:44 INFO - 'PWD': '/builds/slave/test', 04:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:44 INFO - 'SHELL': '/bin/bash', 04:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:44 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:44 INFO - 'USER': 'cltbld', 04:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:44 INFO - 'XPC_FLAGS': '0x0', 04:24:44 INFO - 'XPC_SERVICE_NAME': '0', 04:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:24:44 INFO - Cleaning up... 04:24:44 INFO - Return code: 0 04:24:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:44 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 0x1101e13f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110157570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef147eef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, '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.tEWtvH91pI/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.nuziKcIOrS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:24:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:24:44 INFO - 'HOME': '/Users/cltbld', 04:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:24:44 INFO - 'LOGNAME': 'cltbld', 04:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:44 INFO - 'MOZ_NO_REMOTE': '1', 04:24:44 INFO - 'NO_EM_RESTART': '1', 04:24:44 INFO - 'PAGER': '/bin/cat', 04:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:44 INFO - 'PWD': '/builds/slave/test', 04:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:24:44 INFO - 'SHELL': '/bin/bash', 04:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:24:44 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:24:44 INFO - 'USER': 'cltbld', 04:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:44 INFO - 'XPC_FLAGS': '0x0', 04:24:44 INFO - 'XPC_SERVICE_NAME': '0', 04:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:24:44 INFO - Cleaning up... 04:24:44 INFO - Return code: 0 04:24:44 INFO - Running post-action listener: _resource_record_post_action 04:24:44 INFO - Running post-action listener: _start_resource_monitoring 04:24:44 INFO - Starting resource monitoring. 04:24:44 INFO - [mozharness: 2016-12-11 12:24:44.671230Z] Finished create-virtualenv step (success) 04:24:44 INFO - [mozharness: 2016-12-11 12:24:44.672242Z] Running install step. 04:24:44 INFO - Running pre-action listener: _resource_record_pre_action 04:24:44 INFO - Running main action method: install 04:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:44 INFO - Reading from file tmpfile_stdout 04:24:44 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:45 INFO - Reading from file tmpfile_stdout 04:24:45 INFO - Output received: 04:24:45 INFO - Usage: mozinstall [options] installer 04:24:45 INFO - Options: 04:24:45 INFO - -h, --help show this help message and exit 04:24:45 INFO - -d DEST, --destination=DEST 04:24:45 INFO - Directory to install application into. [default: 04:24:45 INFO - "/builds/slave/test"] 04:24:45 INFO - --app=APP Application being installed. [default: firefox] 04:24:45 INFO - mkdir: /builds/slave/test/build/application 04:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg', '--destination', '/builds/slave/test/build/application'] 04:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac64.dmg --destination /builds/slave/test/build/application 04:25:06 INFO - Reading from file tmpfile_stdout 04:25:06 INFO - Output received: 04:25:06 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:25:06 INFO - Running post-action listener: _resource_record_post_action 04:25:06 INFO - [mozharness: 2016-12-11 12:25:06.535583Z] Finished install step (success) 04:25:06 INFO - [mozharness: 2016-12-11 12:25:06.535750Z] Running run-tests step. 04:25:06 INFO - Running pre-action listener: _resource_record_pre_action 04:25:06 INFO - Running main action method: run_tests 04:25:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:25:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:25:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:25:06 INFO - 2016-12-11 04:25:06.550 screenresolution[1667:11875] starting screenresolution argv=screenresolution get 04:25:06 INFO - 2016-12-11 04:25:06.552 screenresolution[1667:11875] Display 0: 1600x1200x32@60 04:25:06 INFO - 2016-12-11 04:25:06.558 screenresolution[1668:11877] starting screenresolution argv=screenresolution list 04:25:06 INFO - Available Modes on Display 0 04:25:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:25:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:25:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:25:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:25:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:25:06 INFO - Intel Iris: 04:25:06 INFO - Chipset Model: Intel Iris 04:25:06 INFO - Type: GPU 04:25:06 INFO - Bus: Built-In 04:25:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:25:06 INFO - Vendor: Intel (0x8086) 04:25:06 INFO - Device ID: 0x0a2e 04:25:06 INFO - Revision ID: 0x0009 04:25:06 INFO - Displays: 04:25:06 INFO - Display: 04:25:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:25:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:25:06 INFO - Display Serial Number: 1600x1200 60 04:25:06 INFO - Main Display: Yes 04:25:06 INFO - Mirror: Off 04:25:06 INFO - Online: Yes 04:25:06 INFO - Rotation: Supported 04:25:06 INFO - Return code: 0 04:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:06 INFO - Python 2.7.3 04:25:06 INFO - Return code: 0 04:25:06 INFO - grabbing minidump binary from tooltool 04:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:25:06 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 0x10fff6d30>, '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 0x10fe5ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:25:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:25:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:25:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:06 INFO - Return code: 0 04:25:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:25:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:25:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:25:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip --title t-yosemite-r7-0379 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:25:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tEWtvH91pI/Render', 04:25:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:25:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:25:06 INFO - 'HOME': '/Users/cltbld', 04:25:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:25:06 INFO - 'LOGNAME': 'cltbld', 04:25:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:06 INFO - 'MOZ_NO_REMOTE': '1', 04:25:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:06 INFO - 'NO_EM_RESTART': '1', 04:25:06 INFO - 'PAGER': '/bin/cat', 04:25:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:06 INFO - 'PWD': '/builds/slave/test', 04:25:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:25:06 INFO - 'SHELL': '/bin/bash', 04:25:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nuziKcIOrS/Listeners', 04:25:06 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 04:25:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:25:06 INFO - 'USER': 'cltbld', 04:25:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:25:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:06 INFO - 'XPC_FLAGS': '0x0', 04:25:06 INFO - 'XPC_SERVICE_NAME': '0', 04:25:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:25:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:25:07 INFO - mozversion application_buildid: 20161211030209 04:25:07 INFO - mozversion application_changeset: c51e7406d7b2e2246a1ece0d8989282ca752039f 04:25:07 INFO - mozversion application_display_name: Nightly 04:25:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:07 INFO - mozversion application_name: Firefox 04:25:07 INFO - mozversion application_remotingname: firefox 04:25:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:25:07 INFO - mozversion application_vendor: Mozilla 04:25:07 INFO - mozversion application_version: 53.0a1 04:25:07 INFO - mozversion platform_buildid: 20161211030209 04:25:07 INFO - mozversion platform_changeset: c51e7406d7b2e2246a1ece0d8989282ca752039f 04:25:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:25:07 INFO - mozversion platform_version: 53.0a1 04:25:07 INFO - using testdate: 1481459107 04:25:07 INFO - actual date: 1481459107 04:25:07 INFO - starting webserver on 'localhost:49246' 04:25:07 INFO - SUITE-START | Running 2 tests 04:25:07 INFO - TEST-START | dromaeo_css 04:25:07 INFO - operating with platform_type : mac_ 04:25:07 INFO - Initialising browser for dromaeo_css test... 04:25:07 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmp5aGnXm/profile http://localhost:49246/getInfo.html) 04:25:10 INFO - PROCESS | 1678 | 2016-12-11 04:25:10.105 plugin-container[1681:12053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e47, name = 'com.apple.tsm.portname' 04:25:10 INFO - PROCESS | 1678 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:10 INFO - PROCESS | 1678 | 2016-12-11 04:25:10.105 plugin-container[1681:12053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x970b, name = 'com.apple.CFPasteboardClient' 04:25:10 INFO - PROCESS | 1678 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:10 INFO - PROCESS | 1678 | 2016-12-11 04:25:10.105 plugin-container[1681:12053] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:25:10 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 04:25:10 INFO - PROCESS | 1678 | colorDepth:24 04:25:10 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 04:25:10 INFO - PROCESS | 1678 | __metrics 04:25:10 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 04:25:11 INFO - TEST-INFO | 1678: exit 0 04:25:11 INFO - Browser initialized. 04:25:11 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:11 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmp5aGnXm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:13 INFO - PROCESS | 1683 | 2016-12-11 04:25:13.659 plugin-container[1684:12187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 04:25:13 INFO - PROCESS | 1683 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:13 INFO - PROCESS | 1683 | 2016-12-11 04:25:13.660 plugin-container[1684:12187] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:25:13 INFO - PROCESS | 1683 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:25:13 INFO - PROCESS | 1683 | 2016-12-11 04:25:13.660 plugin-container[1684:12187] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:25:23 INFO - PROCESS | 1683 | RSS: Main: 237400064 04:25:23 INFO - PROCESS | 1683 | 04:26:13 INFO - PROCESS | 1683 | 1481459173037 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] 04:28:25 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 04:28:27 INFO - PROCESS | 1683 | RSS: Main: 256331776 04:28:27 INFO - PROCESS | 1683 | 04:31:29 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 04:31:30 INFO - PROCESS | 1683 | RSS: Main: 266096640 04:31:30 INFO - PROCESS | 1683 | 04:34:32 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 04:34:33 INFO - PROCESS | 1683 | RSS: Main: 270581760 04:34:33 INFO - PROCESS | 1683 | 04:37:35 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 04:37:35 INFO - PROCESS | 1683 | RSS: Main: 269139968 04:37:35 INFO - PROCESS | 1683 | 04:40:38 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 04:40:39 INFO - PROCESS | 1683 | RSS: Main: 273559552 04:40:39 INFO - PROCESS | 1683 | 04:43:41 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 04:43:42 INFO - PROCESS | 1683 | RSS: Main: 276455424 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | __start_tp_report 04:43:42 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 04:43:42 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 04:43:42 INFO - PROCESS | 1683 | |i|pagename|runs| 04:43:42 INFO - PROCESS | 1683 | |0;dojo.html;3342.3816593930123;3360.042387919442;3361.210115622828;3378.7803792753452;3381.932361352773;5488.7530061147245;5598.300212473441;5598.63608865424;5648.26572545569;5654.208410822488;5527.2538207342095;5552.139418390146;5607.355154157273;5620.213170156181;5695.316562012554;4184.748915065091;4998.225275082368;5065.696058236508;5175.275461435402;5190.195519694435;5050.595952323805;5199.194124910645;5233.267342572043;5238.52853243208;5242.108841496935;4967.82612608557;4999.675021123615;5163.509466600667;5170.715610641413;5191.221316802472;5101.948980510185;5127.6154288428515;5133.358330208724;5144.4083930348115;5151.278820965068;5017.799288028475;5050.4697006814495;5059.266406371093;5089.338386009795;5103.260027296058;4265.445492086009;5409.972105300019;5421.105517589593;5548.306461692288;5574.080276754371;6113.938860611426;6121.209103132296;6134;6146.709191069881;6157.291911430153;6148.508119350441;6148.77383110543;6193.783217587363;6218.68906554675;6244.313125556185;5541.196526503675;5561.944380556223;5564.666120032811;5726.141078838166;5804.097951024488;6114.236541168587;6166.537509686791;6222.657753823492;6226.128342032119;6268.686565671698;5022.748862556858;5512.283403157564;6025.849353766191;6035.456808887221;6051.788187413419;6012.669303188367;6168.352323006109;6171.290301615282;6200.410960958701;6204.255489341308;5958.344582095966;6027.246594175728;6034.185384972972;6059.545534084961;6116.021436570128;6122.276600501844;6149.0776383542825;6154.630722156596;6159.84600384985;6169.259688837278;4785.784639691222;4843.128236917389;4856.587190088811;4872.6589138760655;4885.487023862514;4228.894277643083;4266.5093514246255;4278.187144442608;4305.117450922553;4305.590968858016;5629.577781666391;5674.886502269931;5685.1756495307945;5698.430156984351;5743.483086522149;6130.601510901777;6135.785247516315;6144.078388241799;6156.815295541141;6160.599561028519;5536.612437129363;5566.137248726453;5599.832005039855;5622.690752008679;5673.773049078073;5261.421243663194;5291.920621190685;5295.258663787073;5296.04671159195;5312.681239125587;6162.907556386568;6182.381761823782;6196.938030619636;6207.131001659681;6231;6133.233345831771;6174.012158054689;6175.135481032569;6195.070739389128;6204.844878878064;5247.9737601311745;6239.251289845248;6239.812805615838;6243.7814676486105;6246.656433896179;5954.672493012926;5956.970215148896;5998.610090344114;6058.818235452944;6098.634081955097;6088.573799833969;6107.886786452593;6108.236470441195;6109.495762817132;6112.0171844544475;5921.082232254007;5954.910676339771;6017.518598512196;6023.337432882292;6041.909371359521;6022.698865056642;6029.57792954489;6034.426729460694;6054.48536874353;6070.271567411939;5668.489835914787;5678.3186017678145;5793.94206057934;5836.533077353716;5908.202392677105;5970.194023806731;6002.429769171922;6036.517078633611;6046.758129674764;6049.637021778707;5833.970830145822;5837.562182836219;5853.414658534112;5858.2677165354335;5902.085176797603 04:43:42 INFO - PROCESS | 1683 | |1;ext.html;445.79493433020815;463.9095376401603;470.08099166130216;499.1133515312117;499.48054023815234;38751.418728719094;40816;40878;40886.59113408865;41121.3831792523;41951;42424.36363454551;42514;42634.72095837122;42724.57275427245;8304.750857474255;9228.723138305862;9448.622055117787;9455.959844417142;9484.05159484053;8352.12302708216;11014.944925275402;11258.380789056599;11265.042471389941;11456.255343402652;11318.32090074598;11369.374684392355;11370.374629395379;11391.54433822646;11406.486708098115;11065.225434219608;11091.611793587186;11109.72225694356;11125.7218569536;11138.3873886937;11051.834222486668;11117.277376970553;11127.998480136826;11164.665060048212;11167.553297868075;39399.8030009851;39746.403803942965;39749.60250397488;39785;40106.799466002776;3298.422776014188;3329.0012996101073;3424.143964008998;3811.2187001664593;4079.4900637420324;24307.63538546923;25098.12156574511;25493.47039177655;27150.864245678844;30877.648940423787;2658.667666541682;2695.3396417877548;2865.398266364066;3113.9065828025196;3302.93394132116;416173;458264;485411;485859;487840;61103.08345374823;61178;61555.07667384993;61615;62097;64228;64435.67782161153;64578;64594.70810583762;65507.67246163739;11698.181127321006;15628.2185890705;15663.921680391524;15846.286917088759;15871.841281587036;10428.5828566858;11091.944540277247;12284.385780710929;12339.012878969661;12451.688707782378;13981.300934953211;16884.57788555296;17208.1395930203;17273.65452690939;17692.557686057695;5632.746526406321;6492.902606460907;7268.001299642535;7312.159101703266;7386.889196662054;851.4848516647463;857.3141486810526;963.1428029054148;1044.6865940217904;1055.5250137438184;27629.723702762716;28779.42441151207;28990.985315513855;29770.10689679313;29810.25474363115;1029.6910926721953;1045.7542477517777;1102.2945314998408;1105.9004689577976;1106.8433487005937;14276.14410126677;14794.704105917821;14876.851231487763;15157.393704251706;15279;501261;630436.6956330378;640574;641457;644534;52716.94566108656;52834.207486887724;52949.2057619136;52965.470345296824;53024.20463693047;1313;1343.0732794372047;1345.9528916487875;1373.368250604713;1376.4700590272816;27511;28511.144665660064;28742.856285719274;28849.105370775516;28974.710252897203;46190.538094619966;46389.07221855612;46432.07135857332;46459.53540464552;46490.37283695055;578687;578741;578776;582336;583891;23728.881355593112;24576.385590360384;24860;24874.890638670167;25008.74991250137;37370.813145934095;40901.59098408978;41164.970875728344;41332.38001429921;41757.37363939604;30224.244393890327;32277.193070173435;34870;35046.82476587601;36088.63911360853;33421.99734007983;34600.13499662428;35126.64873351336;35515.644843551236;35599.28801424009;34551.4817277736;35151;35207.47188792119;35212.82393588016;35434.11414714653;25942.610860836725;27730.920180986912;29910;30028.099157025325;30207.617625093353;18385.568061958926;18639.440816775517;23616.763832362143;23793.286201413986;23810.523789524457 04:43:42 INFO - PROCESS | 1683 | |2;jquery.html;311.76306007434346;364.9142451523891;374.5617627375969;386.32393311704516;403.22983102274645;18675.252989880406;19322.51693707658;19427.90286048568;19689.409317720474;19898.303559375425;19672.704909426335;19815.801841981574;20225.190992360323;20331.288404905794;20389.592208155864;5521.116621340586;5567.4432556744405;5789.957807594631;5793.188953546507;5807.477327040587;5450.127979523277;5627.465390787868;5675.744591493372;5693.544516438675;5704.629199102045;5362.43694412087;5614.775408983635;5640.887182256352;5645.379008309083;5648.265725455705;5502.202180683798;5626.690532020737;5630.943690563083;5633.971830140844;5640.435956404368;4867.537583929521;4898.608111351084;4947.936193718368;4952.62855285855;4963.4292056413615;24885;24953.00187992478;25022.999080036778;25035.49929001428;25238.747612523825;1882.6046530228668;2348.97651023491;2354.7880690737916;2372.406898275431;2450.546648869965;9718.271129665303;10000.599976001024;10127.848082278771;10275.02387273208;10333.586656533806;1848.4639454558162;1865.8880467171878;1866.1992869804212;1876.5121068522146;1894.2896413844808;91532;117365;120856;122753.99999999911;124610.37694811559;11383.487743051583;11421.600243991586;11559.364234967157;11585.131115166396;11686.474108664961;14330.21183834899;14374.137551746928;14389.640258993399;14399.568012959628;14400.711985760227;7844.803879903048;8063.032436107705;8304.792380190544;8328.208820162075;8442.57787110642;8077.83844323122;8091.0695270043525;8239.011318641682;8240.464369815943;8244.876326855101;4391.143726973273;4415.4259946206785;4452.0873220989615;4567.725936443824;4570.862874113782;1891.5082078659648;1933.8742981706143;1935.6128774245208;1941.805819418075;1951.3072859135086;839.9874001889976;859.7162936231028;877.6138499060393;899;931.3945935142211;15686.607834804221;17508.5622859427;17858.91070544639;20273.290434835006;20940.47648808792;765.9961700191575;875.2166810704384;880.0891077734514;896.1397058823602;934.9808708507759;8880.555972201364;10921.962413570698;11019.559217631366;11059.778804424028;11103.44482775858;243062;295552;430390;562242;573014.1349293226;92341.53829230946;93005;98986;116664.41667791607;124537;761.7676608634309;804.2118723650855;921.9216366608913;940.6707652321769;944.8535477001076;18182.90908545449;18355;18779.624407512045;18867.716984244973;18910.810891891455;35454;50559.241611375124;50633.49366506288;51659.48340516547;57499;69308.3069169322;76635;78975;79803.80294295706;81261.18738812536;5008.524190201925;5540.944590554042;7250.20247772734;7689.769306920802;8210.425270231266;11358.375289359165;12416.565420210249;12616.053795965523;12893.548725794928;12989.350532473527;11007.779844402907;11191.048760855418;11298;11298.322100673986;11359.148063895076;10572.36565806054;10854.620088296871;11048.171387146156;11060.391678457761;11188.160887933274;8600.870986935326;9502.334836561651;10857.619983300547;11345.602903898654;11419.31484110956;6072.757089716361;7809.375249980101;8040.83918321642;8094.51432914027;8166.142555031636;9315.441073535609;10626.681199564026;11011.559537618405;11140.88859111431;11258.7748245033 04:43:42 INFO - PROCESS | 1683 | |3;mootools.html;1376.3462355381191;1483.6810085831548;1660.7793271945118;1762.541739147821;1807.322254154692;7386.224446433128;7630.4658673892845;7835.529868207905;8296.37777166712;8307.958460207697;7871.173526779691;8137.9593102034405;8162.877556836652;8245.876311855327;8249.752507424771;2262.6266666000092;2313.4679023824447;2315.518068436194;2324.93025209244;2327.697399338092;1965.4889728670505;2321.1411777642297;2344.2498400511845;2349.8942547585316;2357.5167090746354;2154.353693891826;2167.5231449081257;2171.837112216582;2176.6082105221053;2228.3315005498366;2224.8665080095248;2271.034810205664;2296.2651951375565;2298.425393651587;2309.1225334373;2294.7819957104048;2298.4368829636846;2326.953460930772;2332.055517515409;2337.590921588715;8186.263236308701;8196.098429172845;8237.341012718967;8244.381671374671;8267.338612910953;4312.762798046107;4650.186217411973;4996.400431948153;5152.613553983466;5184.351956005499;2949.4838403279555;3239.9352012959607;3487.633798451177;3503.877364292263;3515.0860776198115;902.5983437370372;987.4963768478057;998.0219385002665;1076.7684947736195;1077.983830242547;10113.949430252802;10300.793984120275;10404.635837745642;10553.683389498327;10596.41719705416;4211.957880421157;4254.340577210537;4410.29435290352;4423.248047831877;4438.245498265303;8374.958125209336;8477.27943124829;8479.321654267644;8489.278411334983;8498.320134389234;4978.77595508203;4987.401511818605;4997.750112494361;5006.524380183877;5010.473900240495;4234.9576504234565;4368.432103826546;4554.24854898938;4648.302754586839;4655.627549796076;3569.7679650822615;3608.9819550902603;3650.5984341722387;3690.9815450922574;3702.8889133326043;1030.2427715629008;1034.849946757716;1040.3445829127752;1041.2919214933765;1042.781015986636;839.7068514487743;871.9476831390136;887.8313120507083;927.4991504587582;941.1576638908276;5351.9464805351445;5508.485166579223;5555.749991250404;5588.497035266845;5688.146777983336;415.90226296820225;417.3468521763431;422.1893963589915;432.5047820245801;438.7849953522751;3628.854845806191;3796.335641262768;3850.2876967760494;3870.5355357356734;3931.6658084063174;8804.119588041145;9238.983711791698;9255.074492550826;9264.861027084598;9266.67566635178;8941.821163576693;8986.730398088068;9115.270778337717;9115.954420227856;9190.954045229731;7506.962465187748;7535.585542795089;7647.694092236359;7649.082110146818;7664.271894170045;4377.715448495965;5142.714321419645;5352.250684904038;5447.863803404946;5535.667859928417;8800.559972001247;8923.776905577153;9030.277577793891;9043.140901614335;9099.727008189764;9188.678396256098;9232.98437171924;9266.907330926873;9323.72028839136;9373.953130234306;6206.441420272197;6362.268339140873;6437.67811609427;6511.902321465087;6639.03733958583;7661.578613176329;7838.412119090977;7845.372370210255;7851.528908265523;7865.252800983897;6956.2000369958105;7030.578165310098;7072.469564782559;7123.358897699232;7200.89198662031;6767.560108592926;6918.411934985583;6958.199807022055;6979.022936788955;7005.124359455068;6367.42693157618;6520.956646936467;6572.901406478811;6581.3747693969;6695.464362851058;4794.376731024944;4805.711657300573;4807.903841923072;4842.080004799077;4908.754562271801;4757.429108507002;4791.47293797689;4838.322634831196;4940.962397896482;4957.454679985271 04:43:42 INFO - PROCESS | 1683 | |4;prototype.html;327.3110103232695;353.3621812628207;367.78668372344043;367.9668829805318;371.2574850299403;5080.949190508094;5221.373435187783;5379.623426360156;5427.18592211168;5474.233607294982;4205.348171033487;4348.739075655455;5062.544371006617;5214.69632591852;5285.577153827694;4144.792760361977;4165.792130171014;4173.64524015459;4187.9111431027995;4232.6613870890405;3525.506429099928;3769.9632601034796;4181.91636167278;4198.706090573661;4199.307114326132;3956.960430395688;3961.3067713150226;3962.2075584882996;3984.752426772186;4008.6592639625665;3507.2634746703225;3959.98020009901;3998.7200895937294;4001.5398229203724;4022.658074063708;3005.0984704588755;3259.722923551501;3297.0273769237892;3452.637473065317;3455.827208639583;4214.515330736974;4730.526947305277;4828.517148285178;5152.330197074394;5190.97404512975;3660.396034654279;3785.5835858055593;4039.899002524931;4121.475054229954;4622;5638.605297629168;5654.984960677883;5685.857853553653;5688.63023903445;5700.8859822803315;3192.9042128736173;3565.3760591896576;3691.53855768029;3838.193979264358;3849.8845034648725;5807.5644326675665;5809.767609295665;5842.415758424124;5851.444112809277;5856.736446859902;3120.547520609499;3430.708389786896;3829.463875057494;3851.5955824638568;3866.9226615467533;3404.69357757803;3832.9370866881195;3851.5692873048865;3905.4922860028582;3906.6093390661276;3530.541029666127;3562.147683204719;4490.640748740093;4498.460184777782;4515.525869783691;5614.69119198448;5616.747246373923;5631.887362252814;5688.715564221855;5719.342275638355;1036.6734478639205;1055.266589720137;1245.4706749631553;1273.5096987659817;1284.6146156153118;844.8268105038452;855.2815634866741;858.9871151932726;861.7371701630938;880.1462581296132;4744.644151688637;5009.44896061433;5086.618503612244;5125.923111153335;5126.948730512721;4986.501349864984;5481.671099734029;5488.8319113950565;5577.856539409411;5579.605098725318;4341.934870976938;4514.553165132407;4674.6260299176665;4680.836170734076;4796.832110876103;2406.7111946566524;2504.94990100197;2882.5443151208506;2895.4932886744737;2936.839948220441;4663.417072865892;4779.578889527243;5637.138560086354;5674.744636491368;5750.396208398141;5192.714400707921;5323.581427415236;5396;5644.238027866268;5672.319321681424;5223.791048358175;5580.581456390787;5729.369769325371;6079.422454866781;6149.185990132922;4925.827596034122;5691.430856914441;5877.206577112035;5918.704064796657;6026.8794624106395;4536.979179684545;5779.393163717918;5842.357340692435;5850.736716847667;5863.648181109147;4829.806807727651;5970.41783927251;6022.638641681513;6057.18228039209;6096.719688865388;3903.2583809076186;3936.783476908683;3941.688981255759;3955;3969.0672691916798;4732.976335118303;5429.049916264717;5725.627834190765;5816.302043754777;5881.647101173943;5368.7047212403695;5377.220303055957;5466.890662186814;5636.605437619492;5662.943370566406;5231.921521177262;5614.52276556481;5658.830235092953;5671.461211185096;5673.113916966891;4843.612510999182;5182.253405694988;5577.9442205577425;5595.300587426572;5598.832035038955;4983.626228032985;5633.549316054788;5670.829875103754;5695.8860822784145;5722.370539240597;4649.325847752125;5510.311211098613;5532.889342213214;5608.6073974821375;5656.745446455002 04:43:42 INFO - PROCESS | 1683 | |5;yui.html;665.3446355339993;708.1431467923812;726.154030554404;747.2079595628634;804.3444592656986;14574.489892853751;15629.374825006986;15671;15683.059016459007;15687.372505099782;14216.147031178136;14385.208813515252;14389.496367627135;14389.928050359733;14426.35081421336;690.5373399822106;705.7529864547419;845.8900342955408;857.4083882121347;867.5315329721974;852.2031900173358;871.0766587417327;871.9912800872005;871.9972032163;872.0625327772638;918.1048477734189;939.5302348825587;939.5865819039601;940.1632547033146;941.2234906202376;932.2868005975434;936.063936063936;937.7702462896634;939.5959737312953;940.5673390240497;694.3369082526175;699.6781480518916;699.7096205074888;700.6181631011111;700.8528209076101;14367;14568.344424500923;14737;15357.46248881295;15622.375104995786;10364.429956352398;11555.768884622345;12765.071734767165;13996.510122145777;14185.929070354685;8723.956380218122;10444.11225045872;11640.825387619108;11819.704507387383;11978.041756659533;3056.205386599478;3522.577290725104;3573.3746594345885;3640.1263696712863;3685.4103343464917;93668.53165734195;96982.51508742411;103361.99999999924;107196;107472;8310;10450.477476126316;10529.157667386591;10564.524596393181;10636;22596.774032259465;23172.536549269258;23178.3046508605;23268;23280;7733.90725103745;7748.651310691032;7757.26306000929;7785.5328680278235;7898.486598371088;3657.561092668897;4184.707070505096;4305.590968857953;4317.222899877989;4423.623991960655;3515.455104458813;3604.585472670624;3620.366435873764;3624.3113808376324;3625.456181572785;611.5871786544154;611.5932904618379;638.6742761191825;643.1446176585131;644.4554351572914;621.7916997805786;630.8517498387876;666.5034549260735;673.0980486148584;673.6497021548865;7913.366930645535;8707.912920870836;8776.605052772513;9243.445393276425;9398.436093834393;609.679918043031;635.2472320300367;664.7141729056456;681.7818298144646;687.7145984416411;3806.638369354907;4373.75944323059;4593.269101768484;4619.260918253063;4689;108568.45715771528;110918.12654987581;110988;111561.44219278851;112739;96116.58680702186;97884;98920.50539747255;99242.51136232962;101060;84974.15025849786;86304.56847715721;86337;86385.70421443683;87932;9008.414453060792;9010.729678109667;9018.278537716837;9046.411983221069;9274.026227246042;37103.47516985882;40052.79841604757;45378.865528362054;53509.929801404534;53850.192247117106;60964.39035609587;61235.46911327253;74822.6258868724;76381.2361876374;77746.6112669433;11691;11872.76254474923;11909.82135267989;11963.581274655693;11973.401329933295;10831.837522437012;12450.501979921064;12624.495020199089;12804.679883003;13163.934180329037;10028.899711002796;11806.547648780668;11833.398209419967;12162.148649594443;12568.120231583702;11759.941200293944;12063;12124.848139427093;12242.510299588273;12572.874271257171;11949.522019119138;11957.58806916719;12062.819057713965;12302.630921072383;12396.81404778947;8925.419847709878;9890.604375824887;10312.896871031193;10436;10456.215783816397;9448.102430269113;10091.495425228855;10130.645427410005;10145.898541014496;10485.318454300446 04:43:42 INFO - PROCESS | 1683 | __end_tp_report 04:43:42 INFO - PROCESS | 1683 | __start_cc_report 04:43:42 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,384 04:43:42 INFO - PROCESS | 1683 | __end_cc_report 04:43:42 INFO - PROCESS | 1683 | __startTimestamp1481460222119__endTimestamp 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | ------- Summary: start ------- 04:43:42 INFO - PROCESS | 1683 | Number of tests: 6 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | [#0] dojo.html Cycles:165 Average:5621.98 Median:5836.53 stddev:647.01 (11.1%) stddev-sans-first:623.79 04:43:42 INFO - PROCESS | 1683 | Values: 3342.4 3360.0 3361.2 3378.8 3381.9 5488.8 5598.3 5598.6 5648.3 5654.2 5527.3 5552.1 5607.4 5620.2 5695.3 4184.7 4998.2 5065.7 5175.3 5190.2 5050.6 5199.2 5233.3 5238.5 5242.1 4967.8 4999.7 5163.5 5170.7 5191.2 5101.9 5127.6 5133.4 5144.4 5151.3 5017.8 5050.5 5059.3 5089.3 5103.3 4265.4 5410.0 5421.1 5548.3 5574.1 6113.9 6121.2 6134.0 6146.7 6157.3 6148.5 6148.8 6193.8 6218.7 6244.3 5541.2 5561.9 5564.7 5726.1 5804.1 6114.2 6166.5 6222.7 6226.1 6268.7 5022.7 5512.3 6025.8 6035.5 6051.8 6012.7 6168.4 6171.3 6200.4 6204.3 5958.3 6027.2 6034.2 6059.5 6116.0 6122.3 6149.1 6154.6 6159.8 6169.3 4785.8 4843.1 4856.6 4872.7 4885.5 4228.9 4266.5 4278.2 4305.1 4305.6 5629.6 5674.9 5685.2 5698.4 5743.5 6130.6 6135.8 6144.1 6156.8 6160.6 5536.6 5566.1 5599.8 5622.7 5673.8 5261.4 5291.9 5295.3 5296.0 5312.7 6162.9 6182.4 6196.9 6207.1 6231.0 6133.2 6174.0 6175.1 6195.1 6204.8 5248.0 6239.3 6239.8 6243.8 6246.7 5954.7 5957.0 5998.6 6058.8 6098.6 6088.6 6107.9 6108.2 6109.5 6112.0 5921.1 5954.9 6017.5 6023.3 6041.9 6022.7 6029.6 6034.4 6054.5 6070.3 5668.5 5678.3 5793.9 5836.5 5908.2 5970.2 6002.4 6036.5 6046.8 6049.6 5834.0 5837.6 5853.4 5858.3 5902.1 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | [#1] ext.html Cycles:180 Average:67752.87 Median:18423.07 stddev:149153.80 (809.6%) stddev-sans-first:149486.60 04:43:42 INFO - PROCESS | 1683 | Values: 445.8 463.9 470.1 499.1 499.5 38751.4 40816.0 40878.0 40886.6 41121.4 41951.0 42424.4 42514.0 42634.7 42724.6 8304.8 9228.7 9448.6 9456.0 9484.1 8352.1 11014.9 11258.4 11265.0 11456.3 11318.3 11369.4 11370.4 11391.5 11406.5 11065.2 11091.6 11109.7 11125.7 11138.4 11051.8 11117.3 11128.0 11164.7 11167.6 39399.8 39746.4 39749.6 39785.0 40106.8 3298.4 3329.0 3424.1 3811.2 4079.5 24307.6 25098.1 25493.5 27150.9 30877.6 2658.7 2695.3 2865.4 3113.9 3302.9 416173.0 458264.0 485411.0 485859.0 487840.0 61103.1 61178.0 61555.1 61615.0 62097.0 64228.0 64435.7 64578.0 64594.7 65507.7 11698.2 15628.2 15663.9 15846.3 15871.8 10428.6 11091.9 12284.4 12339.0 12451.7 13981.3 16884.6 17208.1 17273.7 17692.6 5632.7 6492.9 7268.0 7312.2 7386.9 851.5 857.3 963.1 1044.7 1055.5 27629.7 28779.4 28991.0 29770.1 29810.3 1029.7 1045.8 1102.3 1105.9 1106.8 14276.1 14794.7 14876.9 15157.4 15279.0 501261.0 630436.7 640574.0 641457.0 644534.0 52716.9 52834.2 52949.2 52965.5 53024.2 1313.0 1343.1 1346.0 1373.4 1376.5 27511.0 28511.1 28742.9 28849.1 28974.7 46190.5 46389.1 46432.1 46459.5 46490.4 578687.0 578741.0 578776.0 582336.0 583891.0 23728.9 24576.4 24860.0 24874.9 25008.7 37370.8 40901.6 41165.0 41332.4 41757.4 30224.2 32277.2 34870.0 35046.8 36088.6 33422.0 34600.1 35126.6 35515.6 35599.3 34551.5 35151.0 35207.5 35212.8 35434.1 25942.6 27730.9 29910.0 30028.1 30207.6 18385.6 18639.4 23616.8 23793.3 23810.5 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | [#2] jquery.html Cycles:180 Average:28981.12 Median:369.74 stddev:75084.42 (20307.5%) stddev-sans-first:75264.20 04:43:42 INFO - PROCESS | 1683 | Values: 311.8 364.9 374.6 386.3 403.2 18675.3 19322.5 19427.9 19689.4 19898.3 19672.7 19815.8 20225.2 20331.3 20389.6 5521.1 5567.4 5790.0 5793.2 5807.5 5450.1 5627.5 5675.7 5693.5 5704.6 5362.4 5614.8 5640.9 5645.4 5648.3 5502.2 5626.7 5630.9 5634.0 5640.4 4867.5 4898.6 4947.9 4952.6 4963.4 24885.0 24953.0 25023.0 25035.5 25238.7 1882.6 2349.0 2354.8 2372.4 2450.5 9718.3 10000.6 10127.8 10275.0 10333.6 1848.5 1865.9 1866.2 1876.5 1894.3 91532.0 117365.0 120856.0 122754.0 124610.4 11383.5 11421.6 11559.4 11585.1 11686.5 14330.2 14374.1 14389.6 14399.6 14400.7 7844.8 8063.0 8304.8 8328.2 8442.6 8077.8 8091.1 8239.0 8240.5 8244.9 4391.1 4415.4 4452.1 4567.7 4570.9 1891.5 1933.9 1935.6 1941.8 1951.3 840.0 859.7 877.6 899.0 931.4 15686.6 17508.6 17858.9 20273.3 20940.5 766.0 875.2 880.1 896.1 935.0 8880.6 10922.0 11019.6 11059.8 11103.4 243062.0 295552.0 430390.0 562242.0 573014.1 92341.5 93005.0 98986.0 116664.4 124537.0 761.8 804.2 921.9 940.7 944.9 18182.9 18355.0 18779.6 18867.7 18910.8 35454.0 50559.2 50633.5 51659.5 57499.0 69308.3 76635.0 78975.0 79803.8 81261.2 5008.5 5540.9 7250.2 7689.8 8210.4 11358.4 12416.6 12616.1 12893.5 12989.4 11007.8 11191.0 11298.0 11298.3 11359.1 10572.4 10854.6 11048.2 11060.4 11188.2 8600.9 9502.3 10857.6 11345.6 11419.3 6072.8 7809.4 8040.8 8094.5 8166.1 9315.4 10626.7 11011.6 11140.9 11258.8 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | [#3] mootools.html Cycles:180 Average:5228.54 Median:5076.59 stddev:2840.90 (56.0%) stddev-sans-first:2834.11 04:43:42 INFO - PROCESS | 1683 | Values: 1376.3 1483.7 1660.8 1762.5 1807.3 7386.2 7630.5 7835.5 8296.4 8308.0 7871.2 8138.0 8162.9 8245.9 8249.8 2262.6 2313.5 2315.5 2324.9 2327.7 1965.5 2321.1 2344.2 2349.9 2357.5 2154.4 2167.5 2171.8 2176.6 2228.3 2224.9 2271.0 2296.3 2298.4 2309.1 2294.8 2298.4 2327.0 2332.1 2337.6 8186.3 8196.1 8237.3 8244.4 8267.3 4312.8 4650.2 4996.4 5152.6 5184.4 2949.5 3239.9 3487.6 3503.9 3515.1 902.6 987.5 998.0 1076.8 1078.0 10113.9 10300.8 10404.6 10553.7 10596.4 4212.0 4254.3 4410.3 4423.2 4438.2 8375.0 8477.3 8479.3 8489.3 8498.3 4978.8 4987.4 4997.8 5006.5 5010.5 4235.0 4368.4 4554.2 4648.3 4655.6 3569.8 3609.0 3650.6 3691.0 3702.9 1030.2 1034.8 1040.3 1041.3 1042.8 839.7 871.9 887.8 927.5 941.2 5351.9 5508.5 5555.7 5588.5 5688.1 415.9 417.3 422.2 432.5 438.8 3628.9 3796.3 3850.3 3870.5 3931.7 8804.1 9239.0 9255.1 9264.9 9266.7 8941.8 8986.7 9115.3 9116.0 9191.0 7507.0 7535.6 7647.7 7649.1 7664.3 4377.7 5142.7 5352.3 5447.9 5535.7 8800.6 8923.8 9030.3 9043.1 9099.7 9188.7 9233.0 9266.9 9323.7 9374.0 6206.4 6362.3 6437.7 6511.9 6639.0 7661.6 7838.4 7845.4 7851.5 7865.3 6956.2 7030.6 7072.5 7123.4 7200.9 6767.6 6918.4 6958.2 6979.0 7005.1 6367.4 6521.0 6572.9 6581.4 6695.5 4794.4 4805.7 4807.9 4842.1 4908.8 4757.4 4791.5 4838.3 4941.0 4957.5 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | [#4] prototype.html Cycles:180 Average:4477.42 Median:4997.98 stddev:1419.56 (28.4%) stddev-sans-first:1388.94 04:43:42 INFO - PROCESS | 1683 | Values: 327.3 353.4 367.8 368.0 371.3 5080.9 5221.4 5379.6 5427.2 5474.2 4205.3 4348.7 5062.5 5214.7 5285.6 4144.8 4165.8 4173.6 4187.9 4232.7 3525.5 3770.0 4181.9 4198.7 4199.3 3957.0 3961.3 3962.2 3984.8 4008.7 3507.3 3960.0 3998.7 4001.5 4022.7 3005.1 3259.7 3297.0 3452.6 3455.8 4214.5 4730.5 4828.5 5152.3 5191.0 3660.4 3785.6 4039.9 4121.5 4622.0 5638.6 5655.0 5685.9 5688.6 5700.9 3192.9 3565.4 3691.5 3838.2 3849.9 5807.6 5809.8 5842.4 5851.4 5856.7 3120.5 3430.7 3829.5 3851.6 3866.9 3404.7 3832.9 3851.6 3905.5 3906.6 3530.5 3562.1 4490.6 4498.5 4515.5 5614.7 5616.7 5631.9 5688.7 5719.3 1036.7 1055.3 1245.5 1273.5 1284.6 844.8 855.3 859.0 861.7 880.1 4744.6 5009.4 5086.6 5125.9 5126.9 4986.5 5481.7 5488.8 5577.9 5579.6 4341.9 4514.6 4674.6 4680.8 4796.8 2406.7 2504.9 2882.5 2895.5 2936.8 4663.4 4779.6 5637.1 5674.7 5750.4 5192.7 5323.6 5396.0 5644.2 5672.3 5223.8 5580.6 5729.4 6079.4 6149.2 4925.8 5691.4 5877.2 5918.7 6026.9 4537.0 5779.4 5842.4 5850.7 5863.6 4829.8 5970.4 6022.6 6057.2 6096.7 3903.3 3936.8 3941.7 3955.0 3969.1 4733.0 5429.0 5725.6 5816.3 5881.6 5368.7 5377.2 5466.9 5636.6 5662.9 5231.9 5614.5 5658.8 5671.5 5673.1 4843.6 5182.3 5577.9 5595.3 5598.8 4983.6 5633.5 5670.8 5695.9 5722.4 4649.3 5510.3 5532.9 5608.6 5656.7 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - PROCESS | 1683 | [#5] yui.html Cycles:180 Average:20664.09 Median:4345.49 stddev:31030.26 (714.1%) stddev-sans-first:31080.98 04:43:42 INFO - PROCESS | 1683 | Values: 665.3 708.1 726.2 747.2 804.3 14574.5 15629.4 15671.0 15683.1 15687.4 14216.1 14385.2 14389.5 14389.9 14426.4 690.5 705.8 845.9 857.4 867.5 852.2 871.1 872.0 872.0 872.1 918.1 939.5 939.6 940.2 941.2 932.3 936.1 937.8 939.6 940.6 694.3 699.7 699.7 700.6 700.9 14367.0 14568.3 14737.0 15357.5 15622.4 10364.4 11555.8 12765.1 13996.5 14185.9 8724.0 10444.1 11640.8 11819.7 11978.0 3056.2 3522.6 3573.4 3640.1 3685.4 93668.5 96982.5 103362.0 107196.0 107472.0 8310.0 10450.5 10529.2 10564.5 10636.0 22596.8 23172.5 23178.3 23268.0 23280.0 7733.9 7748.7 7757.3 7785.5 7898.5 3657.6 4184.7 4305.6 4317.2 4423.6 3515.5 3604.6 3620.4 3624.3 3625.5 611.6 611.6 638.7 643.1 644.5 621.8 630.9 666.5 673.1 673.6 7913.4 8707.9 8776.6 9243.4 9398.4 609.7 635.2 664.7 681.8 687.7 3806.6 4373.8 4593.3 4619.3 4689.0 108568.5 110918.1 110988.0 111561.4 112739.0 96116.6 97884.0 98920.5 99242.5 101060.0 84974.2 86304.6 86337.0 86385.7 87932.0 9008.4 9010.7 9018.3 9046.4 9274.0 37103.5 40052.8 45378.9 53509.9 53850.2 60964.4 61235.5 74822.6 76381.2 77746.6 11691.0 11872.8 11909.8 11963.6 11973.4 10831.8 12450.5 12624.5 12804.7 13163.9 10028.9 11806.5 11833.4 12162.1 12568.1 11759.9 12063.0 12124.8 12242.5 12572.9 11949.5 11957.6 12062.8 12302.6 12396.8 8925.4 9890.6 10312.9 10436.0 10456.2 9448.1 10091.5 10130.6 10145.9 10485.3 04:43:42 INFO - PROCESS | 1683 | -------- Summary: end -------- 04:43:42 INFO - PROCESS | 1683 | 04:43:42 INFO - TEST-INFO | 1683: exit 0 04:43:42 INFO - TEST-OK | dromaeo_css | took 1115609ms 04:43:42 INFO - TEST-START | kraken 04:43:42 INFO - operating with platform_type : mac_ 04:43:42 INFO - Initialising browser for kraken test... 04:43:42 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpZ0csRJ/profile http://localhost:49246/getInfo.html) 04:43:45 INFO - PROCESS | 1692 | 2016-12-11 04:43:45.551 plugin-container[1694:14447] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 04:43:45 INFO - PROCESS | 1692 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:45 INFO - PROCESS | 1692 | 2016-12-11 04:43:45.552 plugin-container[1694:14447] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 04:43:45 INFO - PROCESS | 1692 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:45 INFO - PROCESS | 1692 | 2016-12-11 04:43:45.552 plugin-container[1694:14447] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:45 INFO - PROCESS | 1692 | __metrics Screen width/height:1600/1200 04:43:45 INFO - PROCESS | 1692 | colorDepth:24 04:43:45 INFO - PROCESS | 1692 | Browser inner width/height: 1024/689 04:43:45 INFO - PROCESS | 1692 | __metrics 04:43:45 ERROR - PROCESS | 1692 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3212: TypeError: this.tabs is undefined 04:43:46 INFO - TEST-INFO | 1692: exit 0 04:43:46 INFO - Browser initialized. 04:43:46 INFO - Running cycle 1/1 for kraken test... 04:43:46 INFO - TEST-INFO | started process 1695 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpZ0csRJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:48 INFO - PROCESS | 1695 | 2016-12-11 04:43:48.921 plugin-container[1696:14563] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:43:48 INFO - PROCESS | 1695 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:48 INFO - PROCESS | 1695 | 2016-12-11 04:43:48.921 plugin-container[1696:14563] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x481b, name = 'com.apple.CFPasteboardClient' 04:43:48 INFO - PROCESS | 1695 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:43:48 INFO - PROCESS | 1695 | 2016-12-11 04:43:48.922 plugin-container[1696:14563] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:43:58 INFO - PROCESS | 1695 | RSS: Main: 236969984 04:43:58 INFO - PROCESS | 1695 | 04:44:01 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:02 INFO - PROCESS | 1695 | RSS: Main: 249516032 04:44:02 INFO - PROCESS | 1695 | 04:44:05 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 04:44:05 INFO - PROCESS | 1695 | RSS: Main: 257224704 04:44:05 INFO - PROCESS | 1695 | 04:44:09 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 04:44:09 INFO - PROCESS | 1695 | RSS: Main: 259792896 04:44:09 INFO - PROCESS | 1695 | 04:44:11 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 04:44:12 INFO - PROCESS | 1695 | RSS: Main: 262074368 04:44:12 INFO - PROCESS | 1695 | 04:44:14 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:14 INFO - PROCESS | 1695 | RSS: Main: 262377472 04:44:14 INFO - PROCESS | 1695 | 04:44:17 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:18 INFO - PROCESS | 1695 | RSS: Main: 268152832 04:44:18 INFO - PROCESS | 1695 | 04:44:21 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:22 INFO - PROCESS | 1695 | RSS: Main: 267829248 04:44:22 INFO - PROCESS | 1695 | 04:44:25 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 04:44:25 INFO - PROCESS | 1695 | RSS: Main: 267931648 04:44:25 INFO - PROCESS | 1695 | 04:44:27 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:28 INFO - PROCESS | 1695 | RSS: Main: 267026432 04:44:28 INFO - PROCESS | 1695 | 04:44:29 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:30 INFO - PROCESS | 1695 | RSS: Main: 267079680 04:44:30 INFO - PROCESS | 1695 | 04:44:32 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:44:33 INFO - PROCESS | 1695 | RSS: Main: 267108352 04:44:33 INFO - PROCESS | 1695 | 04:44:36 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:44:37 INFO - PROCESS | 1695 | RSS: Main: 267681792 04:44:37 INFO - PROCESS | 1695 | 04:44:40 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:40 INFO - PROCESS | 1695 | RSS: Main: 267739136 04:44:40 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 04:44:42 INFO - PROCESS | 1695 | RSS: Main: 268607488 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | __start_tp_report 04:44:42 INFO - PROCESS | 1695 | _x_x_mozilla_page_load 04:44:42 INFO - PROCESS | 1695 | _x_x_mozilla_page_load_details 04:44:42 INFO - PROCESS | 1695 | |i|pagename|runs| 04:44:42 INFO - PROCESS | 1695 | |0;ai-astar;106;118;118;119;118;139;117;119;118;118 04:44:42 INFO - PROCESS | 1695 | |1;audio-beat-detection;149;129;118;153;114;121;117;128;168;149 04:44:42 INFO - PROCESS | 1695 | |2;audio-dft;195;205;272;260;197;201;198;196;196;192 04:44:42 INFO - PROCESS | 1695 | |3;audio-fft;83;57;58;101;86;85;84;68;71;60 04:44:42 INFO - PROCESS | 1695 | |4;audio-oscillator;91;70;85;72;70;70;84;71;71;81 04:44:42 INFO - PROCESS | 1695 | |5;imaging-gaussian-blur;108;109;116;111;107;125;108;111;109;111 04:44:42 INFO - PROCESS | 1695 | |6;imaging-darkroom;92;139;95;119;156;96;94;125;95;94 04:44:42 INFO - PROCESS | 1695 | |7;imaging-desaturate;91;78;150;153;91;93;100;134;94;100 04:44:42 INFO - PROCESS | 1695 | |8;json-parse-financial;59;57;59;59;60;59;59;61;59;59 04:44:42 INFO - PROCESS | 1695 | |9;json-stringify-tinderbox;74;70;74;85;75;70;70;72;72;72 04:44:42 INFO - PROCESS | 1695 | |10;stanford-crypto-aes;90;93;90;92;88;89;89;90;89;89 04:44:42 INFO - PROCESS | 1695 | |11;stanford-crypto-ccm;147;152;146;161;155;157;164;162;216;170 04:44:42 INFO - PROCESS | 1695 | |12;stanford-crypto-pbkdf2;180;192;177;180;179;183;185;188;240;205 04:44:42 INFO - PROCESS | 1695 | |13;stanford-crypto-sha256-iterative;71;68;67;71;70;78;73;88;70;75 04:44:42 INFO - PROCESS | 1695 | __end_tp_report 04:44:42 INFO - PROCESS | 1695 | __start_cc_report 04:44:42 INFO - PROCESS | 1695 | _x_x_mozilla_cycle_collect,937 04:44:42 INFO - PROCESS | 1695 | __end_cc_report 04:44:42 INFO - PROCESS | 1695 | __startTimestamp1481460282958__endTimestamp 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | ------- Summary: start ------- 04:44:42 INFO - PROCESS | 1695 | Number of tests: 14 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#0] ai-astar Cycles:10 Average:119.00 Median:118.00 stddev:8.01 (6.8%) stddev-sans-first:6.98 04:44:42 INFO - PROCESS | 1695 | Values: 106.0 118.0 118.0 119.0 118.0 139.0 117.0 119.0 118.0 118.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:139.00 stddev:18.67 (13.4%) stddev-sans-first:19.07 04:44:42 INFO - PROCESS | 1695 | Values: 149.0 129.0 118.0 153.0 114.0 121.0 117.0 128.0 168.0 149.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#2] audio-dft Cycles:10 Average:211.20 Median:199.50 stddev:29.23 (14.7%) stddev-sans-first:30.41 04:44:42 INFO - PROCESS | 1695 | Values: 195.0 205.0 272.0 260.0 197.0 201.0 198.0 196.0 196.0 192.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#3] audio-fft Cycles:10 Average:75.30 Median:77.00 stddev:14.70 (19.1%) stddev-sans-first:15.32 04:44:42 INFO - PROCESS | 1695 | Values: 83.0 57.0 58.0 101.0 86.0 85.0 84.0 68.0 71.0 60.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:76.50 stddev:7.93 (10.4%) stddev-sans-first:6.45 04:44:42 INFO - PROCESS | 1695 | Values: 91.0 70.0 85.0 72.0 70.0 70.0 84.0 71.0 71.0 81.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#5] imaging-gaussian-blur Cycles:10 Average:111.50 Median:111.00 stddev:5.38 (4.8%) stddev-sans-first:5.56 04:44:42 INFO - PROCESS | 1695 | Values: 108.0 109.0 116.0 111.0 107.0 125.0 108.0 111.0 109.0 111.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#6] imaging-darkroom Cycles:10 Average:110.50 Median:94.00 stddev:22.96 (24.4%) stddev-sans-first:23.35 04:44:42 INFO - PROCESS | 1695 | Values: 92.0 139.0 95.0 119.0 156.0 96.0 94.0 125.0 95.0 94.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#7] imaging-desaturate Cycles:10 Average:108.40 Median:84.50 stddev:26.85 (31.8%) stddev-sans-first:27.74 04:44:42 INFO - PROCESS | 1695 | Values: 91.0 78.0 150.0 153.0 91.0 93.0 100.0 134.0 94.0 100.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:59.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 04:44:42 INFO - PROCESS | 1695 | Values: 59.0 57.0 59.0 59.0 60.0 59.0 59.0 61.0 59.0 59.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:73.00 stddev:4.45 (6.1%) stddev-sans-first:4.72 04:44:42 INFO - PROCESS | 1695 | Values: 74.0 70.0 74.0 85.0 75.0 70.0 70.0 72.0 72.0 72.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:90.00 stddev:1.52 (1.7%) stddev-sans-first:1.62 04:44:42 INFO - PROCESS | 1695 | Values: 90.0 93.0 90.0 92.0 88.0 89.0 89.0 90.0 89.0 89.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#11] stanford-crypto-ccm Cycles:10 Average:163.00 Median:161.50 stddev:20.08 (12.4%) stddev-sans-first:20.45 04:44:42 INFO - PROCESS | 1695 | Values: 147.0 152.0 146.0 161.0 155.0 157.0 164.0 162.0 216.0 170.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:186.50 stddev:19.12 (10.3%) stddev-sans-first:19.86 04:44:42 INFO - PROCESS | 1695 | Values: 180.0 192.0 177.0 180.0 179.0 183.0 185.0 188.0 240.0 205.0 04:44:42 INFO - PROCESS | 1695 | 04:44:42 INFO - PROCESS | 1695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:72.00 stddev:6.15 (8.5%) stddev-sans-first:6.48 04:44:42 INFO - PROCESS | 1695 | Values: 71.0 68.0 67.0 71.0 70.0 78.0 73.0 88.0 70.0 75.0 04:44:42 INFO - PROCESS | 1695 | -------- Summary: end -------- 04:44:42 INFO - PROCESS | 1695 | 04:44:43 INFO - TEST-INFO | 1695: exit 0 04:44:43 INFO - TEST-OK | kraken | took 61172ms 04:44:43 INFO - SUITE-END | took 1176s 04:44:44 INFO - Completed test suite (00:19:36) 04:44:44 INFO - javascript benchmark 04:44:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7019.019347839844, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3342.3816593930123, 3360.042387919442, 3361.210115622828, 3378.7803792753452, 3381.932361352773, 5488.7530061147245, 5598.300212473441, 5598.63608865424, 5648.26572545569, 5654.208410822488, 5527.2538207342095, 5552.139418390146, 5607.355154157273, 5620.213170156181, 5695.316562012554, 4184.748915065091, 4998.225275082368, 5065.696058236508, 5175.275461435402, 5190.195519694435, 5050.595952323805, 5199.194124910645, 5233.267342572043, 5238.52853243208, 5242.108841496935, 4967.82612608557, 4999.675021123615, 5163.509466600667, 5170.715610641413, 5191.221316802472, 5101.948980510185, 5127.6154288428515, 5133.358330208724, 5144.4083930348115, 5151.278820965068, 5017.799288028475, 5050.4697006814495, 5059.266406371093, 5089.338386009795, 5103.260027296058, 4265.445492086009, 5409.972105300019, 5421.105517589593, 5548.306461692288, 5574.080276754371, 6113.938860611426, 6121.209103132296, 6134.0, 6146.709191069881, 6157.291911430153, 6148.508119350441, 6148.77383110543, 6193.783217587363, 6218.68906554675, 6244.313125556185, 5541.196526503675, 5561.944380556223, 5564.666120032811, 5726.141078838166, 5804.097951024488, 6114.236541168587, 6166.537509686791, 6222.657753823492, 6226.128342032119, 6268.686565671698, 5022.748862556858, 5512.283403157564, 6025.849353766191, 6035.456808887221, 6051.788187413419, 6012.669303188367, 6168.352323006109, 6171.290301615282, 6200.410960958701, 6204.255489341308, 5958.344582095966, 6027.246594175728, 6034.185384972972, 6059.545534084961, 6116.021436570128, 6122.276600501844, 6149.0776383542825, 6154.630722156596, 6159.84600384985, 6169.259688837278, 4785.784639691222, 4843.128236917389, 4856.587190088811, 4872.6589138760655, 4885.487023862514, 4228.894277643083, 4266.5093514246255, 4278.187144442608, 4305.117450922553, 4305.590968858016, 5629.577781666391, 5674.886502269931, 5685.1756495307945, 5698.430156984351, 5743.483086522149, 6130.601510901777, 6135.785247516315, 6144.078388241799, 6156.815295541141, 6160.599561028519, 5536.612437129363, 5566.137248726453, 5599.832005039855, 5622.690752008679, 5673.773049078073, 5261.421243663194, 5291.920621190685, 5295.258663787073, 5296.04671159195, 5312.681239125587, 6162.907556386568, 6182.381761823782, 6196.938030619636, 6207.131001659681, 6231.0, 6133.233345831771, 6174.012158054689, 6175.135481032569, 6195.070739389128, 6204.844878878064, 5247.9737601311745, 6239.251289845248, 6239.812805615838, 6243.7814676486105, 6246.656433896179, 5954.672493012926, 5956.970215148896, 5998.610090344114, 6058.818235452944, 6098.634081955097, 6088.573799833969, 6107.886786452593, 6108.236470441195, 6109.495762817132, 6112.0171844544475, 5921.082232254007, 5954.910676339771, 6017.518598512196, 6023.337432882292, 6041.909371359521, 6022.698865056642, 6029.57792954489, 6034.426729460694, 6054.48536874353, 6070.271567411939, 5668.489835914787, 5678.3186017678145, 5793.94206057934, 5836.533077353716, 5908.202392677105, 5970.194023806731, 6002.429769171922, 6036.517078633611, 6046.758129674764, 6049.637021778707, 5833.970830145822, 5837.562182836219, 5853.414658534112, 5858.2677165354335, 5902.085176797603], "value": 5581.019404195548, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [445.79493433020815, 463.9095376401603, 470.08099166130216, 499.1133515312117, 499.48054023815234, 38751.418728719094, 40816.0, 40878.0, 40886.59113408865, 41121.3831792523, 41951.0, 42424.36363454551, 42514.0, 42634.72095837122, 42724.57275427245, 8304.750857474255, 9228.723138305862, 9448.622055117787, 9455.959844417142, 9484.05159484053, 8352.12302708216, 11014.944925275402, 11258.380789056599, 11265.042471389941, 11456.255343402652, 11318.32090074598, 11369.374684392355, 11370.374629395379, 11391.54433822646, 11406.486708098115, 11065.225434219608, 11091.611793587186, 11109.72225694356, 11125.7218569536, 11138.3873886937, 11051.834222486668, 11117.277376970553, 11127.998480136826, 11164.665060048212, 11167.553297868075, 39399.8030009851, 39746.403803942965, 39749.60250397488, 39785.0, 40106.799466002776, 3298.422776014188, 3329.0012996101073, 3424.143964008998, 3811.2187001664593, 4079.4900637420324, 24307.63538546923, 25098.12156574511, 25493.47039177655, 27150.864245678844, 30877.648940423787, 2658.667666541682, 2695.3396417877548, 2865.398266364066, 3113.9065828025196, 3302.93394132116, 416173.0, 458264.0, 485411.0, 485859.0, 487840.0, 61103.08345374823, 61178.0, 61555.07667384993, 61615.0, 62097.0, 64228.0, 64435.67782161153, 64578.0, 64594.70810583762, 65507.67246163739, 11698.181127321006, 15628.2185890705, 15663.921680391524, 15846.286917088759, 15871.841281587036, 10428.5828566858, 11091.944540277247, 12284.385780710929, 12339.012878969661, 12451.688707782378, 13981.300934953211, 16884.57788555296, 17208.1395930203, 17273.65452690939, 17692.557686057695, 5632.746526406321, 6492.902606460907, 7268.001299642535, 7312.159101703266, 7386.889196662054, 851.4848516647463, 857.3141486810526, 963.1428029054148, 1044.6865940217904, 1055.5250137438184, 27629.723702762716, 28779.42441151207, 28990.985315513855, 29770.10689679313, 29810.25474363115, 1029.6910926721953, 1045.7542477517777, 1102.2945314998408, 1105.9004689577976, 1106.8433487005937, 14276.14410126677, 14794.704105917821, 14876.851231487763, 15157.393704251706, 15279.0, 501261.0, 630436.6956330378, 640574.0, 641457.0, 644534.0, 52716.94566108656, 52834.207486887724, 52949.2057619136, 52965.470345296824, 53024.20463693047, 1313.0, 1343.0732794372047, 1345.9528916487875, 1373.368250604713, 1376.4700590272816, 27511.0, 28511.144665660064, 28742.856285719274, 28849.105370775516, 28974.710252897203, 46190.538094619966, 46389.07221855612, 46432.07135857332, 46459.53540464552, 46490.37283695055, 578687.0, 578741.0, 578776.0, 582336.0, 583891.0, 23728.881355593112, 24576.385590360384, 24860.0, 24874.890638670167, 25008.74991250137, 37370.813145934095, 40901.59098408978, 41164.970875728344, 41332.38001429921, 41757.37363939604, 30224.244393890327, 32277.193070173435, 34870.0, 35046.82476587601, 36088.63911360853, 33421.99734007983, 34600.13499662428, 35126.64873351336, 35515.644843551236, 35599.28801424009, 34551.4817277736, 35151.0, 35207.47188792119, 35212.82393588016, 35434.11414714653, 25942.610860836725, 27730.920180986912, 29910.0, 30028.099157025325, 30207.617625093353, 18385.568061958926, 18639.440816775517, 23616.763832362143, 23793.286201413986, 23810.523789524457], "value": 19258.306227771805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.76306007434346, 364.9142451523891, 374.5617627375969, 386.32393311704516, 403.22983102274645, 18675.252989880406, 19322.51693707658, 19427.90286048568, 19689.409317720474, 19898.303559375425, 19672.704909426335, 19815.801841981574, 20225.190992360323, 20331.288404905794, 20389.592208155864, 5521.116621340586, 5567.4432556744405, 5789.957807594631, 5793.188953546507, 5807.477327040587, 5450.127979523277, 5627.465390787868, 5675.744591493372, 5693.544516438675, 5704.629199102045, 5362.43694412087, 5614.775408983635, 5640.887182256352, 5645.379008309083, 5648.265725455705, 5502.202180683798, 5626.690532020737, 5630.943690563083, 5633.971830140844, 5640.435956404368, 4867.537583929521, 4898.608111351084, 4947.936193718368, 4952.62855285855, 4963.4292056413615, 24885.0, 24953.00187992478, 25022.999080036778, 25035.49929001428, 25238.747612523825, 1882.6046530228668, 2348.97651023491, 2354.7880690737916, 2372.406898275431, 2450.546648869965, 9718.271129665303, 10000.599976001024, 10127.848082278771, 10275.02387273208, 10333.586656533806, 1848.4639454558162, 1865.8880467171878, 1866.1992869804212, 1876.5121068522146, 1894.2896413844808, 91532.0, 117365.0, 120856.0, 122753.99999999911, 124610.37694811559, 11383.487743051583, 11421.600243991586, 11559.364234967157, 11585.131115166396, 11686.474108664961, 14330.21183834899, 14374.137551746928, 14389.640258993399, 14399.568012959628, 14400.711985760227, 7844.803879903048, 8063.032436107705, 8304.792380190544, 8328.208820162075, 8442.57787110642, 8077.83844323122, 8091.0695270043525, 8239.011318641682, 8240.464369815943, 8244.876326855101, 4391.143726973273, 4415.4259946206785, 4452.0873220989615, 4567.725936443824, 4570.862874113782, 1891.5082078659648, 1933.8742981706143, 1935.6128774245208, 1941.805819418075, 1951.3072859135086, 839.9874001889976, 859.7162936231028, 877.6138499060393, 899.0, 931.3945935142211, 15686.607834804221, 17508.5622859427, 17858.91070544639, 20273.290434835006, 20940.47648808792, 765.9961700191575, 875.2166810704384, 880.0891077734514, 896.1397058823602, 934.9808708507759, 8880.555972201364, 10921.962413570698, 11019.559217631366, 11059.778804424028, 11103.44482775858, 243062.0, 295552.0, 430390.0, 562242.0, 573014.1349293226, 92341.53829230946, 93005.0, 98986.0, 116664.41667791607, 124537.0, 761.7676608634309, 804.2118723650855, 921.9216366608913, 940.6707652321769, 944.8535477001076, 18182.90908545449, 18355.0, 18779.624407512045, 18867.716984244973, 18910.810891891455, 35454.0, 50559.241611375124, 50633.49366506288, 51659.48340516547, 57499.0, 69308.3069169322, 76635.0, 78975.0, 79803.80294295706, 81261.18738812536, 5008.524190201925, 5540.944590554042, 7250.20247772734, 7689.769306920802, 8210.425270231266, 11358.375289359165, 12416.565420210249, 12616.053795965523, 12893.548725794928, 12989.350532473527, 11007.779844402907, 11191.048760855418, 11298.0, 11298.322100673986, 11359.148063895076, 10572.36565806054, 10854.620088296871, 11048.171387146156, 11060.391678457761, 11188.160887933274, 8600.870986935326, 9502.334836561651, 10857.619983300547, 11345.602903898654, 11419.31484110956, 6072.757089716361, 7809.375249980101, 8040.83918321642, 8094.51432914027, 8166.142555031636, 9315.441073535609, 10626.681199564026, 11011.559537618405, 11140.88859111431, 11258.7748245033], "value": 9075.76908229126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.3462355381191, 1483.6810085831548, 1660.7793271945118, 1762.541739147821, 1807.322254154692, 7386.224446433128, 7630.4658673892845, 7835.529868207905, 8296.37777166712, 8307.958460207697, 7871.173526779691, 8137.9593102034405, 8162.877556836652, 8245.876311855327, 8249.752507424771, 2262.6266666000092, 2313.4679023824447, 2315.518068436194, 2324.93025209244, 2327.697399338092, 1965.4889728670505, 2321.1411777642297, 2344.2498400511845, 2349.8942547585316, 2357.5167090746354, 2154.353693891826, 2167.5231449081257, 2171.837112216582, 2176.6082105221053, 2228.3315005498366, 2224.8665080095248, 2271.034810205664, 2296.2651951375565, 2298.425393651587, 2309.1225334373, 2294.7819957104048, 2298.4368829636846, 2326.953460930772, 2332.055517515409, 2337.590921588715, 8186.263236308701, 8196.098429172845, 8237.341012718967, 8244.381671374671, 8267.338612910953, 4312.762798046107, 4650.186217411973, 4996.400431948153, 5152.613553983466, 5184.351956005499, 2949.4838403279555, 3239.9352012959607, 3487.633798451177, 3503.877364292263, 3515.0860776198115, 902.5983437370372, 987.4963768478057, 998.0219385002665, 1076.7684947736195, 1077.983830242547, 10113.949430252802, 10300.793984120275, 10404.635837745642, 10553.683389498327, 10596.41719705416, 4211.957880421157, 4254.340577210537, 4410.29435290352, 4423.248047831877, 4438.245498265303, 8374.958125209336, 8477.27943124829, 8479.321654267644, 8489.278411334983, 8498.320134389234, 4978.77595508203, 4987.401511818605, 4997.750112494361, 5006.524380183877, 5010.473900240495, 4234.9576504234565, 4368.432103826546, 4554.24854898938, 4648.302754586839, 4655.627549796076, 3569.7679650822615, 3608.9819550902603, 3650.5984341722387, 3690.9815450922574, 3702.8889133326043, 1030.2427715629008, 1034.849946757716, 1040.3445829127752, 1041.2919214933765, 1042.781015986636, 839.7068514487743, 871.9476831390136, 887.8313120507083, 927.4991504587582, 941.1576638908276, 5351.9464805351445, 5508.485166579223, 5555.749991250404, 5588.497035266845, 5688.146777983336, 415.90226296820225, 417.3468521763431, 422.1893963589915, 432.5047820245801, 438.7849953522751, 3628.854845806191, 3796.335641262768, 3850.2876967760494, 3870.5355357356734, 3931.6658084063174, 8804.119588041145, 9238.983711791698, 9255.074492550826, 9264.861027084598, 9266.67566635178, 8941.821163576693, 8986.730398088068, 9115.270778337717, 9115.954420227856, 9190.954045229731, 7506.962465187748, 7535.585542795089, 7647.694092236359, 7649.082110146818, 7664.271894170045, 4377.715448495965, 5142.714321419645, 5352.250684904038, 5447.863803404946, 5535.667859928417, 8800.559972001247, 8923.776905577153, 9030.277577793891, 9043.140901614335, 9099.727008189764, 9188.678396256098, 9232.98437171924, 9266.907330926873, 9323.72028839136, 9373.953130234306, 6206.441420272197, 6362.268339140873, 6437.67811609427, 6511.902321465087, 6639.03733958583, 7661.578613176329, 7838.412119090977, 7845.372370210255, 7851.528908265523, 7865.252800983897, 6956.2000369958105, 7030.578165310098, 7072.469564782559, 7123.358897699232, 7200.89198662031, 6767.560108592926, 6918.411934985583, 6958.199807022055, 6979.022936788955, 7005.124359455068, 6367.42693157618, 6520.956646936467, 6572.901406478811, 6581.3747693969, 6695.464362851058, 4794.376731024944, 4805.711657300573, 4807.903841923072, 4842.080004799077, 4908.754562271801, 4757.429108507002, 4791.47293797689, 4838.322634831196, 4940.962397896482, 4957.454679985271], "value": 4178.5555699466895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.3110103232695, 353.3621812628207, 367.78668372344043, 367.9668829805318, 371.2574850299403, 5080.949190508094, 5221.373435187783, 5379.623426360156, 5427.18592211168, 5474.233607294982, 4205.348171033487, 4348.739075655455, 5062.544371006617, 5214.69632591852, 5285.577153827694, 4144.792760361977, 4165.792130171014, 4173.64524015459, 4187.9111431027995, 4232.6613870890405, 3525.506429099928, 3769.9632601034796, 4181.91636167278, 4198.706090573661, 4199.307114326132, 3956.960430395688, 3961.3067713150226, 3962.2075584882996, 3984.752426772186, 4008.6592639625665, 3507.2634746703225, 3959.98020009901, 3998.7200895937294, 4001.5398229203724, 4022.658074063708, 3005.0984704588755, 3259.722923551501, 3297.0273769237892, 3452.637473065317, 3455.827208639583, 4214.515330736974, 4730.526947305277, 4828.517148285178, 5152.330197074394, 5190.97404512975, 3660.396034654279, 3785.5835858055593, 4039.899002524931, 4121.475054229954, 4622.0, 5638.605297629168, 5654.984960677883, 5685.857853553653, 5688.63023903445, 5700.8859822803315, 3192.9042128736173, 3565.3760591896576, 3691.53855768029, 3838.193979264358, 3849.8845034648725, 5807.5644326675665, 5809.767609295665, 5842.415758424124, 5851.444112809277, 5856.736446859902, 3120.547520609499, 3430.708389786896, 3829.463875057494, 3851.5955824638568, 3866.9226615467533, 3404.69357757803, 3832.9370866881195, 3851.5692873048865, 3905.4922860028582, 3906.6093390661276, 3530.541029666127, 3562.147683204719, 4490.640748740093, 4498.460184777782, 4515.525869783691, 5614.69119198448, 5616.747246373923, 5631.887362252814, 5688.715564221855, 5719.342275638355, 1036.6734478639205, 1055.266589720137, 1245.4706749631553, 1273.5096987659817, 1284.6146156153118, 844.8268105038452, 855.2815634866741, 858.9871151932726, 861.7371701630938, 880.1462581296132, 4744.644151688637, 5009.44896061433, 5086.618503612244, 5125.923111153335, 5126.948730512721, 4986.501349864984, 5481.671099734029, 5488.8319113950565, 5577.856539409411, 5579.605098725318, 4341.934870976938, 4514.553165132407, 4674.6260299176665, 4680.836170734076, 4796.832110876103, 2406.7111946566524, 2504.94990100197, 2882.5443151208506, 2895.4932886744737, 2936.839948220441, 4663.417072865892, 4779.578889527243, 5637.138560086354, 5674.744636491368, 5750.396208398141, 5192.714400707921, 5323.581427415236, 5396.0, 5644.238027866268, 5672.319321681424, 5223.791048358175, 5580.581456390787, 5729.369769325371, 6079.422454866781, 6149.185990132922, 4925.827596034122, 5691.430856914441, 5877.206577112035, 5918.704064796657, 6026.8794624106395, 4536.979179684545, 5779.393163717918, 5842.357340692435, 5850.736716847667, 5863.648181109147, 4829.806807727651, 5970.41783927251, 6022.638641681513, 6057.18228039209, 6096.719688865388, 3903.2583809076186, 3936.783476908683, 3941.688981255759, 3955.0, 3969.0672691916798, 4732.976335118303, 5429.049916264717, 5725.627834190765, 5816.302043754777, 5881.647101173943, 5368.7047212403695, 5377.220303055957, 5466.890662186814, 5636.605437619492, 5662.943370566406, 5231.921521177262, 5614.52276556481, 5658.830235092953, 5671.461211185096, 5673.113916966891, 4843.612510999182, 5182.253405694988, 5577.9442205577425, 5595.300587426572, 5598.832035038955, 4983.626228032985, 5633.549316054788, 5670.829875103754, 5695.8860822784145, 5722.370539240597, 4649.325847752125, 5510.311211098613, 5532.889342213214, 5608.6073974821375, 5656.745446455002], "value": 4036.8149603841034, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.3446355339993, 708.1431467923812, 726.154030554404, 747.2079595628634, 804.3444592656986, 14574.489892853751, 15629.374825006986, 15671.0, 15683.059016459007, 15687.372505099782, 14216.147031178136, 14385.208813515252, 14389.496367627135, 14389.928050359733, 14426.35081421336, 690.5373399822106, 705.7529864547419, 845.8900342955408, 857.4083882121347, 867.5315329721974, 852.2031900173358, 871.0766587417327, 871.9912800872005, 871.9972032163, 872.0625327772638, 918.1048477734189, 939.5302348825587, 939.5865819039601, 940.1632547033146, 941.2234906202376, 932.2868005975434, 936.063936063936, 937.7702462896634, 939.5959737312953, 940.5673390240497, 694.3369082526175, 699.6781480518916, 699.7096205074888, 700.6181631011111, 700.8528209076101, 14367.0, 14568.344424500923, 14737.0, 15357.46248881295, 15622.375104995786, 10364.429956352398, 11555.768884622345, 12765.071734767165, 13996.510122145777, 14185.929070354685, 8723.956380218122, 10444.11225045872, 11640.825387619108, 11819.704507387383, 11978.041756659533, 3056.205386599478, 3522.577290725104, 3573.3746594345885, 3640.1263696712863, 3685.4103343464917, 93668.53165734195, 96982.51508742411, 103361.99999999924, 107196.0, 107472.0, 8310.0, 10450.477476126316, 10529.157667386591, 10564.524596393181, 10636.0, 22596.774032259465, 23172.536549269258, 23178.3046508605, 23268.0, 23280.0, 7733.90725103745, 7748.651310691032, 7757.26306000929, 7785.5328680278235, 7898.486598371088, 3657.561092668897, 4184.707070505096, 4305.590968857953, 4317.222899877989, 4423.623991960655, 3515.455104458813, 3604.585472670624, 3620.366435873764, 3624.3113808376324, 3625.456181572785, 611.5871786544154, 611.5932904618379, 638.6742761191825, 643.1446176585131, 644.4554351572914, 621.7916997805786, 630.8517498387876, 666.5034549260735, 673.0980486148584, 673.6497021548865, 7913.366930645535, 8707.912920870836, 8776.605052772513, 9243.445393276425, 9398.436093834393, 609.679918043031, 635.2472320300367, 664.7141729056456, 681.7818298144646, 687.7145984416411, 3806.638369354907, 4373.75944323059, 4593.269101768484, 4619.260918253063, 4689.0, 108568.45715771528, 110918.12654987581, 110988.0, 111561.44219278851, 112739.0, 96116.58680702186, 97884.0, 98920.50539747255, 99242.51136232962, 101060.0, 84974.15025849786, 86304.56847715721, 86337.0, 86385.70421443683, 87932.0, 9008.414453060792, 9010.729678109667, 9018.278537716837, 9046.411983221069, 9274.026227246042, 37103.47516985882, 40052.79841604757, 45378.865528362054, 53509.929801404534, 53850.192247117106, 60964.39035609587, 61235.46911327253, 74822.6258868724, 76381.2361876374, 77746.6112669433, 11691.0, 11872.76254474923, 11909.82135267989, 11963.581274655693, 11973.401329933295, 10831.837522437012, 12450.501979921064, 12624.495020199089, 12804.679883003, 13163.934180329037, 10028.899711002796, 11806.547648780668, 11833.398209419967, 12162.148649594443, 12568.120231583702, 11759.941200293944, 12063.0, 12124.848139427093, 12242.510299588273, 12572.874271257171, 11949.522019119138, 11957.58806916719, 12062.819057713965, 12302.630921072383, 12396.81404778947, 8925.419847709878, 9890.604375824887, 10312.896871031193, 10436.0, 10456.215783816397, 9448.102430269113, 10091.495425228855, 10130.645427410005, 10145.898541014496, 10485.318454300446], "value": 7266.584174189461, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1596.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 118.0, 119.0, 118.0, 139.0, 117.0, 119.0, 118.0, 118.0], "value": 119.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 129.0, 118.0, 153.0, 114.0, 121.0, 117.0, 128.0, 168.0, 149.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 205.0, 272.0, 260.0, 197.0, 201.0, 198.0, 196.0, 196.0, 192.0], "value": 211.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 58.0, 101.0, 86.0, 85.0, 84.0, 68.0, 71.0, 60.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 85.0, 72.0, 70.0, 70.0, 84.0, 71.0, 71.0, 81.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 116.0, 111.0, 107.0, 125.0, 108.0, 111.0, 109.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 139.0, 95.0, 119.0, 156.0, 96.0, 94.0, 125.0, 95.0, 94.0], "value": 110.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 78.0, 150.0, 153.0, 91.0, 93.0, 100.0, 134.0, 94.0, 100.0], "value": 108.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 59.0, 59.0, 60.0, 59.0, 59.0, 61.0, 59.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 74.0, 85.0, 75.0, 70.0, 70.0, 72.0, 72.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 90.0, 92.0, 88.0, 89.0, 89.0, 90.0, 89.0, 89.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 152.0, 146.0, 161.0, 155.0, 157.0, 164.0, 162.0, 216.0, 170.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 192.0, 177.0, 180.0, 179.0, 183.0, 185.0, 188.0, 240.0, 205.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 67.0, 71.0, 70.0, 78.0, 73.0, 88.0, 70.0, 75.0], "value": 73.1, "unit": "score"}]}]} 04:44:44 INFO - Return code: 0 04:44:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:44:44 ERROR - # TBPL SUCCESS # 04:44:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:44:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:44:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:44:44 INFO - 2016-12-11 04:44:44.299 screenresolution[1700:14948] starting screenresolution argv=screenresolution get 04:44:44 INFO - 2016-12-11 04:44:44.303 screenresolution[1700:14948] Display 0: 1600x1200x32@60 04:44:44 INFO - 2016-12-11 04:44:44.309 screenresolution[1701:14951] starting screenresolution argv=screenresolution list 04:44:44 INFO - Available Modes on Display 0 04:44:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:44:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:44:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:44:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:44:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:44:44 INFO - Intel Iris: 04:44:44 INFO - Chipset Model: Intel Iris 04:44:44 INFO - Type: GPU 04:44:44 INFO - Bus: Built-In 04:44:44 INFO - VRAM (Dynamic, Max): 1536 MB 04:44:44 INFO - Vendor: Intel (0x8086) 04:44:44 INFO - Device ID: 0x0a2e 04:44:44 INFO - Revision ID: 0x0009 04:44:44 INFO - Displays: 04:44:44 INFO - Display: 04:44:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:44:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:44:44 INFO - Display Serial Number: 1600x1200 60 04:44:44 INFO - Main Display: Yes 04:44:44 INFO - Mirror: Off 04:44:44 INFO - Online: Yes 04:44:44 INFO - Rotation: Supported 04:44:44 INFO - Return code: 0 04:44:44 INFO - Running post-action listener: _resource_record_post_action 04:44:44 INFO - [mozharness: 2016-12-11 12:44:44.553486Z] Finished run-tests step (success) 04:44:44 INFO - Running post-run listener: _resource_record_post_run 04:44:44 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 33607680; Write bytes: 556158976; Read time: 203; Write time: 1721 04:44:44 INFO - TinderboxPrint: CPU usage
54.7% 04:44:44 INFO - TinderboxPrint: I/O read bytes / time
33,607,680 / 203 04:44:44 INFO - TinderboxPrint: I/O write bytes / time
556,158,976 / 1,721 04:44:44 INFO - TinderboxPrint: CPU idle
2,173.7 (45.3%) 04:44:44 INFO - TinderboxPrint: CPU system
971.6 (20.3%) 04:44:44 INFO - TinderboxPrint: CPU user
1,652.4 (34.4%) 04:44:44 INFO - TinderboxPrint: Swap in / out
279,150,592 / 0 04:44:44 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 230738432; Write bytes: 224550400; Read time: 16555; Write time: 490 04:44:44 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 32669696; Write bytes: 304427520; Read time: 189; Write time: 1167 04:44:45 INFO - Running post-run listener: _upload_blobber_files 04:44:45 INFO - Blob upload gear active. 04:44:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:44:45 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'] 04:44:45 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 04:44:45 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:44:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:44:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:46 INFO - (blobuploader) - INFO - Done attempting. 04:44:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:44:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:44:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:48 INFO - (blobuploader) - INFO - Done attempting. 04:44:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:44:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:44:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:50 INFO - (blobuploader) - INFO - Done attempting. 04:44:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:50 INFO - Return code: 0 04:44:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc904906c2b6b5fa435bb59ef7ae5c4ce2d098cc150fe315d3cbfeb8fef273087d1227002782c7ed4923d9f73dd5e1fc1a2e1b9c5792b9ba79f38c6e963d2d42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/859490d76ad7498dd0d016acd2d65d7bb62c484eec9bb3e96d3935c223c31c3061eb4c9fca5897fa580c849a89430ab4fdc4de0c5dfc504c057a03a301d1e6e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9118b2fadd421c3b080526c2654300468c0409f9607ba6c3192e5e1e58f043d4b0384c8abc33a0c90834a90aa7a657d196258bda4451299df6fad5300b81d59a"} 04:44:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:50 INFO - Contents: 04:44:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc904906c2b6b5fa435bb59ef7ae5c4ce2d098cc150fe315d3cbfeb8fef273087d1227002782c7ed4923d9f73dd5e1fc1a2e1b9c5792b9ba79f38c6e963d2d42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/859490d76ad7498dd0d016acd2d65d7bb62c484eec9bb3e96d3935c223c31c3061eb4c9fca5897fa580c849a89430ab4fdc4de0c5dfc504c057a03a301d1e6e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9118b2fadd421c3b080526c2654300468c0409f9607ba6c3192e5e1e58f043d4b0384c8abc33a0c90834a90aa7a657d196258bda4451299df6fad5300b81d59a"} 04:44:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:50 INFO - Copying logs to upload dir... 04:44:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.976497 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-12-11 04:44:51.024823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 04:44:51.028995) ========= 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.tEWtvH91pI/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.nuziKcIOrS/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc904906c2b6b5fa435bb59ef7ae5c4ce2d098cc150fe315d3cbfeb8fef273087d1227002782c7ed4923d9f73dd5e1fc1a2e1b9c5792b9ba79f38c6e963d2d42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/859490d76ad7498dd0d016acd2d65d7bb62c484eec9bb3e96d3935c223c31c3061eb4c9fca5897fa580c849a89430ab4fdc4de0c5dfc504c057a03a301d1e6e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9118b2fadd421c3b080526c2654300468c0409f9607ba6c3192e5e1e58f043d4b0384c8abc33a0c90834a90aa7a657d196258bda4451299df6fad5300b81d59a"} build_url:https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg program finished with exit code 0 elapsedTime=0.011043 build_url: 'https://queue.taskcluster.net/v1/task/DfXmikvaSRG3x-DTcknw3g/artifacts/public/build/firefox-53.0a1.en-US.mac64.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc904906c2b6b5fa435bb59ef7ae5c4ce2d098cc150fe315d3cbfeb8fef273087d1227002782c7ed4923d9f73dd5e1fc1a2e1b9c5792b9ba79f38c6e963d2d42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/859490d76ad7498dd0d016acd2d65d7bb62c484eec9bb3e96d3935c223c31c3061eb4c9fca5897fa580c849a89430ab4fdc4de0c5dfc504c057a03a301d1e6e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9118b2fadd421c3b080526c2654300468c0409f9607ba6c3192e5e1e58f043d4b0384c8abc33a0c90834a90aa7a657d196258bda4451299df6fad5300b81d59a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-11 04:44:51.063766) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 04:44:51.064114) ========= 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.tEWtvH91pI/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.nuziKcIOrS/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.004878 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-11 04:44:51.112507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 04:44:51.112850) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-11 04:44:51.113214) ========= ========= Total master_lag: 0.18 =========