builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0365 starttime: 1485912960.49 results: success (0) buildid: 20170131160608 builduid: deffccb8bc9b47bf987b492a69458a2b revision: 0d5fd88afc55a306466f7d98f895ea9181cc5526 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.491323) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.491757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.492045) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.516537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.516958) ========= 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.8XOqim274w/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.3aJbdPIYoD/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-01-31 17:36:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.82M=0.001s 2017-01-31 17:36:00 (7.82 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081564 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.622017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.622337) ========= 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.8XOqim274w/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.3aJbdPIYoD/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.019912 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.670730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:00.671087) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d5fd88afc55a306466f7d98f895ea9181cc5526 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0d5fd88afc55a306466f7d98f895ea9181cc5526 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8XOqim274w/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.3aJbdPIYoD/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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-01-31 17:36:00,763 truncating revision to first 12 chars 2017-01-31 17:36:00,763 Setting DEBUG logging. 2017-01-31 17:36:00,763 attempt 1/10 2017-01-31 17:36:00,763 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0d5fd88afc55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 17:36:01,236 unpacking tar archive at: mozilla-aurora-0d5fd88afc55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.731434 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:01.425582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:01.425951) ========= script_repo_revision: 0d5fd88afc55a306466f7d98f895ea9181cc5526 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:01.426404) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:01.426663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 17:36:01.446267) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-31 17:36:01.446647) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8XOqim274w/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.3aJbdPIYoD/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:01 INFO - MultiFileLogger online at 20170131 17:36:01 in /builds/slave/test 17:36:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:36:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:36:01 INFO - {'append_to_log': False, 17:36:01 INFO - 'base_work_dir': '/builds/slave/test', 17:36:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:36:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:36:01 INFO - 'branch': 'Mozilla-Aurora', 17:36:01 INFO - 'buildbot_json_path': 'buildprops.json', 17:36:01 INFO - 'config_files': ('talos/mac_config.py',), 17:36:01 INFO - 'default_actions': ('clobber', 17:36:01 INFO - 'read-buildbot-config', 17:36:01 INFO - 'download-and-extract', 17:36:01 INFO - 'populate-webroot', 17:36:01 INFO - 'create-virtualenv', 17:36:01 INFO - 'install', 17:36:01 INFO - 'run-tests'), 17:36:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:36:01 INFO - 'download_minidump_stackwalk': True, 17:36:01 INFO - 'download_symbols': 'ondemand', 17:36:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:36:01 INFO - 'tooltool.py': '/tools/tooltool.py', 17:36:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:36:01 INFO - '/tools/misc-python/virtualenv.py')}, 17:36:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:36:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:36:01 INFO - 'installer_path': 'installer.exe', 17:36:01 INFO - 'log_level': 'info', 17:36:01 INFO - 'log_name': 'talos', 17:36:01 INFO - 'log_to_console': True, 17:36:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:36:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:36:01 INFO - 'opt_config_files': (), 17:36:01 INFO - 'pip_index': False, 17:36:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:01 INFO - 'cmd': ('bash', 17:36:01 INFO - '-c', 17:36:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:01 INFO - 'enabled': True, 17:36:01 INFO - 'halt_on_failure': False, 17:36:01 INFO - 'name': 'check_screen_resolution'},), 17:36:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:36:01 INFO - 'cmd': ('bash', 17:36:01 INFO - '-c', 17:36:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:36:01 INFO - 'enabled': True, 17:36:01 INFO - 'halt_on_failure': False, 17:36:01 INFO - 'name': 'check_screen_resolution'},), 17:36:01 INFO - 'run_cmd_checks_enabled': True, 17:36:01 INFO - 'sps_profile': False, 17:36:01 INFO - 'sps_profile_interval': 0, 17:36:01 INFO - 'suite': 'dromaeojs', 17:36:01 INFO - 'system_bits': '32', 17:36:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:36:01 INFO - 'title': 't-yosemite-r7-0365', 17:36:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:36:01 INFO - 'use_talos_json': True, 17:36:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:36:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:36:01 INFO - 'work_dir': 'build'} 17:36:01 INFO - [mozharness: 2017-02-01 01:36:01.661694Z] Running clobber step. 17:36:01 INFO - Running pre-action listener: _resource_record_pre_action 17:36:01 INFO - Running main action method: clobber 17:36:01 INFO - rmtree: /builds/slave/test/build 17:36:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:36:02 INFO - Running post-action listener: _resource_record_post_action 17:36:02 INFO - [mozharness: 2017-02-01 01:36:02.558578Z] Finished clobber step (success) 17:36:02 INFO - [mozharness: 2017-02-01 01:36:02.558748Z] Running read-buildbot-config step. 17:36:02 INFO - Running pre-action listener: _resource_record_pre_action 17:36:02 INFO - Running main action method: read_buildbot_config 17:36:02 INFO - Using buildbot properties: 17:36:02 INFO - { 17:36:02 INFO - "project": "", 17:36:02 INFO - "product": "firefox", 17:36:02 INFO - "script_repo_revision": "production", 17:36:02 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 17:36:02 INFO - "repository": "", 17:36:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 17:36:02 INFO - "buildid": "20170131160608", 17:36:02 INFO - "pgo_build": "False", 17:36:02 INFO - "basedir": "/builds/slave/test", 17:36:02 INFO - "buildnumber": 3, 17:36:02 INFO - "slavename": "t-yosemite-r7-0365", 17:36:02 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 17:36:02 INFO - "platform": "yosemite_r7", 17:36:02 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:36:02 INFO - "branch": "mozilla-aurora", 17:36:02 INFO - "repo_path": "releases/mozilla-aurora", 17:36:02 INFO - "revision": "0d5fd88afc55a306466f7d98f895ea9181cc5526", 17:36:02 INFO - "stage_platform": "macosx64", 17:36:02 INFO - "builduid": "deffccb8bc9b47bf987b492a69458a2b", 17:36:02 INFO - "slavebuilddir": "test" 17:36:02 INFO - } 17:36:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 17:36:02 INFO - Running post-action listener: _resource_record_post_action 17:36:02 INFO - [mozharness: 2017-02-01 01:36:02.562129Z] Finished read-buildbot-config step (success) 17:36:02 INFO - [mozharness: 2017-02-01 01:36:02.562264Z] Running download-and-extract step. 17:36:02 INFO - Running pre-action listener: _resource_record_pre_action 17:36:02 INFO - Running main action method: download_and_extract 17:36:02 INFO - mkdir: /builds/slave/test/build/tests 17:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:02 INFO - trying https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 17:36:02 INFO - Downloading https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:36:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 17:36:03 INFO - Downloaded 1199 bytes. 17:36:03 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 17:36:03 INFO - Using the following test package requirements: 17:36:03 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:36:03 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 17:36:03 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 17:36:03 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'jsshell-mac.zip'], 17:36:03 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 17:36:03 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 17:36:03 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 17:36:03 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 17:36:03 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 17:36:03 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 17:36:03 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 17:36:03 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:36:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:36:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:36:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:36:04 INFO - Expected file size: 16353494 17:36:04 INFO - Obtained file size: 16353494 17:36:11 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:36:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 17:36:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:36:11 INFO - Fetch https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 17:36:12 INFO - Expected file size: 16353494 17:36:12 INFO - Obtained file size: 16353494 17:36:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 17:36:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:36:18 INFO - Fetch https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 17:36:19 INFO - Expected file size: 14403485 17:36:19 INFO - Obtained file size: 14403485 17:36:19 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')]} 17:36:19 INFO - trying https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:36:19 INFO - Downloading https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 17:36:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 17:36:21 INFO - Downloaded 73859162 bytes. 17:36:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:36:21 INFO - mkdir: /builds/slave/test/properties 17:36:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:21 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:21 INFO - Contents: 17:36:21 INFO - build_url:https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 17:36:22 INFO - Running post-action listener: _resource_record_post_action 17:36:22 INFO - Running post-action listener: set_extra_try_arguments 17:36:22 INFO - [mozharness: 2017-02-01 01:36:22.524535Z] Finished download-and-extract step (success) 17:36:22 INFO - [mozharness: 2017-02-01 01:36:22.524653Z] Running populate-webroot step. 17:36:22 INFO - Running pre-action listener: _resource_record_pre_action 17:36:22 INFO - Running main action method: populate_webroot 17:36:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:22 INFO - '--tppagecycles', 17:36:22 INFO - '7'], 17:36:22 INFO - 'tests': ['tsvgm']}}, 17:36:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:36:22 INFO - 'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:36:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:36:22 INFO - 'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['damp', 'tps']}, 17:36:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:36:22 INFO - 'tests': ['damp', 'tps']}, 17:36:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['dromaeo_dom']}, 17:36:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['basic_compositor_video']}, 17:36:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:36:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['a11yr', 17:36:22 INFO - 'ts_paint', 17:36:22 INFO - 'tpaint', 17:36:22 INFO - 'sessionrestore', 17:36:22 INFO - 'sessionrestore_no_auto_restore', 17:36:22 INFO - 'tabpaint']}, 17:36:22 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:22 INFO - 'ts_paint', 17:36:22 INFO - 'tpaint', 17:36:22 INFO - 'sessionrestore', 17:36:22 INFO - 'sessionrestore_no_auto_restore', 17:36:22 INFO - 'tabpaint']}, 17:36:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:22 INFO - 'ts_paint', 17:36:22 INFO - 'tpaint', 17:36:22 INFO - 'sessionrestore', 17:36:22 INFO - 'sessionrestore_no_auto_restore', 17:36:22 INFO - 'tabpaint']}, 17:36:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:22 INFO - 'ts_paint', 17:36:22 INFO - 'tpaint', 17:36:22 INFO - 'sessionrestore', 17:36:22 INFO - 'sessionrestore_no_auto_restore', 17:36:22 INFO - 'tabpaint']}, 17:36:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['a11yr', 17:36:22 INFO - 'ts_paint', 17:36:22 INFO - 'tpaint', 17:36:22 INFO - 'sessionrestore', 17:36:22 INFO - 'sessionrestore_no_auto_restore', 17:36:22 INFO - 'tabpaint']}, 17:36:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['a11yr', 17:36:22 INFO - 'ts_paint', 17:36:22 INFO - 'tpaint', 17:36:22 INFO - 'sessionrestore', 17:36:22 INFO - 'sessionrestore_no_auto_restore', 17:36:22 INFO - 'tabpaint']}, 17:36:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['tsvgx', 17:36:22 INFO - 'tsvgr_opacity', 17:36:22 INFO - 'tart', 17:36:22 INFO - 'tscrollx', 17:36:22 INFO - 'cart', 17:36:22 INFO - 'tsvg_static']}, 17:36:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:22 INFO - 'tsvgr_opacity', 17:36:22 INFO - 'tart', 17:36:22 INFO - 'tscrollx', 17:36:22 INFO - 'cart', 17:36:22 INFO - 'tsvg_static']}, 17:36:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:36:22 INFO - 'talos_options': ['--disable-e10s'], 17:36:22 INFO - 'tests': ['tp5o']}, 17:36:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:36:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:36:22 INFO - 'talos_options': ['--disable-e10s', 17:36:22 INFO - '--xperf_path', 17:36:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:22 INFO - 'tests': ['tp5n']}, 17:36:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:36:22 INFO - 'talos_options': ['--xperf_path', 17:36:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:22 INFO - 'tests': ['tp5n']}}, 17:36:22 INFO - 'talos.zip': {'path': '', 17:36:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:22 INFO - Running post-action listener: _resource_record_post_action 17:36:22 INFO - [mozharness: 2017-02-01 01:36:22.542868Z] Finished populate-webroot step (success) 17:36:22 INFO - [mozharness: 2017-02-01 01:36:22.542949Z] Running create-virtualenv step. 17:36:22 INFO - Running pre-action listener: _resource_record_pre_action 17:36:22 INFO - Running main action method: create_virtualenv 17:36:22 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:22 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 17:36:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:22 INFO - Using real prefix '/tools/python27' 17:36:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:23 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:26 INFO - Installing pip.................done. 17:36:26 INFO - Return code: 0 17:36:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:36:26 INFO - Reading from file tmpfile_stdout 17:36:26 INFO - Output received: 17:36:26 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) 17:36:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:26 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')]} 17:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:26 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')]} 17:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:26 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:26 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 17:36:26 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 17:36:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:26 INFO - 'HOME': '/Users/cltbld', 17:36:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:26 INFO - 'LOGNAME': 'cltbld', 17:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:26 INFO - 'MOZ_NO_REMOTE': '1', 17:36:26 INFO - 'NO_EM_RESTART': '1', 17:36:26 INFO - 'PAGER': '/bin/cat', 17:36:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:26 INFO - 'PWD': '/builds/slave/test', 17:36:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:26 INFO - 'SHELL': '/bin/bash', 17:36:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:26 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:26 INFO - 'USER': 'cltbld', 17:36:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:26 INFO - 'XPC_FLAGS': '0x0', 17:36:26 INFO - 'XPC_SERVICE_NAME': '0', 17:36:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:27 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 17:36:27 INFO - Cleaning up... 17:36:27 INFO - Return code: 0 17:36:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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', '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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36: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', 'psutil>=3.1.1'] in /builds/slave/test/build 17:36: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 psutil>=3.1.1 17:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:27 INFO - 'HOME': '/Users/cltbld', 17:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:27 INFO - 'LOGNAME': 'cltbld', 17:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:27 INFO - 'MOZ_NO_REMOTE': '1', 17:36:27 INFO - 'NO_EM_RESTART': '1', 17:36:27 INFO - 'PAGER': '/bin/cat', 17:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:27 INFO - 'PWD': '/builds/slave/test', 17:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:27 INFO - 'SHELL': '/bin/bash', 17:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:27 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:27 INFO - 'USER': 'cltbld', 17:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:27 INFO - 'XPC_FLAGS': '0x0', 17:36:27 INFO - 'XPC_SERVICE_NAME': '0', 17:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:27 INFO - Downloading/unpacking psutil>=3.1.1 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:31 INFO - Installing collected packages: psutil 17:36:31 INFO - Running setup.py install for psutil 17:36:31 INFO - building 'psutil._psutil_osx' extension 17:36:31 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 17:36:31 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 17:36:31 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 17:36:31 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 17:36:31 INFO - building 'psutil._psutil_posix' extension 17:36:31 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 17:36:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:36:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:36:31 INFO - ^ 17:36:31 INFO - 1 warning generated. 17:36:31 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 17:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:31 INFO - Successfully installed psutil 17:36:31 INFO - Cleaning up... 17:36:32 INFO - Return code: 0 17:36:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:32 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:32 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 17:36:32 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 17:36:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:32 INFO - 'HOME': '/Users/cltbld', 17:36:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:32 INFO - 'LOGNAME': 'cltbld', 17:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:32 INFO - 'MOZ_NO_REMOTE': '1', 17:36:32 INFO - 'NO_EM_RESTART': '1', 17:36:32 INFO - 'PAGER': '/bin/cat', 17:36:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:32 INFO - 'PWD': '/builds/slave/test', 17:36:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:32 INFO - 'SHELL': '/bin/bash', 17:36:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:32 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:32 INFO - 'USER': 'cltbld', 17:36:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:32 INFO - 'XPC_FLAGS': '0x0', 17:36:32 INFO - 'XPC_SERVICE_NAME': '0', 17:36:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:36:35 INFO - Installing collected packages: mozsystemmonitor 17:36:35 INFO - Running setup.py install for mozsystemmonitor 17:36:35 INFO - Successfully installed mozsystemmonitor 17:36:35 INFO - Cleaning up... 17:36:35 INFO - Return code: 0 17:36:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:36:35 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')]} 17:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:35 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')]} 17:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:35 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:35 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 17:36:35 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 17:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:35 INFO - 'HOME': '/Users/cltbld', 17:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:35 INFO - 'LOGNAME': 'cltbld', 17:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:35 INFO - 'MOZ_NO_REMOTE': '1', 17:36:35 INFO - 'NO_EM_RESTART': '1', 17:36:35 INFO - 'PAGER': '/bin/cat', 17:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:35 INFO - 'PWD': '/builds/slave/test', 17:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:35 INFO - 'SHELL': '/bin/bash', 17:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:35 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:35 INFO - 'USER': 'cltbld', 17:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:35 INFO - 'XPC_FLAGS': '0x0', 17:36:35 INFO - 'XPC_SERVICE_NAME': '0', 17:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:35 INFO - Downloading/unpacking jsonschema==2.5.1 17:36:35 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 17:36:35 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 17:36:35 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 17:36:35 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 17:36:35 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 17:36:35 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 17:36:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:36:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:36:38 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 17:36:38 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 17:36:38 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 17:36:38 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 17:36:38 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 17:36:38 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 17:36:38 INFO - Downloading functools32-3.2.3-2.tar.gz 17:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:36:38 INFO - warning: no files found matching '*.txt' 17:36:38 INFO - no previously-included directories found matching 'build' 17:36:38 INFO - no previously-included directories found matching 'dist' 17:36:38 INFO - no previously-included directories found matching '.git*' 17:36:38 INFO - Installing collected packages: jsonschema, functools32 17:36:38 INFO - Running setup.py install for functools32 17:36:38 INFO - warning: no files found matching '*.txt' 17:36:38 INFO - no previously-included directories found matching 'build' 17:36:38 INFO - no previously-included directories found matching 'dist' 17:36:38 INFO - no previously-included directories found matching '.git*' 17:36:38 INFO - Successfully installed jsonschema functools32 17:36:38 INFO - Cleaning up... 17:36:38 INFO - Return code: 0 17:36:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:38 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:38 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 17:36:38 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 17:36:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:38 INFO - 'HOME': '/Users/cltbld', 17:36:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:38 INFO - 'LOGNAME': 'cltbld', 17:36:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:38 INFO - 'MOZ_NO_REMOTE': '1', 17:36:38 INFO - 'NO_EM_RESTART': '1', 17:36:38 INFO - 'PAGER': '/bin/cat', 17:36:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:38 INFO - 'PWD': '/builds/slave/test', 17:36:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:38 INFO - 'SHELL': '/bin/bash', 17:36:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:38 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:38 INFO - 'USER': 'cltbld', 17:36:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:38 INFO - 'XPC_FLAGS': '0x0', 17:36:38 INFO - 'XPC_SERVICE_NAME': '0', 17:36:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:36:39 INFO - Cleaning up... 17:36:39 INFO - Return code: 0 17:36:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36:39 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')]} 17:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:39 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')]} 17:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:39 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:39 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 17:36:39 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 17:36:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:39 INFO - 'HOME': '/Users/cltbld', 17:36:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:39 INFO - 'LOGNAME': 'cltbld', 17:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:39 INFO - 'MOZ_NO_REMOTE': '1', 17:36:39 INFO - 'NO_EM_RESTART': '1', 17:36:39 INFO - 'PAGER': '/bin/cat', 17:36:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:39 INFO - 'PWD': '/builds/slave/test', 17:36:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:39 INFO - 'SHELL': '/bin/bash', 17:36:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:39 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:39 INFO - 'USER': 'cltbld', 17:36:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:39 INFO - 'XPC_FLAGS': '0x0', 17:36:39 INFO - 'XPC_SERVICE_NAME': '0', 17:36:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:39 INFO - Downloading/unpacking blobuploader==1.2.4 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36:41 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:42 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 17:36:42 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 17:36:42 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 17:36:42 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 17:36:42 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 17:36:42 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 17:36:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:42 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 17:36:42 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 17:36:42 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 17:36:42 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 17:36:42 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 17:36:42 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 17:36:43 INFO - Downloading docopt-0.6.1.tar.gz 17:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:43 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:43 INFO - Running setup.py install for blobuploader 17:36:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:43 INFO - Running setup.py install for requests 17:36:43 INFO - Running setup.py install for docopt 17:36:44 INFO - Successfully installed blobuploader requests docopt 17:36:44 INFO - Cleaning up... 17:36:44 INFO - Return code: 0 17:36:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:44 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:44 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 17:36:44 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 17:36:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:44 INFO - 'HOME': '/Users/cltbld', 17:36:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:44 INFO - 'LOGNAME': 'cltbld', 17:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:44 INFO - 'MOZ_NO_REMOTE': '1', 17:36:44 INFO - 'NO_EM_RESTART': '1', 17:36:44 INFO - 'PAGER': '/bin/cat', 17:36:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:44 INFO - 'PWD': '/builds/slave/test', 17:36:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:44 INFO - 'SHELL': '/bin/bash', 17:36:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:44 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:44 INFO - 'USER': 'cltbld', 17:36:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:44 INFO - 'XPC_FLAGS': '0x0', 17:36:44 INFO - 'XPC_SERVICE_NAME': '0', 17:36:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:44 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-PUG60o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:44 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-8mVfOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:44 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HgSFXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:44 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-s2IWNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:44 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-2HceCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:44 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-GnoxUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-5U8PT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-p6BllW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Sg5bSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Gxpocv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-HgBAFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0m2pQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-vtZhN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-0ySMxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:45 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-2ba9NM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:46 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-rQRZk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:46 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-Db_QjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:46 INFO - Running setup.py install for manifestparser 17:36:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:46 INFO - Running setup.py install for mozcrash 17:36:46 INFO - Running setup.py install for mozdebug 17:36:46 INFO - Running setup.py install for mozdevice 17:36:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:46 INFO - Running setup.py install for mozfile 17:36:47 INFO - Running setup.py install for mozhttpd 17:36:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Running setup.py install for mozinfo 17:36:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Running setup.py install for mozInstall 17:36:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Running setup.py install for mozleak 17:36:47 INFO - Running setup.py install for mozlog 17:36:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Running setup.py install for moznetwork 17:36:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:36:47 INFO - Running setup.py install for mozprocess 17:36:48 INFO - Running setup.py install for mozprofile 17:36:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:36:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:36:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:36:48 INFO - Running setup.py install for mozrunner 17:36:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:36:48 INFO - Running setup.py install for mozscreenshot 17:36:48 INFO - Running setup.py install for moztest 17:36:48 INFO - Running setup.py install for mozversion 17:36:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:36:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:36:48 INFO - Cleaning up... 17:36:48 INFO - Return code: 0 17:36:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:48 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')]} 17:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:48 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')]} 17:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:48 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:48 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 17:36:48 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 17:36:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:48 INFO - 'HOME': '/Users/cltbld', 17:36:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:48 INFO - 'LOGNAME': 'cltbld', 17:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:48 INFO - 'MOZ_NO_REMOTE': '1', 17:36:48 INFO - 'NO_EM_RESTART': '1', 17:36:48 INFO - 'PAGER': '/bin/cat', 17:36:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:48 INFO - 'PWD': '/builds/slave/test', 17:36:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:48 INFO - 'SHELL': '/bin/bash', 17:36:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:48 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:48 INFO - 'USER': 'cltbld', 17:36:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:48 INFO - 'XPC_FLAGS': '0x0', 17:36:48 INFO - 'XPC_SERVICE_NAME': '0', 17:36:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-J8ntJ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:49 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)) 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-yprM3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:49 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)) 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-vjUq1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:49 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)) 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-sdEDNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:49 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)) 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-O27mpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:49 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)) 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-SFEx9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:49 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)) 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-l7icTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:49 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)) 17:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:49 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-uRMAv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-TPbNOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-7toxAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-RVvhRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-U3Pvfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-pRSoTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-TjU0OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-IWz4rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-L_jFWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:50 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)) 17:36:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:50 INFO - Running setup.py (path:/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/pip-kPU2mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:50 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)) 17:36:50 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)) 17:36:50 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)) 17:36:50 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)) 17:36:50 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)) 17:36:50 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)) 17:36:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36:51 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 17:36:51 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 17:36:51 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 17:36:51 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 17:36:51 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 17:36:51 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 17:36:53 INFO - Downloading blessings-1.6.tar.gz 17:36:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:36:53 INFO - Installing collected packages: blessings 17:36:53 INFO - Running setup.py install for blessings 17:36:53 INFO - Successfully installed blessings 17:36:53 INFO - Cleaning up... 17:36:53 INFO - Return code: 0 17:36:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:36:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:54 INFO - Reading from file tmpfile_stdout 17:36:54 INFO - Current package versions: 17:36:54 INFO - blessings == 1.6 17:36:54 INFO - blobuploader == 1.2.4 17:36:54 INFO - docopt == 0.6.1 17:36:54 INFO - functools32 == 3.2.3-2 17:36:54 INFO - jsonschema == 2.5.1 17:36:54 INFO - manifestparser == 1.1 17:36:54 INFO - mozInstall == 1.12 17:36:54 INFO - mozcrash == 1.0 17:36:54 INFO - mozdebug == 0.1 17:36:54 INFO - mozdevice == 0.49 17:36:54 INFO - mozfile == 1.2 17:36:54 INFO - mozhttpd == 0.7 17:36:54 INFO - mozinfo == 0.9 17:36:54 INFO - mozleak == 0.1 17:36:54 INFO - mozlog == 3.4 17:36:54 INFO - moznetwork == 0.27 17:36:54 INFO - mozprocess == 0.24 17:36:54 INFO - mozprofile == 0.28 17:36:54 INFO - mozrunner == 6.13 17:36:54 INFO - mozscreenshot == 0.1 17:36:54 INFO - mozsystemmonitor == 0.3 17:36:54 INFO - moztest == 0.8 17:36:54 INFO - mozversion == 1.4 17:36:54 INFO - psutil == 3.1.1 17:36:54 INFO - requests == 1.2.3 17:36:54 INFO - wsgiref == 0.1.2 17:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:54 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 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:54 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 17:36:54 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 17:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:54 INFO - 'HOME': '/Users/cltbld', 17:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:54 INFO - 'LOGNAME': 'cltbld', 17:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:54 INFO - 'MOZ_NO_REMOTE': '1', 17:36:54 INFO - 'NO_EM_RESTART': '1', 17:36:54 INFO - 'PAGER': '/bin/cat', 17:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:54 INFO - 'PWD': '/builds/slave/test', 17:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:54 INFO - 'SHELL': '/bin/bash', 17:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:54 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:54 INFO - 'USER': 'cltbld', 17:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:54 INFO - 'XPC_FLAGS': '0x0', 17:36:54 INFO - 'XPC_SERVICE_NAME': '0', 17:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 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)) 17:36:54 INFO - Cleaning up... 17:36:54 INFO - Return code: 0 17:36:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d639b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d63c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff42bd687a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, '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.8XOqim274w/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.3aJbdPIYoD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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 17:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:36:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:36:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:54 INFO - 'HOME': '/Users/cltbld', 17:36:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:54 INFO - 'LOGNAME': 'cltbld', 17:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:54 INFO - 'MOZ_NO_REMOTE': '1', 17:36:54 INFO - 'NO_EM_RESTART': '1', 17:36:54 INFO - 'PAGER': '/bin/cat', 17:36:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:54 INFO - 'PWD': '/builds/slave/test', 17:36:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:54 INFO - 'SHELL': '/bin/bash', 17:36:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:36:54 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:36:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:54 INFO - 'USER': 'cltbld', 17:36:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:54 INFO - 'XPC_FLAGS': '0x0', 17:36:54 INFO - 'XPC_SERVICE_NAME': '0', 17:36:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:36:54 INFO - Cleaning up... 17:36:54 INFO - Return code: 0 17:36:54 INFO - Running post-action listener: _resource_record_post_action 17:36:54 INFO - Running post-action listener: _start_resource_monitoring 17:36:54 INFO - Starting resource monitoring. 17:36:54 INFO - [mozharness: 2017-02-01 01:36:54.827233Z] Finished create-virtualenv step (success) 17:36:54 INFO - [mozharness: 2017-02-01 01:36:54.828168Z] Running install step. 17:36:54 INFO - Running pre-action listener: _resource_record_pre_action 17:36:54 INFO - Running main action method: install 17:36:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:55 INFO - Reading from file tmpfile_stdout 17:36:55 INFO - Detecting whether we're running mozinstall >=1.0... 17:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:36:55 INFO - Reading from file tmpfile_stdout 17:36:55 INFO - Output received: 17:36:55 INFO - Usage: mozinstall [options] installer 17:36:55 INFO - Options: 17:36:55 INFO - -h, --help show this help message and exit 17:36:55 INFO - -d DEST, --destination=DEST 17:36:55 INFO - Directory to install application into. [default: 17:36:55 INFO - "/builds/slave/test"] 17:36:55 INFO - --app=APP Application being installed. [default: firefox] 17:36:55 INFO - mkdir: /builds/slave/test/build/application 17:36:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:36:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:37:15 INFO - Reading from file tmpfile_stdout 17:37:15 INFO - Output received: 17:37:15 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:37:15 INFO - Running post-action listener: _resource_record_post_action 17:37:15 INFO - [mozharness: 2017-02-01 01:37:15.176148Z] Finished install step (success) 17:37:15 INFO - [mozharness: 2017-02-01 01:37:15.176288Z] Running run-tests step. 17:37:15 INFO - Running pre-action listener: _resource_record_pre_action 17:37:15 INFO - Running main action method: run_tests 17:37:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:15 INFO - 2017-01-31 17:37:15.190 screenresolution[1985:15646] starting screenresolution argv=screenresolution get 17:37:15 INFO - 2017-01-31 17:37:15.193 screenresolution[1985:15646] Display 0: 1600x1200x32@60 17:37:15 INFO - 2017-01-31 17:37:15.199 screenresolution[1986:15648] starting screenresolution argv=screenresolution list 17:37:15 INFO - Available Modes on Display 0 17:37:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:15 INFO - Intel Iris: 17:37:15 INFO - Chipset Model: Intel Iris 17:37:15 INFO - Type: GPU 17:37:15 INFO - Bus: Built-In 17:37:15 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:15 INFO - Vendor: Intel (0x8086) 17:37:15 INFO - Device ID: 0x0a2e 17:37:15 INFO - Revision ID: 0x0009 17:37:15 INFO - Displays: 17:37:15 INFO - Display: 17:37:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:15 INFO - Display Serial Number: 1600x1200 60 17:37:15 INFO - Main Display: Yes 17:37:15 INFO - Mirror: Off 17:37:15 INFO - Online: Yes 17:37:15 INFO - Rotation: Supported 17:37:15 INFO - Return code: 0 17:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:37:15 INFO - Python 2.7.3 17:37:15 INFO - Return code: 0 17:37:15 INFO - grabbing minidump binary from tooltool 17:37: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')]} 17:37:15 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 0x10d417d30>, '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 0x10d33edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d40cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:37:15 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 17:37:15 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 17:37:15 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 17:37:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:37:15 INFO - Return code: 0 17:37:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:37:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:37:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:37:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:37:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 17:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0365 --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 17:37:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8XOqim274w/Render', 17:37:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:37:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:37:15 INFO - 'HOME': '/Users/cltbld', 17:37:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:37:15 INFO - 'LOGNAME': 'cltbld', 17:37:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:37:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:37:15 INFO - 'MOZ_NO_REMOTE': '1', 17:37:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:37:15 INFO - 'NO_EM_RESTART': '1', 17:37:15 INFO - 'PAGER': '/bin/cat', 17:37:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:37:15 INFO - 'PWD': '/builds/slave/test', 17:37:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:37:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:37:15 INFO - 'SHELL': '/bin/bash', 17:37:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3aJbdPIYoD/Listeners', 17:37:15 INFO - 'TMPDIR': '/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/', 17:37:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:37:15 INFO - 'USER': 'cltbld', 17:37:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:37:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:37:15 INFO - 'XPC_FLAGS': '0x0', 17:37:15 INFO - 'XPC_SERVICE_NAME': '0', 17:37:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:37:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0365', '--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 17:37:15 INFO - mozversion application_buildid: 20170131160608 17:37:15 INFO - mozversion application_changeset: 0d5fd88afc55a306466f7d98f895ea9181cc5526 17:37:15 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:37:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:37:15 INFO - mozversion application_name: Firefox 17:37:15 INFO - mozversion application_remotingname: firefox-dev 17:37:15 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:37:15 INFO - mozversion application_vendor: Mozilla 17:37:15 INFO - mozversion application_version: 53.0a2 17:37:15 INFO - mozversion platform_buildid: 20170131160608 17:37:15 INFO - mozversion platform_changeset: 0d5fd88afc55a306466f7d98f895ea9181cc5526 17:37:15 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:37:15 INFO - mozversion platform_version: 53.0a2 17:37:15 INFO - using testdate: 1485913035 17:37:15 INFO - actual date: 1485913035 17:37:15 INFO - starting webserver on 'localhost:52431' 17:37:15 INFO - SUITE-START | Running 2 tests 17:37:15 INFO - TEST-START | dromaeo_css 17:37:15 INFO - operating with platform_type : mac_ 17:37:15 INFO - Initialising browser for dromaeo_css test... 17:37:15 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpb80JBe/profile http://localhost:52431/getInfo.html) 17:37:18 INFO - PROCESS | 1996 | __metrics Screen width/height:1600/1200 17:37:18 INFO - PROCESS | 1996 | colorDepth:24 17:37:18 INFO - PROCESS | 1996 | Browser inner width/height: 1024/689 17:37:18 INFO - PROCESS | 1996 | __metrics 17:37:18 INFO - PROCESS | 1996 | 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:37:18 INFO - PROCESS | 1996 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:37:18 INFO - TEST-INFO | 1996: exit 0 17:37:18 INFO - Browser initialized. 17:37:18 INFO - Running cycle 1/1 for dromaeo_css test... 17:37:18 INFO - TEST-INFO | started process 1998 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpb80JBe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:31 INFO - PROCESS | 1998 | RSS: Main: 232226816 17:37:31 INFO - PROCESS | 1998 | 17:40:34 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:52431/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52431/tests/dromaeo/cssquery-ext.html) 17:40:36 INFO - PROCESS | 1998 | RSS: Main: 373530624 17:40:36 INFO - PROCESS | 1998 | 17:42:20 INFO - PROCESS | 1998 | ************************* 17:42:20 INFO - PROCESS | 1998 | A coding exception was thrown and uncaught in a Task. 17:42:20 INFO - PROCESS | 1998 | 17:42:20 ERROR - PROCESS | 1998 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:42:20 INFO - PROCESS | 1998 | Full stack: 17:42:20 INFO - PROCESS | 1998 | ************************* 17:43:39 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:52431/tests/dromaeo/cssquery-ext.html (next: http://localhost:52431/tests/dromaeo/cssquery-jquery.html) 17:43:39 INFO - PROCESS | 1998 | RSS: Main: 363872256 17:43:39 INFO - PROCESS | 1998 | 17:46:42 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:52431/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52431/tests/dromaeo/cssquery-mootools.html) 17:46:42 INFO - PROCESS | 1998 | RSS: Main: 353144832 17:46:42 INFO - PROCESS | 1998 | 17:49:45 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:52431/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52431/tests/dromaeo/cssquery-prototype.html) 17:49:45 INFO - PROCESS | 1998 | RSS: Main: 346279936 17:49:45 INFO - PROCESS | 1998 | 17:52:49 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:52431/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52431/tests/dromaeo/cssquery-yui.html) 17:52:50 INFO - PROCESS | 1998 | RSS: Main: 325476352 17:52:50 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | Cycle 1(1): loaded http://localhost:52431/tests/dromaeo/cssquery-yui.html (next: http://localhost:52431/tests/dromaeo/cssquery-dojo.html) 17:55:53 INFO - PROCESS | 1998 | RSS: Main: 425996288 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | __start_tp_report 17:55:53 INFO - PROCESS | 1998 | _x_x_mozilla_page_load 17:55:53 INFO - PROCESS | 1998 | _x_x_mozilla_page_load_details 17:55:53 INFO - PROCESS | 1998 | |i|pagename|runs| 17:55:53 INFO - PROCESS | 1998 | |0;dojo.html;3265.856950067476;3274.3778682050415;3298.934021319575;3330.317284956584;3359.6976272135516;5669.291338582677;5717.3710891801975;5720.113382425726;5734.512566431858;5741.827745167647;5646.943530564703;5717.199592057105;5727.2268243787075;5728.198052272685;5734.79928202513;5169.3279873616375;5223.242629818684;5227.921581176285;5230.973845130788;5266.420693723688;4258.829646814123;5138.203578445347;5283.392409872856;5307.973460132694;5340.519353258206;5206.5834733221445;5243.528082472577;5251.606129540281;5257.185136303879;5272.024675435037;5252.65857719247;5255.710935898524;5262.684238945637;5265.236540701577;5271.525562699337;5084.44071152173;5197.454267301917;5214.322138122057;5215.504527069922;5237.926225123841;5745.7127143643065;5758.395368486333;5764.74058667361;5769.221155144086;5774.220480235199;6150.784722534735;6183.319834818167;6194.845128871769;6268.49852011838;6275.403836635513;6333.334999825044;6334.968325158345;6337.112804207414;6340.175777148987;6354.046892966092;5668;5763.308402991668;5789.363170051291;5808.97095514524;5843.211166492511;5309.36287645485;6226.1905952225925;6303.401176888188;6311.368863113652;6320.652364119926;6224.813255602339;6224.844378890564;6235.812925612239;6238.438540531374;6244.406781355764;6310.905336419957;6321.304656487782;6324.33594472583;6327.303996560375;6334.683265836689;6076.787312444132;6117.632942023492;6121.693915304217;6153.876922461525;6165.907511387333;6275.152854364694;6275.403836635513;6287.182666253358;6306.1171435998995;6331.746730130743;4956.553910148104;4996.525330093636;5001;5009.89980200394;5032.84901452957;4362.760048197316;4405.118976204772;4413.073254616566;4419.64642828573;4472.195004899149;5764.481196692318;5779.8555036124435;5811.0411782056335;5875.383084776037;5904.911426328608;6280.120783090371;6287.748490060438;6311;6312.274088479791;6315.052742088632;5784.797532086357;5838.153467747153;5844.912326315109;5848.444397782204;5897.115432685046;5346.893062138735;5412.83761487156;5423.674579525162;5430.375506816687;5492.038893193675;6246.1255424239735;6324.968375158095;6336.1762970814425;6397.552171347961;6424.9036264455135;6206.286277078013;6246.812595622138;6261.029540421242;6277.1525844010475;6292.465140463112;6227.439530442282;6314.652694101868;6323.114763933145;6332.778352757631;6341.0805433212845;6079.209702738793;6100.786472473442;6135.969320153549;6151.507879369729;6215.316315205414;6309.558330916791;6324.968375158279;6335.271443784024;6337.176167098432;6345.397187267202;6172.8765424690355;6181.84545386369;6184.381561843779;6207.348228435949;6228.22147231596;5903.527717782481;5941.22764040672;6055.818325450244;6147.385261473817;6168.660723660062;5919.970400147971;5951.315598706205;6016.939830601638;6048;6068.120122582112;5984.760609575568;6088.178095957166;6111.297200821785;6151.477124444294;6160.876782464416;5152.330197074356;5757.3954734753925;5800.4489573490455;5907.17299578068;5998.520118390606 17:55:53 INFO - PROCESS | 1998 | |1;ext.html;422.8921624985629;461.74142480211066;462.0435698104922;473.07749887718956;512.825639282644;30661.69338306619;39585;41392.379114313306;41434.37848432276;41551.79224103883;42649.7867510662;42794.35808462876;43004.13991720171;43058.784706076425;43153.56846431535;8426.873596896052;9208.12522810332;9398.765030874249;9412.952935235315;9424.858627120599;8590.613422396007;11084.61203857865;11308.773824523505;11359.091272698206;11501.827472587918;11153.553857845716;11233.887661123366;11240.49417776202;11285.984261416472;11309.377984210865;8471.49171049739;8801.559922003875;9445.622175112987;11033.282836615675;11333.320000799937;10986;11233.550657973672;11248.943755281252;11252.437378131142;11278.379689117095;40012.19975600472;40633.59366406328;40960.795196024126;40987;41015.794921025205;3979.162432899971;3985.342418500944;3998.5801490843623;4012.4382586437923;4090.8363665453644;29165.125046248435;29273.85363073171;29725;30527.08821077532;31205;3087.4442600332154;3163.335699503107;3212.8433763844996;3327.866885324584;3402.2344972381266;396640;470845;470931.6453417745;471709;471901;63133.36866631367;64164.35835641677;64224.036639450445;64252.39369015719;64283.678581607724;55040;65815.67092164508;66151.66924165348;66170.66914665492;66537.66731166313;16258.187090645657;16352.83647163537;16536.586585335222;16565.503034908972;16578.6684266314;11498.022668073307;11894.405279735978;11901;12918;12929.288889111001;15368.848361229437;15499.92250038765;15526.1460619667;18956.93761375521;21644.35066947994;7206.0543653213335;8554.78613034679;8726.825463490695;8780.912190878009;8854.38019338653;852.3394369363792;888.3293113699116;901.6528636475005;917.8714979902819;926.2034650200821;30215.546766798514;30445.54331684982;30535.64107948124;31050.53424198639;31273.90541331088;1062.198040479433;1069.1500257295468;1101.8787933327328;1106.3527836215903;1213.9802565844557;15134.470293539673;15603.06381617084;15704.214789260492;15756.527304180892;15933.840661593467;607997;609419;611436;612110;613853;51040.97918041619;61320.38679613236;61936.451588710646;62049.37950620526;62175;1444.5377479206763;1452.0343971258994;1469.3755154059695;1471.2864260833487;1478.1796103162633;27982.02062927788;29823.70176298296;29956.850215748782;30493.847530762203;30597.388052239276;52281.47718522766;52649.210261845335;52662.736686316326;52715.94568108693;52757.47242527526;586076;590158;591020;591311;591417;25143.87428062921;26080.8695956519;42623.78688106663;43563.78218108889;43588.34617480677;41663;43070.56929430665;43129;43247;43300.35049474324;29683;35334.29331413306;35903.28193436169;36755.26489470249;37107.628923710414;35482.64517354897;35558.28883422265;35614.465783013795;36775.632243677224;36840.81579592085;35334.29331413409;35504;35769;36449.635503644626;36545.63454365529;30622.234444138183;32179.678203217667;32439.837800810845;32500.699972000853;32725.836370817993;20662.483437914172;23735.406614834767;23847.165349212693;23972.28083157508;24694.292633683574 17:55:53 INFO - PROCESS | 1998 | |2;jquery.html;368.97417180797356;387.821602063051;388.3921662598034;398.6153362005664;419.270469383273;15480.225988700562;15534.378624855006;18656.62686746264;21512.677309840365;21600.81195534245;20664.173433062697;20968;21127;21363.786362136372;21651.6752248716;5722.713864306778;5785.595008349417;5906.202662640531;5912.526997840184;5956.493698035651;5816.709164541777;5948.553858460611;5959.940400595982;5975.342712301644;5976.611520251192;4196.496420429553;4405.7356558606425;4413.161499315136;4470.396496472967;6544.541882068257;6587.703553340111;6602.7689030883685;6606.471482281454;6617.602943823338;6622.801315960529;5265.4997775211295;5505.476979686963;5540;5580.469855363734;5611.8877622447735;13422.194668319835;13444.86555134446;13446.058775885693;13626.93186534061;13639.727205455836;2590.417156139872;2613.2552222616464;2618.3454136465884;2626.4484458263787;2635.117235726034;10053.849192262049;10385.32495387805;10403.323783954094;12375.814362784566;15128.092314461168;1810.3663717698832;1843.317972350239;1846.4368367647862;1847.5935294235246;1852.5646473078816;113954;114729;115145;116066.41966790112;116707;9855.901440985499;10614.097801686788;11737;12027.759444811054;12048.915597596259;15954.521364359089;15985.680286394207;15988.200589970687;15989.28048237832;16084.597885052968;8681.696140635173;8824.161704638049;8904.643814247358;8906.777330566658;9027.368084234173;8722;8737.563121843883;8738.86891696625;8855.468671879707;8884.578467445177;4019.457373254573;4691.319758634979;4811.08589368019;4850.805967761321;4938.481459446778;1722.5435259656201;1744.7121224997986;2003.24878170686;2023.8077382648626;2047.5597746484577;951.5527701980059;962.6101428921298;1000.214831357381;1009.2228983682523;1033.1992705653179;19094.61810763805;19538.70691939622;20859;21414.92925353757;21486.35842186649;981.9018098190123;984.8375018122073;988.6687959533493;989.351974456732;1003.9247056470793;10460;10816.621418250481;10819.945900270448;10898.455077246106;10966.835497467544;403070;473175;621062;718086;740217;108380;130036;134793;149907;157605.27184184492;942.8444306689456;945.3996712087874;976.799756050008;976.9902300977042;980.1962390839585;18413.07934603291;18642.906785465984;18644.533886652942;18809.153588088844;18903.716444253623;61299.77400452055;61574.460638484394;62423.38189562961;62509;63427;87218.56390718005;87466.56266718626;89625;91066;91368.54315728378;8326.875096873431;8436.957815210884;8486.108958559262;8679.305655547667;8693.565321734015;11414.657560273205;12981.805272921103;13550.254735989614;13657.248851313274;13785.862141378459;11256.662300131009;11470.025047870691;11509.309441433541;11760;11916.76166476683;10880;11087.390193539433;11138.498767555317;11168.776624467628;11551;9946;11020.834687479855;11197.216194866282;11584.652460426201;11886.643400697993;7505;7524.924750752422;7639.159692433939;7905.090914544901;7956.801079972815;8877.644894204417;11331.943340283246;11421.972022518014;11582.247153934968;11584.362860042778 17:55:53 INFO - PROCESS | 1998 | |3;mootools.html;1259.1815320041974;1434.849340819214;1444.689391780767;1450.6300893272214;1454.8981571290008;7861.68553257869;8132.105468398471;8259.91740082599;8268.875966860502;8272.090070092292;7338.522996005256;7636.923630763691;7645.15903250642;7887.5661838599;8054.838903221932;2289.2788771536952;2316.177756896303;2318.466752646892;2325.244295603927;2326.336993956723;2314.3404129823;2335.7781010804033;2353.752855950126;2357.316378250305;2358.610829213186;2035.2266138867283;2115.1116531056914;2216.9113235470563;2304.158981971585;2304.8040916522114;1947.6755806051879;2304.9654255186188;2306.550222706573;2307.2962746362355;2311.433698743802;2221.533477969628;2330.9184178553837;2337.146941366406;2340.0756701103137;2341.484873327865;8218.753437396888;8276.379271554657;8297.377696672773;8308.667653293862;8313.667453301861;5072.746362681851;5205.9219111713355;5208.973955130238;5211.218317252443;5217.373915130171;3330.9500357494658;3393.5079413484905;3492.266624008961;3572.285542891432;3577.266660334625;1207.1911819081236;1224.7611715715439;1258.704204511939;1269.9426928375997;1282.076904628666;10787.946060269727;10847.67456976292;10856.674299771019;10866.348019118957;10892.183086268482;4398.8020539075815;4652.069586082797;4678.859634210911;4689.62483001359;4712.575868171881;9216.308776841764;9370.578323975302;9372.718818435458;9373.203277721334;9388.530573471437;5199.48005199477;5204.141316682705;5206.140986737221;5214.983078299695;5222.373315202124;4247.235497610398;4367.10474352757;4611.031683346535;4708.411448568929;4756.096341695067;3774.5281839770028;3816.5420149581673;3886.2810380079777;3896.5518965318784;3902.180542086137;1247.1020864977202;1256.4848412150975;1259.2633309513853;1265.4305562496913;1266.2845492296822;913.4199783137756;914.2049948022532;922.5341202692597;928.8374534456443;964.5514835601339;5524.309461317335;5620.5503559715125;5759.992001399738;5793.913091303634;5795.797147099831;977.519058626182;990.138579435881;1029.2435060230725;1033.3180101133366;1056.6882769582992;3695.279420512974;3841.539015318124;3846.0961674006585;3912.882613521599;3943.960560394359;9487.715368538817;9791.902080979242;9806.16647584949;9824.705258842247;9861.211103111735;9614.759631009281;9654.517274136266;9690.660826871026;9698.224142068617;9798.46108464027;7465.514741541891;7619;7758.7672369829;7787.688492460238;7795.376369890395;5611.354694210055;5692.288463942007;5730.598858079894;5825.621334613236;5879.441453061952;7616.504927179715;8867.068957759342;9281.211097056826;9295.07049295065;9306.72079837606;6774.254831968381;9182.908170918205;9196.586153623237;9287.814243715224;9323;6546.116274302908;6761.492888033516;6762.425193858577;7051.6474176292;7208.855822883618;7555.8866616999685;7710.460267781202;7862.960685196537;7927.484713493604;7934.1272460030505;7007.528419032061;7173.892391614234;7174.533655312388;7236.095488063992;7278.308560686726;7004.649767511706;7123;7192.964035179791;7256.984022236997;7366;6303.653299068412;6318.810435686937;6411.743530258737;6457.838554036187;6465.806025819233;4977.054359671651;4996.601120389816;5046.747662616781;5082.2122571001555;5150.381954165524;4959.528844759742;4972.22930445767;5103.540681338697;5173.92239116406;5190.247414124855 17:55:53 INFO - PROCESS | 1998 | |4;prototype.html;279.40765576976804;351.6501081423983;359.36571950507357;362.2501422056343;363.8853761065263;4704.541592106445;4985.7008579485255;5170.379554453461;5198.558122559582;5330.653507522008;4792.6165906727465;5092.414372347182;5141.922871156927;5160.251763494301;5170.767315470804;4096.856610018643;4123.546489838556;4123.917521649565;4139.482564679415;4149.5228048774325;3320.1367644412508;3646.9270614587695;4021.391443422625;4156.334986402177;4156.688248381383;3553.893383198508;3594.97543200188;4080.5307389650275;4102.548719640837;4132.586741325858;3885.669718073953;4089.3661482470266;4096.795160241976;4101.282275601788;4113.465249517573;3299.1092405050504;3444;3633.6729694327637;3639.4722765199162;3656.0859785053735;3926.6466018058227;4856.490068542787;5113;5114.488551144893;5129.512696293883;3959.40608908666;4662.347271382009;4689.6717229793585;4695.272232803921;4711.623070154414;5005.599552035865;5302.469753024667;5450;5457.863553411157;5475.479829416199;3518.384282750534;3645.2345007548183;3778.943315850237;3846.961530384688;4049.8457939487103;5076.822311219164;5763.032038500134;5804.881218355312;5819.730305180983;5824.86434631408;3247.935041299208;3269.73842092632;3277.8688852445634;3849.5957924418094;3867.5165604299464;3897.4738410314244;3905.3556163232747;3911.438008104696;3916.1384495411535;3955.960440395559;4389.6927215095275;4394.890127746768;4421.7789110544345;4727.950471945576;4765.642576806753;5342.2787923630585;5587.681112338415;5591.496765291062;5634.661920284796;5651.321841379061;1245.7134858982304;1281.2952875918209;1329.5280175537546;1329.7340531893467;1363.12078709232;838.528382688378;915.9404638698463;930.464982634974;958.9020571445656;995.5520015992832;4445.82216711328;4920.384951881015;4937.333459982929;4946.752662366867;4985.302057711923;4283.357496375506;4705.435347758223;5395.163749618815;5447.945520544744;5487.42382049887;4109.712320137622;4182.344211425767;4573.268277075718;4947.678400903929;4956.975215123901;2551.502457020863;2616.123598594454;2835.659720833472;2851.146754609479;2871.9282017949718;4710.26990816424;4929.827456039022;4946.802127914843;5320.733963301819;5400.810971616053;5432.076546987022;5529.834104976857;5536.584756143225;5585.273914391103;5588.441155884379;4809.663323567387;5390.95678241319;5398.757055932414;5578.804741834017;5624.353199382123;4707.623390128713;4915.870668638361;5186;5387.7069503318135;5450.037986324841;4477.440319960005;4819.3012013258585;5064.797408103635;5384.488473595002;5404;5061.9493805061475;5630.408807075198;5638.379778224474;5643.7742490299925;5688.260526131742;3275.623303320149;3604.3600161926784;3769.6418840210135;3930.44973703676;3973.754828521876;4984.4517103117905;5079.44126146131;5125.384953805567;5466.34403871538;5466.535344495763;4408.817635270561;4593.655475839392;5262.763175657181;5264.842054738364;5272.288241087557;4676.69601475903;5029.622778291569;5301.6526448312015;5542.11326187808;5557.583181261502;4782.150368953026;5293.2854064702315;5327.987682340343;5355.625106242525;5433.320834895638;4804.543568361;5537.723113844211;5545.3622833373065;5586.720663966867;5602.719864006865;4161.916761664689;4560.361549383023;5209.270702101633;5390.218418329398;5419.428365774039 17:55:53 INFO - PROCESS | 1998 | |5;yui.html;713.1905287498687;729.489357449785;757.3978686943879;816.6855760532194;841.9368547358946;14981.775273370895;15801.288941997609;17055.999999999985;17646.294148234087;17925.462236132906;15853.762193567105;16327.673446531062;16573.50279491617;16747.83252167481;17024.914875425635;867.1545243387694;887.9822403551925;889.7553172877479;890.9331800114985;892.8883889513811;678.5691086160274;706.3572149344097;712.0174159659663;867.9869801952975;870.0559892516595;887.1660638999352;921.2767977137948;924.5608336040394;929.3633860805336;933.0948979489884;921.0283151275402;921.3320342751518;922.3220932614523;922.3543519536352;923.3213588012806;522.8509874685734;543.0821910970486;684.9691763870588;686.1046334533432;687.3950923187563;14811.259437028106;15345.30946107428;15442.845571544252;15747.291371888177;15781.526554203392;13911.79132313016;13915.58253252404;14186.645333866632;14195.503157389441;14212.360443780055;9949.55227014786;11732.472038758277;11775.882241177564;12052.397380130958;12168.026557875348;3708.6847617952235;3760.1351689111384;3787.5833658297565;3807.3717836556934;3873.2640798248244;107611;111853.32220016707;113556.43221783839;114479;115459.42270288679;10879.401632910107;11161.72095697614;11240.831387529193;11336.6032188873;11356.545738170546;21988.670169947465;22148.66776998346;22298.10807567679;22360.217392391187;22398.440038999157;7571.318581327707;7805.882911756328;7811.960940195263;7819;8004;4251.06476575153;4264.019275566637;4394.472663280427;4413.227685155085;4528.252838281646;3583.7133029357587;3591.838367273479;3673.246984368198;3679.2641471705765;3691.7046636269033;648.8248172993266;658.3778329478597;680.6154522694661;682.6825526130373;683.040328338685;704.1866644026157;710.9146902371645;725.1153592616998;729.5768454296496;731.4696844787486;9302.83714535683;9703.9029609703;10210.642627508001;10728.946355268174;10772.730681733019;678.8506528563709;695.1553862057624;718.3642476408417;735.272080640173;737.4284929179821;5015.398152221756;5064.265681476165;5067.315912351859;5078.97460512695;5084.567811736044;101449.49275253576;101665;107912.38131428036;109876.4506177464;111959.32061019092;73203;73701.8944715819;81890;82822.58588707018;85822;68538.62922741617;73328;73953.6302318485;75066.24933750702;75581.62209189028;8720.182369914965;10385.84421233667;10434.791304173723;10456;10461.90150034266;48474.75762621164;48600.75699621479;49289.50710492849;50212.995740085724;50453;47498.762506187246;60650;61245.387546123966;62267.6886615564;62422.375776243476;11938.343391113573;12024.519019239133;12057.939710301393;12103.334316612318;12489.812652810397;13985.881129509818;14653.487127950471;14800.333984970486;15691.843081569496;15836.841631583997;13618.455261789417;14210.786838197642;14871.18208498543;14886.330115145061;14925.253737313307;13967;14082.78875816843;14166.716665666836;14440;14520;13146.934265328613;13653.453861845415;13799.931000344934;13920;14477;11319.886801131883;11545.076393888301;11698.649040528799;11768;12075.51697932108;10294.536745846304;11048.447577620926;11556.306621602731;11647.539311813072;11908.40457977115 17:55:53 INFO - PROCESS | 1998 | __end_tp_report 17:55:53 INFO - PROCESS | 1998 | __start_cc_report 17:55:53 INFO - PROCESS | 1998 | _x_x_mozilla_cycle_collect,1319 17:55:53 INFO - PROCESS | 1998 | __end_cc_report 17:55:53 INFO - PROCESS | 1998 | __startTimestamp1485914153463__endTimestamp 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | ------- Summary: start ------- 17:55:53 INFO - PROCESS | 1998 | Number of tests: 6 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | [#0] dojo.html Cycles:165 Average:5761.55 Median:5941.23 stddev:660.84 (11.1%) stddev-sans-first:633.20 17:55:53 INFO - PROCESS | 1998 | Values: 3265.9 3274.4 3298.9 3330.3 3359.7 5669.3 5717.4 5720.1 5734.5 5741.8 5646.9 5717.2 5727.2 5728.2 5734.8 5169.3 5223.2 5227.9 5231.0 5266.4 4258.8 5138.2 5283.4 5308.0 5340.5 5206.6 5243.5 5251.6 5257.2 5272.0 5252.7 5255.7 5262.7 5265.2 5271.5 5084.4 5197.5 5214.3 5215.5 5237.9 5745.7 5758.4 5764.7 5769.2 5774.2 6150.8 6183.3 6194.8 6268.5 6275.4 6333.3 6335.0 6337.1 6340.2 6354.0 5668.0 5763.3 5789.4 5809.0 5843.2 5309.4 6226.2 6303.4 6311.4 6320.7 6224.8 6224.8 6235.8 6238.4 6244.4 6310.9 6321.3 6324.3 6327.3 6334.7 6076.8 6117.6 6121.7 6153.9 6165.9 6275.2 6275.4 6287.2 6306.1 6331.7 4956.6 4996.5 5001.0 5009.9 5032.8 4362.8 4405.1 4413.1 4419.6 4472.2 5764.5 5779.9 5811.0 5875.4 5904.9 6280.1 6287.7 6311.0 6312.3 6315.1 5784.8 5838.2 5844.9 5848.4 5897.1 5346.9 5412.8 5423.7 5430.4 5492.0 6246.1 6325.0 6336.2 6397.6 6424.9 6206.3 6246.8 6261.0 6277.2 6292.5 6227.4 6314.7 6323.1 6332.8 6341.1 6079.2 6100.8 6136.0 6151.5 6215.3 6309.6 6325.0 6335.3 6337.2 6345.4 6172.9 6181.8 6184.4 6207.3 6228.2 5903.5 5941.2 6055.8 6147.4 6168.7 5920.0 5951.3 6016.9 6048.0 6068.1 5984.8 6088.2 6111.3 6151.5 6160.9 5152.3 5757.4 5800.4 5907.2 5998.5 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | [#1] ext.html Cycles:180 Average:69046.98 Median:36765.45 stddev:148692.87 (404.4%) stddev-sans-first:149020.73 17:55:53 INFO - PROCESS | 1998 | Values: 422.9 461.7 462.0 473.1 512.8 30661.7 39585.0 41392.4 41434.4 41551.8 42649.8 42794.4 43004.1 43058.8 43153.6 8426.9 9208.1 9398.8 9413.0 9424.9 8590.6 11084.6 11308.8 11359.1 11501.8 11153.6 11233.9 11240.5 11286.0 11309.4 8471.5 8801.6 9445.6 11033.3 11333.3 10986.0 11233.6 11248.9 11252.4 11278.4 40012.2 40633.6 40960.8 40987.0 41015.8 3979.2 3985.3 3998.6 4012.4 4090.8 29165.1 29273.9 29725.0 30527.1 31205.0 3087.4 3163.3 3212.8 3327.9 3402.2 396640.0 470845.0 470931.6 471709.0 471901.0 63133.4 64164.4 64224.0 64252.4 64283.7 55040.0 65815.7 66151.7 66170.7 66537.7 16258.2 16352.8 16536.6 16565.5 16578.7 11498.0 11894.4 11901.0 12918.0 12929.3 15368.8 15499.9 15526.1 18956.9 21644.4 7206.1 8554.8 8726.8 8780.9 8854.4 852.3 888.3 901.7 917.9 926.2 30215.5 30445.5 30535.6 31050.5 31273.9 1062.2 1069.2 1101.9 1106.4 1214.0 15134.5 15603.1 15704.2 15756.5 15933.8 607997.0 609419.0 611436.0 612110.0 613853.0 51041.0 61320.4 61936.5 62049.4 62175.0 1444.5 1452.0 1469.4 1471.3 1478.2 27982.0 29823.7 29956.9 30493.8 30597.4 52281.5 52649.2 52662.7 52715.9 52757.5 586076.0 590158.0 591020.0 591311.0 591417.0 25143.9 26080.9 42623.8 43563.8 43588.3 41663.0 43070.6 43129.0 43247.0 43300.4 29683.0 35334.3 35903.3 36755.3 37107.6 35482.6 35558.3 35614.5 36775.6 36840.8 35334.3 35504.0 35769.0 36449.6 36545.6 30622.2 32179.7 32439.8 32500.7 32725.8 20662.5 23735.4 23847.2 23972.3 24694.3 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | [#2] jquery.html Cycles:180 Average:35310.05 Median:12121.05 stddev:101633.94 (838.5%) stddev-sans-first:101885.19 17:55:53 INFO - PROCESS | 1998 | Values: 369.0 387.8 388.4 398.6 419.3 15480.2 15534.4 18656.6 21512.7 21600.8 20664.2 20968.0 21127.0 21363.8 21651.7 5722.7 5785.6 5906.2 5912.5 5956.5 5816.7 5948.6 5959.9 5975.3 5976.6 4196.5 4405.7 4413.2 4470.4 6544.5 6587.7 6602.8 6606.5 6617.6 6622.8 5265.5 5505.5 5540.0 5580.5 5611.9 13422.2 13444.9 13446.1 13626.9 13639.7 2590.4 2613.3 2618.3 2626.4 2635.1 10053.8 10385.3 10403.3 12375.8 15128.1 1810.4 1843.3 1846.4 1847.6 1852.6 113954.0 114729.0 115145.0 116066.4 116707.0 9855.9 10614.1 11737.0 12027.8 12048.9 15954.5 15985.7 15988.2 15989.3 16084.6 8681.7 8824.2 8904.6 8906.8 9027.4 8722.0 8737.6 8738.9 8855.5 8884.6 4019.5 4691.3 4811.1 4850.8 4938.5 1722.5 1744.7 2003.2 2023.8 2047.6 951.6 962.6 1000.2 1009.2 1033.2 19094.6 19538.7 20859.0 21414.9 21486.4 981.9 984.8 988.7 989.4 1003.9 10460.0 10816.6 10819.9 10898.5 10966.8 403070.0 473175.0 621062.0 718086.0 740217.0 108380.0 130036.0 134793.0 149907.0 157605.3 942.8 945.4 976.8 977.0 980.2 18413.1 18642.9 18644.5 18809.2 18903.7 61299.8 61574.5 62423.4 62509.0 63427.0 87218.6 87466.6 89625.0 91066.0 91368.5 8326.9 8437.0 8486.1 8679.3 8693.6 11414.7 12981.8 13550.3 13657.2 13785.9 11256.7 11470.0 11509.3 11760.0 11916.8 10880.0 11087.4 11138.5 11168.8 11551.0 9946.0 11020.8 11197.2 11584.7 11886.6 7505.0 7524.9 7639.2 7905.1 7956.8 8877.6 11331.9 11422.0 11582.2 11584.4 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | [#3] mootools.html Cycles:180 Average:5391.72 Median:5216.18 stddev:2885.12 (55.3%) stddev-sans-first:2876.49 17:55:53 INFO - PROCESS | 1998 | Values: 1259.2 1434.8 1444.7 1450.6 1454.9 7861.7 8132.1 8259.9 8268.9 8272.1 7338.5 7636.9 7645.2 7887.6 8054.8 2289.3 2316.2 2318.5 2325.2 2326.3 2314.3 2335.8 2353.8 2357.3 2358.6 2035.2 2115.1 2216.9 2304.2 2304.8 1947.7 2305.0 2306.6 2307.3 2311.4 2221.5 2330.9 2337.1 2340.1 2341.5 8218.8 8276.4 8297.4 8308.7 8313.7 5072.7 5205.9 5209.0 5211.2 5217.4 3331.0 3393.5 3492.3 3572.3 3577.3 1207.2 1224.8 1258.7 1269.9 1282.1 10787.9 10847.7 10856.7 10866.3 10892.2 4398.8 4652.1 4678.9 4689.6 4712.6 9216.3 9370.6 9372.7 9373.2 9388.5 5199.5 5204.1 5206.1 5215.0 5222.4 4247.2 4367.1 4611.0 4708.4 4756.1 3774.5 3816.5 3886.3 3896.6 3902.2 1247.1 1256.5 1259.3 1265.4 1266.3 913.4 914.2 922.5 928.8 964.6 5524.3 5620.6 5760.0 5793.9 5795.8 977.5 990.1 1029.2 1033.3 1056.7 3695.3 3841.5 3846.1 3912.9 3944.0 9487.7 9791.9 9806.2 9824.7 9861.2 9614.8 9654.5 9690.7 9698.2 9798.5 7465.5 7619.0 7758.8 7787.7 7795.4 5611.4 5692.3 5730.6 5825.6 5879.4 7616.5 8867.1 9281.2 9295.1 9306.7 6774.3 9182.9 9196.6 9287.8 9323.0 6546.1 6761.5 6762.4 7051.6 7208.9 7555.9 7710.5 7863.0 7927.5 7934.1 7007.5 7173.9 7174.5 7236.1 7278.3 7004.6 7123.0 7193.0 7257.0 7366.0 6303.7 6318.8 6411.7 6457.8 6465.8 4977.1 4996.6 5046.7 5082.2 5150.4 4959.5 4972.2 5103.5 5173.9 5190.2 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | [#4] prototype.html Cycles:180 Average:4373.26 Median:4837.90 stddev:1303.16 (26.9%) stddev-sans-first:1270.07 17:55:53 INFO - PROCESS | 1998 | Values: 279.4 351.7 359.4 362.3 363.9 4704.5 4985.7 5170.4 5198.6 5330.7 4792.6 5092.4 5141.9 5160.3 5170.8 4096.9 4123.5 4123.9 4139.5 4149.5 3320.1 3646.9 4021.4 4156.3 4156.7 3553.9 3595.0 4080.5 4102.5 4132.6 3885.7 4089.4 4096.8 4101.3 4113.5 3299.1 3444.0 3633.7 3639.5 3656.1 3926.6 4856.5 5113.0 5114.5 5129.5 3959.4 4662.3 4689.7 4695.3 4711.6 5005.6 5302.5 5450.0 5457.9 5475.5 3518.4 3645.2 3778.9 3847.0 4049.8 5076.8 5763.0 5804.9 5819.7 5824.9 3247.9 3269.7 3277.9 3849.6 3867.5 3897.5 3905.4 3911.4 3916.1 3956.0 4389.7 4394.9 4421.8 4728.0 4765.6 5342.3 5587.7 5591.5 5634.7 5651.3 1245.7 1281.3 1329.5 1329.7 1363.1 838.5 915.9 930.5 958.9 995.6 4445.8 4920.4 4937.3 4946.8 4985.3 4283.4 4705.4 5395.2 5447.9 5487.4 4109.7 4182.3 4573.3 4947.7 4957.0 2551.5 2616.1 2835.7 2851.1 2871.9 4710.3 4929.8 4946.8 5320.7 5400.8 5432.1 5529.8 5536.6 5585.3 5588.4 4809.7 5391.0 5398.8 5578.8 5624.4 4707.6 4915.9 5186.0 5387.7 5450.0 4477.4 4819.3 5064.8 5384.5 5404.0 5061.9 5630.4 5638.4 5643.8 5688.3 3275.6 3604.4 3769.6 3930.4 3973.8 4984.5 5079.4 5125.4 5466.3 5466.5 4408.8 4593.7 5262.8 5264.8 5272.3 4676.7 5029.6 5301.7 5542.1 5557.6 4782.2 5293.3 5328.0 5355.6 5433.3 4804.5 5537.7 5545.4 5586.7 5602.7 4161.9 4560.4 5209.3 5390.2 5419.4 17:55:53 INFO - PROCESS | 1998 | 17:55:53 INFO - PROCESS | 1998 | [#5] yui.html Cycles:180 Average:20343.29 Median:3700.19 stddev:29018.03 (784.2%) stddev-sans-first:29062.00 17:55:53 INFO - PROCESS | 1998 | Values: 713.2 729.5 757.4 816.7 841.9 14981.8 15801.3 17056.0 17646.3 17925.5 15853.8 16327.7 16573.5 16747.8 17024.9 867.2 888.0 889.8 890.9 892.9 678.6 706.4 712.0 868.0 870.1 887.2 921.3 924.6 929.4 933.1 921.0 921.3 922.3 922.4 923.3 522.9 543.1 685.0 686.1 687.4 14811.3 15345.3 15442.8 15747.3 15781.5 13911.8 13915.6 14186.6 14195.5 14212.4 9949.6 11732.5 11775.9 12052.4 12168.0 3708.7 3760.1 3787.6 3807.4 3873.3 107611.0 111853.3 113556.4 114479.0 115459.4 10879.4 11161.7 11240.8 11336.6 11356.5 21988.7 22148.7 22298.1 22360.2 22398.4 7571.3 7805.9 7812.0 7819.0 8004.0 4251.1 4264.0 4394.5 4413.2 4528.3 3583.7 3591.8 3673.2 3679.3 3691.7 648.8 658.4 680.6 682.7 683.0 704.2 710.9 725.1 729.6 731.5 9302.8 9703.9 10210.6 10728.9 10772.7 678.9 695.2 718.4 735.3 737.4 5015.4 5064.3 5067.3 5079.0 5084.6 101449.5 101665.0 107912.4 109876.5 111959.3 73203.0 73701.9 81890.0 82822.6 85822.0 68538.6 73328.0 73953.6 75066.2 75581.6 8720.2 10385.8 10434.8 10456.0 10461.9 48474.8 48600.8 49289.5 50213.0 50453.0 47498.8 60650.0 61245.4 62267.7 62422.4 11938.3 12024.5 12057.9 12103.3 12489.8 13985.9 14653.5 14800.3 15691.8 15836.8 13618.5 14210.8 14871.2 14886.3 14925.3 13967.0 14082.8 14166.7 14440.0 14520.0 13146.9 13653.5 13799.9 13920.0 14477.0 11319.9 11545.1 11698.6 11768.0 12075.5 10294.5 11048.4 11556.3 11647.5 11908.4 17:55:53 INFO - PROCESS | 1998 | -------- Summary: end -------- 17:55:53 INFO - PROCESS | 1998 | 17:55:54 INFO - TEST-INFO | 1998: exit 0 17:55:54 INFO - TEST-OK | dromaeo_css | took 1118294ms 17:55:54 INFO - TEST-START | kraken 17:55:54 INFO - operating with platform_type : mac_ 17:55:54 INFO - Initialising browser for kraken test... 17:55:54 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpOSh0eK/profile http://localhost:52431/getInfo.html) 17:55:56 INFO - PROCESS | 2001 | __metrics Screen width/height:1600/1200 17:55:56 INFO - PROCESS | 2001 | colorDepth:24 17:55:56 INFO - PROCESS | 2001 | Browser inner width/height: 1024/689 17:55:56 INFO - PROCESS | 2001 | __metrics 17:55:56 INFO - PROCESS | 2001 | 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:55:56 INFO - PROCESS | 2001 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:55:57 INFO - TEST-INFO | 2001: exit 0 17:55:57 INFO - Browser initialized. 17:55:57 INFO - Running cycle 1/1 for kraken test... 17:55:57 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/tmpOSh0eK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:56:09 INFO - PROCESS | 2003 | RSS: Main: 232206336 17:56:09 INFO - PROCESS | 2003 | 17:56:12 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52431/tests/kraken/driver.html?testName=audio-beat-detection) 17:56:13 INFO - PROCESS | 2003 | RSS: Main: 280600576 17:56:13 INFO - PROCESS | 2003 | 17:56:16 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52431/tests/kraken/driver.html?testName=audio-dft) 17:56:16 INFO - PROCESS | 2003 | RSS: Main: 295051264 17:56:16 INFO - PROCESS | 2003 | 17:56:19 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52431/tests/kraken/driver.html?testName=audio-fft) 17:56:20 INFO - PROCESS | 2003 | RSS: Main: 388169728 17:56:20 INFO - PROCESS | 2003 | 17:56:22 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52431/tests/kraken/driver.html?testName=audio-oscillator) 17:56:23 INFO - PROCESS | 2003 | RSS: Main: 292704256 17:56:23 INFO - PROCESS | 2003 | 17:56:25 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52431/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:25 INFO - PROCESS | 2003 | RSS: Main: 294273024 17:56:25 INFO - PROCESS | 2003 | 17:56:28 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52431/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:29 INFO - PROCESS | 2003 | RSS: Main: 333389824 17:56:29 INFO - PROCESS | 2003 | 17:56:32 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52431/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:32 INFO - PROCESS | 2003 | RSS: Main: 333152256 17:56:32 INFO - PROCESS | 2003 | 17:56:35 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52431/tests/kraken/driver.html?testName=json-parse-financial) 17:56:36 INFO - PROCESS | 2003 | RSS: Main: 329773056 17:56:36 INFO - PROCESS | 2003 | 17:56:37 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52431/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:38 INFO - PROCESS | 2003 | RSS: Main: 307499008 17:56:38 INFO - PROCESS | 2003 | 17:56:40 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:40 INFO - PROCESS | 2003 | RSS: Main: 311365632 17:56:40 INFO - PROCESS | 2003 | 17:56:43 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:56:43 INFO - PROCESS | 2003 | RSS: Main: 311959552 17:56:43 INFO - PROCESS | 2003 | 17:56:46 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:56:47 INFO - PROCESS | 2003 | RSS: Main: 328925184 17:56:47 INFO - PROCESS | 2003 | 17:56:50 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:56:50 INFO - PROCESS | 2003 | RSS: Main: 322957312 17:56:50 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | Cycle 1(1): loaded http://localhost:52431/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52431/tests/kraken/driver.html?testName=ai-astar) 17:56:52 INFO - PROCESS | 2003 | RSS: Main: 367742976 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | __start_tp_report 17:56:52 INFO - PROCESS | 2003 | _x_x_mozilla_page_load 17:56:52 INFO - PROCESS | 2003 | _x_x_mozilla_page_load_details 17:56:52 INFO - PROCESS | 2003 | |i|pagename|runs| 17:56:52 INFO - PROCESS | 2003 | |0;ai-astar;113;114;114;110;113;114;119;165;163;114 17:56:52 INFO - PROCESS | 2003 | |1;audio-beat-detection;134;110;108;140;112;110;110;107;118;111 17:56:52 INFO - PROCESS | 2003 | |2;audio-dft;183;186;183;182;183;185;184;185;183;186 17:56:52 INFO - PROCESS | 2003 | |3;audio-fft;85;60;74;117;85;66;57;61;76;59 17:56:52 INFO - PROCESS | 2003 | |4;audio-oscillator;83;70;87;71;69;70;83;68;69;82 17:56:52 INFO - PROCESS | 2003 | |5;imaging-gaussian-blur;90;87;89;87;90;86;91;87;90;86 17:56:52 INFO - PROCESS | 2003 | |6;imaging-darkroom;136;124;95;94;94;94;95;95;95;95 17:56:52 INFO - PROCESS | 2003 | |7;imaging-desaturate;86;84;84;85;87;85;84;85;86;84 17:56:52 INFO - PROCESS | 2003 | |8;json-parse-financial;56;52;54;53;55;60;58;58;56;56 17:56:52 INFO - PROCESS | 2003 | |9;json-stringify-tinderbox;65;74;68;81;77;74;72;74;73;73 17:56:52 INFO - PROCESS | 2003 | |10;stanford-crypto-aes;87;84;82;82;85;81;85;82;84;83 17:56:52 INFO - PROCESS | 2003 | |11;stanford-crypto-ccm;140;142;149;155;134;152;154;155;205;150 17:56:52 INFO - PROCESS | 2003 | |12;stanford-crypto-pbkdf2;169;172;171;171;169;176;170;168;172;170 17:56:52 INFO - PROCESS | 2003 | |13;stanford-crypto-sha256-iterative;66;67;68;66;66;66;65;66;66;65 17:56:52 INFO - PROCESS | 2003 | __end_tp_report 17:56:52 INFO - PROCESS | 2003 | __start_cc_report 17:56:52 INFO - PROCESS | 2003 | _x_x_mozilla_cycle_collect,1996 17:56:52 INFO - PROCESS | 2003 | __end_cc_report 17:56:52 INFO - PROCESS | 2003 | __startTimestamp1485914212912__endTimestamp 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | ------- Summary: start ------- 17:56:52 INFO - PROCESS | 2003 | Number of tests: 14 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#0] ai-astar Cycles:10 Average:123.90 Median:114.00 stddev:21.25 (18.6%) stddev-sans-first:22.17 17:56:52 INFO - PROCESS | 2003 | Values: 113.0 114.0 114.0 110.0 113.0 114.0 119.0 165.0 163.0 114.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#1] audio-beat-detection Cycles:10 Average:116.00 Median:111.50 stddev:11.54 (10.3%) stddev-sans-first:10.23 17:56:52 INFO - PROCESS | 2003 | Values: 134.0 110.0 108.0 140.0 112.0 110.0 110.0 107.0 118.0 111.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.50 stddev:1.41 (0.8%) stddev-sans-first:1.45 17:56:52 INFO - PROCESS | 2003 | Values: 183.0 186.0 183.0 182.0 183.0 185.0 184.0 185.0 183.0 186.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#3] audio-fft Cycles:10 Average:74.00 Median:70.00 stddev:18.37 (26.2%) stddev-sans-first:19.05 17:56:52 INFO - PROCESS | 2003 | Values: 85.0 60.0 74.0 117.0 85.0 66.0 57.0 61.0 76.0 59.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.50 stddev:7.51 (9.8%) stddev-sans-first:7.42 17:56:52 INFO - PROCESS | 2003 | Values: 83.0 70.0 87.0 71.0 69.0 70.0 83.0 68.0 69.0 82.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.50 stddev:1.89 (2.1%) stddev-sans-first:1.90 17:56:52 INFO - PROCESS | 2003 | Values: 90.0 87.0 89.0 87.0 90.0 86.0 91.0 87.0 90.0 86.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:95.00 stddev:15.19 (16.0%) stddev-sans-first:9.80 17:56:52 INFO - PROCESS | 2003 | Values: 136.0 124.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 95.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.05 (1.2%) stddev-sans-first:1.05 17:56:52 INFO - PROCESS | 2003 | Values: 86.0 84.0 84.0 85.0 87.0 85.0 84.0 85.0 86.0 84.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:2.44 (4.4%) stddev-sans-first:2.59 17:56:52 INFO - PROCESS | 2003 | Values: 56.0 52.0 54.0 53.0 55.0 60.0 58.0 58.0 56.0 56.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#9] json-stringify-tinderbox Cycles:10 Average:73.10 Median:74.00 stddev:4.38 (5.9%) stddev-sans-first:3.54 17:56:52 INFO - PROCESS | 2003 | Values: 65.0 74.0 68.0 81.0 77.0 74.0 72.0 74.0 73.0 73.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.84 (2.2%) stddev-sans-first:1.45 17:56:52 INFO - PROCESS | 2003 | Values: 87.0 84.0 82.0 82.0 85.0 81.0 85.0 82.0 84.0 83.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:153.00 stddev:19.40 (12.7%) stddev-sans-first:19.94 17:56:52 INFO - PROCESS | 2003 | Values: 140.0 142.0 149.0 155.0 134.0 152.0 154.0 155.0 205.0 150.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:171.00 stddev:2.25 (1.3%) stddev-sans-first:2.29 17:56:52 INFO - PROCESS | 2003 | Values: 169.0 172.0 171.0 171.0 169.0 176.0 170.0 168.0 172.0 170.0 17:56:52 INFO - PROCESS | 2003 | 17:56:52 INFO - PROCESS | 2003 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 17:56:52 INFO - PROCESS | 2003 | Values: 66.0 67.0 68.0 66.0 66.0 66.0 65.0 66.0 66.0 65.0 17:56:52 INFO - PROCESS | 2003 | -------- Summary: end -------- 17:56:52 INFO - PROCESS | 2003 | 17:56:53 INFO - TEST-INFO | 2003: exit 0 17:56:53 INFO - TEST-OK | kraken | took 59824ms 17:56:53 INFO - SUITE-END | took 1178s 17:56:54 INFO - Completed test suite (00:19:38) 17:56:54 INFO - javascript benchmark 17:56:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3265.856950067476, 3274.3778682050415, 3298.934021319575, 3330.317284956584, 3359.6976272135516, 5669.291338582677, 5717.3710891801975, 5720.113382425726, 5734.512566431858, 5741.827745167647, 5646.943530564703, 5717.199592057105, 5727.2268243787075, 5728.198052272685, 5734.79928202513, 5169.3279873616375, 5223.242629818684, 5227.921581176285, 5230.973845130788, 5266.420693723688, 4258.829646814123, 5138.203578445347, 5283.392409872856, 5307.973460132694, 5340.519353258206, 5206.5834733221445, 5243.528082472577, 5251.606129540281, 5257.185136303879, 5272.024675435037, 5252.65857719247, 5255.710935898524, 5262.684238945637, 5265.236540701577, 5271.525562699337, 5084.44071152173, 5197.454267301917, 5214.322138122057, 5215.504527069922, 5237.926225123841, 5745.7127143643065, 5758.395368486333, 5764.74058667361, 5769.221155144086, 5774.220480235199, 6150.784722534735, 6183.319834818167, 6194.845128871769, 6268.49852011838, 6275.403836635513, 6333.334999825044, 6334.968325158345, 6337.112804207414, 6340.175777148987, 6354.046892966092, 5668.0, 5763.308402991668, 5789.363170051291, 5808.97095514524, 5843.211166492511, 5309.36287645485, 6226.1905952225925, 6303.401176888188, 6311.368863113652, 6320.652364119926, 6224.813255602339, 6224.844378890564, 6235.812925612239, 6238.438540531374, 6244.406781355764, 6310.905336419957, 6321.304656487782, 6324.33594472583, 6327.303996560375, 6334.683265836689, 6076.787312444132, 6117.632942023492, 6121.693915304217, 6153.876922461525, 6165.907511387333, 6275.152854364694, 6275.403836635513, 6287.182666253358, 6306.1171435998995, 6331.746730130743, 4956.553910148104, 4996.525330093636, 5001.0, 5009.89980200394, 5032.84901452957, 4362.760048197316, 4405.118976204772, 4413.073254616566, 4419.64642828573, 4472.195004899149, 5764.481196692318, 5779.8555036124435, 5811.0411782056335, 5875.383084776037, 5904.911426328608, 6280.120783090371, 6287.748490060438, 6311.0, 6312.274088479791, 6315.052742088632, 5784.797532086357, 5838.153467747153, 5844.912326315109, 5848.444397782204, 5897.115432685046, 5346.893062138735, 5412.83761487156, 5423.674579525162, 5430.375506816687, 5492.038893193675, 6246.1255424239735, 6324.968375158095, 6336.1762970814425, 6397.552171347961, 6424.9036264455135, 6206.286277078013, 6246.812595622138, 6261.029540421242, 6277.1525844010475, 6292.465140463112, 6227.439530442282, 6314.652694101868, 6323.114763933145, 6332.778352757631, 6341.0805433212845, 6079.209702738793, 6100.786472473442, 6135.969320153549, 6151.507879369729, 6215.316315205414, 6309.558330916791, 6324.968375158279, 6335.271443784024, 6337.176167098432, 6345.397187267202, 6172.8765424690355, 6181.84545386369, 6184.381561843779, 6207.348228435949, 6228.22147231596, 5903.527717782481, 5941.22764040672, 6055.818325450244, 6147.385261473817, 6168.660723660062, 5919.970400147971, 5951.315598706205, 6016.939830601638, 6048.0, 6068.120122582112, 5984.760609575568, 6088.178095957166, 6111.297200821785, 6151.477124444294, 6160.876782464416, 5152.330197074356, 5757.3954734753925, 5800.4489573490455, 5907.17299578068, 5998.520118390606], "value": 5717.705560670819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.8921624985629, 461.74142480211066, 462.0435698104922, 473.07749887718956, 512.825639282644, 30661.69338306619, 39585.0, 41392.379114313306, 41434.37848432276, 41551.79224103883, 42649.7867510662, 42794.35808462876, 43004.13991720171, 43058.784706076425, 43153.56846431535, 8426.873596896052, 9208.12522810332, 9398.765030874249, 9412.952935235315, 9424.858627120599, 8590.613422396007, 11084.61203857865, 11308.773824523505, 11359.091272698206, 11501.827472587918, 11153.553857845716, 11233.887661123366, 11240.49417776202, 11285.984261416472, 11309.377984210865, 8471.49171049739, 8801.559922003875, 9445.622175112987, 11033.282836615675, 11333.320000799937, 10986.0, 11233.550657973672, 11248.943755281252, 11252.437378131142, 11278.379689117095, 40012.19975600472, 40633.59366406328, 40960.795196024126, 40987.0, 41015.794921025205, 3979.162432899971, 3985.342418500944, 3998.5801490843623, 4012.4382586437923, 4090.8363665453644, 29165.125046248435, 29273.85363073171, 29725.0, 30527.08821077532, 31205.0, 3087.4442600332154, 3163.335699503107, 3212.8433763844996, 3327.866885324584, 3402.2344972381266, 396640.0, 470845.0, 470931.6453417745, 471709.0, 471901.0, 63133.36866631367, 64164.35835641677, 64224.036639450445, 64252.39369015719, 64283.678581607724, 55040.0, 65815.67092164508, 66151.66924165348, 66170.66914665492, 66537.66731166313, 16258.187090645657, 16352.83647163537, 16536.586585335222, 16565.503034908972, 16578.6684266314, 11498.022668073307, 11894.405279735978, 11901.0, 12918.0, 12929.288889111001, 15368.848361229437, 15499.92250038765, 15526.1460619667, 18956.93761375521, 21644.35066947994, 7206.0543653213335, 8554.78613034679, 8726.825463490695, 8780.912190878009, 8854.38019338653, 852.3394369363792, 888.3293113699116, 901.6528636475005, 917.8714979902819, 926.2034650200821, 30215.546766798514, 30445.54331684982, 30535.64107948124, 31050.53424198639, 31273.90541331088, 1062.198040479433, 1069.1500257295468, 1101.8787933327328, 1106.3527836215903, 1213.9802565844557, 15134.470293539673, 15603.06381617084, 15704.214789260492, 15756.527304180892, 15933.840661593467, 607997.0, 609419.0, 611436.0, 612110.0, 613853.0, 51040.97918041619, 61320.38679613236, 61936.451588710646, 62049.37950620526, 62175.0, 1444.5377479206763, 1452.0343971258994, 1469.3755154059695, 1471.2864260833487, 1478.1796103162633, 27982.02062927788, 29823.70176298296, 29956.850215748782, 30493.847530762203, 30597.388052239276, 52281.47718522766, 52649.210261845335, 52662.736686316326, 52715.94568108693, 52757.47242527526, 586076.0, 590158.0, 591020.0, 591311.0, 591417.0, 25143.87428062921, 26080.8695956519, 42623.78688106663, 43563.78218108889, 43588.34617480677, 41663.0, 43070.56929430665, 43129.0, 43247.0, 43300.35049474324, 29683.0, 35334.29331413306, 35903.28193436169, 36755.26489470249, 37107.628923710414, 35482.64517354897, 35558.28883422265, 35614.465783013795, 36775.632243677224, 36840.81579592085, 35334.29331413409, 35504.0, 35769.0, 36449.635503644626, 36545.63454365529, 30622.234444138183, 32179.678203217667, 32439.837800810845, 32500.699972000853, 32725.836370817993, 20662.483437914172, 23735.406614834767, 23847.165349212693, 23972.28083157508, 24694.292633683574], "value": 20232.001579233318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.97417180797356, 387.821602063051, 388.3921662598034, 398.6153362005664, 419.270469383273, 15480.225988700562, 15534.378624855006, 18656.62686746264, 21512.677309840365, 21600.81195534245, 20664.173433062697, 20968.0, 21127.0, 21363.786362136372, 21651.6752248716, 5722.713864306778, 5785.595008349417, 5906.202662640531, 5912.526997840184, 5956.493698035651, 5816.709164541777, 5948.553858460611, 5959.940400595982, 5975.342712301644, 5976.611520251192, 4196.496420429553, 4405.7356558606425, 4413.161499315136, 4470.396496472967, 6544.541882068257, 6587.703553340111, 6602.7689030883685, 6606.471482281454, 6617.602943823338, 6622.801315960529, 5265.4997775211295, 5505.476979686963, 5540.0, 5580.469855363734, 5611.8877622447735, 13422.194668319835, 13444.86555134446, 13446.058775885693, 13626.93186534061, 13639.727205455836, 2590.417156139872, 2613.2552222616464, 2618.3454136465884, 2626.4484458263787, 2635.117235726034, 10053.849192262049, 10385.32495387805, 10403.323783954094, 12375.814362784566, 15128.092314461168, 1810.3663717698832, 1843.317972350239, 1846.4368367647862, 1847.5935294235246, 1852.5646473078816, 113954.0, 114729.0, 115145.0, 116066.41966790112, 116707.0, 9855.901440985499, 10614.097801686788, 11737.0, 12027.759444811054, 12048.915597596259, 15954.521364359089, 15985.680286394207, 15988.200589970687, 15989.28048237832, 16084.597885052968, 8681.696140635173, 8824.161704638049, 8904.643814247358, 8906.777330566658, 9027.368084234173, 8722.0, 8737.563121843883, 8738.86891696625, 8855.468671879707, 8884.578467445177, 4019.457373254573, 4691.319758634979, 4811.08589368019, 4850.805967761321, 4938.481459446778, 1722.5435259656201, 1744.7121224997986, 2003.24878170686, 2023.8077382648626, 2047.5597746484577, 951.5527701980059, 962.6101428921298, 1000.214831357381, 1009.2228983682523, 1033.1992705653179, 19094.61810763805, 19538.70691939622, 20859.0, 21414.92925353757, 21486.35842186649, 981.9018098190123, 984.8375018122073, 988.6687959533493, 989.351974456732, 1003.9247056470793, 10460.0, 10816.621418250481, 10819.945900270448, 10898.455077246106, 10966.835497467544, 403070.0, 473175.0, 621062.0, 718086.0, 740217.0, 108380.0, 130036.0, 134793.0, 149907.0, 157605.27184184492, 942.8444306689456, 945.3996712087874, 976.799756050008, 976.9902300977042, 980.1962390839585, 18413.07934603291, 18642.906785465984, 18644.533886652942, 18809.153588088844, 18903.716444253623, 61299.77400452055, 61574.460638484394, 62423.38189562961, 62509.0, 63427.0, 87218.56390718005, 87466.56266718626, 89625.0, 91066.0, 91368.54315728378, 8326.875096873431, 8436.957815210884, 8486.108958559262, 8679.305655547667, 8693.565321734015, 11414.657560273205, 12981.805272921103, 13550.254735989614, 13657.248851313274, 13785.862141378459, 11256.662300131009, 11470.025047870691, 11509.309441433541, 11760.0, 11916.76166476683, 10880.0, 11087.390193539433, 11138.498767555317, 11168.776624467628, 11551.0, 9946.0, 11020.834687479855, 11197.216194866282, 11584.652460426201, 11886.643400697993, 7505.0, 7524.924750752422, 7639.159692433939, 7905.090914544901, 7956.801079972815, 8877.644894204417, 11331.943340283246, 11421.972022518014, 11582.247153934968, 11584.362860042778], "value": 9615.764995528005, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.1815320041974, 1434.849340819214, 1444.689391780767, 1450.6300893272214, 1454.8981571290008, 7861.68553257869, 8132.105468398471, 8259.91740082599, 8268.875966860502, 8272.090070092292, 7338.522996005256, 7636.923630763691, 7645.15903250642, 7887.5661838599, 8054.838903221932, 2289.2788771536952, 2316.177756896303, 2318.466752646892, 2325.244295603927, 2326.336993956723, 2314.3404129823, 2335.7781010804033, 2353.752855950126, 2357.316378250305, 2358.610829213186, 2035.2266138867283, 2115.1116531056914, 2216.9113235470563, 2304.158981971585, 2304.8040916522114, 1947.6755806051879, 2304.9654255186188, 2306.550222706573, 2307.2962746362355, 2311.433698743802, 2221.533477969628, 2330.9184178553837, 2337.146941366406, 2340.0756701103137, 2341.484873327865, 8218.753437396888, 8276.379271554657, 8297.377696672773, 8308.667653293862, 8313.667453301861, 5072.746362681851, 5205.9219111713355, 5208.973955130238, 5211.218317252443, 5217.373915130171, 3330.9500357494658, 3393.5079413484905, 3492.266624008961, 3572.285542891432, 3577.266660334625, 1207.1911819081236, 1224.7611715715439, 1258.704204511939, 1269.9426928375997, 1282.076904628666, 10787.946060269727, 10847.67456976292, 10856.674299771019, 10866.348019118957, 10892.183086268482, 4398.8020539075815, 4652.069586082797, 4678.859634210911, 4689.62483001359, 4712.575868171881, 9216.308776841764, 9370.578323975302, 9372.718818435458, 9373.203277721334, 9388.530573471437, 5199.48005199477, 5204.141316682705, 5206.140986737221, 5214.983078299695, 5222.373315202124, 4247.235497610398, 4367.10474352757, 4611.031683346535, 4708.411448568929, 4756.096341695067, 3774.5281839770028, 3816.5420149581673, 3886.2810380079777, 3896.5518965318784, 3902.180542086137, 1247.1020864977202, 1256.4848412150975, 1259.2633309513853, 1265.4305562496913, 1266.2845492296822, 913.4199783137756, 914.2049948022532, 922.5341202692597, 928.8374534456443, 964.5514835601339, 5524.309461317335, 5620.5503559715125, 5759.992001399738, 5793.913091303634, 5795.797147099831, 977.519058626182, 990.138579435881, 1029.2435060230725, 1033.3180101133366, 1056.6882769582992, 3695.279420512974, 3841.539015318124, 3846.0961674006585, 3912.882613521599, 3943.960560394359, 9487.715368538817, 9791.902080979242, 9806.16647584949, 9824.705258842247, 9861.211103111735, 9614.759631009281, 9654.517274136266, 9690.660826871026, 9698.224142068617, 9798.46108464027, 7465.514741541891, 7619.0, 7758.7672369829, 7787.688492460238, 7795.376369890395, 5611.354694210055, 5692.288463942007, 5730.598858079894, 5825.621334613236, 5879.441453061952, 7616.504927179715, 8867.068957759342, 9281.211097056826, 9295.07049295065, 9306.72079837606, 6774.254831968381, 9182.908170918205, 9196.586153623237, 9287.814243715224, 9323.0, 6546.116274302908, 6761.492888033516, 6762.425193858577, 7051.6474176292, 7208.855822883618, 7555.8866616999685, 7710.460267781202, 7862.960685196537, 7927.484713493604, 7934.1272460030505, 7007.528419032061, 7173.892391614234, 7174.533655312388, 7236.095488063992, 7278.308560686726, 7004.649767511706, 7123.0, 7192.964035179791, 7256.984022236997, 7366.0, 6303.653299068412, 6318.810435686937, 6411.743530258737, 6457.838554036187, 6465.806025819233, 4977.054359671651, 4996.601120389816, 5046.747662616781, 5082.2122571001555, 5150.381954165524, 4959.528844759742, 4972.22930445767, 5103.540681338697, 5173.92239116406, 5190.247414124855], "value": 4416.489776498787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.40765576976804, 351.6501081423983, 359.36571950507357, 362.2501422056343, 363.8853761065263, 4704.541592106445, 4985.7008579485255, 5170.379554453461, 5198.558122559582, 5330.653507522008, 4792.6165906727465, 5092.414372347182, 5141.922871156927, 5160.251763494301, 5170.767315470804, 4096.856610018643, 4123.546489838556, 4123.917521649565, 4139.482564679415, 4149.5228048774325, 3320.1367644412508, 3646.9270614587695, 4021.391443422625, 4156.334986402177, 4156.688248381383, 3553.893383198508, 3594.97543200188, 4080.5307389650275, 4102.548719640837, 4132.586741325858, 3885.669718073953, 4089.3661482470266, 4096.795160241976, 4101.282275601788, 4113.465249517573, 3299.1092405050504, 3444.0, 3633.6729694327637, 3639.4722765199162, 3656.0859785053735, 3926.6466018058227, 4856.490068542787, 5113.0, 5114.488551144893, 5129.512696293883, 3959.40608908666, 4662.347271382009, 4689.6717229793585, 4695.272232803921, 4711.623070154414, 5005.599552035865, 5302.469753024667, 5450.0, 5457.863553411157, 5475.479829416199, 3518.384282750534, 3645.2345007548183, 3778.943315850237, 3846.961530384688, 4049.8457939487103, 5076.822311219164, 5763.032038500134, 5804.881218355312, 5819.730305180983, 5824.86434631408, 3247.935041299208, 3269.73842092632, 3277.8688852445634, 3849.5957924418094, 3867.5165604299464, 3897.4738410314244, 3905.3556163232747, 3911.438008104696, 3916.1384495411535, 3955.960440395559, 4389.6927215095275, 4394.890127746768, 4421.7789110544345, 4727.950471945576, 4765.642576806753, 5342.2787923630585, 5587.681112338415, 5591.496765291062, 5634.661920284796, 5651.321841379061, 1245.7134858982304, 1281.2952875918209, 1329.5280175537546, 1329.7340531893467, 1363.12078709232, 838.528382688378, 915.9404638698463, 930.464982634974, 958.9020571445656, 995.5520015992832, 4445.82216711328, 4920.384951881015, 4937.333459982929, 4946.752662366867, 4985.302057711923, 4283.357496375506, 4705.435347758223, 5395.163749618815, 5447.945520544744, 5487.42382049887, 4109.712320137622, 4182.344211425767, 4573.268277075718, 4947.678400903929, 4956.975215123901, 2551.502457020863, 2616.123598594454, 2835.659720833472, 2851.146754609479, 2871.9282017949718, 4710.26990816424, 4929.827456039022, 4946.802127914843, 5320.733963301819, 5400.810971616053, 5432.076546987022, 5529.834104976857, 5536.584756143225, 5585.273914391103, 5588.441155884379, 4809.663323567387, 5390.95678241319, 5398.757055932414, 5578.804741834017, 5624.353199382123, 4707.623390128713, 4915.870668638361, 5186.0, 5387.7069503318135, 5450.037986324841, 4477.440319960005, 4819.3012013258585, 5064.797408103635, 5384.488473595002, 5404.0, 5061.9493805061475, 5630.408807075198, 5638.379778224474, 5643.7742490299925, 5688.260526131742, 3275.623303320149, 3604.3600161926784, 3769.6418840210135, 3930.44973703676, 3973.754828521876, 4984.4517103117905, 5079.44126146131, 5125.384953805567, 5466.34403871538, 5466.535344495763, 4408.817635270561, 4593.655475839392, 5262.763175657181, 5264.842054738364, 5272.288241087557, 4676.69601475903, 5029.622778291569, 5301.6526448312015, 5542.11326187808, 5557.583181261502, 4782.150368953026, 5293.2854064702315, 5327.987682340343, 5355.625106242525, 5433.320834895638, 4804.543568361, 5537.723113844211, 5545.3622833373065, 5586.720663966867, 5602.719864006865, 4161.916761664689, 4560.361549383023, 5209.270702101633, 5390.218418329398, 5419.428365774039], "value": 3977.180122847539, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.1905287498687, 729.489357449785, 757.3978686943879, 816.6855760532194, 841.9368547358946, 14981.775273370895, 15801.288941997609, 17055.999999999985, 17646.294148234087, 17925.462236132906, 15853.762193567105, 16327.673446531062, 16573.50279491617, 16747.83252167481, 17024.914875425635, 867.1545243387694, 887.9822403551925, 889.7553172877479, 890.9331800114985, 892.8883889513811, 678.5691086160274, 706.3572149344097, 712.0174159659663, 867.9869801952975, 870.0559892516595, 887.1660638999352, 921.2767977137948, 924.5608336040394, 929.3633860805336, 933.0948979489884, 921.0283151275402, 921.3320342751518, 922.3220932614523, 922.3543519536352, 923.3213588012806, 522.8509874685734, 543.0821910970486, 684.9691763870588, 686.1046334533432, 687.3950923187563, 14811.259437028106, 15345.30946107428, 15442.845571544252, 15747.291371888177, 15781.526554203392, 13911.79132313016, 13915.58253252404, 14186.645333866632, 14195.503157389441, 14212.360443780055, 9949.55227014786, 11732.472038758277, 11775.882241177564, 12052.397380130958, 12168.026557875348, 3708.6847617952235, 3760.1351689111384, 3787.5833658297565, 3807.3717836556934, 3873.2640798248244, 107611.0, 111853.32220016707, 113556.43221783839, 114479.0, 115459.42270288679, 10879.401632910107, 11161.72095697614, 11240.831387529193, 11336.6032188873, 11356.545738170546, 21988.670169947465, 22148.66776998346, 22298.10807567679, 22360.217392391187, 22398.440038999157, 7571.318581327707, 7805.882911756328, 7811.960940195263, 7819.0, 8004.0, 4251.06476575153, 4264.019275566637, 4394.472663280427, 4413.227685155085, 4528.252838281646, 3583.7133029357587, 3591.838367273479, 3673.246984368198, 3679.2641471705765, 3691.7046636269033, 648.8248172993266, 658.3778329478597, 680.6154522694661, 682.6825526130373, 683.040328338685, 704.1866644026157, 710.9146902371645, 725.1153592616998, 729.5768454296496, 731.4696844787486, 9302.83714535683, 9703.9029609703, 10210.642627508001, 10728.946355268174, 10772.730681733019, 678.8506528563709, 695.1553862057624, 718.3642476408417, 735.272080640173, 737.4284929179821, 5015.398152221756, 5064.265681476165, 5067.315912351859, 5078.97460512695, 5084.567811736044, 101449.49275253576, 101665.0, 107912.38131428036, 109876.4506177464, 111959.32061019092, 73203.0, 73701.8944715819, 81890.0, 82822.58588707018, 85822.0, 68538.62922741617, 73328.0, 73953.6302318485, 75066.24933750702, 75581.62209189028, 8720.182369914965, 10385.84421233667, 10434.791304173723, 10456.0, 10461.90150034266, 48474.75762621164, 48600.75699621479, 49289.50710492849, 50212.995740085724, 50453.0, 47498.762506187246, 60650.0, 61245.387546123966, 62267.6886615564, 62422.375776243476, 11938.343391113573, 12024.519019239133, 12057.939710301393, 12103.334316612318, 12489.812652810397, 13985.881129509818, 14653.487127950471, 14800.333984970486, 15691.843081569496, 15836.841631583997, 13618.455261789417, 14210.786838197642, 14871.18208498543, 14886.330115145061, 14925.253737313307, 13967.0, 14082.78875816843, 14166.716665666836, 14440.0, 14520.0, 13146.934265328613, 13653.453861845415, 13799.931000344934, 13920.0, 14477.0, 11319.886801131883, 11545.076393888301, 11698.649040528799, 11768.0, 12075.51697932108, 10294.536745846304, 11048.447577620926, 11556.306621602731, 11647.539311813072, 11908.40457977115], "value": 7619.380439740565, "unit": "score"}], "name": "dromaeo_css", "value": 7280.21660523109, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 110.0, 113.0, 114.0, 119.0, 165.0, 163.0, 114.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 110.0, 108.0, 140.0, 112.0, 110.0, 110.0, 107.0, 118.0, 111.0], "value": 116.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 186.0, 183.0, 182.0, 183.0, 185.0, 184.0, 185.0, 183.0, 186.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 60.0, 74.0, 117.0, 85.0, 66.0, 57.0, 61.0, 76.0, 59.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 70.0, 87.0, 71.0, 69.0, 70.0, 83.0, 68.0, 69.0, 82.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 90.0, 86.0, 91.0, 87.0, 90.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 124.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 87.0, 85.0, 84.0, 85.0, 86.0, 84.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 54.0, 53.0, 55.0, 60.0, 58.0, 58.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 74.0, 68.0, 81.0, 77.0, 74.0, 72.0, 74.0, 73.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 82.0, 82.0, 85.0, 81.0, 85.0, 82.0, 84.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 149.0, 155.0, 134.0, 152.0, 154.0, 155.0, 205.0, 150.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 171.0, 171.0, 169.0, 176.0, 170.0, 168.0, 172.0, 170.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 65.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1450.9999999999998, "alertThreshold": 2.0}]} 17:56:54 INFO - Return code: 0 17:56:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:56:54 ERROR - # TBPL SUCCESS # 17:56:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:56:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:56:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:56:54 INFO - 2017-01-31 17:56:54.236 screenresolution[2007:17716] starting screenresolution argv=screenresolution get 17:56:54 INFO - 2017-01-31 17:56:54.239 screenresolution[2007:17716] Display 0: 1600x1200x32@60 17:56:54 INFO - 2017-01-31 17:56:54.245 screenresolution[2008:17719] starting screenresolution argv=screenresolution list 17:56:54 INFO - Available Modes on Display 0 17:56:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:56:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:56:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:56:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:56:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:56:54 INFO - Intel Iris: 17:56:54 INFO - Chipset Model: Intel Iris 17:56:54 INFO - Type: GPU 17:56:54 INFO - Bus: Built-In 17:56:54 INFO - VRAM (Dynamic, Max): 1536 MB 17:56:54 INFO - Vendor: Intel (0x8086) 17:56:54 INFO - Device ID: 0x0a2e 17:56:54 INFO - Revision ID: 0x0009 17:56:54 INFO - Displays: 17:56:54 INFO - Display: 17:56:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:56:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:56:54 INFO - Display Serial Number: 1600x1200 60 17:56:54 INFO - Main Display: Yes 17:56:54 INFO - Mirror: Off 17:56:54 INFO - Online: Yes 17:56:54 INFO - Rotation: Supported 17:56:54 INFO - Return code: 0 17:56:54 INFO - Running post-action listener: _resource_record_post_action 17:56:54 INFO - [mozharness: 2017-02-01 01:56:54.485124Z] Finished run-tests step (success) 17:56:54 INFO - Running post-run listener: _resource_record_post_run 17:56:54 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 864256; Write bytes: 507448832; Read time: 9; Write time: 1590 17:56:54 INFO - TinderboxPrint: CPU usage
53.7% 17:56:54 INFO - TinderboxPrint: I/O read bytes / time
864,256 / 9 17:56:54 INFO - TinderboxPrint: I/O write bytes / time
507,448,832 / 1,590 17:56:54 INFO - TinderboxPrint: CPU idle
2,221.3 (46.3%) 17:56:54 INFO - TinderboxPrint: CPU system
966.7 (20.1%) 17:56:54 INFO - TinderboxPrint: CPU user
1,609.7 (33.6%) 17:56:54 INFO - TinderboxPrint: Swap in / out
208,412,672 / 0 17:56:54 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205097472; Write bytes: 198656000; Read time: 15733; Write time: 423 17:56:54 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 827392; Write bytes: 297836032; Read time: 9; Write time: 1127 17:56:54 INFO - Running post-run listener: _upload_blobber_files 17:56:54 INFO - Blob upload gear active. 17:56:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:56:54 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:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:56:55 INFO - (blobuploader) - INFO - Open directory for files ... 17:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:56 INFO - (blobuploader) - INFO - Done attempting. 17:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:56 INFO - (blobuploader) - INFO - Done attempting. 17:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:57 INFO - (blobuploader) - INFO - Done attempting. 17:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:57:00 INFO - (blobuploader) - INFO - Done attempting. 17:57:00 INFO - (blobuploader) - INFO - Iteration through files over. 17:57:00 INFO - Return code: 0 17:57:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:57:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:57:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fb9007bec3d021398e3b0ab39ca7d8311b2e2494d1e7ab23371955588fae52c814dcff04c8215cb74ba1a06a34a6335bb94b9512d8806c125858624cf73e89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b5c60665d4fa5fe36925cf7de86f06c4e3268921326bb10614943371d16d9dd29e3f8b31c6e5140bf28398bcaeb54027a3fcadd9ca89a587ca0338458b7bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aff5b6dcb13317843ccba50f42e80e054d67ea90b4068702c7e4860e561dac3b4b99007e482c852d86065b8960db4903bea2fb19eb26dd0e3c75e7a607d5b57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/481a24206742a98e38032305d6d89c59d261934db6aecf46fa2627eb19a2ca4bb94db8b5679a09bb0c96e82bb4d1ddad8d833332643b856757558183f83b6744"} 17:57:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:57:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:57:00 INFO - Contents: 17:57:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fb9007bec3d021398e3b0ab39ca7d8311b2e2494d1e7ab23371955588fae52c814dcff04c8215cb74ba1a06a34a6335bb94b9512d8806c125858624cf73e89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b5c60665d4fa5fe36925cf7de86f06c4e3268921326bb10614943371d16d9dd29e3f8b31c6e5140bf28398bcaeb54027a3fcadd9ca89a587ca0338458b7bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aff5b6dcb13317843ccba50f42e80e054d67ea90b4068702c7e4860e561dac3b4b99007e482c852d86065b8960db4903bea2fb19eb26dd0e3c75e7a607d5b57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/481a24206742a98e38032305d6d89c59d261934db6aecf46fa2627eb19a2ca4bb94db8b5679a09bb0c96e82bb4d1ddad8d833332643b856757558183f83b6744"} 17:57:00 INFO - Running post-run listener: copy_logs_to_upload_dir 17:57:00 INFO - Copying logs to upload dir... 17:57:00 INFO - mkdir: /builds/slave/test/build/upload/logs 17:57:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.820223 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-31 17:57:00.306267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 17:57:00.310259) ========= 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.8XOqim274w/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.3aJbdPIYoD/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fb9007bec3d021398e3b0ab39ca7d8311b2e2494d1e7ab23371955588fae52c814dcff04c8215cb74ba1a06a34a6335bb94b9512d8806c125858624cf73e89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b5c60665d4fa5fe36925cf7de86f06c4e3268921326bb10614943371d16d9dd29e3f8b31c6e5140bf28398bcaeb54027a3fcadd9ca89a587ca0338458b7bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aff5b6dcb13317843ccba50f42e80e054d67ea90b4068702c7e4860e561dac3b4b99007e482c852d86065b8960db4903bea2fb19eb26dd0e3c75e7a607d5b57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/481a24206742a98e38032305d6d89c59d261934db6aecf46fa2627eb19a2ca4bb94db8b5679a09bb0c96e82bb4d1ddad8d833332643b856757558183f83b6744"} build_url:https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011066 build_url: 'https://queue.taskcluster.net/v1/task/VduMYrswTJe3iTBwkfa-3w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/69fb9007bec3d021398e3b0ab39ca7d8311b2e2494d1e7ab23371955588fae52c814dcff04c8215cb74ba1a06a34a6335bb94b9512d8806c125858624cf73e89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b5c60665d4fa5fe36925cf7de86f06c4e3268921326bb10614943371d16d9dd29e3f8b31c6e5140bf28398bcaeb54027a3fcadd9ca89a587ca0338458b7bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4aff5b6dcb13317843ccba50f42e80e054d67ea90b4068702c7e4860e561dac3b4b99007e482c852d86065b8960db4903bea2fb19eb26dd0e3c75e7a607d5b57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/481a24206742a98e38032305d6d89c59d261934db6aecf46fa2627eb19a2ca4bb94db8b5679a09bb0c96e82bb4d1ddad8d833332643b856757558183f83b6744"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 17:57:00.344372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:57:00.344665) ========= 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.8XOqim274w/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.3aJbdPIYoD/Listeners TMPDIR=/var/folders/6f/7g8vgtdj6xxdrmc14l087qw800000w/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.005139 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 17:57:00.392800) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 17:57:00.393130) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 17:57:00.397867) ========= ========= Total master_lag: 0.18 =========