builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0369 starttime: 1490745465.86 results: success (0) buildid: 20170328155922 builduid: 4f20ba1a41774f4ebde581c6daeb92f6 revision: 721dbed1c54d846c371b274f81543841af374d7d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:45.856346) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:45.856760) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:45.857074) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:45.884515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:45.885018) ========= 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.frd5cVByBV/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.t8EZv1gSNv/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-28 16:57:45-- 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% 18.7M=0.001s 2017-03-28 16:57:45 (18.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123226 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:46.034893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:46.035471) ========= 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.frd5cVByBV/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.t8EZv1gSNv/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.036008 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:46.093724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 16:57:46.094128) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 721dbed1c54d846c371b274f81543841af374d7d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 721dbed1c54d846c371b274f81543841af374d7d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.frd5cVByBV/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.t8EZv1gSNv/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-28 16:57:46,144 truncating revision to first 12 chars 2017-03-28 16:57:46,144 Setting DEBUG logging. 2017-03-28 16:57:46,144 attempt 1/10 2017-03-28 16:57:46,144 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/721dbed1c54d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-28 16:57:47,331 unpacking tar archive at: mozilla-beta-721dbed1c54d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.450197 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-28 16:57:47.569509) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:47.570031) ========= script_repo_revision: 721dbed1c54d846c371b274f81543841af374d7d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:47.570660) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:47.571134) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-28 16:57:47.589678) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-28 16:57:47.590253) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.frd5cVByBV/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.t8EZv1gSNv/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:57:47 INFO - MultiFileLogger online at 20170328 16:57:47 in /builds/slave/test 16:57:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:57:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:57:47 INFO - {'append_to_log': False, 16:57:47 INFO - 'base_work_dir': '/builds/slave/test', 16:57:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:57:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:57:47 INFO - 'branch': 'Mozilla-Beta', 16:57:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:57:47 INFO - 'config_files': ('talos/mac_config.py',), 16:57:47 INFO - 'default_actions': ('clobber', 16:57:47 INFO - 'read-buildbot-config', 16:57:47 INFO - 'download-and-extract', 16:57:47 INFO - 'populate-webroot', 16:57:47 INFO - 'create-virtualenv', 16:57:47 INFO - 'install', 16:57:47 INFO - 'run-tests'), 16:57:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:57:47 INFO - 'download_minidump_stackwalk': True, 16:57:47 INFO - 'download_symbols': 'ondemand', 16:57:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:57:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:57:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:57:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:57:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:57:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:57:47 INFO - 'installer_path': 'installer.exe', 16:57:47 INFO - 'log_level': 'info', 16:57:47 INFO - 'log_name': 'talos', 16:57:47 INFO - 'log_to_console': True, 16:57:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:57:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:57:47 INFO - 'opt_config_files': (), 16:57:47 INFO - 'pip_index': False, 16:57:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:57:47 INFO - 'cmd': ('bash', 16:57:47 INFO - '-c', 16:57:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:57:47 INFO - 'enabled': True, 16:57:47 INFO - 'halt_on_failure': False, 16:57:47 INFO - 'name': 'check_screen_resolution'},), 16:57:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:57:47 INFO - 'cmd': ('bash', 16:57:47 INFO - '-c', 16:57:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:57:47 INFO - 'enabled': True, 16:57:47 INFO - 'halt_on_failure': False, 16:57:47 INFO - 'name': 'check_screen_resolution'},), 16:57:47 INFO - 'run_cmd_checks_enabled': True, 16:57:47 INFO - 'sps_profile': False, 16:57:47 INFO - 'sps_profile_interval': 0, 16:57:47 INFO - 'suite': 'dromaeojs', 16:57:47 INFO - 'system_bits': '32', 16:57:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:57:47 INFO - 'title': 't-yosemite-r7-0369', 16:57:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:57:47 INFO - 'use_talos_json': True, 16:57:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:57:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:57:47 INFO - 'work_dir': 'build'} 16:57:47 INFO - [mozharness: 2017-03-28 23:57:47.748070Z] Running clobber step. 16:57:47 INFO - Running pre-action listener: _resource_record_pre_action 16:57:47 INFO - Running main action method: clobber 16:57:47 INFO - rmtree: /builds/slave/test/build 16:57:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:57:50 INFO - Running post-action listener: _resource_record_post_action 16:57:50 INFO - [mozharness: 2017-03-28 23:57:50.118873Z] Finished clobber step (success) 16:57:50 INFO - [mozharness: 2017-03-28 23:57:50.119057Z] Running read-buildbot-config step. 16:57:50 INFO - Running pre-action listener: _resource_record_pre_action 16:57:50 INFO - Running main action method: read_buildbot_config 16:57:50 INFO - Using buildbot properties: 16:57:50 INFO - { 16:57:50 INFO - "project": "", 16:57:50 INFO - "product": "firefox", 16:57:50 INFO - "script_repo_revision": "production", 16:57:50 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 16:57:50 INFO - "repository": "", 16:57:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 16:57:50 INFO - "buildid": "20170328155922", 16:57:50 INFO - "pgo_build": "False", 16:57:50 INFO - "basedir": "/builds/slave/test", 16:57:50 INFO - "buildnumber": 62, 16:57:50 INFO - "slavename": "t-yosemite-r7-0369", 16:57:50 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:57:50 INFO - "platform": "yosemite_r7", 16:57:50 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:57:50 INFO - "branch": "mozilla-beta", 16:57:50 INFO - "repo_path": "releases/mozilla-beta", 16:57:50 INFO - "revision": "721dbed1c54d846c371b274f81543841af374d7d", 16:57:50 INFO - "stage_platform": "macosx64", 16:57:50 INFO - "builduid": "4f20ba1a41774f4ebde581c6daeb92f6", 16:57:50 INFO - "slavebuilddir": "test" 16:57:50 INFO - } 16:57:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 16:57:50 INFO - Running post-action listener: _resource_record_post_action 16:57:50 INFO - [mozharness: 2017-03-28 23:57:50.122374Z] Finished read-buildbot-config step (success) 16:57:50 INFO - [mozharness: 2017-03-28 23:57:50.122504Z] Running download-and-extract step. 16:57:50 INFO - Running pre-action listener: _resource_record_pre_action 16:57:50 INFO - Running main action method: download_and_extract 16:57:50 INFO - mkdir: /builds/slave/test/build/tests 16:57:50 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')]} 16:57:50 INFO - trying https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 16:57:50 INFO - Downloading https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:57:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 16:57:51 INFO - Downloaded 1165 bytes. 16:57:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 16:57:51 INFO - Using the following test package requirements: 16:57:51 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:57:51 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:57:51 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 16:57:51 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:57:51 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 16:57:51 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:57:51 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:57:51 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 16:57:51 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 16:57:51 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:57:51 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 16:57:51 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:57:51 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 16:57:51 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:57:51 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 16:57:51 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 16:57:51 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 16:57:51 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 16:57:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:57:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:57:51 INFO - Fetch https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:57:52 INFO - Expected file size: 16108765 16:57:52 INFO - Obtained file size: 16108765 16:57:58 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 16:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 16:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 16:57:59 INFO - Expected file size: 16108765 16:57:59 INFO - Obtained file size: 16108765 16:58:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 16:58:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 16:58:05 INFO - Fetch https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 16:58:09 INFO - Expected file size: 14403663 16:58:09 INFO - Obtained file size: 14403663 16:58: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')]} 16:58:09 INFO - trying https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:58:09 INFO - Downloading https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 16:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 16:58:11 INFO - Downloaded 58678146 bytes. 16:58:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:58:11 INFO - mkdir: /builds/slave/test/properties 16:58:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:58:11 INFO - Writing to file /builds/slave/test/properties/build_url 16:58:11 INFO - Contents: 16:58:11 INFO - build_url:https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg 16:58:11 INFO - Running post-action listener: _resource_record_post_action 16:58:11 INFO - Running post-action listener: set_extra_try_arguments 16:58:11 INFO - [mozharness: 2017-03-28 23:58:11.867951Z] Finished download-and-extract step (success) 16:58:11 INFO - [mozharness: 2017-03-28 23:58:11.868089Z] Running populate-webroot step. 16:58:11 INFO - Running pre-action listener: _resource_record_pre_action 16:58:11 INFO - Running main action method: populate_webroot 16:58:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:58:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:58:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:58:11 INFO - '--tppagecycles', 16:58:11 INFO - '7'], 16:58:11 INFO - 'tests': ['tsvgm']}}, 16:58:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:58:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:58:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:58:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:58:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:58:11 INFO - 'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:58:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:58:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:58:11 INFO - 'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['damp', 'tps']}, 16:58:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:58:11 INFO - 'tests': ['damp', 'tps']}, 16:58:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['dromaeo_dom']}, 16:58:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:58:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['basic_compositor_video']}, 16:58:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:58:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['a11yr', 16:58:11 INFO - 'ts_paint', 16:58:11 INFO - 'tpaint', 16:58:11 INFO - 'sessionrestore', 16:58:11 INFO - 'sessionrestore_no_auto_restore', 16:58:11 INFO - 'tabpaint']}, 16:58:11 INFO - 'other-e10s': {'tests': ['a11yr', 16:58:11 INFO - 'ts_paint', 16:58:11 INFO - 'tpaint', 16:58:11 INFO - 'sessionrestore', 16:58:11 INFO - 'sessionrestore_no_auto_restore', 16:58:11 INFO - 'tabpaint']}, 16:58:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:58:11 INFO - 'ts_paint', 16:58:11 INFO - 'tpaint', 16:58:11 INFO - 'sessionrestore', 16:58:11 INFO - 'sessionrestore_no_auto_restore', 16:58:11 INFO - 'tabpaint']}, 16:58:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:58:11 INFO - 'ts_paint', 16:58:11 INFO - 'tpaint', 16:58:11 INFO - 'sessionrestore', 16:58:11 INFO - 'sessionrestore_no_auto_restore', 16:58:11 INFO - 'tabpaint']}, 16:58:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['a11yr', 16:58:11 INFO - 'ts_paint', 16:58:11 INFO - 'tpaint', 16:58:11 INFO - 'sessionrestore', 16:58:11 INFO - 'sessionrestore_no_auto_restore', 16:58:11 INFO - 'tabpaint']}, 16:58:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['a11yr', 16:58:11 INFO - 'ts_paint', 16:58:11 INFO - 'tpaint', 16:58:11 INFO - 'sessionrestore', 16:58:11 INFO - 'sessionrestore_no_auto_restore', 16:58:11 INFO - 'tabpaint']}, 16:58:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['tsvgx', 16:58:11 INFO - 'tsvgr_opacity', 16:58:11 INFO - 'tart', 16:58:11 INFO - 'tscrollx', 16:58:11 INFO - 'cart', 16:58:11 INFO - 'tsvg_static']}, 16:58:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:58:11 INFO - 'tsvgr_opacity', 16:58:11 INFO - 'tart', 16:58:11 INFO - 'tscrollx', 16:58:11 INFO - 'cart', 16:58:11 INFO - 'tsvg_static']}, 16:58:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:58:11 INFO - 'talos_options': ['--disable-e10s'], 16:58:11 INFO - 'tests': ['tp5o']}, 16:58:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:58:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:58:11 INFO - 'talos_options': ['--disable-e10s', 16:58:11 INFO - '--xperf_path', 16:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:11 INFO - 'tests': ['tp5n']}, 16:58:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:58:11 INFO - 'talos_options': ['--xperf_path', 16:58:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:58:11 INFO - 'tests': ['tp5n']}}, 16:58:11 INFO - 'talos.zip': {'path': '', 16:58:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:58:11 INFO - Running post-action listener: _resource_record_post_action 16:58:11 INFO - [mozharness: 2017-03-28 23:58:11.887375Z] Finished populate-webroot step (success) 16:58:11 INFO - [mozharness: 2017-03-28 23:58:11.887461Z] Running create-virtualenv step. 16:58:11 INFO - Running pre-action listener: _resource_record_pre_action 16:58:11 INFO - Running main action method: create_virtualenv 16:58:11 INFO - Creating virtualenv /builds/slave/test/build/venv 16:58:11 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 16:58:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:58:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:58:12 INFO - Using real prefix '/tools/python27' 16:58:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:58:12 INFO - Installing distribute.............................................................................................................................................................................................done. 16:58:15 INFO - Installing pip.................done. 16:58:15 INFO - Return code: 0 16:58:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:58:15 INFO - Reading from file tmpfile_stdout 16:58:15 INFO - Output received: 16:58:15 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) 16:58:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:15 INFO - 'HOME': '/Users/cltbld', 16:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:15 INFO - 'LOGNAME': 'cltbld', 16:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:15 INFO - 'MOZ_NO_REMOTE': '1', 16:58:15 INFO - 'NO_EM_RESTART': '1', 16:58:15 INFO - 'PAGER': '/bin/cat', 16:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:15 INFO - 'PWD': '/builds/slave/test', 16:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:15 INFO - 'SHELL': '/bin/bash', 16:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:15 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:15 INFO - 'USER': 'cltbld', 16:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:15 INFO - 'XPC_FLAGS': '0x0', 16:58:15 INFO - 'XPC_SERVICE_NAME': '0', 16:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58: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 16:58:16 INFO - Cleaning up... 16:58:16 INFO - Return code: 0 16:58:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58: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 16:58: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 16:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:16 INFO - 'HOME': '/Users/cltbld', 16:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:16 INFO - 'LOGNAME': 'cltbld', 16:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:16 INFO - 'MOZ_NO_REMOTE': '1', 16:58:16 INFO - 'NO_EM_RESTART': '1', 16:58:16 INFO - 'PAGER': '/bin/cat', 16:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:16 INFO - 'PWD': '/builds/slave/test', 16:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:16 INFO - 'SHELL': '/bin/bash', 16:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:16 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:16 INFO - 'USER': 'cltbld', 16:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:16 INFO - 'XPC_FLAGS': '0x0', 16:58:16 INFO - 'XPC_SERVICE_NAME': '0', 16:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:16 INFO - Downloading/unpacking psutil>=3.1.1 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:58:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:19 INFO - Installing collected packages: psutil 16:58:19 INFO - Running setup.py install for psutil 16:58:20 INFO - building 'psutil._psutil_osx' extension 16:58:20 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 16:58:20 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 16:58:20 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 16:58:20 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 16:58:20 INFO - building 'psutil._psutil_posix' extension 16:58:20 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 16:58:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:58:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:58:20 INFO - ^ 16:58:20 INFO - 1 warning generated. 16:58:20 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 16:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:58:21 INFO - Successfully installed psutil 16:58:21 INFO - Cleaning up... 16:58:21 INFO - Return code: 0 16:58:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:21 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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58:21 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 16:58:21 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 16:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:21 INFO - 'HOME': '/Users/cltbld', 16:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:21 INFO - 'LOGNAME': 'cltbld', 16:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:21 INFO - 'MOZ_NO_REMOTE': '1', 16:58:21 INFO - 'NO_EM_RESTART': '1', 16:58:21 INFO - 'PAGER': '/bin/cat', 16:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:21 INFO - 'PWD': '/builds/slave/test', 16:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:21 INFO - 'SHELL': '/bin/bash', 16:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:21 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:21 INFO - 'USER': 'cltbld', 16:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:21 INFO - 'XPC_FLAGS': '0x0', 16:58:21 INFO - 'XPC_SERVICE_NAME': '0', 16:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:58:21 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 16:58:21 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 16:58:21 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 16:58:21 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 16:58:21 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 16:58:21 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 16:58:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:58:24 INFO - Installing collected packages: mozsystemmonitor 16:58:24 INFO - Running setup.py install for mozsystemmonitor 16:58:24 INFO - Successfully installed mozsystemmonitor 16:58:24 INFO - Cleaning up... 16:58:24 INFO - Return code: 0 16:58:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:58:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:24 INFO - 'HOME': '/Users/cltbld', 16:58:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:24 INFO - 'LOGNAME': 'cltbld', 16:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:24 INFO - 'MOZ_NO_REMOTE': '1', 16:58:24 INFO - 'NO_EM_RESTART': '1', 16:58:24 INFO - 'PAGER': '/bin/cat', 16:58:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:24 INFO - 'PWD': '/builds/slave/test', 16:58:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:24 INFO - 'SHELL': '/bin/bash', 16:58:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:24 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:24 INFO - 'USER': 'cltbld', 16:58:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:24 INFO - 'XPC_FLAGS': '0x0', 16:58:24 INFO - 'XPC_SERVICE_NAME': '0', 16:58:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:24 INFO - Downloading/unpacking jsonschema==2.5.1 16:58:24 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 16:58:24 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 16:58:24 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 16:58:24 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 16:58:24 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 16:58:24 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 16:58:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:58:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:58:27 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 16:58:27 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 16:58:27 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 16:58:27 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 16:58:27 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 16:58:27 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 16:58:27 INFO - Downloading functools32-3.2.3-2.tar.gz 16:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:58:27 INFO - warning: no files found matching '*.txt' 16:58:27 INFO - no previously-included directories found matching 'build' 16:58:27 INFO - no previously-included directories found matching 'dist' 16:58:27 INFO - no previously-included directories found matching '.git*' 16:58:27 INFO - Installing collected packages: jsonschema, functools32 16:58:27 INFO - Running setup.py install for functools32 16:58:27 INFO - warning: no files found matching '*.txt' 16:58:27 INFO - no previously-included directories found matching 'build' 16:58:27 INFO - no previously-included directories found matching 'dist' 16:58:27 INFO - no previously-included directories found matching '.git*' 16:58:27 INFO - Successfully installed jsonschema functools32 16:58:27 INFO - Cleaning up... 16:58:27 INFO - Return code: 0 16:58:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:58:27 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')]} 16:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:27 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')]} 16:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:27 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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58:27 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 16:58:27 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 16:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:27 INFO - 'HOME': '/Users/cltbld', 16:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:27 INFO - 'LOGNAME': 'cltbld', 16:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:27 INFO - 'MOZ_NO_REMOTE': '1', 16:58:27 INFO - 'NO_EM_RESTART': '1', 16:58:27 INFO - 'PAGER': '/bin/cat', 16:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:27 INFO - 'PWD': '/builds/slave/test', 16:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:27 INFO - 'SHELL': '/bin/bash', 16:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:27 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:27 INFO - 'USER': 'cltbld', 16:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:27 INFO - 'XPC_FLAGS': '0x0', 16:58:27 INFO - 'XPC_SERVICE_NAME': '0', 16:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:58:28 INFO - Cleaning up... 16:58:28 INFO - Return code: 0 16:58:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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', '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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:58: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 blobuploader==1.2.4 16:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:28 INFO - 'HOME': '/Users/cltbld', 16:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:28 INFO - 'LOGNAME': 'cltbld', 16:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:28 INFO - 'MOZ_NO_REMOTE': '1', 16:58:28 INFO - 'NO_EM_RESTART': '1', 16:58:28 INFO - 'PAGER': '/bin/cat', 16:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:28 INFO - 'PWD': '/builds/slave/test', 16:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:28 INFO - 'SHELL': '/bin/bash', 16:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:28 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:28 INFO - 'USER': 'cltbld', 16:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:28 INFO - 'XPC_FLAGS': '0x0', 16:58:28 INFO - 'XPC_SERVICE_NAME': '0', 16:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:28 INFO - Downloading/unpacking blobuploader==1.2.4 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:58:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:31 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 16:58:32 INFO - Downloading docopt-0.6.1.tar.gz 16:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:32 INFO - Running setup.py install for blobuploader 16:58:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:32 INFO - Running setup.py install for requests 16:58:32 INFO - Running setup.py install for docopt 16:58:33 INFO - Successfully installed blobuploader requests docopt 16:58:33 INFO - Cleaning up... 16:58:33 INFO - Return code: 0 16:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:33 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')]} 16:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:33 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')]} 16:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:33 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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58:33 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 16:58:33 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 16:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:33 INFO - 'HOME': '/Users/cltbld', 16:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:33 INFO - 'LOGNAME': 'cltbld', 16:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:33 INFO - 'MOZ_NO_REMOTE': '1', 16:58:33 INFO - 'NO_EM_RESTART': '1', 16:58:33 INFO - 'PAGER': '/bin/cat', 16:58:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:33 INFO - 'PWD': '/builds/slave/test', 16:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:33 INFO - 'SHELL': '/bin/bash', 16:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:33 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:33 INFO - 'USER': 'cltbld', 16:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:33 INFO - 'XPC_FLAGS': '0x0', 16:58:33 INFO - 'XPC_SERVICE_NAME': '0', 16:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:33 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-HCuOZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:33 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-LX7q3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:33 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-e4dYoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:33 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-ttMoWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:33 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-8hWyfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:33 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-z0zsvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-1FvQnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-uqI42p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-q_MnR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-LhW4ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-NbIFYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-oNL9g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-HQCt85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-bSLoz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-RCwdCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:34 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-DV9gas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:35 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-GUsTJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:35 INFO - Running setup.py install for manifestparser 16:58:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:35 INFO - Running setup.py install for mozcrash 16:58:35 INFO - Running setup.py install for mozdebug 16:58:35 INFO - Running setup.py install for mozdevice 16:58:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:35 INFO - Running setup.py install for mozfile 16:58:35 INFO - Running setup.py install for mozhttpd 16:58:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for mozinfo 16:58:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for mozInstall 16:58:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for mozleak 16:58:36 INFO - Running setup.py install for mozlog 16:58:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for moznetwork 16:58:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:36 INFO - Running setup.py install for mozprocess 16:58:36 INFO - Running setup.py install for mozprofile 16:58:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for mozrunner 16:58:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Running setup.py install for mozscreenshot 16:58:37 INFO - Running setup.py install for moztest 16:58:37 INFO - Running setup.py install for mozversion 16:58:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:37 INFO - Cleaning up... 16:58:37 INFO - Return code: 0 16:58:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:37 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')]} 16:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 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')]} 16:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:37 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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58:37 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 16:58:37 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 16:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:37 INFO - 'HOME': '/Users/cltbld', 16:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:37 INFO - 'LOGNAME': 'cltbld', 16:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:37 INFO - 'MOZ_NO_REMOTE': '1', 16:58:37 INFO - 'NO_EM_RESTART': '1', 16:58:37 INFO - 'PAGER': '/bin/cat', 16:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:37 INFO - 'PWD': '/builds/slave/test', 16:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:37 INFO - 'SHELL': '/bin/bash', 16:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:37 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:37 INFO - 'USER': 'cltbld', 16:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:37 INFO - 'XPC_FLAGS': '0x0', 16:58:37 INFO - 'XPC_SERVICE_NAME': '0', 16:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-pqZktd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-S6Z0eU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-4xK9An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-wbuV9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-bEailT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Frp5zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-UnyN6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-k1DSpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:38 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-DJaZfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:38 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)) 16:58:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-WfsLeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-pFYmpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-IjkkAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-lCIbjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-eDHz2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-Z4YuRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:39 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)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-U66tkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:58:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:39 INFO - Running setup.py (path:/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/pip-gb40td-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:39 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)) 16:58:39 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)) 16:58:39 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)) 16:58:39 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)) 16:58:39 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)) 16:58:39 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)) 16:58:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:39 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 16:58:39 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 16:58:39 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 16:58:39 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 16:58:39 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 16:58:39 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 16:58:42 INFO - Downloading blessings-1.6.tar.gz 16:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:42 INFO - Installing collected packages: blessings 16:58:42 INFO - Running setup.py install for blessings 16:58:42 INFO - Successfully installed blessings 16:58:42 INFO - Cleaning up... 16:58:42 INFO - Return code: 0 16:58:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:43 INFO - Reading from file tmpfile_stdout 16:58:43 INFO - Current package versions: 16:58:43 INFO - blessings == 1.6 16:58:43 INFO - blobuploader == 1.2.4 16:58:43 INFO - docopt == 0.6.1 16:58:43 INFO - functools32 == 3.2.3-2 16:58:43 INFO - jsonschema == 2.5.1 16:58:43 INFO - manifestparser == 1.1 16:58:43 INFO - mozInstall == 1.12 16:58:43 INFO - mozcrash == 1.0 16:58:43 INFO - mozdebug == 0.1 16:58:43 INFO - mozdevice == 0.49 16:58:43 INFO - mozfile == 1.2 16:58:43 INFO - mozhttpd == 0.7 16:58:43 INFO - mozinfo == 0.9 16:58:43 INFO - mozleak == 0.1 16:58:43 INFO - mozlog == 3.4 16:58:43 INFO - moznetwork == 0.27 16:58:43 INFO - mozprocess == 0.24 16:58:43 INFO - mozprofile == 0.28 16:58:43 INFO - mozrunner == 6.13 16:58:43 INFO - mozscreenshot == 0.1 16:58:43 INFO - mozsystemmonitor == 0.3 16:58:43 INFO - moztest == 0.8 16:58:43 INFO - mozversion == 1.4 16:58:43 INFO - psutil == 3.1.1 16:58:43 INFO - requests == 1.2.3 16:58:43 INFO - wsgiref == 0.1.2 16:58:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58:43 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')]} 16:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:43 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')]} 16:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58:43 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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58:43 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 16:58:43 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 16:58:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:43 INFO - 'HOME': '/Users/cltbld', 16:58:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:43 INFO - 'LOGNAME': 'cltbld', 16:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:43 INFO - 'MOZ_NO_REMOTE': '1', 16:58:43 INFO - 'NO_EM_RESTART': '1', 16:58:43 INFO - 'PAGER': '/bin/cat', 16:58:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:43 INFO - 'PWD': '/builds/slave/test', 16:58:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:43 INFO - 'SHELL': '/bin/bash', 16:58:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:43 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:43 INFO - 'USER': 'cltbld', 16:58:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:43 INFO - 'XPC_FLAGS': '0x0', 16:58:43 INFO - 'XPC_SERVICE_NAME': '0', 16:58:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58:44 INFO - Cleaning up... 16:58:44 INFO - Return code: 0 16:58:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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 0x10ee57b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee5a768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf08d83290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, '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.frd5cVByBV/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.t8EZv1gSNv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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 16:58: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 16:58: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 16:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:44 INFO - 'HOME': '/Users/cltbld', 16:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:44 INFO - 'LOGNAME': 'cltbld', 16:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:44 INFO - 'MOZ_NO_REMOTE': '1', 16:58:44 INFO - 'NO_EM_RESTART': '1', 16:58:44 INFO - 'PAGER': '/bin/cat', 16:58:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:44 INFO - 'PWD': '/builds/slave/test', 16:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:44 INFO - 'SHELL': '/bin/bash', 16:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:58:44 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:44 INFO - 'USER': 'cltbld', 16:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:44 INFO - 'XPC_FLAGS': '0x0', 16:58:44 INFO - 'XPC_SERVICE_NAME': '0', 16:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:44 INFO - Cleaning up... 16:58:44 INFO - Return code: 0 16:58:44 INFO - Running post-action listener: _resource_record_post_action 16:58:44 INFO - Running post-action listener: _start_resource_monitoring 16:58:44 INFO - Starting resource monitoring. 16:58:44 INFO - [mozharness: 2017-03-28 23:58:44.740769Z] Finished create-virtualenv step (success) 16:58:44 INFO - [mozharness: 2017-03-28 23:58:44.741745Z] Running install step. 16:58:44 INFO - Running pre-action listener: _resource_record_pre_action 16:58:44 INFO - Running main action method: install 16:58:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:44 INFO - Reading from file tmpfile_stdout 16:58:45 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:45 INFO - Reading from file tmpfile_stdout 16:58:45 INFO - Output received: 16:58:45 INFO - Usage: mozinstall [options] installer 16:58:45 INFO - Options: 16:58:45 INFO - -h, --help show this help message and exit 16:58:45 INFO - -d DEST, --destination=DEST 16:58:45 INFO - Directory to install application into. [default: 16:58:45 INFO - "/builds/slave/test"] 16:58:45 INFO - --app=APP Application being installed. [default: firefox] 16:58:45 INFO - mkdir: /builds/slave/test/build/application 16:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:58:59 INFO - Reading from file tmpfile_stdout 16:58:59 INFO - Output received: 16:58:59 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:58:59 INFO - Running post-action listener: _resource_record_post_action 16:58:59 INFO - [mozharness: 2017-03-28 23:58:59.717137Z] Finished install step (success) 16:58:59 INFO - [mozharness: 2017-03-28 23:58:59.717300Z] Running run-tests step. 16:58:59 INFO - Running pre-action listener: _resource_record_pre_action 16:58:59 INFO - Running main action method: run_tests 16:58:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:59 INFO - 2017-03-28 16:58:59.732 screenresolution[1625:7243] starting screenresolution argv=screenresolution get 16:58:59 INFO - 2017-03-28 16:58:59.734 screenresolution[1625:7243] Display 0: 1600x1200x32@60 16:58:59 INFO - 2017-03-28 16:58:59.740 screenresolution[1626:7245] starting screenresolution argv=screenresolution list 16:58:59 INFO - Available Modes on Display 0 16:58:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:59 INFO - Intel Iris: 16:58:59 INFO - Chipset Model: Intel Iris 16:58:59 INFO - Type: GPU 16:58:59 INFO - Bus: Built-In 16:58:59 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:59 INFO - Vendor: Intel (0x8086) 16:58:59 INFO - Device ID: 0x0a2e 16:58:59 INFO - Revision ID: 0x0009 16:58:59 INFO - Displays: 16:58:59 INFO - Display: 16:58:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:59 INFO - Display Serial Number: 1600x1200 60 16:58:59 INFO - Main Display: Yes 16:58:59 INFO - Mirror: Off 16:58:59 INFO - Online: Yes 16:58:59 INFO - Rotation: Supported 16:58:59 INFO - Return code: 0 16:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:59 INFO - Python 2.7.3 16:58:59 INFO - Return code: 0 16:58:59 INFO - grabbing minidump binary from tooltool 16:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:58:59 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 0x10ec35d30>, '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 0x10eb5cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ec2abe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:59 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 16:58:59 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 16:58:59 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 16:59:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:59:00 INFO - Return code: 0 16:59:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:59:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:59:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:59:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:59:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0369 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:59:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.frd5cVByBV/Render', 16:59:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:59:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:59:00 INFO - 'HOME': '/Users/cltbld', 16:59:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:59:00 INFO - 'LOGNAME': 'cltbld', 16:59:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:59:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:59:00 INFO - 'MOZ_NO_REMOTE': '1', 16:59:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:59:00 INFO - 'NO_EM_RESTART': '1', 16:59:00 INFO - 'PAGER': '/bin/cat', 16:59:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:59:00 INFO - 'PWD': '/builds/slave/test', 16:59:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:59:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:59:00 INFO - 'SHELL': '/bin/bash', 16:59:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.t8EZv1gSNv/Listeners', 16:59:00 INFO - 'TMPDIR': '/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/', 16:59:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:59:00 INFO - 'USER': 'cltbld', 16:59:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:59:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:59:00 INFO - 'XPC_FLAGS': '0x0', 16:59:00 INFO - 'XPC_SERVICE_NAME': '0', 16:59:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:59:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0369', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:59:00 INFO - mozversion application_buildid: 20170328155922 16:59:00 INFO - mozversion application_changeset: 721dbed1c54d846c371b274f81543841af374d7d 16:59:00 INFO - mozversion application_display_name: Firefox 16:59:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:59:00 INFO - mozversion application_name: Firefox 16:59:00 INFO - mozversion application_remotingname: firefox 16:59:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:59:00 INFO - mozversion application_vendor: Mozilla 16:59:00 INFO - mozversion application_version: 53.0 16:59:00 INFO - mozversion platform_buildid: 20170328155922 16:59:00 INFO - mozversion platform_changeset: 721dbed1c54d846c371b274f81543841af374d7d 16:59:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:59:00 INFO - mozversion platform_version: 53.0 16:59:00 INFO - using testdate: 1490745540 16:59:00 INFO - actual date: 1490745540 16:59:00 INFO - starting webserver on 'localhost:49243' 16:59:00 INFO - SUITE-START | Running 2 tests 16:59:00 INFO - TEST-START | dromaeo_css 16:59:00 INFO - operating with platform_type : mac_ 16:59:00 INFO - Initialising browser for dromaeo_css test... 16:59:00 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpI9P_ix/profile http://localhost:49243/getInfo.html) 16:59:02 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 16:59:02 INFO - PROCESS | 1636 | colorDepth:24 16:59:02 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 16:59:02 INFO - PROCESS | 1636 | __metrics 16:59:02 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:59:02 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:59:03 INFO - TEST-INFO | 1636: exit 0 16:59:03 INFO - Browser initialized. 16:59:03 INFO - Running cycle 1/1 for dromaeo_css test... 16:59:03 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpI9P_ix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:15 INFO - PROCESS | 1639 | RSS: Main: 163282944 16:59:15 INFO - PROCESS | 1639 | 17:02:18 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 17:02:20 INFO - PROCESS | 1639 | RSS: Main: 329756672 17:02:20 INFO - PROCESS | 1639 | 17:05:23 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 17:05:23 INFO - PROCESS | 1639 | RSS: Main: 306536448 17:05:23 INFO - PROCESS | 1639 | 17:08:25 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 17:08:26 INFO - PROCESS | 1639 | RSS: Main: 295845888 17:08:26 INFO - PROCESS | 1639 | 17:11:28 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 17:11:29 INFO - PROCESS | 1639 | RSS: Main: 281141248 17:11:29 INFO - PROCESS | 1639 | 17:14:32 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 17:14:33 INFO - PROCESS | 1639 | RSS: Main: 281853952 17:14:33 INFO - PROCESS | 1639 | 17:17:36 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 17:17:37 INFO - PROCESS | 1639 | RSS: Main: 314724352 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | __start_tp_report 17:17:37 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 17:17:37 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 17:17:37 INFO - PROCESS | 1639 | |i|pagename|runs| 17:17:37 INFO - PROCESS | 1639 | |0;dojo.html;3466.861325546978;3474.704650104741;3494.4758286257043;3502.6322236165192;3529.999999999998;5781.161731548923;5815.941840581593;5857.443542863426;5865.35481097079;5869.32502762182;5813.389594092612;5921.822345329636;5999.400059993998;6002.429769171922;6026.668533230671;5311.73441327934;5339.5461385782255;5377.0321342158395;5446.319210098738;5461.290032295796;4496.370508128848;5154.84016096379;5261.657992230512;5476.890462190754;5489.368722596892;5373.596980226479;5378.731063446831;5382.865428364283;5387.24578559002;5396.757145928423;5373.81191658294;5375.0862353399625;5382.703951282678;5391.676499410048;5394.865128371783;5226.5818734501145;5334.199870019489;5343.171808369709;5344.251804747339;5380.139177731583;5938.168656388109;5945.137954996545;5946.167536544887;5953.761849526014;5957.702114894238;5253.448387919251;6273.654948977804;6301.6219026858535;6314.305426403092;6326.145970293997;6303.306636270053;6311.715972781236;6338.239411270631;6344.587601805914;6383.361663833626;5531.3362396512675;6063.454289114001;6067.878642427127;6073.271207455089;6106.931287024841;6247.125402443661;6271.498280137578;6294.244690637152;6295.874082518324;6472.805815825533;6304.211973503312;6326.810195694136;6334.081558174039;6339.683015849189;6353.428191462791;6325.462335701517;6331.461825744863;6336.58812177207;6339.049142628551;6352.809415717536;6180.103884936659;6282.717277722513;6290.150829638032;6296.874062518816;6298.401651843067;6232.220972378453;6267.811965641038;6276.968615156895;6282.968585157045;6305.873882522324;5115.462876397924;5117.155669314596;5124.795008199705;5126.615503837227;5150.562202212779;4457.509673935864;4545.204589196877;4556.430446194226;4558.49856515783;4572.497025327278;4870.634702397264;5919.911201331984;5939.960506911273;5949.9107513387335;5962.25471816023;6284.12022316876;6320.5575609706875;6324.494040476751;6326.177596912372;6345.460635846005;5896.321922978912;5997.790077347272;6007.249093863267;6012.609180403259;6015.939840601625;5469.234307196995;5481.095619222863;5513.062779327524;5579.69311687861;5626.606137570331;6374.043893415932;6501.349865013461;6515.446187074152;6523.347665233438;6534.575252608565;6331.651759153291;6337.144485494399;6344.555881088279;6345.079963405373;6359.300476947625;6322.778702745381;6397.744090236339;6504.4796416285635;6512.446442052478;6607.867842643216;6235.189425374672;6321.367863213642;6338.366163383625;6344.302126766144;6363.93636063652;6289.49684025286;6321.209848768904;6326.746930122744;6327.55707100517;6351.237851457855;6193.040078787795;6282.465990390868;6294.433500984934;6335.619862808247;6345.492360611048;6197.876042479035;6232.594881332699;6249.125122482765;6279.089532017923;6321.747130114928;5985.880282394415;6205.6586887721605;6218.347073557392;6221.129041934042;6230.7507699691505;6114.236541168587;6307.148534947723;6309.3690630936535;6316;6322.33615470369;6049.153118563317;6082.422169893853;6112.938870611415;6139.416755408229;6144.003198960445 17:17:37 INFO - PROCESS | 1639 | |1;ext.html;498.4068957940053;515.1371452816533;516.8886893179665;522.9764660590274;534.5082524077848;32840.50739238913;42183.15633687328;43699.56300436995;43757.562424375705;46343;45943.54056459435;46329.30506042412;46331;46393.30410043852;46442;9608.567614457348;9818.312718109735;9818.901810981906;9831.459269740162;9848.113669769718;7423.851522969564;9148.679796207134;11739.882601174008;11906.880931190708;11931.522739090426;11756.1182911282;11758.706032349173;11852.407379630984;11899.940500297529;11976.981956533706;11881;11961;11963.342016189106;11966.461509232106;11969.880301197007;11696.415179241088;11772.352520611363;11781.823272650918;11805.586804461802;11843.822342664867;34716;42479.36280955788;42766.786166068974;42929.785351073355;43022.56977430248;3982.2433737589763;4145.357469592218;4151.8546850860075;4162.396452514368;4167.854125105607;30945.535816962765;31796.364072718647;31983.52024719631;32910;33217.83391083053;3340.749443791701;3344.6320904700465;3370.208001119735;3433.9828300858585;3492.4761285807076;362811.1859440712;364330;364682.176589118;364948;365257.34742652497;67975.3202467969;68115.31884681189;68168;68207;68246;73203.53592928112;73254.80235592941;73290;73357.6332118336;73374.2662573378;18162.182701778453;18422;18448.26206951734;18449.354272600664;18455.81544184568;12566.931810796003;13841.723165536834;13889.930550347184;13915.582532523838;13954.86045139556;17247.482575522754;17325.30698772035;17606.735898961524;18020.371094199116;18400.723989140173;7073.82315442118;7093.510362823761;7126.2873712628325;7162.212156662763;7210.963945180345;896.3322324867885;902.8826252587122;910.5993362920294;931.7996630724426;940.7836197674574;31507.21231969219;31904.361912761615;31981.360372792413;32467.558355094097;32977;858.7423772868115;1071.9624813131659;1128.3117298448103;1161.8315344275034;1210.6186551236333;15855.841441585668;16115.758263625821;16178.514644560682;16262.336962487538;16469.34122635105;637807;643495;644477;644775;674315.6284218547;54930.45069549333;55473.72263138658;64887;65750;65938.01092983609;1455.9490417835325;1486.420296084528;1486.799282096903;1498.625343664084;1500.0624609618988;31685.683143169197;33285.66714332825;33341.83329083339;33347.83326083354;34157.65842341644;57352;57844.421555783905;57854.7107264461;57926.420735792104;57995;568083.159584216;569556;569718;571453;586519;26541;27039.86480067587;27127.72872271252;27593.310167245978;44162;45382.54617453915;46013;46299.53700463087;46767.532324677675;47174.29238561356;32222.516662250553;32280.35439291154;32367.838160809046;32710.34579308448;33272.50091248585;32009.83995080103;33166.66833331636;33200.83399582987;33457.82897598572;34121.48817767686;37399.626003740705;37931;38209.80895095507;38292.61707382891;38394.0401489965;31843.522347164348;31916.5212521817;31973.68026319707;32294.35411291808;32600.510992335607;23943.161989330987;25095.372615684755;25213.24360269195;25565.13319124924;25597 17:17:37 INFO - PROCESS | 1639 | |2;jquery.html;372.79309982959455;391.53016380343576;398.1678292368948;404.93723472861706;431.65036320580333;20475.771453712787;21907.233246836364;21997.120115195412;22177.44556386091;22458.663120053214;22264.220752273675;22732.65901011486;23256;23545.29364119075;23601.5279694406;5800.303963524372;6165.352637973016;6169.444749972502;6169.444749972502;6177.629342239457;5858.882822343572;6035.818925432244;6107.908381374283;6141.570090093673;6162.537809664271;6049.909251361233;6071.635701857903;6095.146679464879;6098.298695650013;6098.847528811771;5830.621009634381;5913.319968203668;5968.253968253968;5971.313298970631;5976.551758618078;5228.92156617651;5292.814751483718;5312.123499622597;5320.9467905320835;5342.0651386007685;26525.204243872715;26773.73226267732;26837.865810671017;27028.86485567579;27054.5941810873;2568.9871550642315;2823.294176455886;2839.2617919340914;2839.275984623908;2852.286928267933;10275.48622568876;10627.415492148006;10691;10902.836457453144;10959.671209863716;1824.6350729854082;1872.4008317338457;1875.962480750391;1876.0994722533123;1921.3755529452844;112115.43942280317;123769;126902.09646855305;128138;128646;12027.579034733917;12108.81836772449;12136.817947730791;12139.332336721565;12252.693682657826;16195.919020405057;16228.918855405647;16239.756403653955;16261.430849920196;16280.674386512203;8824.073472285447;9106.49914254709;9127;9256.953715231515;9258.583363748647;7232.385247254042;8881.067487913806;8939.776505587282;9127.497987610745;9127.726168214964;4802.231642937183;4898.632602554822;4922.58158056562;4937.802487900443;4943.728094954812;1727.8790484666204;2028.7159797628344;2074.8962551872346;2078.4803799050237;2079.9688004679942;865.3466632692403;876.2464280718577;892.5314210039782;907.863820426928;926.1248120526038;16315.184240787914;18068.909655451902;22076.33770986873;22486.550268994855;22640;829.1087081387533;833.8957630296213;926.1525703980917;941.3645789092335;942.1755963531909;10968.012878840942;11160.665180044612;11552.6534203974;11572.363520006313;11575.073994080454;721809;741606;744513;786340;788003;151626;156715;159626;160606;161169.1941540285;1017.8524114003428;1017.8574999500075;1018.7911478146962;1020.5815615597569;1046.9895301047045;15602.687946241238;17680.55798605045;18851.717224241373;19450.51981903711;19606.509837253612;60129.69935150296;60492;60941.47646308878;61530.38469615247;61654.76690466255;86724.69912951185;87752.56123719341;89521.55239223762;91165.33929276708;91259;8479.491230526188;8544.957275213585;8685.39202255836;8759.255463285437;8777.385583009383;11849.407529623657;13036.608901732963;13059.673508162372;13320;13350.465981360638;11631.243969141979;11636.476358563716;11637.53449861996;11839.348835814113;11981.64055078349;9816.312858099864;9867.950660246654;10672.413017284123;10753.193510486588;11227.101831853268;11743.706407339885;11760.176787624785;11896.988755955494;12079.973202277904;12157.392130393622;7183.640817958976;8446.324294056338;8545.658173672984;8608.225259726654;8753.343499237455;8648.913510865063;11428.828567571327;11780.823287650863;11982.281063136239;11982.820257696316 17:17:37 INFO - PROCESS | 1639 | |3;mootools.html;1396.7346204221192;1477.1063506578519;1501.391936265812;1515.2423788105948;1523.5962469945466;7679.385649148068;8033.79915502112;8385.790355241114;8591.828163436727;8611.26804221642;8445.282151017156;8536.14638536146;8540.48757074576;8545.230929216385;8555.058943516207;2357.77601127893;2396.293093537402;2401.8438801477846;2403.6034054381007;2405.651180578815;1869.8878067316004;2122.596706625744;2187.562487502506;2414.625733011386;2429.9028038878423;2371.3241726108063;2372.8457650252676;2374.121575017246;2374.192774456684;2379.393254720044;2318;2356.4108972756812;2356.622940329556;2358.433975845802;2358.516504116652;2343.6367363058584;2371.0871314544024;2410.180538616861;2414.97585024151;2417.286900364379;8523.06246312905;8524.275436587897;8606.010308814504;8616.181462761027;8654.870176947288;5202.3497062867145;5351.464853514617;5362.731863406814;5365.195220716884;5369.758360873731;3450.810205438725;3619.7466177367596;3695.260947810422;3698.6671199592165;3705.7961812100325;1221.7861874172074;1244.9439775210137;1255.8681338459512;1306.5165888621175;1313.4220942785144;10883.292585981886;11008.559657613767;11015.953484418967;11027.61403350879;11055.613053543088;4019.959800402017;4544.500104988449;4771.9522804772205;4856.708597484162;4875.43932447773;9682.951585242028;9684.32209745311;9687.903120968842;9695.175910047725;9700.805983880284;4556.658250631216;5432.6468779529205;5446.591505637093;5460.262864513319;5465.699386533779;4528.50186479487;4791.137595232892;4900.191468407744;4994.350734404504;5008.549230569193;3677.632236776301;3745.2883952049024;3759.981200093982;3769.6041915599017;3771.830267637963;1033.503918119307;1052.85786418834;1178.6581891251442;1181.5923506390454;1186.1696812231473;896.2247655777705;930.1070971866948;946.8958414574391;952.9857052144223;1006.4263369879098;5390.622656414013;5634.605577609528;5648.209250704905;5835.153902684087;6017.428344307284;988.2291812386206;1003.6487229469773;1004.9296549241483;1032.607609108534;1050.7425680708122;3741.644543768338;3781.9432708509394;3846.653801157909;3911.6088391160656;3917.216556688674;9970.900290997142;10145.28982971185;10216;10219.540120694586;10223.079922806834;10195.898041019494;10207.948960255151;10208.948955255177;10213.846792298122;10225.488725563691;6646.4350530205475;7964.243396877403;8007.439479236397;8133.430659853753;8150.633221505046;4819;4992.475790042138;5723.427657234243;5973.074173503114;5974.312954010171;8978.640854365753;8998.82002359936;9325;9348.719538413858;9457.574409151743;9327.486988215713;9425.57584908667;9488.240940724863;9563.760905977128;9617.2306215504;7881;8085.514869107872;8178.67285308581;8207.466514676527;8213.178682131738;7685.807854803675;7985.161558036322;8072.717454889051;8140.715074972348;8151.1441298662785;6536.640484773383;6592.143021407186;7061.576305421691;7075.080239569029;7077.929220707933;6922.307769223037;6990.580565166107;6990.860182796214;7012.158540975116;7057.682404291922;6471.255805582418;6638.9668051661365;6643.833904152241;6644.335566443317;6646.734130634721;4968.627352948615;5011.749412529286;5066.468020857904;5176.948230517797;5313.149896016619;5072.340595722532;5125.897482050413;5136.871578210575;5353.571714262772;5391.487808658171 17:17:37 INFO - PROCESS | 1639 | |4;prototype.html;304.3471753089623;370.99814500927494;375.06047351384785;381.3821608993429;381.89688784028294;4857.611391088713;5121.513456221658;5270.1040823060075;5359;5386.622936394454;4371.715838470497;4432.335149727543;4829.710217386959;4888.462269150391;4968.900621987558;3654.506641603389;3953.5255769307723;3962.6321732881624;4053.371727382246;4184.602462766047;4129.97935010326;4134.3591743279685;4157.272477316473;4161.9375709364385;4173.645240154576;3495.8426870790877;4132.648724858391;4156.251874662559;4180.874573762792;4186.476690413699;3462.7576069675133;4078.163976384834;4187.330027195634;4196.475440569913;4217.704760666755;3686.926261474782;3699.741018128732;3700.9259814803554;3727.8881633551036;3746.400575907869;4616.8153273869;5088.185890257578;5102.897942041139;5110.488951104897;5127;4790.640701947368;4795.376601041842;4803.78382972767;4811.398575178103;4843.031393721235;4727.881802954919;4924.704517728947;5193.065248255312;5345.856960855329;5570.916436253459;3213.7589680774036;3240;3766.322062028834;3838.9424158637644;3863.826127824255;4510.007798284372;4964.627652926045;5295.285136506599;5713.74288157034;5828.795992140297;3237.7895436797003;3868.6324799144036;3880.5731369549326;3880.574640849413;3895.162540053902;3092.9381412372077;3743.1765011697385;3910.4329872168946;3940.172563761585;3950.4074388841327;4190.476190476191;4360.912781744348;4548.522405147478;4557.701055199253;4560;4862.738826445649;4946.307516947631;5453.590980676465;5548.77804887808;5612.85967850807;1086.9130469562417;1097.742030622803;1180.433391971841;1203.7111093337535;1232.2791167167306;762.656804437994;819.4100247821559;857.5764231376011;868.5961028121953;890.2521881619471;4166.83332666696;4914.550207688741;4926.975365123223;4943;4972.825951091694;4585.977070114628;4599.885002874955;4881.509720549824;5416.214648875891;5471.6169868108855;4402.427684401007;4632.62938964882;4923.37528615556;4965.205567109245;4967.528084831935;2473.492933948536;2565.409446143403;2779.082902642164;2819.675737290197;2835.9149225522856;5018.573421259234;5234.398044224887;5637.9703306809515;5660.632058916157;5664.376918538957;4965.652404331662;5172.120909318011;5244.508828941704;5579.637323573955;5628.690422026828;5631.577631677641;5675.297410776833;5675.404082571271;5679.716014199356;5708.71456427177;5016.566965021889;5371.409144994126;5458.808941687022;5484.025750729814;5526.143447765603;4491.932621010753;5398.650337415646;5661.518770904519;5702.857428564319;5748.971255143698;5325.174597937326;5407.567394608501;5425.864353391197;5711.8857622848145;5824.184614153937;3407.2793239413936;3455.2916652086765;3884.5532763731403;3908.9609103909734;3925.2345792570177;4825.710457372569;5337.638902079945;5767.365589785037;5767.711614419346;5794.82615521535;4898.804047838189;5015.322931404214;5067.847964561069;5573.749181286771;5609.21470994053;4894.632902532396;5571.997040532743;5575.972120139373;5582;5592.888142237214;5046.59627229828;5071.239314102914;5469.781208751764;5506.889862202814;5517.475839795213;4908.94457691598;4959.660891559331;5317.707526086102;5552.694601796778;5606.411326810626;4956.950430495649;5020.146575082172;5033.899322013466;5429.538489228302;5476.780928762805 17:17:37 INFO - PROCESS | 1639 | |5;yui.html;740.3595889555536;748.2853874549805;761.2273542354508;793.9960300198499;832.5629044751503;15133.394664213432;15235.619109522268;16117.83882161178;16132.596685082879;16150.999999999985;14858.257087145654;14934.327955242014;14945.850541494608;14976.625584360369;14982.101073935544;873.7597160780805;876.5836227791812;885.583775625455;888.7822483491553;892.1702816380763;883.7216276872764;883.9602217900177;884.0319849764529;884.1070518776019;886.6674996876171;740.4261697184699;764.0525748072378;902.3999040637968;922.9584668689926;931.6366617019368;892.7455675132621;927.8515437529996;930.418488444722;931.1293940165932;932.2309094996588;662.8773676869795;664.986700265992;689.7861662884521;691.1844024051617;691.861627674462;12321.260724356567;12757.87242127576;15254.161021143833;15449.459268925533;15831.525054248392;14828.184449855253;14841.332140053724;14890.911357686075;14931.925340373336;15015.399384024626;11795.94102029493;11859.347735874524;11869.88130118705;12187.96402305805;12539.811902821464;3742.4760533525327;3767.2277183177384;3771.547414310273;3934.1934903344745;4011.1576568920564;102546;111073.44463277713;111795.99999999919;112179.43910280478;112267;10767.438721385512;11077.058450031676;11602.709932251593;11703.414829258503;11799.823002654966;23497.41256468602;23578.882105589364;24370.390740231636;24373.78131093438;24390;7827.843443131105;7890.802729931683;7894.6842126314305;7944.9205507945335;7972.441929064909;4352.717073390283;4373.978130109329;4445.977770111193;4560.247559152769;4620.168369693488;3674.173311005056;3796.354619714655;3798.582155962842;3801.5628202756484;3803.486529318562;563.5266376243975;684.4148253243504;695.5305169010999;714.8713231618359;718.7699936020528;694.2688109654767;725.8004048886598;728.5228175545027;753.9811504712426;772.4747171923146;9775.706728798148;10617.73455663599;10660.560505749447;10673.626423075155;10955.83566246507;695.266493848984;704.8484575816224;728.803223129752;739.985200295991;751.3238085722784;4755.83354582588;5085.593152547787;5111.923321150186;5118.74406279692;5132.79468821243;102579;103426.48286758517;109288.65810655906;110091;110131;82341.17658823336;82822;83795.7430638541;85232;95315.57026644606;81901.18098819055;83050.58474707587;83445;83481.16518834856;85888;9572.377795443273;9896.257780666623;9916.355436896578;9955.104040636377;9961.35251208669;52314;53866;54346.45653543414;54957;55561;71403.28596713966;72237.27762722305;72724.18240534281;72747;75403.24596754182;11560.884391155982;11594.47824847867;11801.232919860182;12287.385630718249;12352.567660131852;12730.308240512397;13224.669383265495;13254.53609123676;13423.932880335537;13488.12327198729;10188.694339169837;11854.229475084092;12279.69300767488;12313.384330783247;12553.246805191719;12114.636560903187;12183.656192420838;12210.638972570216;12246.387680615755;12384.75230495403;11836.526538938346;11976.820347694616;12150.635480935585;12415.93792031034;12558.87441125577;7482;7683.34691551202;7949.165337639464;8221.588920554068;8227.588620569068;8323.292520135856;8482.448640838325;8593.613287402208;8913.598888050183;8922.286217102486 17:17:37 INFO - PROCESS | 1639 | __end_tp_report 17:17:37 INFO - PROCESS | 1639 | __start_cc_report 17:17:37 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1759 17:17:37 INFO - PROCESS | 1639 | __end_cc_report 17:17:37 INFO - PROCESS | 1639 | __startTimestamp1490746657181__endTimestamp 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | ------- Summary: start ------- 17:17:37 INFO - PROCESS | 1639 | Number of tests: 6 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5881.61 Median:6144.00 stddev:645.50 (10.5%) stddev-sans-first:619.06 17:17:37 INFO - PROCESS | 1639 | Values: 3466.9 3474.7 3494.5 3502.6 3530.0 5781.2 5815.9 5857.4 5865.4 5869.3 5813.4 5921.8 5999.4 6002.4 6026.7 5311.7 5339.5 5377.0 5446.3 5461.3 4496.4 5154.8 5261.7 5476.9 5489.4 5373.6 5378.7 5382.9 5387.2 5396.8 5373.8 5375.1 5382.7 5391.7 5394.9 5226.6 5334.2 5343.2 5344.3 5380.1 5938.2 5945.1 5946.2 5953.8 5957.7 5253.4 6273.7 6301.6 6314.3 6326.1 6303.3 6311.7 6338.2 6344.6 6383.4 5531.3 6063.5 6067.9 6073.3 6106.9 6247.1 6271.5 6294.2 6295.9 6472.8 6304.2 6326.8 6334.1 6339.7 6353.4 6325.5 6331.5 6336.6 6339.0 6352.8 6180.1 6282.7 6290.2 6296.9 6298.4 6232.2 6267.8 6277.0 6283.0 6305.9 5115.5 5117.2 5124.8 5126.6 5150.6 4457.5 4545.2 4556.4 4558.5 4572.5 4870.6 5919.9 5940.0 5949.9 5962.3 6284.1 6320.6 6324.5 6326.2 6345.5 5896.3 5997.8 6007.2 6012.6 6015.9 5469.2 5481.1 5513.1 5579.7 5626.6 6374.0 6501.3 6515.4 6523.3 6534.6 6331.7 6337.1 6344.6 6345.1 6359.3 6322.8 6397.7 6504.5 6512.4 6607.9 6235.2 6321.4 6338.4 6344.3 6363.9 6289.5 6321.2 6326.7 6327.6 6351.2 6193.0 6282.5 6294.4 6335.6 6345.5 6197.9 6232.6 6249.1 6279.1 6321.7 5985.9 6205.7 6218.3 6221.1 6230.8 6114.2 6307.1 6309.4 6316.0 6322.3 6049.2 6082.4 6112.9 6139.4 6144.0 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:68111.54 Median:19074.99 stddev:144905.44 (759.7%) stddev-sans-first:145223.01 17:17:37 INFO - PROCESS | 1639 | Values: 498.4 515.1 516.9 523.0 534.5 32840.5 42183.2 43699.6 43757.6 46343.0 45943.5 46329.3 46331.0 46393.3 46442.0 9608.6 9818.3 9818.9 9831.5 9848.1 7423.9 9148.7 11739.9 11906.9 11931.5 11756.1 11758.7 11852.4 11899.9 11977.0 11881.0 11961.0 11963.3 11966.5 11969.9 11696.4 11772.4 11781.8 11805.6 11843.8 34716.0 42479.4 42766.8 42929.8 43022.6 3982.2 4145.4 4151.9 4162.4 4167.9 30945.5 31796.4 31983.5 32910.0 33217.8 3340.7 3344.6 3370.2 3434.0 3492.5 362811.2 364330.0 364682.2 364948.0 365257.3 67975.3 68115.3 68168.0 68207.0 68246.0 73203.5 73254.8 73290.0 73357.6 73374.3 18162.2 18422.0 18448.3 18449.4 18455.8 12566.9 13841.7 13889.9 13915.6 13954.9 17247.5 17325.3 17606.7 18020.4 18400.7 7073.8 7093.5 7126.3 7162.2 7211.0 896.3 902.9 910.6 931.8 940.8 31507.2 31904.4 31981.4 32467.6 32977.0 858.7 1072.0 1128.3 1161.8 1210.6 15855.8 16115.8 16178.5 16262.3 16469.3 637807.0 643495.0 644477.0 644775.0 674315.6 54930.5 55473.7 64887.0 65750.0 65938.0 1455.9 1486.4 1486.8 1498.6 1500.1 31685.7 33285.7 33341.8 33347.8 34157.7 57352.0 57844.4 57854.7 57926.4 57995.0 568083.2 569556.0 569718.0 571453.0 586519.0 26541.0 27039.9 27127.7 27593.3 44162.0 45382.5 46013.0 46299.5 46767.5 47174.3 32222.5 32280.4 32367.8 32710.3 33272.5 32009.8 33166.7 33200.8 33457.8 34121.5 37399.6 37931.0 38209.8 38292.6 38394.0 31843.5 31916.5 31973.7 32294.4 32600.5 23943.2 25095.4 25213.2 25565.1 25597.0 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:41290.80 Median:26933.37 stddev:125951.12 (467.6%) stddev-sans-first:126266.97 17:17:37 INFO - PROCESS | 1639 | Values: 372.8 391.5 398.2 404.9 431.7 20475.8 21907.2 21997.1 22177.4 22458.7 22264.2 22732.7 23256.0 23545.3 23601.5 5800.3 6165.4 6169.4 6169.4 6177.6 5858.9 6035.8 6107.9 6141.6 6162.5 6049.9 6071.6 6095.1 6098.3 6098.8 5830.6 5913.3 5968.3 5971.3 5976.6 5228.9 5292.8 5312.1 5320.9 5342.1 26525.2 26773.7 26837.9 27028.9 27054.6 2569.0 2823.3 2839.3 2839.3 2852.3 10275.5 10627.4 10691.0 10902.8 10959.7 1824.6 1872.4 1876.0 1876.1 1921.4 112115.4 123769.0 126902.1 128138.0 128646.0 12027.6 12108.8 12136.8 12139.3 12252.7 16195.9 16228.9 16239.8 16261.4 16280.7 8824.1 9106.5 9127.0 9257.0 9258.6 7232.4 8881.1 8939.8 9127.5 9127.7 4802.2 4898.6 4922.6 4937.8 4943.7 1727.9 2028.7 2074.9 2078.5 2080.0 865.3 876.2 892.5 907.9 926.1 16315.2 18068.9 22076.3 22486.6 22640.0 829.1 833.9 926.2 941.4 942.2 10968.0 11160.7 11552.7 11572.4 11575.1 721809.0 741606.0 744513.0 786340.0 788003.0 151626.0 156715.0 159626.0 160606.0 161169.2 1017.9 1017.9 1018.8 1020.6 1047.0 15602.7 17680.6 18851.7 19450.5 19606.5 60129.7 60492.0 60941.5 61530.4 61654.8 86724.7 87752.6 89521.6 91165.3 91259.0 8479.5 8545.0 8685.4 8759.3 8777.4 11849.4 13036.6 13059.7 13320.0 13350.5 11631.2 11636.5 11637.5 11839.3 11981.6 9816.3 9868.0 10672.4 10753.2 11227.1 11743.7 11760.2 11897.0 12080.0 12157.4 7183.6 8446.3 8545.7 8608.2 8753.3 8648.9 11428.8 11780.8 11982.3 11982.8 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5551.71 Median:5099.12 stddev:3023.52 (59.3%) stddev-sans-first:3015.87 17:17:37 INFO - PROCESS | 1639 | Values: 1396.7 1477.1 1501.4 1515.2 1523.6 7679.4 8033.8 8385.8 8591.8 8611.3 8445.3 8536.1 8540.5 8545.2 8555.1 2357.8 2396.3 2401.8 2403.6 2405.7 1869.9 2122.6 2187.6 2414.6 2429.9 2371.3 2372.8 2374.1 2374.2 2379.4 2318.0 2356.4 2356.6 2358.4 2358.5 2343.6 2371.1 2410.2 2415.0 2417.3 8523.1 8524.3 8606.0 8616.2 8654.9 5202.3 5351.5 5362.7 5365.2 5369.8 3450.8 3619.7 3695.3 3698.7 3705.8 1221.8 1244.9 1255.9 1306.5 1313.4 10883.3 11008.6 11016.0 11027.6 11055.6 4020.0 4544.5 4772.0 4856.7 4875.4 9683.0 9684.3 9687.9 9695.2 9700.8 4556.7 5432.6 5446.6 5460.3 5465.7 4528.5 4791.1 4900.2 4994.4 5008.5 3677.6 3745.3 3760.0 3769.6 3771.8 1033.5 1052.9 1178.7 1181.6 1186.2 896.2 930.1 946.9 953.0 1006.4 5390.6 5634.6 5648.2 5835.2 6017.4 988.2 1003.6 1004.9 1032.6 1050.7 3741.6 3781.9 3846.7 3911.6 3917.2 9970.9 10145.3 10216.0 10219.5 10223.1 10195.9 10207.9 10208.9 10213.8 10225.5 6646.4 7964.2 8007.4 8133.4 8150.6 4819.0 4992.5 5723.4 5973.1 5974.3 8978.6 8998.8 9325.0 9348.7 9457.6 9327.5 9425.6 9488.2 9563.8 9617.2 7881.0 8085.5 8178.7 8207.5 8213.2 7685.8 7985.2 8072.7 8140.7 8151.1 6536.6 6592.1 7061.6 7075.1 7077.9 6922.3 6990.6 6990.9 7012.2 7057.7 6471.3 6639.0 6643.8 6644.3 6646.7 4968.6 5011.7 5066.5 5176.9 5313.1 5072.3 5125.9 5136.9 5353.6 5391.5 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4412.00 Median:4918.96 stddev:1334.00 (27.1%) stddev-sans-first:1301.62 17:17:37 INFO - PROCESS | 1639 | Values: 304.3 371.0 375.1 381.4 381.9 4857.6 5121.5 5270.1 5359.0 5386.6 4371.7 4432.3 4829.7 4888.5 4968.9 3654.5 3953.5 3962.6 4053.4 4184.6 4130.0 4134.4 4157.3 4161.9 4173.6 3495.8 4132.6 4156.3 4180.9 4186.5 3462.8 4078.2 4187.3 4196.5 4217.7 3686.9 3699.7 3700.9 3727.9 3746.4 4616.8 5088.2 5102.9 5110.5 5127.0 4790.6 4795.4 4803.8 4811.4 4843.0 4727.9 4924.7 5193.1 5345.9 5570.9 3213.8 3240.0 3766.3 3838.9 3863.8 4510.0 4964.6 5295.3 5713.7 5828.8 3237.8 3868.6 3880.6 3880.6 3895.2 3092.9 3743.2 3910.4 3940.2 3950.4 4190.5 4360.9 4548.5 4557.7 4560.0 4862.7 4946.3 5453.6 5548.8 5612.9 1086.9 1097.7 1180.4 1203.7 1232.3 762.7 819.4 857.6 868.6 890.3 4166.8 4914.6 4927.0 4943.0 4972.8 4586.0 4599.9 4881.5 5416.2 5471.6 4402.4 4632.6 4923.4 4965.2 4967.5 2473.5 2565.4 2779.1 2819.7 2835.9 5018.6 5234.4 5638.0 5660.6 5664.4 4965.7 5172.1 5244.5 5579.6 5628.7 5631.6 5675.3 5675.4 5679.7 5708.7 5016.6 5371.4 5458.8 5484.0 5526.1 4491.9 5398.7 5661.5 5702.9 5749.0 5325.2 5407.6 5425.9 5711.9 5824.2 3407.3 3455.3 3884.6 3909.0 3925.2 4825.7 5337.6 5767.4 5767.7 5794.8 4898.8 5015.3 5067.8 5573.7 5609.2 4894.6 5572.0 5576.0 5582.0 5592.9 5046.6 5071.2 5469.8 5506.9 5517.5 4908.9 4959.7 5317.7 5552.7 5606.4 4957.0 5020.1 5033.9 5429.5 5476.8 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20876.88 Median:5098.76 stddev:30608.64 (600.3%) stddev-sans-first:30657.17 17:17:37 INFO - PROCESS | 1639 | Values: 740.4 748.3 761.2 794.0 832.6 15133.4 15235.6 16117.8 16132.6 16151.0 14858.3 14934.3 14945.9 14976.6 14982.1 873.8 876.6 885.6 888.8 892.2 883.7 884.0 884.0 884.1 886.7 740.4 764.1 902.4 923.0 931.6 892.7 927.9 930.4 931.1 932.2 662.9 665.0 689.8 691.2 691.9 12321.3 12757.9 15254.2 15449.5 15831.5 14828.2 14841.3 14890.9 14931.9 15015.4 11795.9 11859.3 11869.9 12188.0 12539.8 3742.5 3767.2 3771.5 3934.2 4011.2 102546.0 111073.4 111796.0 112179.4 112267.0 10767.4 11077.1 11602.7 11703.4 11799.8 23497.4 23578.9 24370.4 24373.8 24390.0 7827.8 7890.8 7894.7 7944.9 7972.4 4352.7 4374.0 4446.0 4560.2 4620.2 3674.2 3796.4 3798.6 3801.6 3803.5 563.5 684.4 695.5 714.9 718.8 694.3 725.8 728.5 754.0 772.5 9775.7 10617.7 10660.6 10673.6 10955.8 695.3 704.8 728.8 740.0 751.3 4755.8 5085.6 5111.9 5118.7 5132.8 102579.0 103426.5 109288.7 110091.0 110131.0 82341.2 82822.0 83795.7 85232.0 95315.6 81901.2 83050.6 83445.0 83481.2 85888.0 9572.4 9896.3 9916.4 9955.1 9961.4 52314.0 53866.0 54346.5 54957.0 55561.0 71403.3 72237.3 72724.2 72747.0 75403.2 11560.9 11594.5 11801.2 12287.4 12352.6 12730.3 13224.7 13254.5 13423.9 13488.1 10188.7 11854.2 12279.7 12313.4 12553.2 12114.6 12183.7 12210.6 12246.4 12384.8 11836.5 11976.8 12150.6 12415.9 12558.9 7482.0 7683.3 7949.2 8221.6 8227.6 8323.3 8482.4 8593.6 8913.6 8922.3 17:17:37 INFO - PROCESS | 1639 | -------- Summary: end -------- 17:17:37 INFO - PROCESS | 1639 | 17:17:37 INFO - TEST-INFO | 1639: exit 0 17:17:37 INFO - TEST-OK | dromaeo_css | took 1117505ms 17:17:37 INFO - TEST-START | kraken 17:17:37 INFO - operating with platform_type : mac_ 17:17:37 INFO - Initialising browser for kraken test... 17:17:37 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpuKPYUE/profile http://localhost:49243/getInfo.html) 17:17:40 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 17:17:40 INFO - PROCESS | 1648 | colorDepth:24 17:17:40 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 17:17:40 INFO - PROCESS | 1648 | __metrics 17:17:40 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:17:40 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:17:40 INFO - TEST-INFO | 1648: exit 0 17:17:40 INFO - Browser initialized. 17:17:40 INFO - Running cycle 1/1 for kraken test... 17:17:40 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/tmpuKPYUE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:52 INFO - PROCESS | 1650 | RSS: Main: 163459072 17:17:52 INFO - PROCESS | 1650 | 17:17:55 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:56 INFO - PROCESS | 1650 | RSS: Main: 213282816 17:17:56 INFO - PROCESS | 1650 | 17:17:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 17:17:59 INFO - PROCESS | 1650 | RSS: Main: 227766272 17:17:59 INFO - PROCESS | 1650 | 17:18:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 17:18:03 INFO - PROCESS | 1650 | RSS: Main: 325189632 17:18:03 INFO - PROCESS | 1650 | 17:18:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 17:18:05 INFO - PROCESS | 1650 | RSS: Main: 228831232 17:18:05 INFO - PROCESS | 1650 | 17:18:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:18:08 INFO - PROCESS | 1650 | RSS: Main: 230227968 17:18:08 INFO - PROCESS | 1650 | 17:18:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 17:18:11 INFO - PROCESS | 1650 | RSS: Main: 269803520 17:18:11 INFO - PROCESS | 1650 | 17:18:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 17:18:15 INFO - PROCESS | 1650 | RSS: Main: 269824000 17:18:15 INFO - PROCESS | 1650 | 17:18:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 17:18:18 INFO - PROCESS | 1650 | RSS: Main: 267173888 17:18:18 INFO - PROCESS | 1650 | 17:18:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:20 INFO - PROCESS | 1650 | RSS: Main: 244764672 17:18:20 INFO - PROCESS | 1650 | 17:18:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:23 INFO - PROCESS | 1650 | RSS: Main: 247619584 17:18:23 INFO - PROCESS | 1650 | 17:18:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:26 INFO - PROCESS | 1650 | RSS: Main: 254365696 17:18:26 INFO - PROCESS | 1650 | 17:18:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:29 INFO - PROCESS | 1650 | RSS: Main: 259379200 17:18:29 INFO - PROCESS | 1650 | 17:18:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:32 INFO - PROCESS | 1650 | RSS: Main: 261140480 17:18:32 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 17:18:34 INFO - PROCESS | 1650 | RSS: Main: 305197056 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | __start_tp_report 17:18:34 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 17:18:34 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 17:18:34 INFO - PROCESS | 1650 | |i|pagename|runs| 17:18:34 INFO - PROCESS | 1650 | |0;ai-astar;103;115;115;114;115;115;114;113;114;114 17:18:34 INFO - PROCESS | 1650 | |1;audio-beat-detection;137;108;106;151;103;106;106;104;125;109 17:18:34 INFO - PROCESS | 1650 | |2;audio-dft;183;179;186;184;184;182;194;264;208;184 17:18:34 INFO - PROCESS | 1650 | |3;audio-fft;81;59;58;88;59;57;58;58;73;57 17:18:34 INFO - PROCESS | 1650 | |4;audio-oscillator;90;70;85;70;66;68;81;67;67;83 17:18:34 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;89;85;88;86;88;85;88;85;92;127 17:18:34 INFO - PROCESS | 1650 | |6;imaging-darkroom;95;94;93;94;94;93;94;94;94;94 17:18:34 INFO - PROCESS | 1650 | |7;imaging-desaturate;87;85;85;85;84;85;84;85;87;85 17:18:34 INFO - PROCESS | 1650 | |8;json-parse-financial;56;53;52;52;56;55;56;56;56;54 17:18:34 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;66;73;68;77;72;66;68;69;69;68 17:18:34 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;82;83;83;83;84;86;81;87;105;86 17:18:34 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;131;133;134;152;139;133;130;133;149;151 17:18:34 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;167;162;164;162;166;161;159;166;160;161 17:18:34 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;65;64;63;64;63;63;62;64;62;63 17:18:34 INFO - PROCESS | 1650 | __end_tp_report 17:18:34 INFO - PROCESS | 1650 | __start_cc_report 17:18:34 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1947 17:18:34 INFO - PROCESS | 1650 | __end_cc_report 17:18:34 INFO - PROCESS | 1650 | __startTimestamp1490746714927__endTimestamp 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | ------- Summary: start ------- 17:18:34 INFO - PROCESS | 1650 | Number of tests: 14 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:3.65 (3.2%) stddev-sans-first:0.71 17:18:34 INFO - PROCESS | 1650 | Values: 103.0 115.0 115.0 114.0 115.0 115.0 114.0 113.0 114.0 114.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:108.50 stddev:16.57 (15.3%) stddev-sans-first:15.64 17:18:34 INFO - PROCESS | 1650 | Values: 137.0 108.0 106.0 151.0 103.0 106.0 106.0 104.0 125.0 109.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:194.80 Median:185.00 stddev:25.70 (13.9%) stddev-sans-first:26.90 17:18:34 INFO - PROCESS | 1650 | Values: 183.0 179.0 186.0 184.0 184.0 182.0 194.0 264.0 208.0 184.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:64.80 Median:59.00 stddev:11.53 (19.5%) stddev-sans-first:10.63 17:18:34 INFO - PROCESS | 1650 | Values: 81.0 59.0 58.0 88.0 59.0 57.0 58.0 58.0 73.0 57.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:75.50 stddev:9.02 (11.9%) stddev-sans-first:7.68 17:18:34 INFO - PROCESS | 1650 | Values: 90.0 70.0 85.0 70.0 66.0 68.0 81.0 67.0 67.0 83.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:88.00 stddev:12.74 (14.5%) stddev-sans-first:13.48 17:18:34 INFO - PROCESS | 1650 | Values: 89.0 85.0 88.0 86.0 88.0 85.0 88.0 85.0 92.0 127.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 17:18:34 INFO - PROCESS | 1650 | Values: 95.0 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:0.87 17:18:34 INFO - PROCESS | 1650 | Values: 87.0 85.0 85.0 85.0 84.0 85.0 84.0 85.0 87.0 85.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:56.00 stddev:1.71 (3.1%) stddev-sans-first:1.74 17:18:34 INFO - PROCESS | 1650 | Values: 56.0 53.0 52.0 52.0 56.0 55.0 56.0 56.0 56.0 54.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:69.00 stddev:3.44 (5.0%) stddev-sans-first:3.39 17:18:34 INFO - PROCESS | 1650 | Values: 66.0 73.0 68.0 77.0 72.0 66.0 68.0 69.0 69.0 68.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.50 stddev:6.94 (8.3%) stddev-sans-first:7.21 17:18:34 INFO - PROCESS | 1650 | Values: 82.0 83.0 83.0 83.0 84.0 86.0 81.0 87.0 105.0 86.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:136.50 stddev:8.75 (6.4%) stddev-sans-first:8.85 17:18:34 INFO - PROCESS | 1650 | Values: 131.0 133.0 134.0 152.0 139.0 133.0 130.0 133.0 149.0 151.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.80 Median:163.00 stddev:2.78 (1.7%) stddev-sans-first:2.50 17:18:34 INFO - PROCESS | 1650 | Values: 167.0 162.0 164.0 162.0 166.0 161.0 159.0 166.0 160.0 161.0 17:18:34 INFO - PROCESS | 1650 | 17:18:34 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:0.78 17:18:34 INFO - PROCESS | 1650 | Values: 65.0 64.0 63.0 64.0 63.0 63.0 62.0 64.0 62.0 63.0 17:18:34 INFO - PROCESS | 1650 | -------- Summary: end -------- 17:18:34 INFO - PROCESS | 1650 | 17:18:35 INFO - TEST-INFO | 1650: exit 0 17:18:35 INFO - TEST-OK | kraken | took 58020ms 17:18:35 INFO - SUITE-END | took 1175s 17:18:36 INFO - Completed test suite (00:19:35) 17:18:36 INFO - javascript benchmark 17:18:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3466.861325546978, 3474.704650104741, 3494.4758286257043, 3502.6322236165192, 3529.999999999998, 5781.161731548923, 5815.941840581593, 5857.443542863426, 5865.35481097079, 5869.32502762182, 5813.389594092612, 5921.822345329636, 5999.400059993998, 6002.429769171922, 6026.668533230671, 5311.73441327934, 5339.5461385782255, 5377.0321342158395, 5446.319210098738, 5461.290032295796, 4496.370508128848, 5154.84016096379, 5261.657992230512, 5476.890462190754, 5489.368722596892, 5373.596980226479, 5378.731063446831, 5382.865428364283, 5387.24578559002, 5396.757145928423, 5373.81191658294, 5375.0862353399625, 5382.703951282678, 5391.676499410048, 5394.865128371783, 5226.5818734501145, 5334.199870019489, 5343.171808369709, 5344.251804747339, 5380.139177731583, 5938.168656388109, 5945.137954996545, 5946.167536544887, 5953.761849526014, 5957.702114894238, 5253.448387919251, 6273.654948977804, 6301.6219026858535, 6314.305426403092, 6326.145970293997, 6303.306636270053, 6311.715972781236, 6338.239411270631, 6344.587601805914, 6383.361663833626, 5531.3362396512675, 6063.454289114001, 6067.878642427127, 6073.271207455089, 6106.931287024841, 6247.125402443661, 6271.498280137578, 6294.244690637152, 6295.874082518324, 6472.805815825533, 6304.211973503312, 6326.810195694136, 6334.081558174039, 6339.683015849189, 6353.428191462791, 6325.462335701517, 6331.461825744863, 6336.58812177207, 6339.049142628551, 6352.809415717536, 6180.103884936659, 6282.717277722513, 6290.150829638032, 6296.874062518816, 6298.401651843067, 6232.220972378453, 6267.811965641038, 6276.968615156895, 6282.968585157045, 6305.873882522324, 5115.462876397924, 5117.155669314596, 5124.795008199705, 5126.615503837227, 5150.562202212779, 4457.509673935864, 4545.204589196877, 4556.430446194226, 4558.49856515783, 4572.497025327278, 4870.634702397264, 5919.911201331984, 5939.960506911273, 5949.9107513387335, 5962.25471816023, 6284.12022316876, 6320.5575609706875, 6324.494040476751, 6326.177596912372, 6345.460635846005, 5896.321922978912, 5997.790077347272, 6007.249093863267, 6012.609180403259, 6015.939840601625, 5469.234307196995, 5481.095619222863, 5513.062779327524, 5579.69311687861, 5626.606137570331, 6374.043893415932, 6501.349865013461, 6515.446187074152, 6523.347665233438, 6534.575252608565, 6331.651759153291, 6337.144485494399, 6344.555881088279, 6345.079963405373, 6359.300476947625, 6322.778702745381, 6397.744090236339, 6504.4796416285635, 6512.446442052478, 6607.867842643216, 6235.189425374672, 6321.367863213642, 6338.366163383625, 6344.302126766144, 6363.93636063652, 6289.49684025286, 6321.209848768904, 6326.746930122744, 6327.55707100517, 6351.237851457855, 6193.040078787795, 6282.465990390868, 6294.433500984934, 6335.619862808247, 6345.492360611048, 6197.876042479035, 6232.594881332699, 6249.125122482765, 6279.089532017923, 6321.747130114928, 5985.880282394415, 6205.6586887721605, 6218.347073557392, 6221.129041934042, 6230.7507699691505, 6114.236541168587, 6307.148534947723, 6309.3690630936535, 6316.0, 6322.33615470369, 6049.153118563317, 6082.422169893853, 6112.938870611415, 6139.416755408229, 6144.003198960445], "value": 5841.45136147343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.4068957940053, 515.1371452816533, 516.8886893179665, 522.9764660590274, 534.5082524077848, 32840.50739238913, 42183.15633687328, 43699.56300436995, 43757.562424375705, 46343.0, 45943.54056459435, 46329.30506042412, 46331.0, 46393.30410043852, 46442.0, 9608.567614457348, 9818.312718109735, 9818.901810981906, 9831.459269740162, 9848.113669769718, 7423.851522969564, 9148.679796207134, 11739.882601174008, 11906.880931190708, 11931.522739090426, 11756.1182911282, 11758.706032349173, 11852.407379630984, 11899.940500297529, 11976.981956533706, 11881.0, 11961.0, 11963.342016189106, 11966.461509232106, 11969.880301197007, 11696.415179241088, 11772.352520611363, 11781.823272650918, 11805.586804461802, 11843.822342664867, 34716.0, 42479.36280955788, 42766.786166068974, 42929.785351073355, 43022.56977430248, 3982.2433737589763, 4145.357469592218, 4151.8546850860075, 4162.396452514368, 4167.854125105607, 30945.535816962765, 31796.364072718647, 31983.52024719631, 32910.0, 33217.83391083053, 3340.749443791701, 3344.6320904700465, 3370.208001119735, 3433.9828300858585, 3492.4761285807076, 362811.1859440712, 364330.0, 364682.176589118, 364948.0, 365257.34742652497, 67975.3202467969, 68115.31884681189, 68168.0, 68207.0, 68246.0, 73203.53592928112, 73254.80235592941, 73290.0, 73357.6332118336, 73374.2662573378, 18162.182701778453, 18422.0, 18448.26206951734, 18449.354272600664, 18455.81544184568, 12566.931810796003, 13841.723165536834, 13889.930550347184, 13915.582532523838, 13954.86045139556, 17247.482575522754, 17325.30698772035, 17606.735898961524, 18020.371094199116, 18400.723989140173, 7073.82315442118, 7093.510362823761, 7126.2873712628325, 7162.212156662763, 7210.963945180345, 896.3322324867885, 902.8826252587122, 910.5993362920294, 931.7996630724426, 940.7836197674574, 31507.21231969219, 31904.361912761615, 31981.360372792413, 32467.558355094097, 32977.0, 858.7423772868115, 1071.9624813131659, 1128.3117298448103, 1161.8315344275034, 1210.6186551236333, 15855.841441585668, 16115.758263625821, 16178.514644560682, 16262.336962487538, 16469.34122635105, 637807.0, 643495.0, 644477.0, 644775.0, 674315.6284218547, 54930.45069549333, 55473.72263138658, 64887.0, 65750.0, 65938.01092983609, 1455.9490417835325, 1486.420296084528, 1486.799282096903, 1498.625343664084, 1500.0624609618988, 31685.683143169197, 33285.66714332825, 33341.83329083339, 33347.83326083354, 34157.65842341644, 57352.0, 57844.421555783905, 57854.7107264461, 57926.420735792104, 57995.0, 568083.159584216, 569556.0, 569718.0, 571453.0, 586519.0, 26541.0, 27039.86480067587, 27127.72872271252, 27593.310167245978, 44162.0, 45382.54617453915, 46013.0, 46299.53700463087, 46767.532324677675, 47174.29238561356, 32222.516662250553, 32280.35439291154, 32367.838160809046, 32710.34579308448, 33272.50091248585, 32009.83995080103, 33166.66833331636, 33200.83399582987, 33457.82897598572, 34121.48817767686, 37399.626003740705, 37931.0, 38209.80895095507, 38292.61707382891, 38394.0401489965, 31843.522347164348, 31916.5212521817, 31973.68026319707, 32294.35411291808, 32600.510992335607, 23943.161989330987, 25095.372615684755, 25213.24360269195, 25565.13319124924, 25597.0], "value": 20813.42042794753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.79309982959455, 391.53016380343576, 398.1678292368948, 404.93723472861706, 431.65036320580333, 20475.771453712787, 21907.233246836364, 21997.120115195412, 22177.44556386091, 22458.663120053214, 22264.220752273675, 22732.65901011486, 23256.0, 23545.29364119075, 23601.5279694406, 5800.303963524372, 6165.352637973016, 6169.444749972502, 6169.444749972502, 6177.629342239457, 5858.882822343572, 6035.818925432244, 6107.908381374283, 6141.570090093673, 6162.537809664271, 6049.909251361233, 6071.635701857903, 6095.146679464879, 6098.298695650013, 6098.847528811771, 5830.621009634381, 5913.319968203668, 5968.253968253968, 5971.313298970631, 5976.551758618078, 5228.92156617651, 5292.814751483718, 5312.123499622597, 5320.9467905320835, 5342.0651386007685, 26525.204243872715, 26773.73226267732, 26837.865810671017, 27028.86485567579, 27054.5941810873, 2568.9871550642315, 2823.294176455886, 2839.2617919340914, 2839.275984623908, 2852.286928267933, 10275.48622568876, 10627.415492148006, 10691.0, 10902.836457453144, 10959.671209863716, 1824.6350729854082, 1872.4008317338457, 1875.962480750391, 1876.0994722533123, 1921.3755529452844, 112115.43942280317, 123769.0, 126902.09646855305, 128138.0, 128646.0, 12027.579034733917, 12108.81836772449, 12136.817947730791, 12139.332336721565, 12252.693682657826, 16195.919020405057, 16228.918855405647, 16239.756403653955, 16261.430849920196, 16280.674386512203, 8824.073472285447, 9106.49914254709, 9127.0, 9256.953715231515, 9258.583363748647, 7232.385247254042, 8881.067487913806, 8939.776505587282, 9127.497987610745, 9127.726168214964, 4802.231642937183, 4898.632602554822, 4922.58158056562, 4937.802487900443, 4943.728094954812, 1727.8790484666204, 2028.7159797628344, 2074.8962551872346, 2078.4803799050237, 2079.9688004679942, 865.3466632692403, 876.2464280718577, 892.5314210039782, 907.863820426928, 926.1248120526038, 16315.184240787914, 18068.909655451902, 22076.33770986873, 22486.550268994855, 22640.0, 829.1087081387533, 833.8957630296213, 926.1525703980917, 941.3645789092335, 942.1755963531909, 10968.012878840942, 11160.665180044612, 11552.6534203974, 11572.363520006313, 11575.073994080454, 721809.0, 741606.0, 744513.0, 786340.0, 788003.0, 151626.0, 156715.0, 159626.0, 160606.0, 161169.1941540285, 1017.8524114003428, 1017.8574999500075, 1018.7911478146962, 1020.5815615597569, 1046.9895301047045, 15602.687946241238, 17680.55798605045, 18851.717224241373, 19450.51981903711, 19606.509837253612, 60129.69935150296, 60492.0, 60941.47646308878, 61530.38469615247, 61654.76690466255, 86724.69912951185, 87752.56123719341, 89521.55239223762, 91165.33929276708, 91259.0, 8479.491230526188, 8544.957275213585, 8685.39202255836, 8759.255463285437, 8777.385583009383, 11849.407529623657, 13036.608901732963, 13059.673508162372, 13320.0, 13350.465981360638, 11631.243969141979, 11636.476358563716, 11637.53449861996, 11839.348835814113, 11981.64055078349, 9816.312858099864, 9867.950660246654, 10672.413017284123, 10753.193510486588, 11227.101831853268, 11743.706407339885, 11760.176787624785, 11896.988755955494, 12079.973202277904, 12157.392130393622, 7183.640817958976, 8446.324294056338, 8545.658173672984, 8608.225259726654, 8753.343499237455, 8648.913510865063, 11428.828567571327, 11780.823287650863, 11982.281063136239, 11982.820257696316], "value": 10089.590364130121, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.7346204221192, 1477.1063506578519, 1501.391936265812, 1515.2423788105948, 1523.5962469945466, 7679.385649148068, 8033.79915502112, 8385.790355241114, 8591.828163436727, 8611.26804221642, 8445.282151017156, 8536.14638536146, 8540.48757074576, 8545.230929216385, 8555.058943516207, 2357.77601127893, 2396.293093537402, 2401.8438801477846, 2403.6034054381007, 2405.651180578815, 1869.8878067316004, 2122.596706625744, 2187.562487502506, 2414.625733011386, 2429.9028038878423, 2371.3241726108063, 2372.8457650252676, 2374.121575017246, 2374.192774456684, 2379.393254720044, 2318.0, 2356.4108972756812, 2356.622940329556, 2358.433975845802, 2358.516504116652, 2343.6367363058584, 2371.0871314544024, 2410.180538616861, 2414.97585024151, 2417.286900364379, 8523.06246312905, 8524.275436587897, 8606.010308814504, 8616.181462761027, 8654.870176947288, 5202.3497062867145, 5351.464853514617, 5362.731863406814, 5365.195220716884, 5369.758360873731, 3450.810205438725, 3619.7466177367596, 3695.260947810422, 3698.6671199592165, 3705.7961812100325, 1221.7861874172074, 1244.9439775210137, 1255.8681338459512, 1306.5165888621175, 1313.4220942785144, 10883.292585981886, 11008.559657613767, 11015.953484418967, 11027.61403350879, 11055.613053543088, 4019.959800402017, 4544.500104988449, 4771.9522804772205, 4856.708597484162, 4875.43932447773, 9682.951585242028, 9684.32209745311, 9687.903120968842, 9695.175910047725, 9700.805983880284, 4556.658250631216, 5432.6468779529205, 5446.591505637093, 5460.262864513319, 5465.699386533779, 4528.50186479487, 4791.137595232892, 4900.191468407744, 4994.350734404504, 5008.549230569193, 3677.632236776301, 3745.2883952049024, 3759.981200093982, 3769.6041915599017, 3771.830267637963, 1033.503918119307, 1052.85786418834, 1178.6581891251442, 1181.5923506390454, 1186.1696812231473, 896.2247655777705, 930.1070971866948, 946.8958414574391, 952.9857052144223, 1006.4263369879098, 5390.622656414013, 5634.605577609528, 5648.209250704905, 5835.153902684087, 6017.428344307284, 988.2291812386206, 1003.6487229469773, 1004.9296549241483, 1032.607609108534, 1050.7425680708122, 3741.644543768338, 3781.9432708509394, 3846.653801157909, 3911.6088391160656, 3917.216556688674, 9970.900290997142, 10145.28982971185, 10216.0, 10219.540120694586, 10223.079922806834, 10195.898041019494, 10207.948960255151, 10208.948955255177, 10213.846792298122, 10225.488725563691, 6646.4350530205475, 7964.243396877403, 8007.439479236397, 8133.430659853753, 8150.633221505046, 4819.0, 4992.475790042138, 5723.427657234243, 5973.074173503114, 5974.312954010171, 8978.640854365753, 8998.82002359936, 9325.0, 9348.719538413858, 9457.574409151743, 9327.486988215713, 9425.57584908667, 9488.240940724863, 9563.760905977128, 9617.2306215504, 7881.0, 8085.514869107872, 8178.67285308581, 8207.466514676527, 8213.178682131738, 7685.807854803675, 7985.161558036322, 8072.717454889051, 8140.715074972348, 8151.1441298662785, 6536.640484773383, 6592.143021407186, 7061.576305421691, 7075.080239569029, 7077.929220707933, 6922.307769223037, 6990.580565166107, 6990.860182796214, 7012.158540975116, 7057.682404291922, 6471.255805582418, 6638.9668051661365, 6643.833904152241, 6644.335566443317, 6646.734130634721, 4968.627352948615, 5011.749412529286, 5066.468020857904, 5176.948230517797, 5313.149896016619, 5072.340595722532, 5125.897482050413, 5136.871578210575, 5353.571714262772, 5391.487808658171], "value": 4515.100384492683, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3471753089623, 370.99814500927494, 375.06047351384785, 381.3821608993429, 381.89688784028294, 4857.611391088713, 5121.513456221658, 5270.1040823060075, 5359.0, 5386.622936394454, 4371.715838470497, 4432.335149727543, 4829.710217386959, 4888.462269150391, 4968.900621987558, 3654.506641603389, 3953.5255769307723, 3962.6321732881624, 4053.371727382246, 4184.602462766047, 4129.97935010326, 4134.3591743279685, 4157.272477316473, 4161.9375709364385, 4173.645240154576, 3495.8426870790877, 4132.648724858391, 4156.251874662559, 4180.874573762792, 4186.476690413699, 3462.7576069675133, 4078.163976384834, 4187.330027195634, 4196.475440569913, 4217.704760666755, 3686.926261474782, 3699.741018128732, 3700.9259814803554, 3727.8881633551036, 3746.400575907869, 4616.8153273869, 5088.185890257578, 5102.897942041139, 5110.488951104897, 5127.0, 4790.640701947368, 4795.376601041842, 4803.78382972767, 4811.398575178103, 4843.031393721235, 4727.881802954919, 4924.704517728947, 5193.065248255312, 5345.856960855329, 5570.916436253459, 3213.7589680774036, 3240.0, 3766.322062028834, 3838.9424158637644, 3863.826127824255, 4510.007798284372, 4964.627652926045, 5295.285136506599, 5713.74288157034, 5828.795992140297, 3237.7895436797003, 3868.6324799144036, 3880.5731369549326, 3880.574640849413, 3895.162540053902, 3092.9381412372077, 3743.1765011697385, 3910.4329872168946, 3940.172563761585, 3950.4074388841327, 4190.476190476191, 4360.912781744348, 4548.522405147478, 4557.701055199253, 4560.0, 4862.738826445649, 4946.307516947631, 5453.590980676465, 5548.77804887808, 5612.85967850807, 1086.9130469562417, 1097.742030622803, 1180.433391971841, 1203.7111093337535, 1232.2791167167306, 762.656804437994, 819.4100247821559, 857.5764231376011, 868.5961028121953, 890.2521881619471, 4166.83332666696, 4914.550207688741, 4926.975365123223, 4943.0, 4972.825951091694, 4585.977070114628, 4599.885002874955, 4881.509720549824, 5416.214648875891, 5471.6169868108855, 4402.427684401007, 4632.62938964882, 4923.37528615556, 4965.205567109245, 4967.528084831935, 2473.492933948536, 2565.409446143403, 2779.082902642164, 2819.675737290197, 2835.9149225522856, 5018.573421259234, 5234.398044224887, 5637.9703306809515, 5660.632058916157, 5664.376918538957, 4965.652404331662, 5172.120909318011, 5244.508828941704, 5579.637323573955, 5628.690422026828, 5631.577631677641, 5675.297410776833, 5675.404082571271, 5679.716014199356, 5708.71456427177, 5016.566965021889, 5371.409144994126, 5458.808941687022, 5484.025750729814, 5526.143447765603, 4491.932621010753, 5398.650337415646, 5661.518770904519, 5702.857428564319, 5748.971255143698, 5325.174597937326, 5407.567394608501, 5425.864353391197, 5711.8857622848145, 5824.184614153937, 3407.2793239413936, 3455.2916652086765, 3884.5532763731403, 3908.9609103909734, 3925.2345792570177, 4825.710457372569, 5337.638902079945, 5767.365589785037, 5767.711614419346, 5794.82615521535, 4898.804047838189, 5015.322931404214, 5067.847964561069, 5573.749181286771, 5609.21470994053, 4894.632902532396, 5571.997040532743, 5575.972120139373, 5582.0, 5592.888142237214, 5046.59627229828, 5071.239314102914, 5469.781208751764, 5506.889862202814, 5517.475839795213, 4908.94457691598, 4959.660891559331, 5317.707526086102, 5552.694601796778, 5606.411326810626, 4956.950430495649, 5020.146575082172, 5033.899322013466, 5429.538489228302, 5476.780928762805], "value": 3995.4416568958936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.3595889555536, 748.2853874549805, 761.2273542354508, 793.9960300198499, 832.5629044751503, 15133.394664213432, 15235.619109522268, 16117.83882161178, 16132.596685082879, 16150.999999999985, 14858.257087145654, 14934.327955242014, 14945.850541494608, 14976.625584360369, 14982.101073935544, 873.7597160780805, 876.5836227791812, 885.583775625455, 888.7822483491553, 892.1702816380763, 883.7216276872764, 883.9602217900177, 884.0319849764529, 884.1070518776019, 886.6674996876171, 740.4261697184699, 764.0525748072378, 902.3999040637968, 922.9584668689926, 931.6366617019368, 892.7455675132621, 927.8515437529996, 930.418488444722, 931.1293940165932, 932.2309094996588, 662.8773676869795, 664.986700265992, 689.7861662884521, 691.1844024051617, 691.861627674462, 12321.260724356567, 12757.87242127576, 15254.161021143833, 15449.459268925533, 15831.525054248392, 14828.184449855253, 14841.332140053724, 14890.911357686075, 14931.925340373336, 15015.399384024626, 11795.94102029493, 11859.347735874524, 11869.88130118705, 12187.96402305805, 12539.811902821464, 3742.4760533525327, 3767.2277183177384, 3771.547414310273, 3934.1934903344745, 4011.1576568920564, 102546.0, 111073.44463277713, 111795.99999999919, 112179.43910280478, 112267.0, 10767.438721385512, 11077.058450031676, 11602.709932251593, 11703.414829258503, 11799.823002654966, 23497.41256468602, 23578.882105589364, 24370.390740231636, 24373.78131093438, 24390.0, 7827.843443131105, 7890.802729931683, 7894.6842126314305, 7944.9205507945335, 7972.441929064909, 4352.717073390283, 4373.978130109329, 4445.977770111193, 4560.247559152769, 4620.168369693488, 3674.173311005056, 3796.354619714655, 3798.582155962842, 3801.5628202756484, 3803.486529318562, 563.5266376243975, 684.4148253243504, 695.5305169010999, 714.8713231618359, 718.7699936020528, 694.2688109654767, 725.8004048886598, 728.5228175545027, 753.9811504712426, 772.4747171923146, 9775.706728798148, 10617.73455663599, 10660.560505749447, 10673.626423075155, 10955.83566246507, 695.266493848984, 704.8484575816224, 728.803223129752, 739.985200295991, 751.3238085722784, 4755.83354582588, 5085.593152547787, 5111.923321150186, 5118.74406279692, 5132.79468821243, 102579.0, 103426.48286758517, 109288.65810655906, 110091.0, 110131.0, 82341.17658823336, 82822.0, 83795.7430638541, 85232.0, 95315.57026644606, 81901.18098819055, 83050.58474707587, 83445.0, 83481.16518834856, 85888.0, 9572.377795443273, 9896.257780666623, 9916.355436896578, 9955.104040636377, 9961.35251208669, 52314.0, 53866.0, 54346.45653543414, 54957.0, 55561.0, 71403.28596713966, 72237.27762722305, 72724.18240534281, 72747.0, 75403.24596754182, 11560.884391155982, 11594.47824847867, 11801.232919860182, 12287.385630718249, 12352.567660131852, 12730.308240512397, 13224.669383265495, 13254.53609123676, 13423.932880335537, 13488.12327198729, 10188.694339169837, 11854.229475084092, 12279.69300767488, 12313.384330783247, 12553.246805191719, 12114.636560903187, 12183.656192420838, 12210.638972570216, 12246.387680615755, 12384.75230495403, 11836.526538938346, 11976.820347694616, 12150.635480935585, 12415.93792031034, 12558.87441125577, 7482.0, 7683.34691551202, 7949.165337639464, 8221.588920554068, 8227.588620569068, 8323.292520135856, 8482.448640838325, 8593.613287402208, 8913.598888050183, 8922.286217102486], "value": 7509.625060139605, "unit": "score"}], "name": "dromaeo_css", "value": 7414.916964043106, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 108.0, 106.0, 151.0, 103.0, 106.0, 106.0, 104.0, 125.0, 109.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 186.0, 184.0, 184.0, 182.0, 194.0, 264.0, 208.0, 184.0], "value": 194.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 59.0, 57.0, 58.0, 58.0, 73.0, 57.0], "value": 64.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 85.0, 70.0, 66.0, 68.0, 81.0, 67.0, 67.0, 83.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 86.0, 88.0, 85.0, 88.0, 85.0, 92.0, 127.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 87.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 52.0, 56.0, 55.0, 56.0, 56.0, 56.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 68.0, 77.0, 72.0, 66.0, 68.0, 69.0, 69.0, 68.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 83.0, 84.0, 86.0, 81.0, 87.0, 105.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 134.0, 152.0, 139.0, 133.0, 130.0, 133.0, 149.0, 151.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 164.0, 162.0, 166.0, 161.0, 159.0, 166.0, 160.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 64.0, 63.0, 63.0, 62.0, 64.0, 62.0, 63.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1408.1999999999998, "alertThreshold": 2.0}]} 17:18:36 INFO - Return code: 0 17:18:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:36 INFO - # TBPL SUCCESS # 17:18:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:36 INFO - 2017-03-28 17:18:36.253 screenresolution[1654:9621] starting screenresolution argv=screenresolution get 17:18:36 INFO - 2017-03-28 17:18:36.256 screenresolution[1654:9621] Display 0: 1600x1200x32@60 17:18:36 INFO - 2017-03-28 17:18:36.262 screenresolution[1655:9624] starting screenresolution argv=screenresolution list 17:18:36 INFO - Available Modes on Display 0 17:18:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:36 INFO - Intel Iris: 17:18:36 INFO - Chipset Model: Intel Iris 17:18:36 INFO - Type: GPU 17:18:36 INFO - Bus: Built-In 17:18:36 INFO - VRAM (Dynamic, Max): 1536 MB 17:18:36 INFO - Vendor: Intel (0x8086) 17:18:36 INFO - Device ID: 0x0a2e 17:18:36 INFO - Revision ID: 0x0009 17:18:36 INFO - Displays: 17:18:36 INFO - Display: 17:18:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:36 INFO - Display Serial Number: 1600x1200 60 17:18:36 INFO - Main Display: Yes 17:18:36 INFO - Mirror: Off 17:18:36 INFO - Online: Yes 17:18:36 INFO - Rotation: Supported 17:18:36 INFO - Return code: 0 17:18:36 INFO - Running post-action listener: _resource_record_post_action 17:18:36 INFO - [mozharness: 2017-03-29 00:18:36.499693Z] Finished run-tests step (success) 17:18:36 INFO - Running post-run listener: _resource_record_post_run 17:18:36 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 38044672; Write bytes: 421916672; Read time: 339; Write time: 1403 17:18:36 INFO - TinderboxPrint: CPU usage
53.6% 17:18:36 INFO - TinderboxPrint: I/O read bytes / time
38,044,672 / 339 17:18:36 INFO - TinderboxPrint: I/O write bytes / time
421,916,672 / 1,403 17:18:36 INFO - TinderboxPrint: CPU idle
2,212.7 (46.4%) 17:18:36 INFO - TinderboxPrint: CPU system
954.0 (20.0%) 17:18:36 INFO - TinderboxPrint: CPU user
1,598.9 (33.6%) 17:18:36 INFO - TinderboxPrint: Swap in / out
159,977,472 / 0 17:18:36 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 109787648; Write bytes: 102088704; Read time: 9964; Write time: 215 17:18:36 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37114880; Write bytes: 297363456; Read time: 327; Write time: 1118 17:18:36 INFO - Running post-run listener: _upload_blobber_files 17:18:36 INFO - Blob upload gear active. 17:18:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18:36 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 17:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:18:37 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:18:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:18:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:38 INFO - (blobuploader) - INFO - Done attempting. 17:18:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:18:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:18:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:39 INFO - (blobuploader) - INFO - Done attempting. 17:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:41 INFO - (blobuploader) - INFO - Done attempting. 17:18:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:43 INFO - (blobuploader) - INFO - Done attempting. 17:18:43 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:43 INFO - Return code: 0 17:18:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/391ca5147a3d0b33ec1e8f6aad28ed06887391b1b0f93eca7d57a6d54697624763d2a70b755e9fe8fab3bb9aac20130a22a585ee3964741cb9f2d9623188def9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b4d0bd57df0788bb937f39beabc1987cdbc9c41189f3016d1cef2dfad42f530e6870489061b59a4eb7572fd1da2517f1870a3502e5eef06209b579b9c5ae2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af538faeff71bb963b2d95792cb51dc5626205565ddba743b6ffad837f1d0dddf886139eb9b15482ac6013885bf19ff3d25ca191a829c1697cd10c09745ef1e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0588786ffd9d3169df7d82729398a327e5e7bbfedf9be82a7827a6e309f7ecb7e5d0b1b768217d9b3f33dd9b5231010cf0726ab7d32bac9ba305a89222755277"} 17:18:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:43 INFO - Contents: 17:18:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/391ca5147a3d0b33ec1e8f6aad28ed06887391b1b0f93eca7d57a6d54697624763d2a70b755e9fe8fab3bb9aac20130a22a585ee3964741cb9f2d9623188def9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b4d0bd57df0788bb937f39beabc1987cdbc9c41189f3016d1cef2dfad42f530e6870489061b59a4eb7572fd1da2517f1870a3502e5eef06209b579b9c5ae2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af538faeff71bb963b2d95792cb51dc5626205565ddba743b6ffad837f1d0dddf886139eb9b15482ac6013885bf19ff3d25ca191a829c1697cd10c09745ef1e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0588786ffd9d3169df7d82729398a327e5e7bbfedf9be82a7827a6e309f7ecb7e5d0b1b768217d9b3f33dd9b5231010cf0726ab7d32bac9ba305a89222755277"} 17:18:43 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:43 INFO - Copying logs to upload dir... 17:18:43 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.401856 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-03-28 17:18:44.047480) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 17:18:44.051508) ========= 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.frd5cVByBV/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.t8EZv1gSNv/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/391ca5147a3d0b33ec1e8f6aad28ed06887391b1b0f93eca7d57a6d54697624763d2a70b755e9fe8fab3bb9aac20130a22a585ee3964741cb9f2d9623188def9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b4d0bd57df0788bb937f39beabc1987cdbc9c41189f3016d1cef2dfad42f530e6870489061b59a4eb7572fd1da2517f1870a3502e5eef06209b579b9c5ae2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af538faeff71bb963b2d95792cb51dc5626205565ddba743b6ffad837f1d0dddf886139eb9b15482ac6013885bf19ff3d25ca191a829c1697cd10c09745ef1e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0588786ffd9d3169df7d82729398a327e5e7bbfedf9be82a7827a6e309f7ecb7e5d0b1b768217d9b3f33dd9b5231010cf0726ab7d32bac9ba305a89222755277"} build_url:https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011030 build_url: 'https://queue.taskcluster.net/v1/task/EiAgoftcSaCY-mEmDAFLSA/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/391ca5147a3d0b33ec1e8f6aad28ed06887391b1b0f93eca7d57a6d54697624763d2a70b755e9fe8fab3bb9aac20130a22a585ee3964741cb9f2d9623188def9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b4d0bd57df0788bb937f39beabc1987cdbc9c41189f3016d1cef2dfad42f530e6870489061b59a4eb7572fd1da2517f1870a3502e5eef06209b579b9c5ae2b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/af538faeff71bb963b2d95792cb51dc5626205565ddba743b6ffad837f1d0dddf886139eb9b15482ac6013885bf19ff3d25ca191a829c1697cd10c09745ef1e6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0588786ffd9d3169df7d82729398a327e5e7bbfedf9be82a7827a6e309f7ecb7e5d0b1b768217d9b3f33dd9b5231010cf0726ab7d32bac9ba305a89222755277"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-28 17:18:44.092690) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 17:18:44.093512) ========= 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.frd5cVByBV/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.t8EZv1gSNv/Listeners TMPDIR=/var/folders/n3/6lv2w58n1hbdpjv4x880h_7c00000w/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.005230 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-28 17:18:44.147196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 17:18:44.147963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-28 17:18:44.148645) ========= ========= Total master_lag: 0.21 =========