builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1484323948.06 results: success (0) buildid: 20170113065915 builduid: 5d915976ee784e608a5fcff17b64ac89 revision: de67fccc4c64a49f261aea29141357b94c7b3b9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.057565) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.058054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.058347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.085259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.085668) ========= 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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-13 08:12:28-- 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% 173M=0s 2017-01-13 08:12:28 (173 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.266351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.266773) ========= 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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.025717 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:28.315970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 08:12:28.316316) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev de67fccc4c64a49f261aea29141357b94c7b3b9c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev de67fccc4c64a49f261aea29141357b94c7b3b9c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OmO7GI3pJV/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.04kvrX1Tq1/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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-13 08:12:28,410 truncating revision to first 12 chars 2017-01-13 08:12:28,410 Setting DEBUG logging. 2017-01-13 08:12:28,410 attempt 1/10 2017-01-13 08:12:28,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/de67fccc4c64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 08:12:29,417 unpacking tar archive at: mozilla-central-de67fccc4c64/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263464 ========= master_lag: 1.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-13 08:12:31.097566) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:31.097869) ========= script_repo_revision: de67fccc4c64a49f261aea29141357b94c7b3b9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:31.098238) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:31.098501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 08:12:31.119474) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-13 08:12:31.119904) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OmO7GI3pJV/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.04kvrX1Tq1/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:12:31 INFO - MultiFileLogger online at 20170113 08:12:31 in /builds/slave/test 08:12:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:12:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:31 INFO - {'append_to_log': False, 08:12:31 INFO - 'base_work_dir': '/builds/slave/test', 08:12:31 INFO - 'blob_upload_branch': 'Firefox', 08:12:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:31 INFO - 'branch': 'Firefox', 08:12:31 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:31 INFO - 'config_files': ('talos/mac_config.py',), 08:12:31 INFO - 'default_actions': ('clobber', 08:12:31 INFO - 'read-buildbot-config', 08:12:31 INFO - 'download-and-extract', 08:12:31 INFO - 'populate-webroot', 08:12:31 INFO - 'create-virtualenv', 08:12:31 INFO - 'install', 08:12:31 INFO - 'run-tests'), 08:12:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:31 INFO - 'download_minidump_stackwalk': True, 08:12:31 INFO - 'download_symbols': 'ondemand', 08:12:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:31 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:31 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:31 INFO - 'installer_path': 'installer.exe', 08:12:31 INFO - 'log_level': 'info', 08:12:31 INFO - 'log_name': 'talos', 08:12:31 INFO - 'log_to_console': True, 08:12:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:12:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:12:31 INFO - 'opt_config_files': (), 08:12:31 INFO - 'pip_index': False, 08:12:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:12:31 INFO - 'cmd': ('bash', 08:12:31 INFO - '-c', 08:12:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:12:31 INFO - 'enabled': True, 08:12:31 INFO - 'halt_on_failure': False, 08:12:31 INFO - 'name': 'check_screen_resolution'},), 08:12:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:12:31 INFO - 'cmd': ('bash', 08:12:31 INFO - '-c', 08:12:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:12:31 INFO - 'enabled': True, 08:12:31 INFO - 'halt_on_failure': False, 08:12:31 INFO - 'name': 'check_screen_resolution'},), 08:12:31 INFO - 'run_cmd_checks_enabled': True, 08:12:31 INFO - 'sps_profile': False, 08:12:31 INFO - 'sps_profile_interval': 0, 08:12:31 INFO - 'suite': 'dromaeojs', 08:12:31 INFO - 'system_bits': '32', 08:12:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:31 INFO - 'title': 't-yosemite-r7-0114', 08:12:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:31 INFO - 'use_talos_json': True, 08:12:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:31 INFO - 'work_dir': 'build'} 08:12:31 INFO - [mozharness: 2017-01-13 16:12:31.329757Z] Running clobber step. 08:12:31 INFO - Running pre-action listener: _resource_record_pre_action 08:12:31 INFO - Running main action method: clobber 08:12:31 INFO - rmtree: /builds/slave/test/build 08:12:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:33 INFO - Running post-action listener: _resource_record_post_action 08:12:33 INFO - [mozharness: 2017-01-13 16:12:33.665895Z] Finished clobber step (success) 08:12:33 INFO - [mozharness: 2017-01-13 16:12:33.666020Z] Running read-buildbot-config step. 08:12:33 INFO - Running pre-action listener: _resource_record_pre_action 08:12:33 INFO - Running main action method: read_buildbot_config 08:12:33 INFO - Using buildbot properties: 08:12:33 INFO - { 08:12:33 INFO - "project": "", 08:12:33 INFO - "product": "firefox", 08:12:33 INFO - "script_repo_revision": "production", 08:12:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:12:33 INFO - "repository": "", 08:12:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:12:33 INFO - "buildid": "20170113065915", 08:12:33 INFO - "pgo_build": "False", 08:12:33 INFO - "basedir": "/builds/slave/test", 08:12:33 INFO - "buildnumber": 12, 08:12:33 INFO - "slavename": "t-yosemite-r7-0114", 08:12:33 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:12:33 INFO - "platform": "yosemite_r7", 08:12:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:12:33 INFO - "branch": "mozilla-central", 08:12:33 INFO - "repo_path": "mozilla-central", 08:12:33 INFO - "revision": "de67fccc4c64a49f261aea29141357b94c7b3b9c", 08:12:33 INFO - "stage_platform": "macosx64", 08:12:33 INFO - "builduid": "5d915976ee784e608a5fcff17b64ac89", 08:12:33 INFO - "slavebuilddir": "test" 08:12:33 INFO - } 08:12:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:12:33 INFO - Running post-action listener: _resource_record_post_action 08:12:33 INFO - [mozharness: 2017-01-13 16:12:33.669342Z] Finished read-buildbot-config step (success) 08:12:33 INFO - [mozharness: 2017-01-13 16:12:33.669466Z] Running download-and-extract step. 08:12:33 INFO - Running pre-action listener: _resource_record_pre_action 08:12:33 INFO - Running main action method: download_and_extract 08:12:33 INFO - mkdir: /builds/slave/test/build/tests 08:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:33 INFO - trying https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:12:34 INFO - Downloaded 1199 bytes. 08:12:34 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:12:34 INFO - Using the following test package requirements: 08:12:34 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:12:34 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:12:34 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:12:34 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'jsshell-mac.zip'], 08:12:34 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:12:34 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:12:34 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:12:34 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:12:34 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:12:34 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:12:34 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:12:34 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:12:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:12:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:12:34 INFO - Fetch https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:12:35 INFO - Expected file size: 16316999 08:12:35 INFO - Obtained file size: 16316999 08:12:42 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:12:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:12:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:12:42 INFO - Fetch https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:12:43 INFO - Expected file size: 16316999 08:12:43 INFO - Obtained file size: 16316999 08:12:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:12:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:12:50 INFO - Fetch https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:12:51 INFO - Expected file size: 14403555 08:12:51 INFO - Obtained file size: 14403555 08:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:51 INFO - trying https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:12:51 INFO - Downloading https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:12:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:12:53 INFO - Downloaded 70065805 bytes. 08:12:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:12:53 INFO - mkdir: /builds/slave/test/properties 08:12:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:12:53 INFO - Writing to file /builds/slave/test/properties/build_url 08:12:53 INFO - Contents: 08:12:53 INFO - build_url:https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:12:54 INFO - Running post-action listener: _resource_record_post_action 08:12:54 INFO - Running post-action listener: set_extra_try_arguments 08:12:54 INFO - [mozharness: 2017-01-13 16:12:54.474273Z] Finished download-and-extract step (success) 08:12:54 INFO - [mozharness: 2017-01-13 16:12:54.474392Z] Running populate-webroot step. 08:12:54 INFO - Running pre-action listener: _resource_record_pre_action 08:12:54 INFO - Running main action method: populate_webroot 08:12:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:54 INFO - '--tppagecycles', 08:12:54 INFO - '7'], 08:12:54 INFO - 'tests': ['tsvgm']}}, 08:12:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:12:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:12:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:12:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:12:54 INFO - 'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:12:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:12:54 INFO - 'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['damp', 'tps']}, 08:12:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:12:54 INFO - 'tests': ['damp', 'tps']}, 08:12:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['dromaeo_dom']}, 08:12:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['basic_compositor_video']}, 08:12:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:12:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['a11yr', 08:12:54 INFO - 'ts_paint', 08:12:54 INFO - 'tpaint', 08:12:54 INFO - 'sessionrestore', 08:12:54 INFO - 'sessionrestore_no_auto_restore', 08:12:54 INFO - 'tabpaint']}, 08:12:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:12:54 INFO - 'ts_paint', 08:12:54 INFO - 'tpaint', 08:12:54 INFO - 'sessionrestore', 08:12:54 INFO - 'sessionrestore_no_auto_restore', 08:12:54 INFO - 'tabpaint']}, 08:12:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:12:54 INFO - 'ts_paint', 08:12:54 INFO - 'tpaint', 08:12:54 INFO - 'sessionrestore', 08:12:54 INFO - 'sessionrestore_no_auto_restore', 08:12:54 INFO - 'tabpaint']}, 08:12:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:12:54 INFO - 'ts_paint', 08:12:54 INFO - 'tpaint', 08:12:54 INFO - 'sessionrestore', 08:12:54 INFO - 'sessionrestore_no_auto_restore', 08:12:54 INFO - 'tabpaint']}, 08:12:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['a11yr', 08:12:54 INFO - 'ts_paint', 08:12:54 INFO - 'tpaint', 08:12:54 INFO - 'sessionrestore', 08:12:54 INFO - 'sessionrestore_no_auto_restore', 08:12:54 INFO - 'tabpaint']}, 08:12:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['a11yr', 08:12:54 INFO - 'ts_paint', 08:12:54 INFO - 'tpaint', 08:12:54 INFO - 'sessionrestore', 08:12:54 INFO - 'sessionrestore_no_auto_restore', 08:12:54 INFO - 'tabpaint']}, 08:12:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['tsvgx', 08:12:54 INFO - 'tsvgr_opacity', 08:12:54 INFO - 'tart', 08:12:54 INFO - 'tscrollx', 08:12:54 INFO - 'cart', 08:12:54 INFO - 'tsvg_static']}, 08:12:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:12:54 INFO - 'tsvgr_opacity', 08:12:54 INFO - 'tart', 08:12:54 INFO - 'tscrollx', 08:12:54 INFO - 'cart', 08:12:54 INFO - 'tsvg_static']}, 08:12:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:12:54 INFO - 'talos_options': ['--disable-e10s'], 08:12:54 INFO - 'tests': ['tp5o']}, 08:12:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:12:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:12:54 INFO - 'talos_options': ['--disable-e10s', 08:12:54 INFO - '--xperf_path', 08:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:54 INFO - 'tests': ['tp5n']}, 08:12:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:12:54 INFO - 'talos_options': ['--xperf_path', 08:12:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:54 INFO - 'tests': ['tp5n']}}, 08:12:54 INFO - 'talos.zip': {'path': '', 08:12:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:54 INFO - Running post-action listener: _resource_record_post_action 08:12:54 INFO - [mozharness: 2017-01-13 16:12:54.493125Z] Finished populate-webroot step (success) 08:12:54 INFO - [mozharness: 2017-01-13 16:12:54.493265Z] Running create-virtualenv step. 08:12:54 INFO - Running pre-action listener: _resource_record_pre_action 08:12:54 INFO - Running main action method: create_virtualenv 08:12:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:12:54 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 08:12:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:12:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:54 INFO - Using real prefix '/tools/python27' 08:12:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:12:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:58 INFO - Installing pip.................done. 08:12:58 INFO - Return code: 0 08:12:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:12:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:12:58 INFO - Reading from file tmpfile_stdout 08:12:58 INFO - Output received: 08:12:58 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) 08:12:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:12:58 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')]} 08:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:58 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')]} 08:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:58 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:12:58 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 08:12:58 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 08:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:58 INFO - 'HOME': '/Users/cltbld', 08:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:58 INFO - 'LOGNAME': 'cltbld', 08:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:58 INFO - 'MOZ_NO_REMOTE': '1', 08:12:58 INFO - 'NO_EM_RESTART': '1', 08:12:58 INFO - 'PAGER': '/bin/cat', 08:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:58 INFO - 'PWD': '/builds/slave/test', 08:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:58 INFO - 'SHELL': '/bin/bash', 08:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:12:58 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:58 INFO - 'USER': 'cltbld', 08:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:58 INFO - 'XPC_FLAGS': '0x0', 08:12:58 INFO - 'XPC_SERVICE_NAME': '0', 08:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:58 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 08:12:58 INFO - Cleaning up... 08:12:58 INFO - Return code: 0 08:12:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:12:58 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')]} 08:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:58 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')]} 08:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:58 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:12:58 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 08:12:58 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 08:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:58 INFO - 'HOME': '/Users/cltbld', 08:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:58 INFO - 'LOGNAME': 'cltbld', 08:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:58 INFO - 'MOZ_NO_REMOTE': '1', 08:12:58 INFO - 'NO_EM_RESTART': '1', 08:12:58 INFO - 'PAGER': '/bin/cat', 08:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:58 INFO - 'PWD': '/builds/slave/test', 08:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:58 INFO - 'SHELL': '/bin/bash', 08:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:12:58 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:58 INFO - 'USER': 'cltbld', 08:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:58 INFO - 'XPC_FLAGS': '0x0', 08:12:58 INFO - 'XPC_SERVICE_NAME': '0', 08:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:58 INFO - Downloading/unpacking psutil>=3.1.1 08:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:13:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:02 INFO - Installing collected packages: psutil 08:13:02 INFO - Running setup.py install for psutil 08:13:02 INFO - building 'psutil._psutil_osx' extension 08:13:02 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 08:13:03 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 08:13:03 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 08:13:03 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 08:13:03 INFO - building 'psutil._psutil_posix' extension 08:13:03 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 08:13:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:13:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:13:03 INFO - ^ 08:13:03 INFO - 1 warning generated. 08:13:03 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 08:13:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:13:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:13:03 INFO - Successfully installed psutil 08:13:03 INFO - Cleaning up... 08:13:03 INFO - Return code: 0 08:13:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:13:03 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')]} 08:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:03 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')]} 08:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:03 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13:03 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 08:13:03 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 08:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:03 INFO - 'HOME': '/Users/cltbld', 08:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:03 INFO - 'LOGNAME': 'cltbld', 08:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:03 INFO - 'MOZ_NO_REMOTE': '1', 08:13:03 INFO - 'NO_EM_RESTART': '1', 08:13:03 INFO - 'PAGER': '/bin/cat', 08:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:03 INFO - 'PWD': '/builds/slave/test', 08:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:03 INFO - 'SHELL': '/bin/bash', 08:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:03 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:03 INFO - 'USER': 'cltbld', 08:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:03 INFO - 'XPC_FLAGS': '0x0', 08:13:03 INFO - 'XPC_SERVICE_NAME': '0', 08:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:13:04 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 08:13:04 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 08:13:04 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 08:13:04 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 08:13:04 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 08:13:04 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 08:13:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:13:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:13:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:13:06 INFO - Installing collected packages: mozsystemmonitor 08:13:06 INFO - Running setup.py install for mozsystemmonitor 08:13:06 INFO - Successfully installed mozsystemmonitor 08:13:06 INFO - Cleaning up... 08:13:06 INFO - Return code: 0 08:13:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:06 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13:06 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 08:13:06 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 08:13:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:06 INFO - 'HOME': '/Users/cltbld', 08:13:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:06 INFO - 'LOGNAME': 'cltbld', 08:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:06 INFO - 'MOZ_NO_REMOTE': '1', 08:13:06 INFO - 'NO_EM_RESTART': '1', 08:13:06 INFO - 'PAGER': '/bin/cat', 08:13:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:06 INFO - 'PWD': '/builds/slave/test', 08:13:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:06 INFO - 'SHELL': '/bin/bash', 08:13:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:06 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:06 INFO - 'USER': 'cltbld', 08:13:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:06 INFO - 'XPC_FLAGS': '0x0', 08:13:06 INFO - 'XPC_SERVICE_NAME': '0', 08:13:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:07 INFO - Downloading/unpacking jsonschema==2.5.1 08:13:07 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 08:13:07 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 08:13:07 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 08:13:07 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 08:13:07 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 08:13:07 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 08:13:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:10 INFO - warning: no files found matching '*.txt' 08:13:10 INFO - no previously-included directories found matching 'build' 08:13:10 INFO - no previously-included directories found matching 'dist' 08:13:10 INFO - no previously-included directories found matching '.git*' 08:13:10 INFO - Installing collected packages: jsonschema, functools32 08:13:10 INFO - Running setup.py install for functools32 08:13:10 INFO - warning: no files found matching '*.txt' 08:13:10 INFO - no previously-included directories found matching 'build' 08:13:10 INFO - no previously-included directories found matching 'dist' 08:13:10 INFO - no previously-included directories found matching '.git*' 08:13:10 INFO - Successfully installed jsonschema functools32 08:13:10 INFO - Cleaning up... 08:13:10 INFO - Return code: 0 08:13:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:13:10 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')]} 08:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 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')]} 08:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13:10 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 08:13:10 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 08:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:10 INFO - 'HOME': '/Users/cltbld', 08:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:10 INFO - 'LOGNAME': 'cltbld', 08:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:10 INFO - 'MOZ_NO_REMOTE': '1', 08:13:10 INFO - 'NO_EM_RESTART': '1', 08:13:10 INFO - 'PAGER': '/bin/cat', 08:13:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:10 INFO - 'PWD': '/builds/slave/test', 08:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:10 INFO - 'SHELL': '/bin/bash', 08:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:10 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:10 INFO - 'USER': 'cltbld', 08:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:10 INFO - 'XPC_FLAGS': '0x0', 08:13:10 INFO - 'XPC_SERVICE_NAME': '0', 08:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:13:10 INFO - Cleaning up... 08:13:10 INFO - Return code: 0 08:13:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:13:10 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')]} 08:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 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')]} 08:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:10 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13:10 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 08:13:10 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 08:13:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:10 INFO - 'HOME': '/Users/cltbld', 08:13:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:10 INFO - 'LOGNAME': 'cltbld', 08:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:10 INFO - 'MOZ_NO_REMOTE': '1', 08:13:10 INFO - 'NO_EM_RESTART': '1', 08:13:10 INFO - 'PAGER': '/bin/cat', 08:13:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:10 INFO - 'PWD': '/builds/slave/test', 08:13:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:10 INFO - 'SHELL': '/bin/bash', 08:13:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:10 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:10 INFO - 'USER': 'cltbld', 08:13:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:10 INFO - 'XPC_FLAGS': '0x0', 08:13:10 INFO - 'XPC_SERVICE_NAME': '0', 08:13:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:13:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:13:13 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 08:13:13 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 08:13:13 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 08:13:13 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 08:13:13 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 08:13:13 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 08:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:13:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:13:14 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 08:13:14 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 08:13:14 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 08:13:14 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 08:13:14 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 08:13:14 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 08:13:14 INFO - Downloading docopt-0.6.1.tar.gz 08:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:13:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:13:14 INFO - Running setup.py install for blobuploader 08:13:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:13:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:13:15 INFO - Running setup.py install for requests 08:13:15 INFO - Running setup.py install for docopt 08:13:15 INFO - Successfully installed blobuploader requests docopt 08:13:15 INFO - Cleaning up... 08:13:15 INFO - Return code: 0 08:13:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:15 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13:15 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 08:13:15 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 08:13:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:15 INFO - 'HOME': '/Users/cltbld', 08:13:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:15 INFO - 'LOGNAME': 'cltbld', 08:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:15 INFO - 'MOZ_NO_REMOTE': '1', 08:13:15 INFO - 'NO_EM_RESTART': '1', 08:13:15 INFO - 'PAGER': '/bin/cat', 08:13:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:15 INFO - 'PWD': '/builds/slave/test', 08:13:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:15 INFO - 'SHELL': '/bin/bash', 08:13:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:15 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:15 INFO - 'USER': 'cltbld', 08:13:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:15 INFO - 'XPC_FLAGS': '0x0', 08:13:15 INFO - 'XPC_SERVICE_NAME': '0', 08:13:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-xnpm_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ZT_snG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-OKF7mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-UUboWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-UEIJa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-TriyG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-zj55RS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-jKhJ24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:16 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-22NpKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-8kRAEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-uTrD4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-bL3QRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-L6W9Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-2pZgMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-IetZhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-3ercIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:17 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-KdrrW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:13:17 INFO - Running setup.py install for manifestparser 08:13:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozcrash 08:13:18 INFO - Running setup.py install for mozdebug 08:13:18 INFO - Running setup.py install for mozdevice 08:13:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozfile 08:13:18 INFO - Running setup.py install for mozhttpd 08:13:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozinfo 08:13:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:13:18 INFO - Running setup.py install for mozInstall 08:13:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Running setup.py install for mozleak 08:13:19 INFO - Running setup.py install for mozlog 08:13:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Running setup.py install for moznetwork 08:13:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Running setup.py install for mozprocess 08:13:19 INFO - Running setup.py install for mozprofile 08:13:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:13:19 INFO - Running setup.py install for mozrunner 08:13:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:13:20 INFO - Running setup.py install for mozscreenshot 08:13:20 INFO - Running setup.py install for moztest 08:13:20 INFO - Running setup.py install for mozversion 08:13:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:13:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:13:20 INFO - Cleaning up... 08:13:20 INFO - Return code: 0 08:13:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:20 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')]} 08:13:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:20 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')]} 08:13:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:20 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13:20 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 08:13:20 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 08:13:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:20 INFO - 'HOME': '/Users/cltbld', 08:13:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:20 INFO - 'LOGNAME': 'cltbld', 08:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:20 INFO - 'MOZ_NO_REMOTE': '1', 08:13:20 INFO - 'NO_EM_RESTART': '1', 08:13:20 INFO - 'PAGER': '/bin/cat', 08:13:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:20 INFO - 'PWD': '/builds/slave/test', 08:13:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:20 INFO - 'SHELL': '/bin/bash', 08:13:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:20 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:20 INFO - 'USER': 'cltbld', 08:13:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:20 INFO - 'XPC_FLAGS': '0x0', 08:13:20 INFO - 'XPC_SERVICE_NAME': '0', 08:13:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:13:20 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-MbhKk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:13:20 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)) 08:13:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:13:20 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kbbMeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:13:20 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-74j9E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-dkhhlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-JYCLfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Vb01Gm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-EXLrSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kmAJ5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-s3_xhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-XMOI45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-EwZLgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:21 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)) 08:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:21 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-CiWpoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:22 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)) 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:22 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-nEHv7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:22 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)) 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:22 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-nqE8Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:22 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)) 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:22 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-1PzBDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:22 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)) 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:22 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Eyvc7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:22 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)) 08:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:22 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-GT9JR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:22 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)) 08:13:22 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)) 08:13:22 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)) 08:13:22 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)) 08:13:22 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)) 08:13:22 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)) 08:13:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:25 INFO - Downloading blessings-1.6.tar.gz 08:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:25 INFO - Installing collected packages: blessings 08:13:25 INFO - Running setup.py install for blessings 08:13:25 INFO - Successfully installed blessings 08:13:25 INFO - Cleaning up... 08:13:25 INFO - Return code: 0 08:13:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:25 INFO - Reading from file tmpfile_stdout 08:13:25 INFO - Current package versions: 08:13:25 INFO - blessings == 1.6 08:13:25 INFO - blobuploader == 1.2.4 08:13:25 INFO - docopt == 0.6.1 08:13:25 INFO - functools32 == 3.2.3-2 08:13:25 INFO - jsonschema == 2.5.1 08:13:25 INFO - manifestparser == 1.1 08:13:25 INFO - mozInstall == 1.12 08:13:25 INFO - mozcrash == 1.0 08:13:25 INFO - mozdebug == 0.1 08:13:25 INFO - mozdevice == 0.49 08:13:25 INFO - mozfile == 1.2 08:13:25 INFO - mozhttpd == 0.7 08:13:25 INFO - mozinfo == 0.9 08:13:25 INFO - mozleak == 0.1 08:13:25 INFO - mozlog == 3.4 08:13:25 INFO - moznetwork == 0.27 08:13:25 INFO - mozprocess == 0.24 08:13:25 INFO - mozprofile == 0.28 08:13:25 INFO - mozrunner == 6.13 08:13:25 INFO - mozscreenshot == 0.1 08:13:25 INFO - mozsystemmonitor == 0.3 08:13:25 INFO - moztest == 0.8 08:13:25 INFO - mozversion == 1.4 08:13:25 INFO - psutil == 3.1.1 08:13:25 INFO - requests == 1.2.3 08:13:25 INFO - wsgiref == 0.1.2 08:13:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:26 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 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13:26 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 08:13:26 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 08:13:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:26 INFO - 'HOME': '/Users/cltbld', 08:13:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:26 INFO - 'LOGNAME': 'cltbld', 08:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:26 INFO - 'MOZ_NO_REMOTE': '1', 08:13:26 INFO - 'NO_EM_RESTART': '1', 08:13:26 INFO - 'PAGER': '/bin/cat', 08:13:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:26 INFO - 'PWD': '/builds/slave/test', 08:13:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:26 INFO - 'SHELL': '/bin/bash', 08:13:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:26 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:26 INFO - 'USER': 'cltbld', 08:13:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:26 INFO - 'XPC_FLAGS': '0x0', 08:13:26 INFO - 'XPC_SERVICE_NAME': '0', 08:13:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 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)) 08:13:26 INFO - Cleaning up... 08:13:26 INFO - Return code: 0 08:13:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13: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')]} 08:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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')]} 08:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c629b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c62c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5a94da8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, '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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 08:13: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', 'jsonschema'] in /builds/slave/test/build 08:13: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 jsonschema 08:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:27 INFO - 'HOME': '/Users/cltbld', 08:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:27 INFO - 'LOGNAME': 'cltbld', 08:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:27 INFO - 'MOZ_NO_REMOTE': '1', 08:13:27 INFO - 'NO_EM_RESTART': '1', 08:13:27 INFO - 'PAGER': '/bin/cat', 08:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:27 INFO - 'PWD': '/builds/slave/test', 08:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:27 INFO - 'SHELL': '/bin/bash', 08:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:27 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:27 INFO - 'USER': 'cltbld', 08:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:27 INFO - 'XPC_FLAGS': '0x0', 08:13:27 INFO - 'XPC_SERVICE_NAME': '0', 08:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:13:27 INFO - Cleaning up... 08:13:27 INFO - Return code: 0 08:13:27 INFO - Running post-action listener: _resource_record_post_action 08:13:27 INFO - Running post-action listener: _start_resource_monitoring 08:13:27 INFO - Starting resource monitoring. 08:13:27 INFO - [mozharness: 2017-01-13 16:13:27.446739Z] Finished create-virtualenv step (success) 08:13:27 INFO - [mozharness: 2017-01-13 16:13:27.447744Z] Running install step. 08:13:27 INFO - Running pre-action listener: _resource_record_pre_action 08:13:27 INFO - Running main action method: install 08:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:27 INFO - Reading from file tmpfile_stdout 08:13:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:27 INFO - Reading from file tmpfile_stdout 08:13:27 INFO - Output received: 08:13:27 INFO - Usage: mozinstall [options] installer 08:13:27 INFO - Options: 08:13:27 INFO - -h, --help show this help message and exit 08:13:27 INFO - -d DEST, --destination=DEST 08:13:27 INFO - Directory to install application into. [default: 08:13:27 INFO - "/builds/slave/test"] 08:13:27 INFO - --app=APP Application being installed. [default: firefox] 08:13:27 INFO - mkdir: /builds/slave/test/build/application 08:13:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:13:49 INFO - Reading from file tmpfile_stdout 08:13:49 INFO - Output received: 08:13:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:13:49 INFO - Running post-action listener: _resource_record_post_action 08:13:49 INFO - [mozharness: 2017-01-13 16:13:49.714645Z] Finished install step (success) 08:13:49 INFO - [mozharness: 2017-01-13 16:13:49.714813Z] Running run-tests step. 08:13:49 INFO - Running pre-action listener: _resource_record_pre_action 08:13:49 INFO - Running main action method: run_tests 08:13:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:49 INFO - 2017-01-13 08:13:49.729 screenresolution[1629:7517] starting screenresolution argv=screenresolution get 08:13:49 INFO - 2017-01-13 08:13:49.732 screenresolution[1629:7517] Display 0: 1600x1200x32@60 08:13:49 INFO - 2017-01-13 08:13:49.738 screenresolution[1630:7520] starting screenresolution argv=screenresolution list 08:13:49 INFO - Available Modes on Display 0 08:13:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:49 INFO - Intel Iris: 08:13:49 INFO - Chipset Model: Intel Iris 08:13:49 INFO - Type: GPU 08:13:49 INFO - Bus: Built-In 08:13:49 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:49 INFO - Vendor: Intel (0x8086) 08:13:49 INFO - Device ID: 0x0a2e 08:13:49 INFO - Revision ID: 0x0009 08:13:49 INFO - Displays: 08:13:49 INFO - Display: 08:13:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:49 INFO - Display Serial Number: 1600x1200 60 08:13:49 INFO - Main Display: Yes 08:13:49 INFO - Mirror: Off 08:13:49 INFO - Online: Yes 08:13:49 INFO - Rotation: Supported 08:13:49 INFO - Return code: 0 08:13:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:49 INFO - Python 2.7.3 08:13:49 INFO - Return code: 0 08:13:49 INFO - grabbing minidump binary from tooltool 08:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:49 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 0x10c407d30>, '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 0x10c32edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c3fcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:49 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 08:13:49 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 08:13:49 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 08:13:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:50 INFO - Return code: 0 08:13:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:13:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:13:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 08:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --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 08:13:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OmO7GI3pJV/Render', 08:13:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:50 INFO - 'HOME': '/Users/cltbld', 08:13:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:50 INFO - 'LOGNAME': 'cltbld', 08:13:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:50 INFO - 'MOZ_NO_REMOTE': '1', 08:13:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:50 INFO - 'NO_EM_RESTART': '1', 08:13:50 INFO - 'PAGER': '/bin/cat', 08:13:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:50 INFO - 'PWD': '/builds/slave/test', 08:13:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:50 INFO - 'SHELL': '/bin/bash', 08:13:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.04kvrX1Tq1/Listeners', 08:13:50 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 08:13:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:50 INFO - 'USER': 'cltbld', 08:13:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:50 INFO - 'XPC_FLAGS': '0x0', 08:13:50 INFO - 'XPC_SERVICE_NAME': '0', 08:13:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--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 08:13:50 INFO - mozversion application_buildid: 20170113065915 08:13:50 INFO - mozversion application_changeset: de67fccc4c64a49f261aea29141357b94c7b3b9c 08:13:50 INFO - mozversion application_display_name: Nightly 08:13:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:50 INFO - mozversion application_name: Firefox 08:13:50 INFO - mozversion application_remotingname: firefox 08:13:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:13:50 INFO - mozversion application_vendor: Mozilla 08:13:50 INFO - mozversion application_version: 53.0a1 08:13:50 INFO - mozversion platform_buildid: 20170113065915 08:13:50 INFO - mozversion platform_changeset: de67fccc4c64a49f261aea29141357b94c7b3b9c 08:13:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:13:50 INFO - mozversion platform_version: 53.0a1 08:13:50 INFO - using testdate: 1484324030 08:13:50 INFO - actual date: 1484324030 08:13:50 INFO - starting webserver on 'localhost:49241' 08:13:50 INFO - SUITE-START | Running 2 tests 08:13:50 INFO - TEST-START | dromaeo_css 08:13:50 INFO - operating with platform_type : mac_ 08:13:50 INFO - Initialising browser for dromaeo_css test... 08:13:50 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpAW8Uee/profile http://localhost:49241/getInfo.html) 08:13:52 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 08:13:52 INFO - PROCESS | 1640 | colorDepth:24 08:13:52 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 08:13:52 INFO - PROCESS | 1640 | __metrics 08:13:52 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:13:52 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:53 INFO - TEST-INFO | 1640: exit 0 08:13:53 INFO - Browser initialized. 08:13:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:53 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpAW8Uee/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:05 INFO - PROCESS | 1642 | RSS: Main: 235442176 08:14:05 INFO - PROCESS | 1642 | 08:17:08 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 08:17:11 INFO - PROCESS | 1642 | RSS: Main: 384245760 08:17:11 INFO - PROCESS | 1642 | 08:18:55 INFO - PROCESS | 1642 | ************************* 08:18:55 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 08:18:55 INFO - PROCESS | 1642 | 08:18:55 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:18:55 INFO - PROCESS | 1642 | Full stack: 08:18:55 INFO - PROCESS | 1642 | ************************* 08:20:14 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 08:20:14 INFO - PROCESS | 1642 | RSS: Main: 366149632 08:20:14 INFO - PROCESS | 1642 | 08:23:17 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 08:23:17 INFO - PROCESS | 1642 | RSS: Main: 342683648 08:23:17 INFO - PROCESS | 1642 | 08:26:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 08:26:20 INFO - PROCESS | 1642 | RSS: Main: 326787072 08:26:20 INFO - PROCESS | 1642 | 08:29:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 08:29:24 INFO - PROCESS | 1642 | RSS: Main: 327499776 08:29:24 INFO - PROCESS | 1642 | 08:32:27 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 08:32:28 INFO - PROCESS | 1642 | RSS: Main: 403505152 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | __start_tp_report 08:32:28 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 08:32:28 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 08:32:28 INFO - PROCESS | 1642 | |i|pagename|runs| 08:32:28 INFO - PROCESS | 1642 | |0;dojo.html;3054.144839444955;3360.495925611158;3365.394229038772;3399.694027537524;3416.572928383952;5399.271098401715;5619.4942455179025;5695.316562012559;5701.828945131642;5727.79952701655;5669.121286200635;5730.4269573042675;5801.53587712983;5822;5825.504832089277;5110.1312776827845;5166.870828229286;5178.611604129686;5219.530242278194;5253.553447956928;5307.363116426015;5322.973385133088;5375.75809088592;5382.300300960869;5387.138057910735;5245.160774276135;5249.1338929076655;5264.657797243186;5292.470752924696;5296.25852380667;5120.257562653432;5164.535191832753;5175.197844334134;5208.921866172011;5211.452797456251;4243.681723870691;5171.534561889411;5172.250023746536;5191.636585439021;5191.922121168185;5634.267545219136;5648.576356773258;5655.717214139277;5669.433056694339;5677.091665333527;5637.816058627693;6043.3956604339655;6228.47058000066;6305.653189074599;6308.369163083701;6229.221347331583;6258.530610204253;6266.749330026793;6299.716512756937;6301.180846489973;5744.425557444306;5794.159846822187;5937.465628093449;5942.40393163588;5943.821685349447;6175;6209.782657606962;6210.192674952227;6224.37756224374;6229.470495007885;6191.566590338633;6197.96901015492;6203.193584834033;6209.627422354582;6219.813405597839;5494.423085576037;6233.532485063638;6264.029075493306;6284.308726040132;6284.780032698925;5963.4334738199805;6117.705611546597;6118.7714669719035;6148.784792532329;6183.96908015457;6224.253089629274;6268.780592679234;6269.655168965751;6271.122042913996;6279.905801412891;4967.205247160437;4982.252662100714;4982.750862456863;4988.625853060962;5005.849824505271;3710.666040056408;4296.5273819879785;4321.870343889688;4477.395551600493;4496;5752.798652047159;5790.71046447676;5794.652320860678;5836.649801011953;5859.589828711949;6187.597806142587;6222.968885155636;6233.2208473940755;6262.091996660459;6272.8118156455375;5592.993261213021;5827.24245848037;5831;5833.38749431312;5838.883222335615;5215.295935048795;5401.351837779492;5434.266374039533;5449.291592093082;5493.505584497335;6333.1450254216015;6337.809865703944;6351.174347334817;6375.171227740364;6384.361563843579;6166.630002199703;6208.751649933952;6251.187345645037;6259.78090766821;6266.185395898504;6155.876882462415;6192.2569291683485;6283.277423096402;6356.968215158895;6368.77709280173;6160.045192995093;6200.100985357189;6204.72078756448;6260.186175797117;6268.1851359323;6157.784477543264;6205.348438413902;6252.124702541739;6255.56211065221;6259.123722678738;5697.314023889696;5998.880022399615;6071.787487437919;6217.782377616762;6226.1905952225925;6027.668478233739;6060.787872424444;6068.4841788448475;6133.141360209664;6144.2319710036245;5932.970335148297;5979.671118088547;5981.7607295707685;5996.37038110992;5998.70006499682;6104.974570883654;6137.1101190328045;6162.815115546541;6178.320384757763;6205.689715514297;6048.848778780566;6051.13664726493;6054.939450605614;6065.029595264913;6092.299385570539 08:32:28 INFO - PROCESS | 1642 | |1;ext.html;463.8080134055477;495.09150708449994;502.94970502949684;520.1080147546957;540.2544488605723;29897.55153672694;40702.59297407025;40719.778406647776;40727;40854.795726021366;41872.58127418725;42298.154036919244;42407.78796106015;42444.363334549926;42504.3624345635;8357.206065423805;8590.239001004778;9146.222571081466;9377.062293770603;9397.718068457958;10930.344179349224;11232.943835280812;11266.4366781661;11403.315801051922;11425.5429782809;11253.54985800567;11291.49188286525;11297.096232301437;11305.039071678875;11307.547698092067;8457.746267611981;8679.088695686989;8679.132086791333;11270.492827822767;11326.263792853479;8522;8602.440841345293;10875.293105948167;11151.665450036511;11157.38634375109;40169;40482.595174048176;40537.59462405368;40549;40550.39174412386;4033.899152521181;4072.7759973201464;4095.3037983542868;4096.365063415145;4119.588041195886;30663;30824.691753082407;31359;31378.52932206019;31625.683743162503;3163.3831402876217;3188.1232661018175;3202.6957439043254;3285.3100848821537;3316.2206881382854;467083.66458167834;481150;483618;484807;485429;59655.70172149198;59988.80022399528;59998;60077.399226008056;60123.386427492944;63656;63867.36132638707;63897.680511597144;63924.36075639277;63927.680361598825;15521.767173492406;16023.278952447168;16038.919805400898;16049.358025678843;16057.598560035858;11102.61140860066;11386.715332116597;12246.081543884244;12445.502179912883;12534.74930501385;16103.19484025794;16145;16171.67656646884;16253.837461625233;16274.430394936357;5171.379434467813;5391.892162156813;6334.674295994548;6406.67966601668;6446.580972236789;869.9217070463562;882.2544949517647;882.4881568690273;893.4862454088925;915.5239275576663;29840.701592984227;29909.953151640024;30046.399072018874;30535.389292214033;30705.69294307073;1019.2457581389866;1029.4029462911642;1032.1845741863995;1072.1208608940594;1075.7095584192225;11489.790622941779;12415.882570568512;13427.865721342858;14083.465346040024;14318;609277;611800;613848;614448;614559;51384.229236561485;51522.48477515177;51588.74205628948;51594.22608660873;51605;1392.9860701393059;1430.6423394151461;1456.0462896802612;1459.9854001460062;1462.2542503323168;26834.731652683222;27154.049608263616;28306;29717.554236686035;30636.234094147825;50853;51458;51590.484095158565;51716.74141629268;51734.48265517447;522034;526894;527373;527519;527984;21940.45148871291;22263.888680556494;23699.763002369757;24082.638760418256;24117.276481705576;40709.59290407058;42313;42421.15157696767;42732.93167670833;43929.34105988349;35826.462603060456;36242;36392.45411318779;37150.44274335833;37159.81420092882;35090;35099.649003509636;35491.46762798508;36177.819110904275;36354.818225908704;34742.65257347495;35146;35644.93065208048;35745.28509429849;36101.63898361088;31454.370912581162;31925.201869952507;32344.35311293808;32546.02361929146;32643.836780816895;23984.042632965364;24114;24585.508289834463;24587;24634.47186495544 08:32:28 INFO - PROCESS | 1642 | |2;jquery.html;367.69848724046295;390.5313623651618;393.1213737297142;400.7054814711188;426.63948963126165;14365.928170359146;15987.200639968;19107.331243406465;20998.370048898556;21477.92610369483;18084.547886302847;20968.685469717966;21271.468213294676;21367.57264854702;21652.89173554134;5675.801346952858;5931.169636250928;5931.851703707421;7548.66031028605;7900.525968441883;7669.846603067936;7850.9214907850765;8030.678772849079;8031.799205019863;8032.076311224197;7914.3272821810215;7984.680612775482;8009.599520024005;8011.158828323029;8016.038075430956;7259.74590889319;7579.355754760852;7666.195049519832;7744.186860379692;7960.641771120285;7331.523450975723;7536.095668519758;7556.924430755732;7585.317321441042;7655.617219139021;22836.429089272737;28451.57322640162;28507.57238641422;28702.282442938886;28889.56665650017;2172.8153106985924;2256.435891027243;2334.4163959010248;3012.4426981008364;3022.350194708148;17057.40299089538;17102.144892755314;17275.963442193384;17724.379646712434;17934.372296969545;1560.6020464781523;1777.7155655095123;1861.6782084719864;1937.2832052140657;1964.2437661500283;125689.37155314165;141188;142222;144803;144956.10087798184;22401.88799056027;22852.65721014186;23057.654135187986;23365.76634233636;23708.021315523933;39386.42454301853;39469.40795888064;39655;39668.801655992116;39687.40468892969;9104.31717621181;9684.661036863676;10278.33190842593;10584;10757.78484430307;8760.95619521911;8762;8781.385303028854;8782.341324400695;8933.017368089504;9006.459612423276;9144.725658230263;10644.09525190352;10928.180386471047;11033.724156896142;3665.340238756996;3875.3529749856198;4085.976377480643;4139.5653456387245;4142.937855932163;974.2206235011962;1015.7866847961863;1021.7701017271203;1034.1261633919326;1053.7102296868422;20117.396478105682;20947.476313092295;21066.368008959755;21100.47248818792;21244.57510849805;1016.202281209262;1030.9639162629271;1039.927205095651;1072.5280876414354;1084.8481212630238;10435.530401131968;10626.46867656614;10911.945440272748;11075.889241107647;11159.38623375722;737738;740378;753722;758576;759536;137000;145266;146757;150279;152930.23534882255;967.5065716484644;1011.2112552209288;1013.437542164106;1019.9235057370727;1037.0303765978683;13733.725325493633;15246.695066098839;18076.367327143485;18433.986130762936;19003.334883279018;55311.723441382535;55588.610284743205;57127;57171;57843.42156578381;82602.58698706709;82897.17102829136;83764.58117709616;84253.57873210595;84255;7133.500654954103;7280.854382912418;7457.515261507984;7938.5236885787035;8656.091110433314;12178.66034736196;12704.237745735285;12933.353332333534;13098.2141071536;13140;9194.494302813142;10263.23025773055;10571.735706607396;10647.520861561094;11273.323600583992;9462.384944978554;9815.46014969155;10559.841602375816;10985.395803230898;11166.49750761234;11086.168537359568;11464.82802757976;11717.179797414099;11734.119941004288;11773.823392648947;7991.880121798294;8033.598320084089;8036.437449378721;8504.319654427754;8506.191911768372;6742.42689371409;9431.811363772824;11383.487743051417;11490.885091149315;11504.424778760862 08:32:28 INFO - PROCESS | 1642 | |3;mootools.html;1452.9128252304856;1460.926953652317;1463.4731496661193;1484.5620541940127;1485.4875068101505;8087.6764929402825;8498.362622803284;8506.064332923374;8511.978562572485;8520.872186917186;7478.364339031175;7708.653110610022;7904.723334683287;8278.875816862752;8286.41995060346;2269.4553307206274;2345.3550273674705;2346.2022912209845;2348.3894187511287;2355.49356888269;2328.3247858121126;2352.9647055294186;2359.8112151027963;2362.14962613459;2364.108713029578;2310.306907927615;2314.143766806284;2329.9301020969397;2333.4049817296564;2340.0756701103137;2283.1552325639454;2287.9885600571974;2306.031466783955;2307.3424074138957;2308.215206829669;2264.116994372196;2330.382448651109;2331.80179684727;2337.053493335202;2337.49743805081;8156.469829461066;8212.507249564986;8317.708880189164;8317.708880189224;8323.66705331786;5007.624428167902;5031.371078615173;5149.510796474329;5152.510511501401;5168.224766285088;3195.265089029513;3337.599488061424;3452.5339079224236;3512.227309991798;3514;1177.43483128099;1187.1274613159321;1220.9023278137727;1222.1628184693514;1234.9012079033746;10467.52896119669;10581.365118092863;10721.142308615292;10731.731706707316;10750.677479675544;4390.648748100144;4643.164230438486;4692.225782745877;4696.694714843524;4701.4358277006295;8602.827943441096;8729.91270087291;9172.12864777845;9192.862107068398;9453.480058596706;5055.16589762685;5177.948220517746;5186.714730689773;5188;5190.091733946544;4251.511076226274;4505.211587972091;4628.282616194495;4737.905241895142;4800.255960326155;3815.904602384907;3818.6181381861593;3823.1780167263614;3926.744761590545;3944.901377465529;1221.9938900305442;1254.5797157952006;1264.4942023190797;1281.4681907008487;1281.641140480667;789.2022779247582;856.5374697663192;906.1436942089794;909.5088652127777;934.3226161033197;4548.363229147922;5342.198670199424;5477.287952566141;5603.719814009283;5830.154627578977;848.9957550212209;851.8977722673195;1020.4897551224387;1026.830572955454;1051.153821173947;3616.8191590420374;3769.189624230749;3779.962200378016;3864.516935383077;3947.2500224957166;9745.12293893553;9999.650012249536;10088.344257623232;10097.747556311151;10105.040021198121;8330.541820199947;10009.699709008595;10011.599536018623;10025.899741002497;10036.19710423179;7402.074740657418;7732.497387669783;7734.071911370559;7814.6092695365005;7825.100113487022;4914.557689807934;5681.9147712783515;5757.7121143941795;5881;5904.848554531825;8538.829223415622;8851.513166775632;9211.493367864832;9214.124658157465;9344.345895787501;9233.907660923305;9447.527623618655;9485.525723713648;9555.283353748635;9651.131398174199;6663.100481435138;6907.930920690729;6966.164060312795;7191.964040179766;7222.855542889218;7937.960310198412;8036.799080023046;8090.069641991011;8106.108328084024;8108.027036755627;6948.933100087977;7107.147142342952;7167.8566428672175;7169.5698258104685;7171.42628589722;6943.375096241362;6969.756058537927;6973.860522789414;7125.786226413215;7166.856662866818;6295.276043254901;6316.3367846377305;6429.485641148791;6457.257415397289;6460.418562329413;4932.28481870134;4985.351904252424;4994.425641051325;5038.647294689336;5078.390593128848;4868.513148685103;4957.570790312649;5005.62457815658;5154.948450515597;5174.663646862942 08:32:28 INFO - PROCESS | 1642 | |4;prototype.html;328.7961463892387;358.33528804068453;367.3167907691693;368.90961714379966;377.51489336202985;4444.377787109807;5265.710385928773;5272.8154514592;5278.947210527894;5297.417284098746;5226.7647955841985;5232.895342093156;5235;5248.165990365198;5258.842234732964;3130.7338876195436;3736.2901048800777;3922.0783115967724;4084.8774536763945;4253.638440732541;4051.731030622846;4062.9796851015703;4099.70859179359;4102.774347410891;4107.897302567445;3864.3237433449035;4064.7764372959623;4087.4453466583386;4087.6306437343524;4102.835886564549;3375.3418083473734;3485.4597537381746;3747.220070466534;3880.2433525462548;4114.382842573638;3009.9849500752575;3357.748168887343;3370.7640465167447;3587.8744243951596;3640.3993341098685;5103.198117402559;5108.3359163308905;5126.743662816882;5133.204353325241;5144.971005798855;4154.563770804082;4346.500152482442;4560.8859778505475;4667.113248482811;4704.1062198182235;4435.852477933143;4876.341693871317;5092.363454568179;5525.861853453655;5567.610267281292;3540.964590354089;3702.777833330009;3987.3819557968563;4011.097503061788;4050.5949405059555;5588.636738611977;5589.289194740588;5701.009293494571;5719.685417302005;5842.298924129089;3429.4341433663167;4080.367543030835;4084.4894388201474;4089.161721847014;4110.280700877334;3687.3178461984617;3813.580506144322;3859.980700096538;4156.06488540076;4158.251514727378;3764.9269958061823;4203.5320860290385;4682;4736.076465089343;4737.8341758038305;4372.737635741865;4783.914375227959;5637.7181140942785;5649.12438572022;5667.4332566743;1248.456921239264;1264.6838290427393;1266.9303188324545;1267.9619611411672;1277.5783991282854;680.9285025072395;854.478767951549;859.8907409441875;862.611824678897;869.7216890594949;4317.7841107945105;4320.135972805451;4398.832840354939;5103.668261562986;5250.921236181461;4690.929636055462;5112.846614601568;5524.674078221278;5720.1991721159075;5720.313562372542;4059.939100913489;4086.5300490443383;4418.895276180955;4665.693605790384;4865.781039853215;2361.547648196381;2680.8257463264827;2798.0486634544354;2841.417509410566;2879.4097210071886;4540.296254080623;4782.715099814724;4888.95111048885;5506.449355064542;5592.468715472024;4822.9758851206225;5061.785171558799;5287;5348;5536.501714845684;4997.90004199914;5486.31421072366;5532.644502097012;6009.278886533644;6029.728662210211;5789.507891829242;5794.913076303775;5800.4489573490455;5812.593118481665;5812.593118481835;4838.927416088832;5440.374356949002;5596.4123767003875;5677.3754886963225;5734.397888221677;5652.745626446737;5902.881942361043;5912.349641539513;5913.822585322448;5941.435563621449;3573.6783689468075;3722;3878.42923615936;3895.6883449324555;3896.337622604221;5398.244245805512;5728.4271572844045;5731.3408957968695;5779.566532509994;5789.247397838254;4776.355192049029;5611.80358687444;5616.135770757025;5624.29696287964;5648.63283886546;4945.975270123627;4949.406071271471;5116.283720279238;5474.768177160107;5581.995240856685;4862.246351815475;5169.302144210634;5432.266644003009;5449.509544141047;5483.670979741229;4619.491855895782;4846.660733748604;4985.127602669446;4986.8753281168265;5062.569681577107;5087.592992560661;5246.527812496894;5338.386085600206;5418.187271909087;5432.854022661106 08:32:28 INFO - PROCESS | 1642 | |5;yui.html;716.6452605960051;752.8005078654157;765.0933643632296;819.2258315891481;844.6199210355339;15022.474213402533;15146.697066058687;15432.228388580568;15887.682246355065;15893.84106158938;14180.858191418083;14372.856271437282;14479.203643799587;14641.487547935798;14652.120872747615;884.2218847414266;892.6340200517789;898.5417437107089;898.9730308090768;898.9865152022692;694.3924066441863;722.8807246804297;873.978150546235;894.4007514964957;904.6291020681522;937.2829785214283;939.3377668743519;941.3645789092369;942.0861764088822;944.8535477001076;931.3992474853716;935.2751617496494;936.3632729743772;938.2634631814061;938.3056538161779;525.9552938000274;541.1044720986773;681.2268075734078;696.4045740891567;699.7410957945542;15030.473933412279;15048.699026019527;15050.32273547682;15052.397904083824;15117.244137793066;13558.93220533901;13572.660683482893;13635.045546811727;13636.522721704692;13711.520096796665;12602.369881505889;12732.745345093139;12782.10525263232;12988.155769875022;13126.671833204151;4324.783760811947;4374.562543745632;4425.9114817703785;4453.287474004176;4501.572350626685;103626.48186759018;104355;104715.47642261816;106408.4679576605;106840;10566;10713.625023124308;10731.731706707395;10764;10775.461226938622;20802.687959680617;21456.785432145793;21507.34375156227;21523.13907443716;21583.67624485634;7258;7380.077490313711;7527.774166775005;7666.540007599562;7727.150013498511;4196.874093777192;4280.400743895857;4290.635295999875;4310;4324.13517296542;3474.982625086909;3536.8938931832085;3539.1682954505673;3563.198280386944;3582.731295152822;651.9087327774115;654.3946849164504;661.5270081891471;668.1714673804447;669.6885948034187;532.9014132385521;622.1352320274822;641.5124505375948;644.8323435906698;645.3965542217948;9534.761630959143;9586.616535338648;9652.613895444103;9678.564464598969;10146.746331341776;627.3945642455053;638.1735652330243;647.2750519418281;658.5488940075968;683.2586643491768;3978.562358140602;4540.500544940054;4633.791479383436;4685.67200295976;4739.241721324572;105336;106354;108419;108555;112132.43933780279;95323.61690957782;98397.50801245948;98408;100383;101303.97392052118;85171;85441.57279213564;87294.56352718196;87504.99999999872;88771;8786.692465763668;8796.95601522014;8846.292296616126;8990.370674052754;9050.818983620422;36802.81598592097;46957.765211173726;47409.52590474189;47962.16302695846;47981.163861409026;60711;68241;68305.65847170733;71410.64294678494;75370;13092.934535327262;13120.753528414785;13133.934330328288;13209.141405808592;13621.659458513617;14884.10695358282;14893.180875051976;14974.251287435367;14975.1014939104;15224.162671052756;13550.32248387557;13596.388162532512;13675;13765.518206862711;13874.028817982644;11517.02105321057;12183.573574924834;12278.815817762563;14101;14450.85549144495;13708.725825483236;13749.931250343685;13814.930925345308;13980.370883310072;14629.049111807699;11194.608188713355;11309.71725706864;11430.885691143314;11452.770944580896;11672.941635291769;9079.016481175;9592.328537002342;11489.82765258505;11526.711832204262;11566.363849988331 08:32:28 INFO - PROCESS | 1642 | __end_tp_report 08:32:28 INFO - PROCESS | 1642 | __start_cc_report 08:32:28 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2173 08:32:28 INFO - PROCESS | 1642 | __end_cc_report 08:32:28 INFO - PROCESS | 1642 | __startTimestamp1484325148169__endTimestamp 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | ------- Summary: start ------- 08:32:28 INFO - PROCESS | 1642 | Number of tests: 6 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5745.50 Median:5996.37 stddev:662.60 (11.1%) stddev-sans-first:630.10 08:32:28 INFO - PROCESS | 1642 | Values: 3054.1 3360.5 3365.4 3399.7 3416.6 5399.3 5619.5 5695.3 5701.8 5727.8 5669.1 5730.4 5801.5 5822.0 5825.5 5110.1 5166.9 5178.6 5219.5 5253.6 5307.4 5323.0 5375.8 5382.3 5387.1 5245.2 5249.1 5264.7 5292.5 5296.3 5120.3 5164.5 5175.2 5208.9 5211.5 4243.7 5171.5 5172.3 5191.6 5191.9 5634.3 5648.6 5655.7 5669.4 5677.1 5637.8 6043.4 6228.5 6305.7 6308.4 6229.2 6258.5 6266.7 6299.7 6301.2 5744.4 5794.2 5937.5 5942.4 5943.8 6175.0 6209.8 6210.2 6224.4 6229.5 6191.6 6198.0 6203.2 6209.6 6219.8 5494.4 6233.5 6264.0 6284.3 6284.8 5963.4 6117.7 6118.8 6148.8 6184.0 6224.3 6268.8 6269.7 6271.1 6279.9 4967.2 4982.3 4982.8 4988.6 5005.8 3710.7 4296.5 4321.9 4477.4 4496.0 5752.8 5790.7 5794.7 5836.6 5859.6 6187.6 6223.0 6233.2 6262.1 6272.8 5593.0 5827.2 5831.0 5833.4 5838.9 5215.3 5401.4 5434.3 5449.3 5493.5 6333.1 6337.8 6351.2 6375.2 6384.4 6166.6 6208.8 6251.2 6259.8 6266.2 6155.9 6192.3 6283.3 6357.0 6368.8 6160.0 6200.1 6204.7 6260.2 6268.2 6157.8 6205.3 6252.1 6255.6 6259.1 5697.3 5998.9 6071.8 6217.8 6226.2 6027.7 6060.8 6068.5 6133.1 6144.2 5933.0 5979.7 5981.8 5996.4 5998.7 6105.0 6137.1 6162.8 6178.3 6205.7 6048.8 6051.1 6054.9 6065.0 6092.3 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:67031.95 Median:36209.91 stddev:144889.20 (400.1%) stddev-sans-first:145209.45 08:32:28 INFO - PROCESS | 1642 | Values: 463.8 495.1 502.9 520.1 540.3 29897.6 40702.6 40719.8 40727.0 40854.8 41872.6 42298.2 42407.8 42444.4 42504.4 8357.2 8590.2 9146.2 9377.1 9397.7 10930.3 11232.9 11266.4 11403.3 11425.5 11253.5 11291.5 11297.1 11305.0 11307.5 8457.7 8679.1 8679.1 11270.5 11326.3 8522.0 8602.4 10875.3 11151.7 11157.4 40169.0 40482.6 40537.6 40549.0 40550.4 4033.9 4072.8 4095.3 4096.4 4119.6 30663.0 30824.7 31359.0 31378.5 31625.7 3163.4 3188.1 3202.7 3285.3 3316.2 467083.7 481150.0 483618.0 484807.0 485429.0 59655.7 59988.8 59998.0 60077.4 60123.4 63656.0 63867.4 63897.7 63924.4 63927.7 15521.8 16023.3 16038.9 16049.4 16057.6 11102.6 11386.7 12246.1 12445.5 12534.7 16103.2 16145.0 16171.7 16253.8 16274.4 5171.4 5391.9 6334.7 6406.7 6446.6 869.9 882.3 882.5 893.5 915.5 29840.7 29910.0 30046.4 30535.4 30705.7 1019.2 1029.4 1032.2 1072.1 1075.7 11489.8 12415.9 13427.9 14083.5 14318.0 609277.0 611800.0 613848.0 614448.0 614559.0 51384.2 51522.5 51588.7 51594.2 51605.0 1393.0 1430.6 1456.0 1460.0 1462.3 26834.7 27154.0 28306.0 29717.6 30636.2 50853.0 51458.0 51590.5 51716.7 51734.5 522034.0 526894.0 527373.0 527519.0 527984.0 21940.5 22263.9 23699.8 24082.6 24117.3 40709.6 42313.0 42421.2 42732.9 43929.3 35826.5 36242.0 36392.5 37150.4 37159.8 35090.0 35099.6 35491.5 36177.8 36354.8 34742.7 35146.0 35644.9 35745.3 36101.6 31454.4 31925.2 32344.4 32546.0 32643.8 23984.0 24114.0 24585.5 24587.0 24634.5 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:42259.42 Median:12850.09 stddev:124583.95 (969.5%) stddev-sans-first:124893.73 08:32:28 INFO - PROCESS | 1642 | Values: 367.7 390.5 393.1 400.7 426.6 14365.9 15987.2 19107.3 20998.4 21477.9 18084.5 20968.7 21271.5 21367.6 21652.9 5675.8 5931.2 5931.9 7548.7 7900.5 7669.8 7850.9 8030.7 8031.8 8032.1 7914.3 7984.7 8009.6 8011.2 8016.0 7259.7 7579.4 7666.2 7744.2 7960.6 7331.5 7536.1 7556.9 7585.3 7655.6 22836.4 28451.6 28507.6 28702.3 28889.6 2172.8 2256.4 2334.4 3012.4 3022.4 17057.4 17102.1 17276.0 17724.4 17934.4 1560.6 1777.7 1861.7 1937.3 1964.2 125689.4 141188.0 142222.0 144803.0 144956.1 22401.9 22852.7 23057.7 23365.8 23708.0 39386.4 39469.4 39655.0 39668.8 39687.4 9104.3 9684.7 10278.3 10584.0 10757.8 8761.0 8762.0 8781.4 8782.3 8933.0 9006.5 9144.7 10644.1 10928.2 11033.7 3665.3 3875.4 4086.0 4139.6 4142.9 974.2 1015.8 1021.8 1034.1 1053.7 20117.4 20947.5 21066.4 21100.5 21244.6 1016.2 1031.0 1039.9 1072.5 1084.8 10435.5 10626.5 10911.9 11075.9 11159.4 737738.0 740378.0 753722.0 758576.0 759536.0 137000.0 145266.0 146757.0 150279.0 152930.2 967.5 1011.2 1013.4 1019.9 1037.0 13733.7 15246.7 18076.4 18434.0 19003.3 55311.7 55588.6 57127.0 57171.0 57843.4 82602.6 82897.2 83764.6 84253.6 84255.0 7133.5 7280.9 7457.5 7938.5 8656.1 12178.7 12704.2 12933.4 13098.2 13140.0 9194.5 10263.2 10571.7 10647.5 11273.3 9462.4 9815.5 10559.8 10985.4 11166.5 11086.2 11464.8 11717.2 11734.1 11773.8 7991.9 8033.6 8036.4 8504.3 8506.2 6742.4 9431.8 11383.5 11490.9 11504.4 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5409.93 Median:5046.91 stddev:2918.53 (57.8%) stddev-sans-first:2911.56 08:32:28 INFO - PROCESS | 1642 | Values: 1452.9 1460.9 1463.5 1484.6 1485.5 8087.7 8498.4 8506.1 8512.0 8520.9 7478.4 7708.7 7904.7 8278.9 8286.4 2269.5 2345.4 2346.2 2348.4 2355.5 2328.3 2353.0 2359.8 2362.1 2364.1 2310.3 2314.1 2329.9 2333.4 2340.1 2283.2 2288.0 2306.0 2307.3 2308.2 2264.1 2330.4 2331.8 2337.1 2337.5 8156.5 8212.5 8317.7 8317.7 8323.7 5007.6 5031.4 5149.5 5152.5 5168.2 3195.3 3337.6 3452.5 3512.2 3514.0 1177.4 1187.1 1220.9 1222.2 1234.9 10467.5 10581.4 10721.1 10731.7 10750.7 4390.6 4643.2 4692.2 4696.7 4701.4 8602.8 8729.9 9172.1 9192.9 9453.5 5055.2 5177.9 5186.7 5188.0 5190.1 4251.5 4505.2 4628.3 4737.9 4800.3 3815.9 3818.6 3823.2 3926.7 3944.9 1222.0 1254.6 1264.5 1281.5 1281.6 789.2 856.5 906.1 909.5 934.3 4548.4 5342.2 5477.3 5603.7 5830.2 849.0 851.9 1020.5 1026.8 1051.2 3616.8 3769.2 3780.0 3864.5 3947.3 9745.1 9999.7 10088.3 10097.7 10105.0 8330.5 10009.7 10011.6 10025.9 10036.2 7402.1 7732.5 7734.1 7814.6 7825.1 4914.6 5681.9 5757.7 5881.0 5904.8 8538.8 8851.5 9211.5 9214.1 9344.3 9233.9 9447.5 9485.5 9555.3 9651.1 6663.1 6907.9 6966.2 7192.0 7222.9 7938.0 8036.8 8090.1 8106.1 8108.0 6948.9 7107.1 7167.9 7169.6 7171.4 6943.4 6969.8 6973.9 7125.8 7166.9 6295.3 6316.3 6429.5 6457.3 6460.4 4932.3 4985.4 4994.4 5038.6 5078.4 4868.5 4957.6 5005.6 5154.9 5174.7 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4429.73 Median:4871.06 stddev:1357.39 (27.9%) stddev-sans-first:1325.84 08:32:28 INFO - PROCESS | 1642 | Values: 328.8 358.3 367.3 368.9 377.5 4444.4 5265.7 5272.8 5278.9 5297.4 5226.8 5232.9 5235.0 5248.2 5258.8 3130.7 3736.3 3922.1 4084.9 4253.6 4051.7 4063.0 4099.7 4102.8 4107.9 3864.3 4064.8 4087.4 4087.6 4102.8 3375.3 3485.5 3747.2 3880.2 4114.4 3010.0 3357.7 3370.8 3587.9 3640.4 5103.2 5108.3 5126.7 5133.2 5145.0 4154.6 4346.5 4560.9 4667.1 4704.1 4435.9 4876.3 5092.4 5525.9 5567.6 3541.0 3702.8 3987.4 4011.1 4050.6 5588.6 5589.3 5701.0 5719.7 5842.3 3429.4 4080.4 4084.5 4089.2 4110.3 3687.3 3813.6 3860.0 4156.1 4158.3 3764.9 4203.5 4682.0 4736.1 4737.8 4372.7 4783.9 5637.7 5649.1 5667.4 1248.5 1264.7 1266.9 1268.0 1277.6 680.9 854.5 859.9 862.6 869.7 4317.8 4320.1 4398.8 5103.7 5250.9 4690.9 5112.8 5524.7 5720.2 5720.3 4059.9 4086.5 4418.9 4665.7 4865.8 2361.5 2680.8 2798.0 2841.4 2879.4 4540.3 4782.7 4889.0 5506.4 5592.5 4823.0 5061.8 5287.0 5348.0 5536.5 4997.9 5486.3 5532.6 6009.3 6029.7 5789.5 5794.9 5800.4 5812.6 5812.6 4838.9 5440.4 5596.4 5677.4 5734.4 5652.7 5902.9 5912.3 5913.8 5941.4 3573.7 3722.0 3878.4 3895.7 3896.3 5398.2 5728.4 5731.3 5779.6 5789.2 4776.4 5611.8 5616.1 5624.3 5648.6 4946.0 4949.4 5116.3 5474.8 5582.0 4862.2 5169.3 5432.3 5449.5 5483.7 4619.5 4846.7 4985.1 4986.9 5062.6 5087.6 5246.5 5338.4 5418.2 5432.9 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:21038.99 Median:4300.32 stddev:30851.85 (717.4%) stddev-sans-first:30900.66 08:32:28 INFO - PROCESS | 1642 | Values: 716.6 752.8 765.1 819.2 844.6 15022.5 15146.7 15432.2 15887.7 15893.8 14180.9 14372.9 14479.2 14641.5 14652.1 884.2 892.6 898.5 899.0 899.0 694.4 722.9 874.0 894.4 904.6 937.3 939.3 941.4 942.1 944.9 931.4 935.3 936.4 938.3 938.3 526.0 541.1 681.2 696.4 699.7 15030.5 15048.7 15050.3 15052.4 15117.2 13558.9 13572.7 13635.0 13636.5 13711.5 12602.4 12732.7 12782.1 12988.2 13126.7 4324.8 4374.6 4425.9 4453.3 4501.6 103626.5 104355.0 104715.5 106408.5 106840.0 10566.0 10713.6 10731.7 10764.0 10775.5 20802.7 21456.8 21507.3 21523.1 21583.7 7258.0 7380.1 7527.8 7666.5 7727.2 4196.9 4280.4 4290.6 4310.0 4324.1 3475.0 3536.9 3539.2 3563.2 3582.7 651.9 654.4 661.5 668.2 669.7 532.9 622.1 641.5 644.8 645.4 9534.8 9586.6 9652.6 9678.6 10146.7 627.4 638.2 647.3 658.5 683.3 3978.6 4540.5 4633.8 4685.7 4739.2 105336.0 106354.0 108419.0 108555.0 112132.4 95323.6 98397.5 98408.0 100383.0 101304.0 85171.0 85441.6 87294.6 87505.0 88771.0 8786.7 8797.0 8846.3 8990.4 9050.8 36802.8 46957.8 47409.5 47962.2 47981.2 60711.0 68241.0 68305.7 71410.6 75370.0 13092.9 13120.8 13133.9 13209.1 13621.7 14884.1 14893.2 14974.3 14975.1 15224.2 13550.3 13596.4 13675.0 13765.5 13874.0 11517.0 12183.6 12278.8 14101.0 14450.9 13708.7 13749.9 13814.9 13980.4 14629.0 11194.6 11309.7 11430.9 11452.8 11672.9 9079.0 9592.3 11489.8 11526.7 11566.4 08:32:28 INFO - PROCESS | 1642 | -------- Summary: end -------- 08:32:28 INFO - PROCESS | 1642 | 08:32:28 INFO - TEST-INFO | 1642: exit 0 08:32:28 INFO - TEST-OK | dromaeo_css | took 1118519ms 08:32:28 INFO - TEST-START | kraken 08:32:28 INFO - operating with platform_type : mac_ 08:32:28 INFO - Initialising browser for kraken test... 08:32:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpcubnSk/profile http://localhost:49241/getInfo.html) 08:32:31 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 08:32:31 INFO - PROCESS | 1653 | colorDepth:24 08:32:31 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 08:32:31 INFO - PROCESS | 1653 | __metrics 08:32:31 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:32:31 INFO - PROCESS | 1653 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:31 INFO - TEST-INFO | 1653: exit 0 08:32:31 INFO - Browser initialized. 08:32:31 INFO - Running cycle 1/1 for kraken test... 08:32:31 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpcubnSk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:43 INFO - PROCESS | 1654 | RSS: Main: 226582528 08:32:43 INFO - PROCESS | 1654 | 08:32:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:47 INFO - PROCESS | 1654 | RSS: Main: 286945280 08:32:47 INFO - PROCESS | 1654 | 08:32:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 08:32:50 INFO - PROCESS | 1654 | RSS: Main: 288669696 08:32:50 INFO - PROCESS | 1654 | 08:32:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 08:32:54 INFO - PROCESS | 1654 | RSS: Main: 379920384 08:32:54 INFO - PROCESS | 1654 | 08:32:56 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 08:32:57 INFO - PROCESS | 1654 | RSS: Main: 283889664 08:32:57 INFO - PROCESS | 1654 | 08:32:59 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:33:00 INFO - PROCESS | 1654 | RSS: Main: 287821824 08:33:00 INFO - PROCESS | 1654 | 08:33:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 08:33:03 INFO - PROCESS | 1654 | RSS: Main: 329170944 08:33:03 INFO - PROCESS | 1654 | 08:33:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 08:33:07 INFO - PROCESS | 1654 | RSS: Main: 330518528 08:33:07 INFO - PROCESS | 1654 | 08:33:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 08:33:10 INFO - PROCESS | 1654 | RSS: Main: 329056256 08:33:10 INFO - PROCESS | 1654 | 08:33:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:12 INFO - PROCESS | 1654 | RSS: Main: 303915008 08:33:12 INFO - PROCESS | 1654 | 08:33:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:15 INFO - PROCESS | 1654 | RSS: Main: 308842496 08:33:15 INFO - PROCESS | 1654 | 08:33:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:18 INFO - PROCESS | 1654 | RSS: Main: 310374400 08:33:18 INFO - PROCESS | 1654 | 08:33:20 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:21 INFO - PROCESS | 1654 | RSS: Main: 326631424 08:33:21 INFO - PROCESS | 1654 | 08:33:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:25 INFO - PROCESS | 1654 | RSS: Main: 319741952 08:33:25 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 08:33:27 INFO - PROCESS | 1654 | RSS: Main: 363831296 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | __start_tp_report 08:33:27 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 08:33:27 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 08:33:27 INFO - PROCESS | 1654 | |i|pagename|runs| 08:33:27 INFO - PROCESS | 1654 | |0;ai-astar;116;162;167;114;114;113;114;113;114;113 08:33:27 INFO - PROCESS | 1654 | |1;audio-beat-detection;141;109;108;146;112;130;110;110;127;110 08:33:27 INFO - PROCESS | 1654 | |2;audio-dft;184;185;182;185;182;182;180;183;186;184 08:33:27 INFO - PROCESS | 1654 | |3;audio-fft;80;59;59;88;60;59;58;58;71;58 08:33:27 INFO - PROCESS | 1654 | |4;audio-oscillator;90;72;83;70;68;69;81;68;69;83 08:33:27 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;88;88;85;87;85;88;85;88;84 08:33:27 INFO - PROCESS | 1654 | |6;imaging-darkroom;92;93;93;117;128;148;148;93;93;93 08:33:27 INFO - PROCESS | 1654 | |7;imaging-desaturate;87;88;87;87;86;88;87;87;85;84 08:33:27 INFO - PROCESS | 1654 | |8;json-parse-financial;57;53;53;56;56;55;56;56;55;54 08:33:27 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;65;72;83;78;75;76;70;72;72;71 08:33:27 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;88;90;87;87;85;88;91;96;107;107 08:33:27 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;140;144;159;138;137;141;141;141;199;142 08:33:27 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;176;171;172;172;172;170;169;172;171;171 08:33:27 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;68;67;67;66;67;67;66;66;65;66 08:33:27 INFO - PROCESS | 1654 | __end_tp_report 08:33:27 INFO - PROCESS | 1654 | __start_cc_report 08:33:27 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1975 08:33:27 INFO - PROCESS | 1654 | __end_cc_report 08:33:27 INFO - PROCESS | 1654 | __startTimestamp1484325207269__endTimestamp 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | ------- Summary: start ------- 08:33:27 INFO - PROCESS | 1654 | Number of tests: 14 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:124.00 Median:114.00 stddev:21.40 (18.8%) stddev-sans-first:22.50 08:33:27 INFO - PROCESS | 1654 | Values: 116.0 162.0 167.0 114.0 114.0 113.0 114.0 113.0 114.0 113.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:120.30 Median:119.50 stddev:14.51 (12.1%) stddev-sans-first:13.31 08:33:27 INFO - PROCESS | 1654 | Values: 141.0 109.0 108.0 146.0 112.0 130.0 110.0 110.0 127.0 110.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.83 (1.0%) stddev-sans-first:1.92 08:33:27 INFO - PROCESS | 1654 | Values: 184.0 185.0 182.0 185.0 182.0 182.0 180.0 183.0 186.0 184.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:65.00 Median:59.50 stddev:10.90 (18.3%) stddev-sans-first:10.12 08:33:27 INFO - PROCESS | 1654 | Values: 80.0 59.0 59.0 88.0 60.0 59.0 58.0 58.0 71.0 58.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.50 stddev:8.11 (10.6%) stddev-sans-first:6.63 08:33:27 INFO - PROCESS | 1654 | Values: 90.0 72.0 83.0 70.0 68.0 69.0 81.0 68.0 69.0 83.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:1.65 (1.9%) stddev-sans-first:1.67 08:33:27 INFO - PROCESS | 1654 | Values: 88.0 88.0 88.0 85.0 87.0 85.0 88.0 85.0 88.0 84.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:109.80 Median:93.00 stddev:23.64 (25.4%) stddev-sans-first:24.18 08:33:27 INFO - PROCESS | 1654 | Values: 92.0 93.0 93.0 117.0 128.0 148.0 148.0 93.0 93.0 93.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 08:33:27 INFO - PROCESS | 1654 | Values: 87.0 88.0 87.0 87.0 86.0 88.0 87.0 87.0 85.0 84.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.37 (2.4%) stddev-sans-first:1.27 08:33:27 INFO - PROCESS | 1654 | Values: 57.0 53.0 53.0 56.0 56.0 55.0 56.0 56.0 55.0 54.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:73.50 stddev:4.90 (6.7%) stddev-sans-first:4.15 08:33:27 INFO - PROCESS | 1654 | Values: 65.0 72.0 83.0 78.0 75.0 76.0 70.0 72.0 72.0 71.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:88.00 stddev:8.15 (9.3%) stddev-sans-first:8.48 08:33:27 INFO - PROCESS | 1654 | Values: 88.0 90.0 87.0 87.0 85.0 88.0 91.0 96.0 107.0 107.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:141.50 stddev:18.87 (13.3%) stddev-sans-first:19.78 08:33:27 INFO - PROCESS | 1654 | Values: 140.0 144.0 159.0 138.0 137.0 141.0 141.0 141.0 199.0 142.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:172.00 stddev:1.84 (1.1%) stddev-sans-first:1.05 08:33:27 INFO - PROCESS | 1654 | Values: 176.0 171.0 172.0 172.0 172.0 170.0 169.0 172.0 171.0 171.0 08:33:27 INFO - PROCESS | 1654 | 08:33:27 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 08:33:27 INFO - PROCESS | 1654 | Values: 68.0 67.0 67.0 66.0 67.0 67.0 66.0 66.0 65.0 66.0 08:33:27 INFO - PROCESS | 1654 | -------- Summary: end -------- 08:33:27 INFO - PROCESS | 1654 | 08:33:28 INFO - TEST-INFO | 1654: exit 0 08:33:28 INFO - TEST-OK | kraken | took 59354ms 08:33:28 INFO - SUITE-END | took 1177s 08:33:28 INFO - Completed test suite (00:19:38) 08:33:28 INFO - javascript benchmark 08:33:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3054.144839444955, 3360.495925611158, 3365.394229038772, 3399.694027537524, 3416.572928383952, 5399.271098401715, 5619.4942455179025, 5695.316562012559, 5701.828945131642, 5727.79952701655, 5669.121286200635, 5730.4269573042675, 5801.53587712983, 5822.0, 5825.504832089277, 5110.1312776827845, 5166.870828229286, 5178.611604129686, 5219.530242278194, 5253.553447956928, 5307.363116426015, 5322.973385133088, 5375.75809088592, 5382.300300960869, 5387.138057910735, 5245.160774276135, 5249.1338929076655, 5264.657797243186, 5292.470752924696, 5296.25852380667, 5120.257562653432, 5164.535191832753, 5175.197844334134, 5208.921866172011, 5211.452797456251, 4243.681723870691, 5171.534561889411, 5172.250023746536, 5191.636585439021, 5191.922121168185, 5634.267545219136, 5648.576356773258, 5655.717214139277, 5669.433056694339, 5677.091665333527, 5637.816058627693, 6043.3956604339655, 6228.47058000066, 6305.653189074599, 6308.369163083701, 6229.221347331583, 6258.530610204253, 6266.749330026793, 6299.716512756937, 6301.180846489973, 5744.425557444306, 5794.159846822187, 5937.465628093449, 5942.40393163588, 5943.821685349447, 6175.0, 6209.782657606962, 6210.192674952227, 6224.37756224374, 6229.470495007885, 6191.566590338633, 6197.96901015492, 6203.193584834033, 6209.627422354582, 6219.813405597839, 5494.423085576037, 6233.532485063638, 6264.029075493306, 6284.308726040132, 6284.780032698925, 5963.4334738199805, 6117.705611546597, 6118.7714669719035, 6148.784792532329, 6183.96908015457, 6224.253089629274, 6268.780592679234, 6269.655168965751, 6271.122042913996, 6279.905801412891, 4967.205247160437, 4982.252662100714, 4982.750862456863, 4988.625853060962, 5005.849824505271, 3710.666040056408, 4296.5273819879785, 4321.870343889688, 4477.395551600493, 4496.0, 5752.798652047159, 5790.71046447676, 5794.652320860678, 5836.649801011953, 5859.589828711949, 6187.597806142587, 6222.968885155636, 6233.2208473940755, 6262.091996660459, 6272.8118156455375, 5592.993261213021, 5827.24245848037, 5831.0, 5833.38749431312, 5838.883222335615, 5215.295935048795, 5401.351837779492, 5434.266374039533, 5449.291592093082, 5493.505584497335, 6333.1450254216015, 6337.809865703944, 6351.174347334817, 6375.171227740364, 6384.361563843579, 6166.630002199703, 6208.751649933952, 6251.187345645037, 6259.78090766821, 6266.185395898504, 6155.876882462415, 6192.2569291683485, 6283.277423096402, 6356.968215158895, 6368.77709280173, 6160.045192995093, 6200.100985357189, 6204.72078756448, 6260.186175797117, 6268.1851359323, 6157.784477543264, 6205.348438413902, 6252.124702541739, 6255.56211065221, 6259.123722678738, 5697.314023889696, 5998.880022399615, 6071.787487437919, 6217.782377616762, 6226.1905952225925, 6027.668478233739, 6060.787872424444, 6068.4841788448475, 6133.141360209664, 6144.2319710036245, 5932.970335148297, 5979.671118088547, 5981.7607295707685, 5996.37038110992, 5998.70006499682, 6104.974570883654, 6137.1101190328045, 6162.815115546541, 6178.320384757763, 6205.689715514297, 6048.848778780566, 6051.13664726493, 6054.939450605614, 6065.029595264913, 6092.299385570539], "value": 5701.318071929789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.8080134055477, 495.09150708449994, 502.94970502949684, 520.1080147546957, 540.2544488605723, 29897.55153672694, 40702.59297407025, 40719.778406647776, 40727.0, 40854.795726021366, 41872.58127418725, 42298.154036919244, 42407.78796106015, 42444.363334549926, 42504.3624345635, 8357.206065423805, 8590.239001004778, 9146.222571081466, 9377.062293770603, 9397.718068457958, 10930.344179349224, 11232.943835280812, 11266.4366781661, 11403.315801051922, 11425.5429782809, 11253.54985800567, 11291.49188286525, 11297.096232301437, 11305.039071678875, 11307.547698092067, 8457.746267611981, 8679.088695686989, 8679.132086791333, 11270.492827822767, 11326.263792853479, 8522.0, 8602.440841345293, 10875.293105948167, 11151.665450036511, 11157.38634375109, 40169.0, 40482.595174048176, 40537.59462405368, 40549.0, 40550.39174412386, 4033.899152521181, 4072.7759973201464, 4095.3037983542868, 4096.365063415145, 4119.588041195886, 30663.0, 30824.691753082407, 31359.0, 31378.52932206019, 31625.683743162503, 3163.3831402876217, 3188.1232661018175, 3202.6957439043254, 3285.3100848821537, 3316.2206881382854, 467083.66458167834, 481150.0, 483618.0, 484807.0, 485429.0, 59655.70172149198, 59988.80022399528, 59998.0, 60077.399226008056, 60123.386427492944, 63656.0, 63867.36132638707, 63897.680511597144, 63924.36075639277, 63927.680361598825, 15521.767173492406, 16023.278952447168, 16038.919805400898, 16049.358025678843, 16057.598560035858, 11102.61140860066, 11386.715332116597, 12246.081543884244, 12445.502179912883, 12534.74930501385, 16103.19484025794, 16145.0, 16171.67656646884, 16253.837461625233, 16274.430394936357, 5171.379434467813, 5391.892162156813, 6334.674295994548, 6406.67966601668, 6446.580972236789, 869.9217070463562, 882.2544949517647, 882.4881568690273, 893.4862454088925, 915.5239275576663, 29840.701592984227, 29909.953151640024, 30046.399072018874, 30535.389292214033, 30705.69294307073, 1019.2457581389866, 1029.4029462911642, 1032.1845741863995, 1072.1208608940594, 1075.7095584192225, 11489.790622941779, 12415.882570568512, 13427.865721342858, 14083.465346040024, 14318.0, 609277.0, 611800.0, 613848.0, 614448.0, 614559.0, 51384.229236561485, 51522.48477515177, 51588.74205628948, 51594.22608660873, 51605.0, 1392.9860701393059, 1430.6423394151461, 1456.0462896802612, 1459.9854001460062, 1462.2542503323168, 26834.731652683222, 27154.049608263616, 28306.0, 29717.554236686035, 30636.234094147825, 50853.0, 51458.0, 51590.484095158565, 51716.74141629268, 51734.48265517447, 522034.0, 526894.0, 527373.0, 527519.0, 527984.0, 21940.45148871291, 22263.888680556494, 23699.763002369757, 24082.638760418256, 24117.276481705576, 40709.59290407058, 42313.0, 42421.15157696767, 42732.93167670833, 43929.34105988349, 35826.462603060456, 36242.0, 36392.45411318779, 37150.44274335833, 37159.81420092882, 35090.0, 35099.649003509636, 35491.46762798508, 36177.819110904275, 36354.818225908704, 34742.65257347495, 35146.0, 35644.93065208048, 35745.28509429849, 36101.63898361088, 31454.370912581162, 31925.201869952507, 32344.35311293808, 32546.02361929146, 32643.836780816895, 23984.042632965364, 24114.0, 24585.508289834463, 24587.0, 24634.47186495544], "value": 19422.090676519478, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.69848724046295, 390.5313623651618, 393.1213737297142, 400.7054814711188, 426.63948963126165, 14365.928170359146, 15987.200639968, 19107.331243406465, 20998.370048898556, 21477.92610369483, 18084.547886302847, 20968.685469717966, 21271.468213294676, 21367.57264854702, 21652.89173554134, 5675.801346952858, 5931.169636250928, 5931.851703707421, 7548.66031028605, 7900.525968441883, 7669.846603067936, 7850.9214907850765, 8030.678772849079, 8031.799205019863, 8032.076311224197, 7914.3272821810215, 7984.680612775482, 8009.599520024005, 8011.158828323029, 8016.038075430956, 7259.74590889319, 7579.355754760852, 7666.195049519832, 7744.186860379692, 7960.641771120285, 7331.523450975723, 7536.095668519758, 7556.924430755732, 7585.317321441042, 7655.617219139021, 22836.429089272737, 28451.57322640162, 28507.57238641422, 28702.282442938886, 28889.56665650017, 2172.8153106985924, 2256.435891027243, 2334.4163959010248, 3012.4426981008364, 3022.350194708148, 17057.40299089538, 17102.144892755314, 17275.963442193384, 17724.379646712434, 17934.372296969545, 1560.6020464781523, 1777.7155655095123, 1861.6782084719864, 1937.2832052140657, 1964.2437661500283, 125689.37155314165, 141188.0, 142222.0, 144803.0, 144956.10087798184, 22401.88799056027, 22852.65721014186, 23057.654135187986, 23365.76634233636, 23708.021315523933, 39386.42454301853, 39469.40795888064, 39655.0, 39668.801655992116, 39687.40468892969, 9104.31717621181, 9684.661036863676, 10278.33190842593, 10584.0, 10757.78484430307, 8760.95619521911, 8762.0, 8781.385303028854, 8782.341324400695, 8933.017368089504, 9006.459612423276, 9144.725658230263, 10644.09525190352, 10928.180386471047, 11033.724156896142, 3665.340238756996, 3875.3529749856198, 4085.976377480643, 4139.5653456387245, 4142.937855932163, 974.2206235011962, 1015.7866847961863, 1021.7701017271203, 1034.1261633919326, 1053.7102296868422, 20117.396478105682, 20947.476313092295, 21066.368008959755, 21100.47248818792, 21244.57510849805, 1016.202281209262, 1030.9639162629271, 1039.927205095651, 1072.5280876414354, 1084.8481212630238, 10435.530401131968, 10626.46867656614, 10911.945440272748, 11075.889241107647, 11159.38623375722, 737738.0, 740378.0, 753722.0, 758576.0, 759536.0, 137000.0, 145266.0, 146757.0, 150279.0, 152930.23534882255, 967.5065716484644, 1011.2112552209288, 1013.437542164106, 1019.9235057370727, 1037.0303765978683, 13733.725325493633, 15246.695066098839, 18076.367327143485, 18433.986130762936, 19003.334883279018, 55311.723441382535, 55588.610284743205, 57127.0, 57171.0, 57843.42156578381, 82602.58698706709, 82897.17102829136, 83764.58117709616, 84253.57873210595, 84255.0, 7133.500654954103, 7280.854382912418, 7457.515261507984, 7938.5236885787035, 8656.091110433314, 12178.66034736196, 12704.237745735285, 12933.353332333534, 13098.2141071536, 13140.0, 9194.494302813142, 10263.23025773055, 10571.735706607396, 10647.520861561094, 11273.323600583992, 9462.384944978554, 9815.46014969155, 10559.841602375816, 10985.395803230898, 11166.49750761234, 11086.168537359568, 11464.82802757976, 11717.179797414099, 11734.119941004288, 11773.823392648947, 7991.880121798294, 8033.598320084089, 8036.437449378721, 8504.319654427754, 8506.191911768372, 6742.42689371409, 9431.811363772824, 11383.487743051417, 11490.885091149315, 11504.424778760862], "value": 11300.303167116324, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1452.9128252304856, 1460.926953652317, 1463.4731496661193, 1484.5620541940127, 1485.4875068101505, 8087.6764929402825, 8498.362622803284, 8506.064332923374, 8511.978562572485, 8520.872186917186, 7478.364339031175, 7708.653110610022, 7904.723334683287, 8278.875816862752, 8286.41995060346, 2269.4553307206274, 2345.3550273674705, 2346.2022912209845, 2348.3894187511287, 2355.49356888269, 2328.3247858121126, 2352.9647055294186, 2359.8112151027963, 2362.14962613459, 2364.108713029578, 2310.306907927615, 2314.143766806284, 2329.9301020969397, 2333.4049817296564, 2340.0756701103137, 2283.1552325639454, 2287.9885600571974, 2306.031466783955, 2307.3424074138957, 2308.215206829669, 2264.116994372196, 2330.382448651109, 2331.80179684727, 2337.053493335202, 2337.49743805081, 8156.469829461066, 8212.507249564986, 8317.708880189164, 8317.708880189224, 8323.66705331786, 5007.624428167902, 5031.371078615173, 5149.510796474329, 5152.510511501401, 5168.224766285088, 3195.265089029513, 3337.599488061424, 3452.5339079224236, 3512.227309991798, 3514.0, 1177.43483128099, 1187.1274613159321, 1220.9023278137727, 1222.1628184693514, 1234.9012079033746, 10467.52896119669, 10581.365118092863, 10721.142308615292, 10731.731706707316, 10750.677479675544, 4390.648748100144, 4643.164230438486, 4692.225782745877, 4696.694714843524, 4701.4358277006295, 8602.827943441096, 8729.91270087291, 9172.12864777845, 9192.862107068398, 9453.480058596706, 5055.16589762685, 5177.948220517746, 5186.714730689773, 5188.0, 5190.091733946544, 4251.511076226274, 4505.211587972091, 4628.282616194495, 4737.905241895142, 4800.255960326155, 3815.904602384907, 3818.6181381861593, 3823.1780167263614, 3926.744761590545, 3944.901377465529, 1221.9938900305442, 1254.5797157952006, 1264.4942023190797, 1281.4681907008487, 1281.641140480667, 789.2022779247582, 856.5374697663192, 906.1436942089794, 909.5088652127777, 934.3226161033197, 4548.363229147922, 5342.198670199424, 5477.287952566141, 5603.719814009283, 5830.154627578977, 848.9957550212209, 851.8977722673195, 1020.4897551224387, 1026.830572955454, 1051.153821173947, 3616.8191590420374, 3769.189624230749, 3779.962200378016, 3864.516935383077, 3947.2500224957166, 9745.12293893553, 9999.650012249536, 10088.344257623232, 10097.747556311151, 10105.040021198121, 8330.541820199947, 10009.699709008595, 10011.599536018623, 10025.899741002497, 10036.19710423179, 7402.074740657418, 7732.497387669783, 7734.071911370559, 7814.6092695365005, 7825.100113487022, 4914.557689807934, 5681.9147712783515, 5757.7121143941795, 5881.0, 5904.848554531825, 8538.829223415622, 8851.513166775632, 9211.493367864832, 9214.124658157465, 9344.345895787501, 9233.907660923305, 9447.527623618655, 9485.525723713648, 9555.283353748635, 9651.131398174199, 6663.100481435138, 6907.930920690729, 6966.164060312795, 7191.964040179766, 7222.855542889218, 7937.960310198412, 8036.799080023046, 8090.069641991011, 8106.108328084024, 8108.027036755627, 6948.933100087977, 7107.147142342952, 7167.8566428672175, 7169.5698258104685, 7171.42628589722, 6943.375096241362, 6969.756058537927, 6973.860522789414, 7125.786226413215, 7166.856662866818, 6295.276043254901, 6316.3367846377305, 6429.485641148791, 6457.257415397289, 6460.418562329413, 4932.28481870134, 4985.351904252424, 4994.425641051325, 5038.647294689336, 5078.390593128848, 4868.513148685103, 4957.570790312649, 5005.62457815658, 5154.948450515597, 5174.663646862942], "value": 4416.433873528507, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.7961463892387, 358.33528804068453, 367.3167907691693, 368.90961714379966, 377.51489336202985, 4444.377787109807, 5265.710385928773, 5272.8154514592, 5278.947210527894, 5297.417284098746, 5226.7647955841985, 5232.895342093156, 5235.0, 5248.165990365198, 5258.842234732964, 3130.7338876195436, 3736.2901048800777, 3922.0783115967724, 4084.8774536763945, 4253.638440732541, 4051.731030622846, 4062.9796851015703, 4099.70859179359, 4102.774347410891, 4107.897302567445, 3864.3237433449035, 4064.7764372959623, 4087.4453466583386, 4087.6306437343524, 4102.835886564549, 3375.3418083473734, 3485.4597537381746, 3747.220070466534, 3880.2433525462548, 4114.382842573638, 3009.9849500752575, 3357.748168887343, 3370.7640465167447, 3587.8744243951596, 3640.3993341098685, 5103.198117402559, 5108.3359163308905, 5126.743662816882, 5133.204353325241, 5144.971005798855, 4154.563770804082, 4346.500152482442, 4560.8859778505475, 4667.113248482811, 4704.1062198182235, 4435.852477933143, 4876.341693871317, 5092.363454568179, 5525.861853453655, 5567.610267281292, 3540.964590354089, 3702.777833330009, 3987.3819557968563, 4011.097503061788, 4050.5949405059555, 5588.636738611977, 5589.289194740588, 5701.009293494571, 5719.685417302005, 5842.298924129089, 3429.4341433663167, 4080.367543030835, 4084.4894388201474, 4089.161721847014, 4110.280700877334, 3687.3178461984617, 3813.580506144322, 3859.980700096538, 4156.06488540076, 4158.251514727378, 3764.9269958061823, 4203.5320860290385, 4682.0, 4736.076465089343, 4737.8341758038305, 4372.737635741865, 4783.914375227959, 5637.7181140942785, 5649.12438572022, 5667.4332566743, 1248.456921239264, 1264.6838290427393, 1266.9303188324545, 1267.9619611411672, 1277.5783991282854, 680.9285025072395, 854.478767951549, 859.8907409441875, 862.611824678897, 869.7216890594949, 4317.7841107945105, 4320.135972805451, 4398.832840354939, 5103.668261562986, 5250.921236181461, 4690.929636055462, 5112.846614601568, 5524.674078221278, 5720.1991721159075, 5720.313562372542, 4059.939100913489, 4086.5300490443383, 4418.895276180955, 4665.693605790384, 4865.781039853215, 2361.547648196381, 2680.8257463264827, 2798.0486634544354, 2841.417509410566, 2879.4097210071886, 4540.296254080623, 4782.715099814724, 4888.95111048885, 5506.449355064542, 5592.468715472024, 4822.9758851206225, 5061.785171558799, 5287.0, 5348.0, 5536.501714845684, 4997.90004199914, 5486.31421072366, 5532.644502097012, 6009.278886533644, 6029.728662210211, 5789.507891829242, 5794.913076303775, 5800.4489573490455, 5812.593118481665, 5812.593118481835, 4838.927416088832, 5440.374356949002, 5596.4123767003875, 5677.3754886963225, 5734.397888221677, 5652.745626446737, 5902.881942361043, 5912.349641539513, 5913.822585322448, 5941.435563621449, 3573.6783689468075, 3722.0, 3878.42923615936, 3895.6883449324555, 3896.337622604221, 5398.244245805512, 5728.4271572844045, 5731.3408957968695, 5779.566532509994, 5789.247397838254, 4776.355192049029, 5611.80358687444, 5616.135770757025, 5624.29696287964, 5648.63283886546, 4945.975270123627, 4949.406071271471, 5116.283720279238, 5474.768177160107, 5581.995240856685, 4862.246351815475, 5169.302144210634, 5432.266644003009, 5449.509544141047, 5483.670979741229, 4619.491855895782, 4846.660733748604, 4985.127602669446, 4986.8753281168265, 5062.569681577107, 5087.592992560661, 5246.527812496894, 5338.386085600206, 5418.187271909087, 5432.854022661106], "value": 4010.384484942414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.6452605960051, 752.8005078654157, 765.0933643632296, 819.2258315891481, 844.6199210355339, 15022.474213402533, 15146.697066058687, 15432.228388580568, 15887.682246355065, 15893.84106158938, 14180.858191418083, 14372.856271437282, 14479.203643799587, 14641.487547935798, 14652.120872747615, 884.2218847414266, 892.6340200517789, 898.5417437107089, 898.9730308090768, 898.9865152022692, 694.3924066441863, 722.8807246804297, 873.978150546235, 894.4007514964957, 904.6291020681522, 937.2829785214283, 939.3377668743519, 941.3645789092369, 942.0861764088822, 944.8535477001076, 931.3992474853716, 935.2751617496494, 936.3632729743772, 938.2634631814061, 938.3056538161779, 525.9552938000274, 541.1044720986773, 681.2268075734078, 696.4045740891567, 699.7410957945542, 15030.473933412279, 15048.699026019527, 15050.32273547682, 15052.397904083824, 15117.244137793066, 13558.93220533901, 13572.660683482893, 13635.045546811727, 13636.522721704692, 13711.520096796665, 12602.369881505889, 12732.745345093139, 12782.10525263232, 12988.155769875022, 13126.671833204151, 4324.783760811947, 4374.562543745632, 4425.9114817703785, 4453.287474004176, 4501.572350626685, 103626.48186759018, 104355.0, 104715.47642261816, 106408.4679576605, 106840.0, 10566.0, 10713.625023124308, 10731.731706707395, 10764.0, 10775.461226938622, 20802.687959680617, 21456.785432145793, 21507.34375156227, 21523.13907443716, 21583.67624485634, 7258.0, 7380.077490313711, 7527.774166775005, 7666.540007599562, 7727.150013498511, 4196.874093777192, 4280.400743895857, 4290.635295999875, 4310.0, 4324.13517296542, 3474.982625086909, 3536.8938931832085, 3539.1682954505673, 3563.198280386944, 3582.731295152822, 651.9087327774115, 654.3946849164504, 661.5270081891471, 668.1714673804447, 669.6885948034187, 532.9014132385521, 622.1352320274822, 641.5124505375948, 644.8323435906698, 645.3965542217948, 9534.761630959143, 9586.616535338648, 9652.613895444103, 9678.564464598969, 10146.746331341776, 627.3945642455053, 638.1735652330243, 647.2750519418281, 658.5488940075968, 683.2586643491768, 3978.562358140602, 4540.500544940054, 4633.791479383436, 4685.67200295976, 4739.241721324572, 105336.0, 106354.0, 108419.0, 108555.0, 112132.43933780279, 95323.61690957782, 98397.50801245948, 98408.0, 100383.0, 101303.97392052118, 85171.0, 85441.57279213564, 87294.56352718196, 87504.99999999872, 88771.0, 8786.692465763668, 8796.95601522014, 8846.292296616126, 8990.370674052754, 9050.818983620422, 36802.81598592097, 46957.765211173726, 47409.52590474189, 47962.16302695846, 47981.163861409026, 60711.0, 68241.0, 68305.65847170733, 71410.64294678494, 75370.0, 13092.934535327262, 13120.753528414785, 13133.934330328288, 13209.141405808592, 13621.659458513617, 14884.10695358282, 14893.180875051976, 14974.251287435367, 14975.1014939104, 15224.162671052756, 13550.32248387557, 13596.388162532512, 13675.0, 13765.518206862711, 13874.028817982644, 11517.02105321057, 12183.573574924834, 12278.815817762563, 14101.0, 14450.85549144495, 13708.725825483236, 13749.931250343685, 13814.930925345308, 13980.370883310072, 14629.049111807699, 11194.608188713355, 11309.71725706864, 11430.885691143314, 11452.770944580896, 11672.941635291769, 9079.016481175, 9592.328537002342, 11489.82765258505, 11526.711832204262, 11566.363849988331], "value": 7552.268269481806, "unit": "score"}], "name": "dromaeo_css", "value": 7423.76865910366, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 162.0, 167.0, 114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0], "value": 124.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 108.0, 146.0, 112.0, 130.0, 110.0, 110.0, 127.0, 110.0], "value": 120.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 182.0, 185.0, 182.0, 182.0, 180.0, 183.0, 186.0, 184.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 88.0, 60.0, 59.0, 58.0, 58.0, 71.0, 58.0], "value": 65.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 83.0, 70.0, 68.0, 69.0, 81.0, 68.0, 69.0, 83.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 85.0, 87.0, 85.0, 88.0, 85.0, 88.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 117.0, 128.0, 148.0, 148.0, 93.0, 93.0, 93.0], "value": 109.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 87.0, 86.0, 88.0, 87.0, 87.0, 85.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 83.0, 78.0, 75.0, 76.0, 70.0, 72.0, 72.0, 71.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 87.0, 87.0, 85.0, 88.0, 91.0, 96.0, 107.0, 107.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 159.0, 138.0, 137.0, 141.0, 141.0, 141.0, 199.0, 142.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 172.0, 172.0, 172.0, 170.0, 169.0, 172.0, 171.0, 171.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 65.0, 66.0], "value": 66.5, "unit": "score"}], "name": "kraken", "value": 1458.3, "alertThreshold": 2.0}]} 08:33:28 INFO - Return code: 0 08:33:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:33:28 ERROR - # TBPL SUCCESS # 08:33:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:33:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:33:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:33:28 INFO - 2017-01-13 08:33:28.564 screenresolution[1658:9881] starting screenresolution argv=screenresolution get 08:33:28 INFO - 2017-01-13 08:33:28.567 screenresolution[1658:9881] Display 0: 1600x1200x32@60 08:33:28 INFO - 2017-01-13 08:33:28.573 screenresolution[1659:9884] starting screenresolution argv=screenresolution list 08:33:28 INFO - Available Modes on Display 0 08:33:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:33:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:33:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:33:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:33:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:33:28 INFO - Intel Iris: 08:33:28 INFO - Chipset Model: Intel Iris 08:33:28 INFO - Type: GPU 08:33:28 INFO - Bus: Built-In 08:33:28 INFO - VRAM (Dynamic, Max): 1536 MB 08:33:28 INFO - Vendor: Intel (0x8086) 08:33:28 INFO - Device ID: 0x0a2e 08:33:28 INFO - Revision ID: 0x0009 08:33:28 INFO - Displays: 08:33:28 INFO - Display: 08:33:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:33:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:33:28 INFO - Display Serial Number: 1600x1200 60 08:33:28 INFO - Main Display: Yes 08:33:28 INFO - Mirror: Off 08:33:28 INFO - Online: Yes 08:33:28 INFO - Rotation: Supported 08:33:28 INFO - Return code: 0 08:33:28 INFO - Running post-action listener: _resource_record_post_action 08:33:28 INFO - [mozharness: 2017-01-13 16:33:28.814320Z] Finished run-tests step (success) 08:33:28 INFO - Running post-run listener: _resource_record_post_run 08:33:28 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38876160; Write bytes: 551417856; Read time: 388; Write time: 1690 08:33:28 INFO - TinderboxPrint: CPU usage
53.7% 08:33:28 INFO - TinderboxPrint: I/O read bytes / time
38,876,160 / 388 08:33:28 INFO - TinderboxPrint: I/O write bytes / time
551,417,856 / 1,690 08:33:28 INFO - TinderboxPrint: CPU idle
2,222.4 (46.3%) 08:33:28 INFO - TinderboxPrint: CPU system
962.7 (20.0%) 08:33:28 INFO - TinderboxPrint: CPU user
1,616.6 (33.7%) 08:33:28 INFO - TinderboxPrint: Swap in / out
290,095,104 / 0 08:33:28 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 249625088; Write bytes: 241881088; Read time: 18107; Write time: 427 08:33:28 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34472960; Write bytes: 297920512; Read time: 352; Write time: 1228 08:33:29 INFO - Running post-run listener: _upload_blobber_files 08:33:29 INFO - Blob upload gear active. 08:33:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:33:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:33:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:33:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:31 INFO - (blobuploader) - INFO - Done attempting. 08:33:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:33:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:33:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:32 INFO - (blobuploader) - INFO - Done attempting. 08:33:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:33:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:33:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:33 INFO - (blobuploader) - INFO - Done attempting. 08:33:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:33:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:33:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:35 INFO - (blobuploader) - INFO - Done attempting. 08:33:35 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:35 INFO - Return code: 0 08:33:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada5cd35608d496ec25cd5f374dfcc30d1a0971e6f1bcf86b28fcc20eaf9a66f3fe133f48e1b8de8ff02cd443d9093dc0a3d27498567670c3d82dabf954e2148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f324f173411d2199d81e95be0b7c74de8f34096239720b3b39d3fe359268f0bdf329c8a18f88d665c843608d6559e1fa89c47dc4c563d4821c325757f2d09dcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fac4742faa396d6a1099add5b32a8552dc6d3be91f065ab916b31ad66328c058aea23fa15c674ba51467f81cbd2ff761713221fcf970d3c2d9c2bfc97059ed81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e44117a5d15c7173ff906c72a681baddd75a91d6505ab14c4775ce9dd029f4c41e2bec2910837e5d9a6ab227a0b48c1c66f94ff7a844c67337fb60a003e55"} 08:33:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:35 INFO - Contents: 08:33:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada5cd35608d496ec25cd5f374dfcc30d1a0971e6f1bcf86b28fcc20eaf9a66f3fe133f48e1b8de8ff02cd443d9093dc0a3d27498567670c3d82dabf954e2148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f324f173411d2199d81e95be0b7c74de8f34096239720b3b39d3fe359268f0bdf329c8a18f88d665c843608d6559e1fa89c47dc4c563d4821c325757f2d09dcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fac4742faa396d6a1099add5b32a8552dc6d3be91f065ab916b31ad66328c058aea23fa15c674ba51467f81cbd2ff761713221fcf970d3c2d9c2bfc97059ed81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e44117a5d15c7173ff906c72a681baddd75a91d6505ab14c4775ce9dd029f4c41e2bec2910837e5d9a6ab227a0b48c1c66f94ff7a844c67337fb60a003e55"} 08:33:35 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:35 INFO - Copying logs to upload dir... 08:33:35 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.373110 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-01-13 08:33:35.546814) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 08:33:35.550547) ========= 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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada5cd35608d496ec25cd5f374dfcc30d1a0971e6f1bcf86b28fcc20eaf9a66f3fe133f48e1b8de8ff02cd443d9093dc0a3d27498567670c3d82dabf954e2148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f324f173411d2199d81e95be0b7c74de8f34096239720b3b39d3fe359268f0bdf329c8a18f88d665c843608d6559e1fa89c47dc4c563d4821c325757f2d09dcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fac4742faa396d6a1099add5b32a8552dc6d3be91f065ab916b31ad66328c058aea23fa15c674ba51467f81cbd2ff761713221fcf970d3c2d9c2bfc97059ed81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e44117a5d15c7173ff906c72a681baddd75a91d6505ab14c4775ce9dd029f4c41e2bec2910837e5d9a6ab227a0b48c1c66f94ff7a844c67337fb60a003e55"} build_url:https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011172 build_url: 'https://queue.taskcluster.net/v1/task/cj4pn-0vRcehwOhwtxqgRw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ada5cd35608d496ec25cd5f374dfcc30d1a0971e6f1bcf86b28fcc20eaf9a66f3fe133f48e1b8de8ff02cd443d9093dc0a3d27498567670c3d82dabf954e2148", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f324f173411d2199d81e95be0b7c74de8f34096239720b3b39d3fe359268f0bdf329c8a18f88d665c843608d6559e1fa89c47dc4c563d4821c325757f2d09dcd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fac4742faa396d6a1099add5b32a8552dc6d3be91f065ab916b31ad66328c058aea23fa15c674ba51467f81cbd2ff761713221fcf970d3c2d9c2bfc97059ed81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac3e44117a5d15c7173ff906c72a681baddd75a91d6505ab14c4775ce9dd029f4c41e2bec2910837e5d9a6ab227a0b48c1c66f94ff7a844c67337fb60a003e55"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 08:33:35.588429) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 08:33:35.588762) ========= 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.OmO7GI3pJV/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.04kvrX1Tq1/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005186 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 08:33:35.637629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 08:33:35.637946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 08:33:35.638261) ========= ========= Total master_lag: 1.69 =========