builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0238 starttime: 1482420951.73 results: success (0) buildid: 20161222030229 builduid: bb0f02f22436450da9022035d84eb747 revision: f179934df0c1bab590c558485d419c7910e41325 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:51.731891) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:51.732350) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:51.732644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:51.760541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:51.760804) ========= 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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-22 07:35:51-- 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% 18.9M=0.001s 2016-12-22 07:35:52 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.535321 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.323122) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.323436) ========= 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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.025138 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:52.371725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 07:35:52.372061) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f179934df0c1bab590c558485d419c7910e41325 --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 f179934df0c1bab590c558485d419c7910e41325 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-22 07:35:52,474 truncating revision to first 12 chars 2016-12-22 07:35:52,474 Setting DEBUG logging. 2016-12-22 07:35:52,474 attempt 1/10 2016-12-22 07:35:52,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f179934df0c1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 07:35:53,198 unpacking tar archive at: mozilla-central-f179934df0c1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.000795 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 07:35:53.500871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:53.501188) ========= script_repo_revision: f179934df0c1bab590c558485d419c7910e41325 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:53.501597) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:53.501868) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 07:35:53.523409) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-22 07:35:53.523674) ========= /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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:35:53 INFO - MultiFileLogger online at 20161222 07:35:53 in /builds/slave/test 07:35:53 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 07:35:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:35:53 INFO - {'append_to_log': False, 07:35:53 INFO - 'base_work_dir': '/builds/slave/test', 07:35:53 INFO - 'blob_upload_branch': 'Firefox', 07:35:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:35:53 INFO - 'branch': 'Firefox', 07:35:53 INFO - 'buildbot_json_path': 'buildprops.json', 07:35:53 INFO - 'config_files': ('talos/mac_config.py',), 07:35:53 INFO - 'default_actions': ('clobber', 07:35:53 INFO - 'read-buildbot-config', 07:35:53 INFO - 'download-and-extract', 07:35:53 INFO - 'populate-webroot', 07:35:53 INFO - 'create-virtualenv', 07:35:53 INFO - 'install', 07:35:53 INFO - 'run-tests'), 07:35:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:35:53 INFO - 'download_minidump_stackwalk': True, 07:35:53 INFO - 'download_symbols': 'ondemand', 07:35:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:35:53 INFO - 'tooltool.py': '/tools/tooltool.py', 07:35:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:35:53 INFO - '/tools/misc-python/virtualenv.py')}, 07:35:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:35:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:35:53 INFO - 'installer_path': 'installer.exe', 07:35:53 INFO - 'log_level': 'info', 07:35:53 INFO - 'log_name': 'talos', 07:35:53 INFO - 'log_to_console': True, 07:35:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:35:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:35:53 INFO - 'opt_config_files': (), 07:35:53 INFO - 'pip_index': False, 07:35:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:53 INFO - 'cmd': ('bash', 07:35:53 INFO - '-c', 07:35:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:53 INFO - 'enabled': True, 07:35:53 INFO - 'halt_on_failure': False, 07:35:53 INFO - 'name': 'check_screen_resolution'},), 07:35:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:35:53 INFO - 'cmd': ('bash', 07:35:53 INFO - '-c', 07:35:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:35:53 INFO - 'enabled': True, 07:35:53 INFO - 'halt_on_failure': False, 07:35:53 INFO - 'name': 'check_screen_resolution'},), 07:35:53 INFO - 'run_cmd_checks_enabled': True, 07:35:53 INFO - 'sps_profile': False, 07:35:53 INFO - 'sps_profile_interval': 0, 07:35:53 INFO - 'suite': 'dromaeojs', 07:35:53 INFO - 'system_bits': '32', 07:35:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:35:53 INFO - 'title': 't-yosemite-r7-0238', 07:35:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:35:53 INFO - 'use_talos_json': True, 07:35:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:35:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:35:53 INFO - 'work_dir': 'build'} 07:35:53 INFO - [mozharness: 2016-12-22 15:35:53.732295Z] Running clobber step. 07:35:53 INFO - Running pre-action listener: _resource_record_pre_action 07:35:53 INFO - Running main action method: clobber 07:35:53 INFO - rmtree: /builds/slave/test/build 07:35:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:35:56 INFO - Running post-action listener: _resource_record_post_action 07:35:56 INFO - [mozharness: 2016-12-22 15:35:56.110004Z] Finished clobber step (success) 07:35:56 INFO - [mozharness: 2016-12-22 15:35:56.110134Z] Running read-buildbot-config step. 07:35:56 INFO - Running pre-action listener: _resource_record_pre_action 07:35:56 INFO - Running main action method: read_buildbot_config 07:35:56 INFO - Using buildbot properties: 07:35:56 INFO - { 07:35:56 INFO - "project": "", 07:35:56 INFO - "product": "firefox", 07:35:56 INFO - "script_repo_revision": "production", 07:35:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:35:56 INFO - "repository": "", 07:35:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:35:56 INFO - "buildid": "20161222030229", 07:35:56 INFO - "stage_platform": "macosx64", 07:35:56 INFO - "basedir": "/builds/slave/test", 07:35:56 INFO - "nightly_build": "True", 07:35:56 INFO - "buildnumber": 40, 07:35:56 INFO - "slavename": "t-yosemite-r7-0238", 07:35:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:35:56 INFO - "platform": "yosemite_r7", 07:35:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:35:56 INFO - "branch": "mozilla-central", 07:35:56 INFO - "repo_path": "mozilla-central", 07:35:56 INFO - "revision": "f179934df0c1bab590c558485d419c7910e41325", 07:35:56 INFO - "pgo_build": "False", 07:35:56 INFO - "builduid": "bb0f02f22436450da9022035d84eb747", 07:35:56 INFO - "slavebuilddir": "test" 07:35:56 INFO - } 07:35:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 07:35:56 INFO - Running post-action listener: _resource_record_post_action 07:35:56 INFO - [mozharness: 2016-12-22 15:35:56.113715Z] Finished read-buildbot-config step (success) 07:35:56 INFO - [mozharness: 2016-12-22 15:35:56.113829Z] Running download-and-extract step. 07:35:56 INFO - Running pre-action listener: _resource_record_pre_action 07:35:56 INFO - Running main action method: download_and_extract 07:35:56 INFO - mkdir: /builds/slave/test/build/tests 07:35:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:35:56 INFO - trying https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 07:35:56 INFO - Downloading https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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 07:35:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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 07:35:57 INFO - Downloaded 1199 bytes. 07:35:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 07:35:57 INFO - Using the following test package requirements: 07:35:57 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:35:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 07:35:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 07:35:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'jsshell-mac.zip'], 07:35:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 07:35:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 07:35:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 07:35:57 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 07:35:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 07:35:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 07:35:57 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 07:35:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:35:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:35:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:35:57 INFO - Fetch https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:35:58 INFO - Expected file size: 16289308 07:35:58 INFO - Obtained file size: 16289308 07:36:05 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 07:36:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 07:36:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:36:05 INFO - Fetch https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 07:36:06 INFO - Expected file size: 16289308 07:36:06 INFO - Obtained file size: 16289308 07:36:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 07:36:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:36:12 INFO - Fetch https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 07:36:14 INFO - Expected file size: 14409734 07:36:14 INFO - Obtained file size: 14409734 07:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:14 INFO - trying https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:36:14 INFO - Downloading https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 07:36:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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 07:36:18 INFO - Downloaded 69750756 bytes. 07:36:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:36:18 INFO - mkdir: /builds/slave/test/properties 07:36:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:18 INFO - Contents: 07:36:18 INFO - build_url:https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 07:36:18 INFO - Running post-action listener: _resource_record_post_action 07:36:18 INFO - Running post-action listener: set_extra_try_arguments 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.931378Z] Finished download-and-extract step (success) 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.931498Z] Running populate-webroot step. 07:36:18 INFO - Running pre-action listener: _resource_record_pre_action 07:36:18 INFO - Running main action method: populate_webroot 07:36:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:18 INFO - '--tppagecycles', 07:36:18 INFO - '7'], 07:36:18 INFO - 'tests': ['tsvgm']}}, 07:36:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['damp', 'tps']}, 07:36:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'tests': ['damp', 'tps']}, 07:36:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['dromaeo_dom']}, 07:36:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['basic_compositor_video']}, 07:36:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['a11yr', 07:36:18 INFO - 'ts_paint', 07:36:18 INFO - 'tpaint', 07:36:18 INFO - 'sessionrestore', 07:36:18 INFO - 'sessionrestore_no_auto_restore', 07:36:18 INFO - 'tabpaint']}, 07:36:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tsvgx', 07:36:18 INFO - 'tsvgr_opacity', 07:36:18 INFO - 'tart', 07:36:18 INFO - 'tscrollx', 07:36:18 INFO - 'cart', 07:36:18 INFO - 'tsvg_static']}, 07:36:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:18 INFO - 'tsvgr_opacity', 07:36:18 INFO - 'tart', 07:36:18 INFO - 'tscrollx', 07:36:18 INFO - 'cart', 07:36:18 INFO - 'tsvg_static']}, 07:36:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s'], 07:36:18 INFO - 'tests': ['tp5o']}, 07:36:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:36:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--disable-e10s', 07:36:18 INFO - '--xperf_path', 07:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:18 INFO - 'tests': ['tp5n']}, 07:36:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:36:18 INFO - 'talos_options': ['--xperf_path', 07:36:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:18 INFO - 'tests': ['tp5n']}}, 07:36:18 INFO - 'talos.zip': {'path': '', 07:36:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:18 INFO - Running post-action listener: _resource_record_post_action 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.949800Z] Finished populate-webroot step (success) 07:36:18 INFO - [mozharness: 2016-12-22 15:36:18.949909Z] Running create-virtualenv step. 07:36:18 INFO - Running pre-action listener: _resource_record_pre_action 07:36:18 INFO - Running main action method: create_virtualenv 07:36:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:18 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 07:36:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:19 INFO - Using real prefix '/tools/python27' 07:36:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:22 INFO - Installing pip.................done. 07:36:22 INFO - Return code: 0 07:36:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:36:22 INFO - Reading from file tmpfile_stdout 07:36:22 INFO - Output received: 07:36:22 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) 07:36:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:36:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:22 INFO - 'HOME': '/Users/cltbld', 07:36:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:22 INFO - 'LOGNAME': 'cltbld', 07:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:22 INFO - 'MOZ_NO_REMOTE': '1', 07:36:22 INFO - 'NO_EM_RESTART': '1', 07:36:22 INFO - 'PAGER': '/bin/cat', 07:36:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:22 INFO - 'PWD': '/builds/slave/test', 07:36:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:22 INFO - 'SHELL': '/bin/bash', 07:36:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:22 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:22 INFO - 'USER': 'cltbld', 07:36:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:22 INFO - 'XPC_FLAGS': '0x0', 07:36:22 INFO - 'XPC_SERVICE_NAME': '0', 07:36:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:23 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 07:36:23 INFO - Cleaning up... 07:36:23 INFO - Return code: 0 07:36:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:23 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')]} 07:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:23 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')]} 07:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:23 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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:23 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 07:36:23 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 07:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:23 INFO - 'HOME': '/Users/cltbld', 07:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:23 INFO - 'LOGNAME': 'cltbld', 07:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:23 INFO - 'MOZ_NO_REMOTE': '1', 07:36:23 INFO - 'NO_EM_RESTART': '1', 07:36:23 INFO - 'PAGER': '/bin/cat', 07:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:23 INFO - 'PWD': '/builds/slave/test', 07:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:23 INFO - 'SHELL': '/bin/bash', 07:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:23 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:23 INFO - 'USER': 'cltbld', 07:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:23 INFO - 'XPC_FLAGS': '0x0', 07:36:23 INFO - 'XPC_SERVICE_NAME': '0', 07:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:23 INFO - Downloading/unpacking psutil>=3.1.1 07:36:23 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 07:36:23 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 07:36:23 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 07:36:23 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 07:36:23 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 07:36:23 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 07:36:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:27 INFO - Installing collected packages: psutil 07:36:27 INFO - Running setup.py install for psutil 07:36:27 INFO - building 'psutil._psutil_osx' extension 07:36:27 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 07:36:27 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 07:36:28 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 07:36:28 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 07:36:28 INFO - building 'psutil._psutil_posix' extension 07:36:28 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 07:36:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:36:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:36:28 INFO - ^ 07:36:28 INFO - 1 warning generated. 07:36:28 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 07:36:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:28 INFO - Successfully installed psutil 07:36:28 INFO - Cleaning up... 07:36:28 INFO - Return code: 0 07:36:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:28 INFO - 'HOME': '/Users/cltbld', 07:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:28 INFO - 'LOGNAME': 'cltbld', 07:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:28 INFO - 'MOZ_NO_REMOTE': '1', 07:36:28 INFO - 'NO_EM_RESTART': '1', 07:36:28 INFO - 'PAGER': '/bin/cat', 07:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:28 INFO - 'PWD': '/builds/slave/test', 07:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:28 INFO - 'SHELL': '/bin/bash', 07:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:28 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:28 INFO - 'USER': 'cltbld', 07:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:28 INFO - 'XPC_FLAGS': '0x0', 07:36:28 INFO - 'XPC_SERVICE_NAME': '0', 07:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:31 INFO - Installing collected packages: mozsystemmonitor 07:36:31 INFO - Running setup.py install for mozsystemmonitor 07:36:31 INFO - Successfully installed mozsystemmonitor 07:36:31 INFO - Cleaning up... 07:36:31 INFO - Return code: 0 07:36:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:31 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')]} 07:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:31 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')]} 07:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:31 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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:31 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 07:36:31 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 07:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:31 INFO - 'HOME': '/Users/cltbld', 07:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:31 INFO - 'LOGNAME': 'cltbld', 07:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:31 INFO - 'MOZ_NO_REMOTE': '1', 07:36:31 INFO - 'NO_EM_RESTART': '1', 07:36:31 INFO - 'PAGER': '/bin/cat', 07:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:31 INFO - 'PWD': '/builds/slave/test', 07:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:31 INFO - 'SHELL': '/bin/bash', 07:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:31 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:31 INFO - 'USER': 'cltbld', 07:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:31 INFO - 'XPC_FLAGS': '0x0', 07:36:31 INFO - 'XPC_SERVICE_NAME': '0', 07:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:32 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:34 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 07:36:34 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 07:36:34 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 07:36:34 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 07:36:34 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 07:36:34 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 07:36:35 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:35 INFO - warning: no files found matching '*.txt' 07:36:35 INFO - no previously-included directories found matching 'build' 07:36:35 INFO - no previously-included directories found matching 'dist' 07:36:35 INFO - no previously-included directories found matching '.git*' 07:36:35 INFO - Installing collected packages: jsonschema, functools32 07:36:35 INFO - Running setup.py install for functools32 07:36:35 INFO - warning: no files found matching '*.txt' 07:36:35 INFO - no previously-included directories found matching 'build' 07:36:35 INFO - no previously-included directories found matching 'dist' 07:36:35 INFO - no previously-included directories found matching '.git*' 07:36:35 INFO - Successfully installed jsonschema functools32 07:36:35 INFO - Cleaning up... 07:36:35 INFO - Return code: 0 07:36:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:35 INFO - 'HOME': '/Users/cltbld', 07:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:35 INFO - 'LOGNAME': 'cltbld', 07:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:35 INFO - 'MOZ_NO_REMOTE': '1', 07:36:35 INFO - 'NO_EM_RESTART': '1', 07:36:35 INFO - 'PAGER': '/bin/cat', 07:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:35 INFO - 'PWD': '/builds/slave/test', 07:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:35 INFO - 'SHELL': '/bin/bash', 07:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:35 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:35 INFO - 'USER': 'cltbld', 07:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:35 INFO - 'XPC_FLAGS': '0x0', 07:36:35 INFO - 'XPC_SERVICE_NAME': '0', 07:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:35 INFO - Cleaning up... 07:36:35 INFO - Return code: 0 07:36:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:35 INFO - 'HOME': '/Users/cltbld', 07:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:35 INFO - 'LOGNAME': 'cltbld', 07:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:35 INFO - 'MOZ_NO_REMOTE': '1', 07:36:35 INFO - 'NO_EM_RESTART': '1', 07:36:35 INFO - 'PAGER': '/bin/cat', 07:36:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:35 INFO - 'PWD': '/builds/slave/test', 07:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:35 INFO - 'SHELL': '/bin/bash', 07:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:35 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:35 INFO - 'USER': 'cltbld', 07:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:35 INFO - 'XPC_FLAGS': '0x0', 07:36:35 INFO - 'XPC_SERVICE_NAME': '0', 07:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:35 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:38 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:39 INFO - Downloading docopt-0.6.1.tar.gz 07:36:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:39 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:39 INFO - Running setup.py install for blobuploader 07:36:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:40 INFO - Running setup.py install for requests 07:36:40 INFO - Running setup.py install for docopt 07:36:40 INFO - Successfully installed blobuploader requests docopt 07:36:40 INFO - Cleaning up... 07:36:40 INFO - Return code: 0 07:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:40 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')]} 07:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 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')]} 07:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:40 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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:40 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 07:36:40 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 07:36:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:40 INFO - 'HOME': '/Users/cltbld', 07:36:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:40 INFO - 'LOGNAME': 'cltbld', 07:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:40 INFO - 'MOZ_NO_REMOTE': '1', 07:36:40 INFO - 'NO_EM_RESTART': '1', 07:36:40 INFO - 'PAGER': '/bin/cat', 07:36:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:40 INFO - 'PWD': '/builds/slave/test', 07:36:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:40 INFO - 'SHELL': '/bin/bash', 07:36:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:40 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:40 INFO - 'USER': 'cltbld', 07:36:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:40 INFO - 'XPC_FLAGS': '0x0', 07:36:40 INFO - 'XPC_SERVICE_NAME': '0', 07:36:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-WkDnYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-8uptyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-B3s398-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-p1WDQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-JYp7p4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-UjHuG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-YrMyQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-nf8mid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:41 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-AZTlZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-5C7D6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-eZwOcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-inB6qW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-gblj87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-99QK56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-NE1T5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-jBMt3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-1WaZ5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:42 INFO - Running setup.py install for manifestparser 07:36:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:42 INFO - Running setup.py install for mozcrash 07:36:43 INFO - Running setup.py install for mozdebug 07:36:43 INFO - Running setup.py install for mozdevice 07:36:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozfile 07:36:43 INFO - Running setup.py install for mozhttpd 07:36:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozinfo 07:36:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozInstall 07:36:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:43 INFO - Running setup.py install for mozleak 07:36:44 INFO - Running setup.py install for mozlog 07:36:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for moznetwork 07:36:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for mozprocess 07:36:44 INFO - Running setup.py install for mozprofile 07:36:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for mozrunner 07:36:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:44 INFO - Running setup.py install for mozscreenshot 07:36:45 INFO - Running setup.py install for moztest 07:36:45 INFO - Running setup.py install for mozversion 07:36:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:45 INFO - Cleaning up... 07:36:45 INFO - Return code: 0 07:36:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:45 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')]} 07:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 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')]} 07:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:45 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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:45 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 07:36:45 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 07:36:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:45 INFO - 'HOME': '/Users/cltbld', 07:36:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:45 INFO - 'LOGNAME': 'cltbld', 07:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:45 INFO - 'MOZ_NO_REMOTE': '1', 07:36:45 INFO - 'NO_EM_RESTART': '1', 07:36:45 INFO - 'PAGER': '/bin/cat', 07:36:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:45 INFO - 'PWD': '/builds/slave/test', 07:36:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:45 INFO - 'SHELL': '/bin/bash', 07:36:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:45 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:45 INFO - 'USER': 'cltbld', 07:36:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:45 INFO - 'XPC_FLAGS': '0x0', 07:36:45 INFO - 'XPC_SERVICE_NAME': '0', 07:36:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Ycla3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Qr9UOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:45 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)) 07:36:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:45 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-LPLUEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-tthoJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Iz1JyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-E10C89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-ygyxBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-TOxI3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Zx5PnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-VROqJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Ot1MVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:46 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)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-UAVt9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:36:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:46 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-8VT9KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:47 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)) 07:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:47 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-enXDWO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:47 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)) 07:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:47 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Pudoeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:47 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)) 07:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:47 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-nc_ZZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:47 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-cj6kIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 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)) 07:36:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:47 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 07:36:50 INFO - Downloading blessings-1.6.tar.gz 07:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:50 INFO - Installing collected packages: blessings 07:36:50 INFO - Running setup.py install for blessings 07:36:50 INFO - Successfully installed blessings 07:36:50 INFO - Cleaning up... 07:36:50 INFO - Return code: 0 07:36:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:50 INFO - Reading from file tmpfile_stdout 07:36:50 INFO - Current package versions: 07:36:50 INFO - blessings == 1.6 07:36:50 INFO - blobuploader == 1.2.4 07:36:50 INFO - docopt == 0.6.1 07:36:50 INFO - functools32 == 3.2.3-2 07:36:50 INFO - jsonschema == 2.5.1 07:36:50 INFO - manifestparser == 1.1 07:36:50 INFO - mozInstall == 1.12 07:36:50 INFO - mozcrash == 1.0 07:36:50 INFO - mozdebug == 0.1 07:36:50 INFO - mozdevice == 0.49 07:36:50 INFO - mozfile == 1.2 07:36:50 INFO - mozhttpd == 0.7 07:36:50 INFO - mozinfo == 0.9 07:36:50 INFO - mozleak == 0.1 07:36:50 INFO - mozlog == 3.4 07:36:50 INFO - moznetwork == 0.27 07:36:50 INFO - mozprocess == 0.23 07:36:50 INFO - mozprofile == 0.28 07:36:50 INFO - mozrunner == 6.13 07:36:50 INFO - mozscreenshot == 0.1 07:36:50 INFO - mozsystemmonitor == 0.3 07:36:50 INFO - moztest == 0.7 07:36:50 INFO - mozversion == 1.4 07:36:50 INFO - psutil == 3.1.1 07:36:50 INFO - requests == 1.2.3 07:36:50 INFO - wsgiref == 0.1.2 07:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:50 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 07:36:50 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 07:36:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:50 INFO - 'HOME': '/Users/cltbld', 07:36:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:50 INFO - 'LOGNAME': 'cltbld', 07:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:50 INFO - 'MOZ_NO_REMOTE': '1', 07:36:50 INFO - 'NO_EM_RESTART': '1', 07:36:50 INFO - 'PAGER': '/bin/cat', 07:36:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:50 INFO - 'PWD': '/builds/slave/test', 07:36:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:50 INFO - 'SHELL': '/bin/bash', 07:36:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:50 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:50 INFO - 'USER': 'cltbld', 07:36:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:50 INFO - 'XPC_FLAGS': '0x0', 07:36:50 INFO - 'XPC_SERVICE_NAME': '0', 07:36:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 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)) 07:36:51 INFO - Cleaning up... 07:36:51 INFO - Return code: 0 07:36:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:51 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 0x1008efb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008f2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff923d4d1d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, '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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 07:36:51 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 07:36:51 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 07:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:36:51 INFO - 'HOME': '/Users/cltbld', 07:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:36:51 INFO - 'LOGNAME': 'cltbld', 07:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:51 INFO - 'MOZ_NO_REMOTE': '1', 07:36:51 INFO - 'NO_EM_RESTART': '1', 07:36:51 INFO - 'PAGER': '/bin/cat', 07:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:51 INFO - 'PWD': '/builds/slave/test', 07:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:36:51 INFO - 'SHELL': '/bin/bash', 07:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:36:51 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:36:51 INFO - 'USER': 'cltbld', 07:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:51 INFO - 'XPC_FLAGS': '0x0', 07:36:51 INFO - 'XPC_SERVICE_NAME': '0', 07:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:51 INFO - Cleaning up... 07:36:51 INFO - Return code: 0 07:36:51 INFO - Running post-action listener: _resource_record_post_action 07:36:51 INFO - Running post-action listener: _start_resource_monitoring 07:36:51 INFO - Starting resource monitoring. 07:36:51 INFO - [mozharness: 2016-12-22 15:36:51.357573Z] Finished create-virtualenv step (success) 07:36:51 INFO - [mozharness: 2016-12-22 15:36:51.358538Z] Running install step. 07:36:51 INFO - Running pre-action listener: _resource_record_pre_action 07:36:51 INFO - Running main action method: install 07:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:51 INFO - Reading from file tmpfile_stdout 07:36:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:51 INFO - Reading from file tmpfile_stdout 07:36:51 INFO - Output received: 07:36:51 INFO - Usage: mozinstall [options] installer 07:36:51 INFO - Options: 07:36:51 INFO - -h, --help show this help message and exit 07:36:51 INFO - -d DEST, --destination=DEST 07:36:51 INFO - Directory to install application into. [default: 07:36:51 INFO - "/builds/slave/test"] 07:36:51 INFO - --app=APP Application being installed. [default: firefox] 07:36:51 INFO - mkdir: /builds/slave/test/build/application 07:36:51 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'] 07:36:51 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 07:37:13 INFO - Reading from file tmpfile_stdout 07:37:13 INFO - Output received: 07:37:13 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 07:37:13 INFO - Running post-action listener: _resource_record_post_action 07:37:13 INFO - [mozharness: 2016-12-22 15:37:13.811756Z] Finished install step (success) 07:37:13 INFO - [mozharness: 2016-12-22 15:37:13.811894Z] Running run-tests step. 07:37:13 INFO - Running pre-action listener: _resource_record_pre_action 07:37:13 INFO - Running main action method: run_tests 07:37:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:37:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:37:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:37:13 INFO - 2016-12-22 07:37:13.826 screenresolution[1639:9448] starting screenresolution argv=screenresolution get 07:37:13 INFO - 2016-12-22 07:37:13.829 screenresolution[1639:9448] Display 0: 1600x1200x32@60 07:37:13 INFO - 2016-12-22 07:37:13.834 screenresolution[1640:9450] starting screenresolution argv=screenresolution list 07:37:13 INFO - Available Modes on Display 0 07:37:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:37:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:37:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:37:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:37:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:37:14 INFO - Intel Iris: 07:37:14 INFO - Chipset Model: Intel Iris 07:37:14 INFO - Type: GPU 07:37:14 INFO - Bus: Built-In 07:37:14 INFO - VRAM (Dynamic, Max): 1536 MB 07:37:14 INFO - Vendor: Intel (0x8086) 07:37:14 INFO - Device ID: 0x0a2e 07:37:14 INFO - Revision ID: 0x0009 07:37:14 INFO - Displays: 07:37:14 INFO - Display: 07:37:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:37:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:37:14 INFO - Display Serial Number: 1600x1200 60 07:37:14 INFO - Main Display: Yes 07:37:14 INFO - Mirror: Off 07:37:14 INFO - Online: Yes 07:37:14 INFO - Rotation: Supported 07:37:14 INFO - Return code: 0 07:37:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:14 INFO - Python 2.7.3 07:37:14 INFO - Return code: 0 07:37:14 INFO - grabbing minidump binary from tooltool 07:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:14 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 0x1006cdd30>, '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 0x1005f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006c2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:14 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 07:37:14 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 07:37:14 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 07:37:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:14 INFO - Return code: 0 07:37:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:37:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:37:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:14 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 07:37:14 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --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 07:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iQNZ9Jk8zq/Render', 07:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:37:14 INFO - 'HOME': '/Users/cltbld', 07:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:37:14 INFO - 'LOGNAME': 'cltbld', 07:37:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:14 INFO - 'MOZ_NO_REMOTE': '1', 07:37:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:14 INFO - 'NO_EM_RESTART': '1', 07:37:14 INFO - 'PAGER': '/bin/cat', 07:37:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:14 INFO - 'PWD': '/builds/slave/test', 07:37:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:37:14 INFO - 'SHELL': '/bin/bash', 07:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Nwj6OYYzNi/Listeners', 07:37:14 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 07:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:37:14 INFO - 'USER': 'cltbld', 07:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:14 INFO - 'XPC_FLAGS': '0x0', 07:37:14 INFO - 'XPC_SERVICE_NAME': '0', 07:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:37:14 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--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 07:37:14 INFO - mozversion application_buildid: 20161222030229 07:37:14 INFO - mozversion application_changeset: f179934df0c1bab590c558485d419c7910e41325 07:37:14 INFO - mozversion application_display_name: Nightly 07:37:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:14 INFO - mozversion application_name: Firefox 07:37:14 INFO - mozversion application_remotingname: firefox 07:37:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:37:14 INFO - mozversion application_vendor: Mozilla 07:37:14 INFO - mozversion application_version: 53.0a1 07:37:14 INFO - mozversion platform_buildid: 20161222030229 07:37:14 INFO - mozversion platform_changeset: f179934df0c1bab590c558485d419c7910e41325 07:37:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:37:14 INFO - mozversion platform_version: 53.0a1 07:37:14 INFO - using testdate: 1482421034 07:37:14 INFO - actual date: 1482421034 07:37:14 INFO - starting webserver on 'localhost:49237' 07:37:14 INFO - SUITE-START | Running 2 tests 07:37:14 INFO - TEST-START | dromaeo_css 07:37:14 INFO - operating with platform_type : mac_ 07:37:14 INFO - Initialising browser for dromaeo_css test... 07:37:14 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpkt88DJ/profile http://localhost:49237/getInfo.html) 07:37:17 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 07:37:17 INFO - PROCESS | 1650 | colorDepth:24 07:37:17 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 07:37:17 INFO - PROCESS | 1650 | __metrics 07:37:17 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:37:17 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:17 INFO - TEST-INFO | 1650: exit 0 07:37:17 INFO - Browser initialized. 07:37:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:17 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpkt88DJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:30 INFO - PROCESS | 1654 | RSS: Main: 254947328 07:37:30 INFO - PROCESS | 1654 | 07:38:21 INFO - PROCESS | 1654 | 1482421101275 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:40:33 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 07:40:35 INFO - PROCESS | 1654 | RSS: Main: 460328960 07:40:35 INFO - PROCESS | 1654 | 07:43:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 07:43:39 INFO - PROCESS | 1654 | RSS: Main: 385896448 07:43:39 INFO - PROCESS | 1654 | 07:46:41 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 07:46:42 INFO - PROCESS | 1654 | RSS: Main: 361877504 07:46:42 INFO - PROCESS | 1654 | 07:49:44 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 07:49:45 INFO - PROCESS | 1654 | RSS: Main: 380964864 07:49:45 INFO - PROCESS | 1654 | 07:52:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 07:52:49 INFO - PROCESS | 1654 | RSS: Main: 348286976 07:52:49 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 07:55:53 INFO - PROCESS | 1654 | RSS: Main: 419065856 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | __start_tp_report 07:55:53 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 07:55:53 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 07:55:53 INFO - PROCESS | 1654 | |i|pagename|runs| 07:55:53 INFO - PROCESS | 1654 | |0;dojo.html;2695.636089127968;3000.309928716395;3222.6938440848116;3280.507923811428;3306.718928891047;5402.702851343174;5544.33467983842;5546.972265138679;5570.220169176314;5595.888082238353;5493.615446918718;5551.139573366125;5611.466910643492;5612;5654.632448890829;4954.628402869781;5008.12357837377;5027.949720502785;5051.141305977974;5063.063333283354;5040.571551418134;5141.357330333708;5153.9742301288625;5159.329287192679;5180.093483640367;4972.776225069881;5089.1348470759685;5091.2108623163285;5111.897762044739;5206.921896171561;4989.151844186497;5068.366454193226;5068.670536415121;5069.518395752398;5081.618878584084;5011.6241281904;5055.292259083732;5061.063703214881;5063.063333283318;5065.341505604285;5543.861403464905;5563.443655634444;5565.554755619541;5565.833025009256;5573.777048918038;5050.217216331474;6041.184440100574;6044.637321760709;6061.42416470439;6062.818115456544;6048.7882924097885;6067.848303792441;6093.786717464912;6107.389261073901;6116.633002019893;4720.575148236675;5534.75093620788;5572.58205634579;5613.943860561383;5620.325560932673;6187.597806142587;6187.876242475215;6190.473809726133;6197.4732147767945;6213;5978.790742324085;5982.940170598238;5989.251343582052;5992.490638295706;6026.758929642765;5909.645421274738;5992.940070599326;6012.338642749294;6031.396860314021;6104.511639068864;6015.368386319461;6042.818715438544;6054.455099041107;6084.787032453932;6099.878002440015;6049.455549000611;6099.390060993954;6104.61795224595;6104.694765261719;6121.3572574879;4698.600618947359;4750.382450281441;4828.106800241966;4831.879203019882;4832.202686556749;4245.405643209953;4245.957540424618;4294.935575966363;4316.805743741539;4341.19687857741;5614.9612321720615;5627.212190293362;5627.352854421794;5628.97185514078;5682.431756824367;6124.234470691164;6163.414475624809;6165.383461653889;6170.907436388457;6171.352008039091;5356.5982551308025;5507.642003269774;5524.281843360418;5577;5584.944150558443;5194.6104042196985;5245.0558899398475;5247.868803279872;5249.396319423316;5254.054270231395;6127.189528148541;6178.382161783786;6179.752809887644;6206.193194884727;6215.316315205414;6146.494108943338;6168.167297414791;6170.290416601969;6171.814845554641;6187.504999599932;6213.565050446426;6239.937600624117;6243.96878015607;6269.185005949197;6273.121762953281;5826.475617194473;5907.763689452546;5939.970300148471;5999.520038397005;6000.21997140369;5905.852353691193;6108.267007959073;6117.1130186123655;6119.3268740437625;6133.3866613338305;5890.52875769946;5904.350521442552;5908.497777688945;5909;5925.911111333247;5630.774769009194;5649.68926709035;5696.259486266758;5886.558508111823;5896.764129434946;5832.416758324133;5838.795642152504;5845.649261044351;5849.502792262705;5857.58996870215;5962.821115366546;5965.91051134242;5983.922893879144;6004.42957918997;6014.218151640259;5605.271314729059;5688.345840228427;5690.2887139107615;5697.7436015380235;5817.621854579439 07:55:53 INFO - PROCESS | 1654 | |1;ext.html;427.4229789783792;449.82007197121146;501.8820577164366;504.7678068088679;519.6777997641462;32785.344293114154;39233.4114988275;39585.99999999996;41236.79381603095;41486.17027659445;33882.32235355292;40006.7999660002;40472.59527404725;40623.59376406235;40625.796871015606;8167.509949403055;8419.031811341712;9158.954205228982;9359.906400936006;9388.342816002883;9009.189172974431;11179.944100279487;11223.438828058564;11367.204295699305;11369.772604547905;11210.327380357165;11239.325640461557;11253.718657033598;11285.605003824869;11291.266067705614;11126.054285385711;11236.47179384632;11248.662540123809;11257.155713321534;11262.43687815614;9306.488143152124;11055.834162487488;11064.28082174656;11080.889191108066;11094.833577496343;38406;38713.41929871054;38826;38889.22221555553;39005.82982510529;3343.2310568569123;3387.0622388869624;3389.57630296213;3531.964680353189;3537.823108844573;28874;29361.11916642504;29564.556531652044;30790.38419231603;30813.53779693284;3092;3163.225009872596;3164.17731389838;3220.5652236947944;3276.3938671345877;362013;362566;363033;363404;363500;55455.168172477446;55473.167902481495;56380.15429768557;56746;56811.86376272451;57969;58101.418985810444;58109.12836307459;58185;58203;14961.625959351104;14986.40054397812;15227.923860380628;15446.613834654223;15483.458078967407;10811.78376432467;10993.450327483753;11043.558257669763;11781.823272650918;11965.700857478632;14622.341994610268;15071.4724984625;15080.170590617401;15131.243437828065;15224.619384515254;5305.920411193835;6170.969145154246;6213.378662133841;6246.781362652377;6324.810255692337;851.7061613743249;872.4621659171992;941.1717688434134;943.6932996776076;1036.6682661548232;27280.727192728216;27920.58119128215;28463;28679.856600716863;29308.706912931026;980.8970058143792;1000.9049140331657;1007.3452256033637;1028.9022542858565;1046.2623850185753;14495.927520362542;15044.924775376272;15058.698826023417;15385.615229639423;15554.066755994676;606002;610364;610898.891011093;611154;613699;55315.72342138264;55396.89206215853;55467.72266138643;55543.61140971508;55820.16269755957;1238.6036468330049;1279.7952327627536;1340.2762508245632;1366.8769810717083;1383;24399.092517264988;29785.940948196207;29962.25094372658;30121.849390752905;30199.396012080077;46768;47583.286250705576;47654.28518572293;47717.807054822515;47806.76096619495;435925;436459;437679;437835.1355539896;439099;23253.883730581914;23514;23903.88048059818;23972;24510.75489245085;39673.801630991664;40158;40609.390859137726;40896.79551602223;40988.385174223;28325.71674283231;32289.51565726563;33725.83137084299;34594.44325005331;34674.47988280127;33957.830210848784;34061.82969085139;34671;35186.296274073866;35322.470162947066;32937.39999900341;33814.830925846196;34150.14624634304;34234;34273.65726342705;25895;26855.597166042917;28327.29181770472;29070.418591628473;30333;23054.654180186975;23271.76728232696;23519.41201469977;23571.17500887461;23665.763342366357 07:55:53 INFO - PROCESS | 1654 | |2;jquery.html;351.54299410766;368.2653107051432;370.20590832663936;377.72614854230676;403.17751786355836;14469.276536173189;14887.478938237164;16127.75808362874;20098.79407235563;20165.294214702488;18916.905415472902;19190;19684.11421486033;19879.40361789145;20684.27605033824;5388.245645609618;5688.829335119953;5698.287714035746;5708.286464191976;5719.19931209631;4854.053459575384;5522.6686398816;5583.581231407661;5603;5612.69130197839;5551.250581171531;5560.165975103747;5560.388357280696;5574.024545704506;5575.609707320489;5300.761465734032;5545.085060964936;5596.3284405871145;5612.242347283105;5613.887722245532;4724.952750472486;4919.852404427837;4929.926051109236;4935.703857768545;4939.629527785394;20471.5905681887;24780.008799647992;25810.483790324088;25830.354241143934;26102.73897261022;1975.6838905775007;2284.200529814568;2314.953700925989;2333.953320933572;2400.207931382657;7756.573388463632;9795.216382689368;10071.304798135723;10225.130863876579;10299;1560.680060587577;1814.2833580735535;1824.2942848436753;1851.9166637501344;1882.8305452509203;95812.52093739486;97347.51326243395;106852;110559;112536;11367.033802126747;11389.373584452935;11389.544418223344;11506.712332191762;11582.420878956018;14406.351714172888;14432.855671443362;14439.061461005002;14443;14461.710765784625;7059.152901651834;8035.437519373705;8207.671693132208;8323.334133269324;8459.534725590152;8133.901923240287;8175.100738918714;8175.7138500152205;8319.292860106838;8324.875126872981;4447.777611119496;4456.442944631921;4474.910501789946;4475.843345482893;4610.170169369546;1660.3147804977716;1873.6440076385716;1883.5102873253054;1885.9622807544047;1893.3278686066524;831.3889291370838;847.6355167278007;864.3016472631309;864.6584599083327;924.7549399409162;18447.53881152982;20171.39485815428;21199.364019079145;21207.15171393127;21258.681119783214;793.730131755206;895.901450840407;933.1135421349745;940.3088729783603;994.2344394815951;8526.701565445304;9081.273498120134;10739.731506712395;11083.279586826831;11120.38837863909;523017;539511;548497;562214;565463.7268136659;71914;112411.6276511706;119594.4020279893;122170;127674;939.5912777941618;968.9777284964289;974.8147851908114;995.8298998676526;996.0437979539578;18414;18814.52963675919;18867.716984245522;19306.93811840362;19352.612947741247;39701.808945731675;50065.49017647382;52751.73624131855;53510.92978140338;53731.119410822;66859.66570167118;73690.63154684192;74684;75585;75596.24403755892;6667.566608170453;7193.964030179815;7370.189279179393;7995.440319177602;8369.372297077865;9456.763580910532;12633.93683031579;12804.48782048745;13160.670983225496;13321.600351989457;8162.959185204036;11106.50020749052;11197.160212984221;11260.549578016788;11472.31166130035;8653.567321633767;10722.624708135178;10899;11119.27724697892;11602.593909213138;10470.947645261725;11259.774804504028;11618.593349232737;11653.76692466163;11892.345920974083;7233.891491627735;7253.782386528202;7342.559446433231;7404.481686282124;7631.885521717068;10899.237053406503;11141.832872506757;11148.55405783792;11501.079913606723;11528.481218345027 07:55:53 INFO - PROCESS | 1654 | |3;mootools.html;1455.5778824140996;1498.8276348219954;1688.5609741467215;1817.6909925312696;1878.5867109235962;7769.689212431503;8210.178982101786;8212;8226.712065077723;8241.58792060396;7280.089988751406;7522.736704215354;7538.472306938516;7695.192004839495;8029.598520073988;2194.9341519754435;2234.977650223493;2235.2958817972367;2239.2498512998163;2242.921497747579;2249.1790496468752;2251.594712951668;2266.3087758233733;2321.9883900580558;2325.500017496238;2015.9819291257895;2260.740014898283;2261.9434514137197;2286.074139973305;2288.9084436622516;2170.4899348653134;2268.0134141648437;2269.6822444857735;2276.7950884420316;2282.9200977965775;2221.677856710768;2255.041607316884;2257.943551411228;2265.8527195732227;2268.7050683411217;7865.016872890888;8067.354611631055;8071.878921816177;8081.838363232761;8085.95957020217;4893.388326459192;5059.595232381401;5065.949340506585;5075.264086707407;5088.6946783193125;3212.887548935776;3367.225538126245;3416.28258065804;3422.366862130489;3422.863085476578;988.3723835364524;1024.0425202435747;1036.5491011409986;1043.2644985285356;1068.775557133003;10224.539895704711;10374.481275936248;10375.273730838844;10388.324758890649;10476.47617619116;4252.893677658083;4507.864764057083;4556.11155824611;4562.064776720765;4563.954360456353;9192.954035229915;9205.677801276923;9213.078692130734;9214.90785092154;9244.075592440702;5072.619553533426;5077.568406685399;5077.847664570068;5082.567981721595;5111.463296353903;3889.727719059695;4456.732596044248;4577.404937358188;4667.9766601166775;4677.579017888406;3545.592256890439;3576.46353047045;3612.7290453215587;3641.471986561987;3658.304922064799;1167.7664467106442;1197.9700507487207;1198.2510930668332;1206.6199147268583;1212.248405988293;801.9318357939524;804.2239239134263;886.0607755778894;935.8348855674728;944.7449188719007;4467.932981005288;4911.852644420673;5277.551408130275;5485.780568777204;5530.087535556669;423.9957600424018;433.40839753735924;446.5846762510896;446.825737962195;448.2872233149308;3590.4075827488696;3711.4247291669835;3715.535558055243;3833.923321533554;3838.4626152338697;9238.58426370815;9684.176844968257;9737.269704772028;9744.658936937172;9746.317757757031;9698.466584337788;9700.708978730649;9713.417194968324;9717.902820971842;9724;7161.4628902831455;7499.287567681062;7616.695332186761;7622.809429764189;7625;5482.259894914136;5663.830085097454;5668.26312579362;5692.231548741032;5716.685582293014;8783;9003.414778039407;9092.045335239705;9155.13026262504;9179.724608261762;8351.498910065415;8591.957040214758;9153.725388238363;9226.169644732006;9379.624815007322;5622.5501959842295;7662.885056724042;7667.808304792425;7676.846463070819;7691.1539730628465;7373.373263272468;7639.388848891964;7735.613219338898;7822.335101516434;7828.217178282354;5874.647521148574;6683.9331606685255;6823.28355522663;6870.45036397097;6950.20072691647;6573.079768832272;6719.428848547928;6784.253732089367;6811.693473793592;6812.659367031728;6404.327545607644;6422.486201103807;6509.153810004669;6512.544121911421;6517.837054073686;4635.745034023161;4660.580547750718;4777.3072904429355;4817.1810792164715;4888.560029597211;4611.79246933882;4686.268445260315;4769.117713223065;4967.254911763264;4986.900261994812 07:55:53 INFO - PROCESS | 1654 | |4;prototype.html;341.3667646515713;341.8905950095969;354.35507376574634;364.6171519904103;366.730453116959;4071.0917519181585;4565.086982603476;4885.8534243972645;5020.698758074509;5045.924311135336;4385.451818522684;4549.294859296806;4587.0137920347115;4996.7751451184695;5009.69941803492;3685.5208822853124;3834.386498160295;3929.489166408377;3930.78380689062;3988.561258261589;3310.3710295043984;3354.698077173054;3548.325818094567;3616.7468277220605;3840.6543411093;3906.0820707133803;3929.862454814082;3939.8621048263317;3949.308870947587;3953.1815364932168;3720.437416285167;3946.0923987482897;3948.9605103949166;3961.445397644332;3965.742226755266;2958.6745457999605;3359.9160020999425;3422.6064002639764;3453;3481.4603736420895;4243.745375277463;4637.837675681335;4786.458021064387;4861.611071114302;4881.511848815126;3787.2993496203017;4418.690691651585;4453.953320969602;4469.44131983502;4476.149531588988;4722.527747225285;4901.926471102936;5218.556422704075;5227.843164705065;5241.004209200278;3827.770333779982;3838.769673819552;3842.3660096084113;3846.307664620367;3858.765195137557;4526.366308716782;4860.128850392624;4883.096627123958;5477.643953143033;5512.531434828044;3184.6656101109515;3498.8950331490096;3841.9231615367535;3881.4760007399204;3982.920341593152;3401.1157099154398;4010.21800748857;4024.2353952748886;4048.109415928491;4065.2479291331197;3871.922561548753;4014.698897582693;4478.283474644041;4498.482674492409;4502.594766470967;4455.866324010285;4827.948122048116;5144.2283657450935;5217.139172036572;5244.659097158673;1142.8913953465126;1284.2679672586723;1306.9869301307056;1316.486570237608;1318.2617734068951;742.3652776875693;794.3406972213049;907.6233363154349;935.6070450410843;936.7330310861372;4096.446979657768;4660.4154587440435;4679.4964693888605;4690.437147542317;4703.905921881543;4669.595158493378;5180.430152683201;5203.16749320107;5279;5491.945080549143;4539;4981.476944920803;4993.350864387679;5006.774695138727;5015.648904576645;2372.0904671739418;2422.297533715238;2567.895804803915;2611.738826117411;2668.7731542818688;4801.511531425269;5265.394479634814;5318;5357.7053262070185;5455.345358556999;4303.278688524615;4449.421575195204;4722.6079745836705;4874.683145595525;4923.212286034217;4414.381986521889;5198.9740051299505;5279.709615971082;5283.550898173698;5327.600429967691;5109.565686916654;5133.435322114489;5159.380874295109;5187.325647665779;5206.869828254324;5048.91448338609;5085.8728531787;5091.465396133352;5097.572679649704;5111.616628752784;4481.775911204361;4887.0714564232685;5245.193821305583;5288.3918349390315;5321.9467805323;3375.6118046423994;3716.9814150929074;3733.738638295293;3744.307303148817;3754.511913451343;4440.689151759346;4489.214387482243;5115.4373018967135;5202.60980426462;5230.790768369223;4341.978290108529;4583.656225783013;4877.853704379539;5062.898742025065;5135.457948315458;4502.842400515966;4713.410823647044;4812.230043193073;4972.152151652111;4996.525330093636;4432.534583868647;4566;4868.853934381974;4917.631177661761;4946.466595355451;3972.6226008529143;4342.9131417370845;4533.911861153366;4766.833160839493;4958.578520825626;4243.321068629005;4902.7058376497525;5106.642535022513;5108.616853736059;5170.767315470737 07:55:53 INFO - PROCESS | 1654 | |5;yui.html;631.8767840271146;737.6311844077961;739.8520295940813;750.8535835512074;805.2028491793127;14613.488527901525;15299.92350038251;15354.385824567004;15434.305456254468;15451.381944722212;15182.013169143998;15844.683106337867;15921.920390398032;16253.106079165642;16285.51143465695;674.706502671337;695.30816837247;868.5917618719192;894.7852515396323;896.9013408525057;718.3319512853045;722.1081963774734;723.3200791256229;853.5262929074361;877.627008521379;918.1874041473277;929.3076657889882;929.330881765128;930.7393929699695;933.3932943586689;883.5140672630092;922.686286662538;924.9491277979674;925.0194793518858;926.1201858234637;540.7323374929396;550.8294873394037;661.1801366305795;670.2627110178813;700.2402393403164;14839.10965342083;15122.470713525085;15412.768808467881;15418.53744387659;15420.306086226146;13898.749112579917;13921.512747053906;13945.302734863217;13969.650758731012;14084.225367604779;12855.228686278853;12996.935015324863;13066.934665326708;13134.080614356999;13594.592162235149;4219.135077309144;4275.636570891478;4315.07225946423;4342.544032876534;4462.531434199427;121354;122024;122575;124341;126123.47753044887;10999.395033273087;11094.500747466383;11099.167562432849;11100.777984440267;11519.19365644397;21077.78922210789;21711;22770.886145569166;22775.430614234778;22933.541329173324;7772.84454310922;8010.919890801134;8041.718539851077;8096.190380961974;8312.20034076942;4265.509466411402;4338.891527711769;4365.158660378846;4377;4547.704399214107;3616.1321282891918;3682.576503702055;3704.8518059277326;3711.7030637548933;3741.5136032315627;575.8905807896487;576.224977405389;586.8151532267323;588.793922127252;592.3454582686156;616.7933742196325;655.9472047364007;659.9076129341896;671.9025741267488;680.2381332907175;8499.852519909857;8705.651773928972;9324.393914395543;9364.25085993119;9412.388194767318;621.3351713666334;638.4987784589075;653.8561516466369;663.5288944849115;667.9799606011827;4336.869893903188;4544.386507821402;4558.361829343895;4623.398958135421;4724.480307166209;85401;89475;105341;111544;117852.00862550826;83266.16733832705;100314.4984275074;101309;102743.4862825681;103571.96428035774;88990.09643601772;90295;90513.54743226242;90984;91069.08930910738;8478.957605211934;8789.208971192624;8869.379143460154;8897.28821694276;9281;36395;52160.73919630377;54872.176917345474;56301.15548266861;57488.1376779357;74327.62836185785;79920.60039699764;82065;82399;82508;11679.124065694938;11734.589289374831;11961.521539138337;12022.458989345325;12441.93779031099;10513.737156570842;12590.433430495832;12618.305993170463;12792.74414511686;12815.231086134489;11826;12038.578649747216;12071.336076515876;12321.93839030799;12610.180338277982;12020.75958480843;12227.755444890874;12248.081393895316;12448.377581120727;12731.363431828186;11873.287602743863;11962.461689223832;12361.690957725768;12384.380780961095;12532.310722909962;9075.818483630423;10053.69838904834;10111.3427627204;10442.477876106012;10466.267361284637;10156.74608134773;10389.116925061455;10396.688099357032;10404.427756473164;10420.583176673152 07:55:53 INFO - PROCESS | 1654 | __end_tp_report 07:55:53 INFO - PROCESS | 1654 | __start_cc_report 07:55:53 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2259 07:55:53 INFO - PROCESS | 1654 | __end_cc_report 07:55:53 INFO - PROCESS | 1654 | __startTimestamp1482422153587__endTimestamp 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | ------- Summary: start ------- 07:55:53 INFO - PROCESS | 1654 | Number of tests: 6 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5583.78 Median:5697.74 stddev:655.87 (11.5%) stddev-sans-first:617.51 07:55:53 INFO - PROCESS | 1654 | Values: 2695.6 3000.3 3222.7 3280.5 3306.7 5402.7 5544.3 5547.0 5570.2 5595.9 5493.6 5551.1 5611.5 5612.0 5654.6 4954.6 5008.1 5027.9 5051.1 5063.1 5040.6 5141.4 5154.0 5159.3 5180.1 4972.8 5089.1 5091.2 5111.9 5206.9 4989.2 5068.4 5068.7 5069.5 5081.6 5011.6 5055.3 5061.1 5063.1 5065.3 5543.9 5563.4 5565.6 5565.8 5573.8 5050.2 6041.2 6044.6 6061.4 6062.8 6048.8 6067.8 6093.8 6107.4 6116.6 4720.6 5534.8 5572.6 5613.9 5620.3 6187.6 6187.9 6190.5 6197.5 6213.0 5978.8 5982.9 5989.3 5992.5 6026.8 5909.6 5992.9 6012.3 6031.4 6104.5 6015.4 6042.8 6054.5 6084.8 6099.9 6049.5 6099.4 6104.6 6104.7 6121.4 4698.6 4750.4 4828.1 4831.9 4832.2 4245.4 4246.0 4294.9 4316.8 4341.2 5615.0 5627.2 5627.4 5629.0 5682.4 6124.2 6163.4 6165.4 6170.9 6171.4 5356.6 5507.6 5524.3 5577.0 5584.9 5194.6 5245.1 5247.9 5249.4 5254.1 6127.2 6178.4 6179.8 6206.2 6215.3 6146.5 6168.2 6170.3 6171.8 6187.5 6213.6 6239.9 6244.0 6269.2 6273.1 5826.5 5907.8 5940.0 5999.5 6000.2 5905.9 6108.3 6117.1 6119.3 6133.4 5890.5 5904.4 5908.5 5909.0 5925.9 5630.8 5649.7 5696.3 5886.6 5896.8 5832.4 5838.8 5845.6 5849.5 5857.6 5962.8 5965.9 5983.9 6004.4 6014.2 5605.3 5688.3 5690.3 5697.7 5817.6 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:60415.70 Median:18634.69 stddev:128552.51 (689.9%) stddev-sans-first:128834.23 07:55:53 INFO - PROCESS | 1654 | Values: 427.4 449.8 501.9 504.8 519.7 32785.3 39233.4 39586.0 41236.8 41486.2 33882.3 40006.8 40472.6 40623.6 40625.8 8167.5 8419.0 9159.0 9359.9 9388.3 9009.2 11179.9 11223.4 11367.2 11369.8 11210.3 11239.3 11253.7 11285.6 11291.3 11126.1 11236.5 11248.7 11257.2 11262.4 9306.5 11055.8 11064.3 11080.9 11094.8 38406.0 38713.4 38826.0 38889.2 39005.8 3343.2 3387.1 3389.6 3532.0 3537.8 28874.0 29361.1 29564.6 30790.4 30813.5 3092.0 3163.2 3164.2 3220.6 3276.4 362013.0 362566.0 363033.0 363404.0 363500.0 55455.2 55473.2 56380.2 56746.0 56811.9 57969.0 58101.4 58109.1 58185.0 58203.0 14961.6 14986.4 15227.9 15446.6 15483.5 10811.8 10993.5 11043.6 11781.8 11965.7 14622.3 15071.5 15080.2 15131.2 15224.6 5305.9 6171.0 6213.4 6246.8 6324.8 851.7 872.5 941.2 943.7 1036.7 27280.7 27920.6 28463.0 28679.9 29308.7 980.9 1000.9 1007.3 1028.9 1046.3 14495.9 15044.9 15058.7 15385.6 15554.1 606002.0 610364.0 610898.9 611154.0 613699.0 55315.7 55396.9 55467.7 55543.6 55820.2 1238.6 1279.8 1340.3 1366.9 1383.0 24399.1 29785.9 29962.3 30121.8 30199.4 46768.0 47583.3 47654.3 47717.8 47806.8 435925.0 436459.0 437679.0 437835.1 439099.0 23253.9 23514.0 23903.9 23972.0 24510.8 39673.8 40158.0 40609.4 40896.8 40988.4 28325.7 32289.5 33725.8 34594.4 34674.5 33957.8 34061.8 34671.0 35186.3 35322.5 32937.4 33814.8 34150.1 34234.0 34273.7 25895.0 26855.6 28327.3 29070.4 30333.0 23054.7 23271.8 23519.4 23571.2 23665.8 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:32240.17 Median:2425.48 stddev:91248.30 (3762.1%) stddev-sans-first:91472.86 07:55:53 INFO - PROCESS | 1654 | Values: 351.5 368.3 370.2 377.7 403.2 14469.3 14887.5 16127.8 20098.8 20165.3 18916.9 19190.0 19684.1 19879.4 20684.3 5388.2 5688.8 5698.3 5708.3 5719.2 4854.1 5522.7 5583.6 5603.0 5612.7 5551.3 5560.2 5560.4 5574.0 5575.6 5300.8 5545.1 5596.3 5612.2 5613.9 4725.0 4919.9 4929.9 4935.7 4939.6 20471.6 24780.0 25810.5 25830.4 26102.7 1975.7 2284.2 2315.0 2334.0 2400.2 7756.6 9795.2 10071.3 10225.1 10299.0 1560.7 1814.3 1824.3 1851.9 1882.8 95812.5 97347.5 106852.0 110559.0 112536.0 11367.0 11389.4 11389.5 11506.7 11582.4 14406.4 14432.9 14439.1 14443.0 14461.7 7059.2 8035.4 8207.7 8323.3 8459.5 8133.9 8175.1 8175.7 8319.3 8324.9 4447.8 4456.4 4474.9 4475.8 4610.2 1660.3 1873.6 1883.5 1886.0 1893.3 831.4 847.6 864.3 864.7 924.8 18447.5 20171.4 21199.4 21207.2 21258.7 793.7 895.9 933.1 940.3 994.2 8526.7 9081.3 10739.7 11083.3 11120.4 523017.0 539511.0 548497.0 562214.0 565463.7 71914.0 112411.6 119594.4 122170.0 127674.0 939.6 969.0 974.8 995.8 996.0 18414.0 18814.5 18867.7 19306.9 19352.6 39701.8 50065.5 52751.7 53510.9 53731.1 66859.7 73690.6 74684.0 75585.0 75596.2 6667.6 7194.0 7370.2 7995.4 8369.4 9456.8 12633.9 12804.5 13160.7 13321.6 8163.0 11106.5 11197.2 11260.5 11472.3 8653.6 10722.6 10899.0 11119.3 11602.6 10470.9 11259.8 11618.6 11653.8 11892.3 7233.9 7253.8 7342.6 7404.5 7631.9 10899.2 11141.8 11148.6 11501.1 11528.5 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5265.52 Median:5076.42 stddev:2883.81 (56.8%) stddev-sans-first:2877.69 07:55:53 INFO - PROCESS | 1654 | Values: 1455.6 1498.8 1688.6 1817.7 1878.6 7769.7 8210.2 8212.0 8226.7 8241.6 7280.1 7522.7 7538.5 7695.2 8029.6 2194.9 2235.0 2235.3 2239.2 2242.9 2249.2 2251.6 2266.3 2322.0 2325.5 2016.0 2260.7 2261.9 2286.1 2288.9 2170.5 2268.0 2269.7 2276.8 2282.9 2221.7 2255.0 2257.9 2265.9 2268.7 7865.0 8067.4 8071.9 8081.8 8086.0 4893.4 5059.6 5065.9 5075.3 5088.7 3212.9 3367.2 3416.3 3422.4 3422.9 988.4 1024.0 1036.5 1043.3 1068.8 10224.5 10374.5 10375.3 10388.3 10476.5 4252.9 4507.9 4556.1 4562.1 4564.0 9193.0 9205.7 9213.1 9214.9 9244.1 5072.6 5077.6 5077.8 5082.6 5111.5 3889.7 4456.7 4577.4 4668.0 4677.6 3545.6 3576.5 3612.7 3641.5 3658.3 1167.8 1198.0 1198.3 1206.6 1212.2 801.9 804.2 886.1 935.8 944.7 4467.9 4911.9 5277.6 5485.8 5530.1 424.0 433.4 446.6 446.8 448.3 3590.4 3711.4 3715.5 3833.9 3838.5 9238.6 9684.2 9737.3 9744.7 9746.3 9698.5 9700.7 9713.4 9717.9 9724.0 7161.5 7499.3 7616.7 7622.8 7625.0 5482.3 5663.8 5668.3 5692.2 5716.7 8783.0 9003.4 9092.0 9155.1 9179.7 8351.5 8592.0 9153.7 9226.2 9379.6 5622.6 7662.9 7667.8 7676.8 7691.2 7373.4 7639.4 7735.6 7822.3 7828.2 5874.6 6683.9 6823.3 6870.5 6950.2 6573.1 6719.4 6784.3 6811.7 6812.7 6404.3 6422.5 6509.2 6512.5 6517.8 4635.7 4660.6 4777.3 4817.2 4888.6 4611.8 4686.3 4769.1 4967.3 4986.9 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4168.95 Median:4557.19 stddev:1211.03 (26.6%) stddev-sans-first:1179.86 07:55:53 INFO - PROCESS | 1654 | Values: 341.4 341.9 354.4 364.6 366.7 4071.1 4565.1 4885.9 5020.7 5045.9 4385.5 4549.3 4587.0 4996.8 5009.7 3685.5 3834.4 3929.5 3930.8 3988.6 3310.4 3354.7 3548.3 3616.7 3840.7 3906.1 3929.9 3939.9 3949.3 3953.2 3720.4 3946.1 3949.0 3961.4 3965.7 2958.7 3359.9 3422.6 3453.0 3481.5 4243.7 4637.8 4786.5 4861.6 4881.5 3787.3 4418.7 4454.0 4469.4 4476.1 4722.5 4901.9 5218.6 5227.8 5241.0 3827.8 3838.8 3842.4 3846.3 3858.8 4526.4 4860.1 4883.1 5477.6 5512.5 3184.7 3498.9 3841.9 3881.5 3982.9 3401.1 4010.2 4024.2 4048.1 4065.2 3871.9 4014.7 4478.3 4498.5 4502.6 4455.9 4827.9 5144.2 5217.1 5244.7 1142.9 1284.3 1307.0 1316.5 1318.3 742.4 794.3 907.6 935.6 936.7 4096.4 4660.4 4679.5 4690.4 4703.9 4669.6 5180.4 5203.2 5279.0 5491.9 4539.0 4981.5 4993.4 5006.8 5015.6 2372.1 2422.3 2567.9 2611.7 2668.8 4801.5 5265.4 5318.0 5357.7 5455.3 4303.3 4449.4 4722.6 4874.7 4923.2 4414.4 5199.0 5279.7 5283.6 5327.6 5109.6 5133.4 5159.4 5187.3 5206.9 5048.9 5085.9 5091.5 5097.6 5111.6 4481.8 4887.1 5245.2 5288.4 5321.9 3375.6 3717.0 3733.7 3744.3 3754.5 4440.7 4489.2 5115.4 5202.6 5230.8 4342.0 4583.7 4877.9 5062.9 5135.5 4502.8 4713.4 4812.2 4972.2 4996.5 4432.5 4566.0 4868.9 4917.6 4946.5 3972.6 4342.9 4533.9 4766.8 4958.6 4243.3 4902.7 5106.6 5108.6 5170.8 07:55:53 INFO - PROCESS | 1654 | 07:55:53 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:21759.28 Median:4325.97 stddev:32876.17 (760.0%) stddev-sans-first:32930.12 07:55:53 INFO - PROCESS | 1654 | Values: 631.9 737.6 739.9 750.9 805.2 14613.5 15299.9 15354.4 15434.3 15451.4 15182.0 15844.7 15921.9 16253.1 16285.5 674.7 695.3 868.6 894.8 896.9 718.3 722.1 723.3 853.5 877.6 918.2 929.3 929.3 930.7 933.4 883.5 922.7 924.9 925.0 926.1 540.7 550.8 661.2 670.3 700.2 14839.1 15122.5 15412.8 15418.5 15420.3 13898.7 13921.5 13945.3 13969.7 14084.2 12855.2 12996.9 13066.9 13134.1 13594.6 4219.1 4275.6 4315.1 4342.5 4462.5 121354.0 122024.0 122575.0 124341.0 126123.5 10999.4 11094.5 11099.2 11100.8 11519.2 21077.8 21711.0 22770.9 22775.4 22933.5 7772.8 8010.9 8041.7 8096.2 8312.2 4265.5 4338.9 4365.2 4377.0 4547.7 3616.1 3682.6 3704.9 3711.7 3741.5 575.9 576.2 586.8 588.8 592.3 616.8 655.9 659.9 671.9 680.2 8499.9 8705.7 9324.4 9364.3 9412.4 621.3 638.5 653.9 663.5 668.0 4336.9 4544.4 4558.4 4623.4 4724.5 85401.0 89475.0 105341.0 111544.0 117852.0 83266.2 100314.5 101309.0 102743.5 103572.0 88990.1 90295.0 90513.5 90984.0 91069.1 8479.0 8789.2 8869.4 8897.3 9281.0 36395.0 52160.7 54872.2 56301.2 57488.1 74327.6 79920.6 82065.0 82399.0 82508.0 11679.1 11734.6 11961.5 12022.5 12441.9 10513.7 12590.4 12618.3 12792.7 12815.2 11826.0 12038.6 12071.3 12321.9 12610.2 12020.8 12227.8 12248.1 12448.4 12731.4 11873.3 11962.5 12361.7 12384.4 12532.3 9075.8 10053.7 10111.3 10442.5 10466.3 10156.7 10389.1 10396.7 10404.4 10420.6 07:55:53 INFO - PROCESS | 1654 | -------- Summary: end -------- 07:55:53 INFO - PROCESS | 1654 | 07:55:54 INFO - TEST-INFO | 1654: exit 0 07:55:54 INFO - TEST-OK | dromaeo_css | took 1119822ms 07:55:54 INFO - TEST-START | kraken 07:55:54 INFO - operating with platform_type : mac_ 07:55:54 INFO - Initialising browser for kraken test... 07:55:54 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpEF6nD5/profile http://localhost:49237/getInfo.html) 07:55:56 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 07:55:56 INFO - PROCESS | 1659 | colorDepth:24 07:55:56 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 07:55:56 INFO - PROCESS | 1659 | __metrics 07:55:56 INFO - PROCESS | 1659 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:55:56 INFO - PROCESS | 1659 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:55:57 INFO - TEST-INFO | 1659: exit 0 07:55:57 INFO - Browser initialized. 07:55:57 INFO - Running cycle 1/1 for kraken test... 07:55:57 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpEF6nD5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:09 INFO - PROCESS | 1661 | RSS: Main: 254279680 07:56:09 INFO - PROCESS | 1661 | 07:56:12 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:13 INFO - PROCESS | 1661 | RSS: Main: 304852992 07:56:13 INFO - PROCESS | 1661 | 07:56:15 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 07:56:16 INFO - PROCESS | 1661 | RSS: Main: 305774592 07:56:16 INFO - PROCESS | 1661 | 07:56:19 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 07:56:20 INFO - PROCESS | 1661 | RSS: Main: 394719232 07:56:20 INFO - PROCESS | 1661 | 07:56:22 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 07:56:23 INFO - PROCESS | 1661 | RSS: Main: 296452096 07:56:23 INFO - PROCESS | 1661 | 07:56:25 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:25 INFO - PROCESS | 1661 | RSS: Main: 299823104 07:56:25 INFO - PROCESS | 1661 | 07:56:28 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:29 INFO - PROCESS | 1661 | RSS: Main: 341520384 07:56:29 INFO - PROCESS | 1661 | 07:56:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:32 INFO - PROCESS | 1661 | RSS: Main: 344727552 07:56:32 INFO - PROCESS | 1661 | 07:56:35 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 07:56:36 INFO - PROCESS | 1661 | RSS: Main: 341422080 07:56:36 INFO - PROCESS | 1661 | 07:56:37 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:38 INFO - PROCESS | 1661 | RSS: Main: 318140416 07:56:38 INFO - PROCESS | 1661 | 07:56:40 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:40 INFO - PROCESS | 1661 | RSS: Main: 323026944 07:56:40 INFO - PROCESS | 1661 | 07:56:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:43 INFO - PROCESS | 1661 | RSS: Main: 326045696 07:56:43 INFO - PROCESS | 1661 | 07:56:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:47 INFO - PROCESS | 1661 | RSS: Main: 340733952 07:56:47 INFO - PROCESS | 1661 | 07:56:50 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:50 INFO - PROCESS | 1661 | RSS: Main: 335097856 07:56:50 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 07:56:52 INFO - PROCESS | 1661 | RSS: Main: 378863616 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | __start_tp_report 07:56:52 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 07:56:52 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 07:56:52 INFO - PROCESS | 1661 | |i|pagename|runs| 07:56:52 INFO - PROCESS | 1661 | |0;ai-astar;115;117;115;114;115;115;114;114;114;114 07:56:52 INFO - PROCESS | 1661 | |1;audio-beat-detection;145;106;112;134;131;138;129;110;134;111 07:56:52 INFO - PROCESS | 1661 | |2;audio-dft;184;186;184;185;186;187;181;181;184;186 07:56:52 INFO - PROCESS | 1661 | |3;audio-fft;80;59;59;86;65;61;59;59;74;59 07:56:52 INFO - PROCESS | 1661 | |4;audio-oscillator;84;72;86;70;69;68;83;69;70;84 07:56:52 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;88;86;88;85;88;84;88;86;87;83 07:56:52 INFO - PROCESS | 1661 | |6;imaging-darkroom;97;97;113;163;97;97;99;101;98;97 07:56:52 INFO - PROCESS | 1661 | |7;imaging-desaturate;89;88;87;88;85;86;85;88;88;81 07:56:52 INFO - PROCESS | 1661 | |8;json-parse-financial;58;55;56;55;55;54;55;54;55;54 07:56:52 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;66;66;73;80;74;70;72;71;71;73 07:56:52 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;89;86;86;90;89;87;87;90;87;92 07:56:52 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;145;151;154;151;149;138;138;138;184;151 07:56:52 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;172;175;171;174;173;173;172;174;173;179 07:56:52 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;66;69;67;67;68;67;66;67;67 07:56:52 INFO - PROCESS | 1661 | __end_tp_report 07:56:52 INFO - PROCESS | 1661 | __start_cc_report 07:56:52 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2022 07:56:52 INFO - PROCESS | 1661 | __end_cc_report 07:56:52 INFO - PROCESS | 1661 | __startTimestamp1482422212972__endTimestamp 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | ------- Summary: start ------- 07:56:52 INFO - PROCESS | 1661 | Number of tests: 14 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 07:56:52 INFO - PROCESS | 1661 | Values: 115.0 117.0 115.0 114.0 115.0 115.0 114.0 114.0 114.0 114.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:125.00 Median:132.50 stddev:13.88 (10.5%) stddev-sans-first:12.70 07:56:52 INFO - PROCESS | 1661 | Values: 145.0 106.0 112.0 134.0 131.0 138.0 129.0 110.0 134.0 111.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.50 stddev:2.07 (1.1%) stddev-sans-first:2.19 07:56:52 INFO - PROCESS | 1661 | Values: 184.0 186.0 184.0 185.0 186.0 187.0 181.0 181.0 184.0 186.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:66.10 Median:63.00 stddev:10.17 (16.1%) stddev-sans-first:9.46 07:56:52 INFO - PROCESS | 1661 | Values: 80.0 59.0 59.0 86.0 65.0 61.0 59.0 59.0 74.0 59.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:77.50 stddev:7.63 (9.9%) stddev-sans-first:7.45 07:56:52 INFO - PROCESS | 1661 | Values: 84.0 72.0 86.0 70.0 69.0 68.0 83.0 69.0 70.0 84.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.83 (2.1%) stddev-sans-first:1.83 07:56:52 INFO - PROCESS | 1661 | Values: 88.0 86.0 88.0 85.0 88.0 84.0 88.0 86.0 87.0 83.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:97.00 stddev:20.66 (21.3%) stddev-sans-first:21.66 07:56:52 INFO - PROCESS | 1661 | Values: 97.0 97.0 113.0 163.0 97.0 97.0 99.0 101.0 98.0 97.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:86.50 Median:88.00 stddev:2.37 (2.7%) stddev-sans-first:2.33 07:56:52 INFO - PROCESS | 1661 | Values: 89.0 88.0 87.0 88.0 85.0 86.0 85.0 88.0 88.0 81.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:0.67 07:56:52 INFO - PROCESS | 1661 | Values: 58.0 55.0 56.0 55.0 55.0 54.0 55.0 54.0 55.0 54.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:72.50 stddev:4.03 (5.6%) stddev-sans-first:3.73 07:56:52 INFO - PROCESS | 1661 | Values: 66.0 66.0 73.0 80.0 74.0 70.0 72.0 71.0 71.0 73.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:89.00 stddev:2.00 (2.3%) stddev-sans-first:2.11 07:56:52 INFO - PROCESS | 1661 | Values: 89.0 86.0 86.0 90.0 89.0 87.0 87.0 90.0 87.0 92.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:151.00 stddev:13.47 (8.9%) stddev-sans-first:14.17 07:56:52 INFO - PROCESS | 1661 | Values: 145.0 151.0 154.0 151.0 149.0 138.0 138.0 138.0 184.0 151.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.50 stddev:2.22 (1.3%) stddev-sans-first:2.28 07:56:52 INFO - PROCESS | 1661 | Values: 172.0 175.0 171.0 174.0 173.0 173.0 172.0 174.0 173.0 179.0 07:56:52 INFO - PROCESS | 1661 | 07:56:52 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 07:56:52 INFO - PROCESS | 1661 | Values: 67.0 66.0 69.0 67.0 67.0 68.0 67.0 66.0 67.0 67.0 07:56:52 INFO - PROCESS | 1661 | -------- Summary: end -------- 07:56:52 INFO - PROCESS | 1661 | 07:56:53 INFO - TEST-INFO | 1661: exit 0 07:56:53 INFO - TEST-OK | kraken | took 59670ms 07:56:53 INFO - SUITE-END | took 1179s 07:56:54 INFO - Completed test suite (00:19:39) 07:56:54 INFO - javascript benchmark 07:56:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2695.636089127968, 3000.309928716395, 3222.6938440848116, 3280.507923811428, 3306.718928891047, 5402.702851343174, 5544.33467983842, 5546.972265138679, 5570.220169176314, 5595.888082238353, 5493.615446918718, 5551.139573366125, 5611.466910643492, 5612.0, 5654.632448890829, 4954.628402869781, 5008.12357837377, 5027.949720502785, 5051.141305977974, 5063.063333283354, 5040.571551418134, 5141.357330333708, 5153.9742301288625, 5159.329287192679, 5180.093483640367, 4972.776225069881, 5089.1348470759685, 5091.2108623163285, 5111.897762044739, 5206.921896171561, 4989.151844186497, 5068.366454193226, 5068.670536415121, 5069.518395752398, 5081.618878584084, 5011.6241281904, 5055.292259083732, 5061.063703214881, 5063.063333283318, 5065.341505604285, 5543.861403464905, 5563.443655634444, 5565.554755619541, 5565.833025009256, 5573.777048918038, 5050.217216331474, 6041.184440100574, 6044.637321760709, 6061.42416470439, 6062.818115456544, 6048.7882924097885, 6067.848303792441, 6093.786717464912, 6107.389261073901, 6116.633002019893, 4720.575148236675, 5534.75093620788, 5572.58205634579, 5613.943860561383, 5620.325560932673, 6187.597806142587, 6187.876242475215, 6190.473809726133, 6197.4732147767945, 6213.0, 5978.790742324085, 5982.940170598238, 5989.251343582052, 5992.490638295706, 6026.758929642765, 5909.645421274738, 5992.940070599326, 6012.338642749294, 6031.396860314021, 6104.511639068864, 6015.368386319461, 6042.818715438544, 6054.455099041107, 6084.787032453932, 6099.878002440015, 6049.455549000611, 6099.390060993954, 6104.61795224595, 6104.694765261719, 6121.3572574879, 4698.600618947359, 4750.382450281441, 4828.106800241966, 4831.879203019882, 4832.202686556749, 4245.405643209953, 4245.957540424618, 4294.935575966363, 4316.805743741539, 4341.19687857741, 5614.9612321720615, 5627.212190293362, 5627.352854421794, 5628.97185514078, 5682.431756824367, 6124.234470691164, 6163.414475624809, 6165.383461653889, 6170.907436388457, 6171.352008039091, 5356.5982551308025, 5507.642003269774, 5524.281843360418, 5577.0, 5584.944150558443, 5194.6104042196985, 5245.0558899398475, 5247.868803279872, 5249.396319423316, 5254.054270231395, 6127.189528148541, 6178.382161783786, 6179.752809887644, 6206.193194884727, 6215.316315205414, 6146.494108943338, 6168.167297414791, 6170.290416601969, 6171.814845554641, 6187.504999599932, 6213.565050446426, 6239.937600624117, 6243.96878015607, 6269.185005949197, 6273.121762953281, 5826.475617194473, 5907.763689452546, 5939.970300148471, 5999.520038397005, 6000.21997140369, 5905.852353691193, 6108.267007959073, 6117.1130186123655, 6119.3268740437625, 6133.3866613338305, 5890.52875769946, 5904.350521442552, 5908.497777688945, 5909.0, 5925.911111333247, 5630.774769009194, 5649.68926709035, 5696.259486266758, 5886.558508111823, 5896.764129434946, 5832.416758324133, 5838.795642152504, 5845.649261044351, 5849.502792262705, 5857.58996870215, 5962.821115366546, 5965.91051134242, 5983.922893879144, 6004.42957918997, 6014.218151640259, 5605.271314729059, 5688.345840228427, 5690.2887139107615, 5697.7436015380235, 5817.621854579439], "value": 5538.526143061963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.4229789783792, 449.82007197121146, 501.8820577164366, 504.7678068088679, 519.6777997641462, 32785.344293114154, 39233.4114988275, 39585.99999999996, 41236.79381603095, 41486.17027659445, 33882.32235355292, 40006.7999660002, 40472.59527404725, 40623.59376406235, 40625.796871015606, 8167.509949403055, 8419.031811341712, 9158.954205228982, 9359.906400936006, 9388.342816002883, 9009.189172974431, 11179.944100279487, 11223.438828058564, 11367.204295699305, 11369.772604547905, 11210.327380357165, 11239.325640461557, 11253.718657033598, 11285.605003824869, 11291.266067705614, 11126.054285385711, 11236.47179384632, 11248.662540123809, 11257.155713321534, 11262.43687815614, 9306.488143152124, 11055.834162487488, 11064.28082174656, 11080.889191108066, 11094.833577496343, 38406.0, 38713.41929871054, 38826.0, 38889.22221555553, 39005.82982510529, 3343.2310568569123, 3387.0622388869624, 3389.57630296213, 3531.964680353189, 3537.823108844573, 28874.0, 29361.11916642504, 29564.556531652044, 30790.38419231603, 30813.53779693284, 3092.0, 3163.225009872596, 3164.17731389838, 3220.5652236947944, 3276.3938671345877, 362013.0, 362566.0, 363033.0, 363404.0, 363500.0, 55455.168172477446, 55473.167902481495, 56380.15429768557, 56746.0, 56811.86376272451, 57969.0, 58101.418985810444, 58109.12836307459, 58185.0, 58203.0, 14961.625959351104, 14986.40054397812, 15227.923860380628, 15446.613834654223, 15483.458078967407, 10811.78376432467, 10993.450327483753, 11043.558257669763, 11781.823272650918, 11965.700857478632, 14622.341994610268, 15071.4724984625, 15080.170590617401, 15131.243437828065, 15224.619384515254, 5305.920411193835, 6170.969145154246, 6213.378662133841, 6246.781362652377, 6324.810255692337, 851.7061613743249, 872.4621659171992, 941.1717688434134, 943.6932996776076, 1036.6682661548232, 27280.727192728216, 27920.58119128215, 28463.0, 28679.856600716863, 29308.706912931026, 980.8970058143792, 1000.9049140331657, 1007.3452256033637, 1028.9022542858565, 1046.2623850185753, 14495.927520362542, 15044.924775376272, 15058.698826023417, 15385.615229639423, 15554.066755994676, 606002.0, 610364.0, 610898.891011093, 611154.0, 613699.0, 55315.72342138264, 55396.89206215853, 55467.72266138643, 55543.61140971508, 55820.16269755957, 1238.6036468330049, 1279.7952327627536, 1340.2762508245632, 1366.8769810717083, 1383.0, 24399.092517264988, 29785.940948196207, 29962.25094372658, 30121.849390752905, 30199.396012080077, 46768.0, 47583.286250705576, 47654.28518572293, 47717.807054822515, 47806.76096619495, 435925.0, 436459.0, 437679.0, 437835.1355539896, 439099.0, 23253.883730581914, 23514.0, 23903.88048059818, 23972.0, 24510.75489245085, 39673.801630991664, 40158.0, 40609.390859137726, 40896.79551602223, 40988.385174223, 28325.71674283231, 32289.51565726563, 33725.83137084299, 34594.44325005331, 34674.47988280127, 33957.830210848784, 34061.82969085139, 34671.0, 35186.296274073866, 35322.470162947066, 32937.39999900341, 33814.830925846196, 34150.14624634304, 34234.0, 34273.65726342705, 25895.0, 26855.597166042917, 28327.29181770472, 29070.418591628473, 30333.0, 23054.654180186975, 23271.76728232696, 23519.41201469977, 23571.17500887461, 23665.763342366357], "value": 18686.407314506992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.54299410766, 368.2653107051432, 370.20590832663936, 377.72614854230676, 403.17751786355836, 14469.276536173189, 14887.478938237164, 16127.75808362874, 20098.79407235563, 20165.294214702488, 18916.905415472902, 19190.0, 19684.11421486033, 19879.40361789145, 20684.27605033824, 5388.245645609618, 5688.829335119953, 5698.287714035746, 5708.286464191976, 5719.19931209631, 4854.053459575384, 5522.6686398816, 5583.581231407661, 5603.0, 5612.69130197839, 5551.250581171531, 5560.165975103747, 5560.388357280696, 5574.024545704506, 5575.609707320489, 5300.761465734032, 5545.085060964936, 5596.3284405871145, 5612.242347283105, 5613.887722245532, 4724.952750472486, 4919.852404427837, 4929.926051109236, 4935.703857768545, 4939.629527785394, 20471.5905681887, 24780.008799647992, 25810.483790324088, 25830.354241143934, 26102.73897261022, 1975.6838905775007, 2284.200529814568, 2314.953700925989, 2333.953320933572, 2400.207931382657, 7756.573388463632, 9795.216382689368, 10071.304798135723, 10225.130863876579, 10299.0, 1560.680060587577, 1814.2833580735535, 1824.2942848436753, 1851.9166637501344, 1882.8305452509203, 95812.52093739486, 97347.51326243395, 106852.0, 110559.0, 112536.0, 11367.033802126747, 11389.373584452935, 11389.544418223344, 11506.712332191762, 11582.420878956018, 14406.351714172888, 14432.855671443362, 14439.061461005002, 14443.0, 14461.710765784625, 7059.152901651834, 8035.437519373705, 8207.671693132208, 8323.334133269324, 8459.534725590152, 8133.901923240287, 8175.100738918714, 8175.7138500152205, 8319.292860106838, 8324.875126872981, 4447.777611119496, 4456.442944631921, 4474.910501789946, 4475.843345482893, 4610.170169369546, 1660.3147804977716, 1873.6440076385716, 1883.5102873253054, 1885.9622807544047, 1893.3278686066524, 831.3889291370838, 847.6355167278007, 864.3016472631309, 864.6584599083327, 924.7549399409162, 18447.53881152982, 20171.39485815428, 21199.364019079145, 21207.15171393127, 21258.681119783214, 793.730131755206, 895.901450840407, 933.1135421349745, 940.3088729783603, 994.2344394815951, 8526.701565445304, 9081.273498120134, 10739.731506712395, 11083.279586826831, 11120.38837863909, 523017.0, 539511.0, 548497.0, 562214.0, 565463.7268136659, 71914.0, 112411.6276511706, 119594.4020279893, 122170.0, 127674.0, 939.5912777941618, 968.9777284964289, 974.8147851908114, 995.8298998676526, 996.0437979539578, 18414.0, 18814.52963675919, 18867.716984245522, 19306.93811840362, 19352.612947741247, 39701.808945731675, 50065.49017647382, 52751.73624131855, 53510.92978140338, 53731.119410822, 66859.66570167118, 73690.63154684192, 74684.0, 75585.0, 75596.24403755892, 6667.566608170453, 7193.964030179815, 7370.189279179393, 7995.440319177602, 8369.372297077865, 9456.763580910532, 12633.93683031579, 12804.48782048745, 13160.670983225496, 13321.600351989457, 8162.959185204036, 11106.50020749052, 11197.160212984221, 11260.549578016788, 11472.31166130035, 8653.567321633767, 10722.624708135178, 10899.0, 11119.27724697892, 11602.593909213138, 10470.947645261725, 11259.774804504028, 11618.593349232737, 11653.76692466163, 11892.345920974083, 7233.891491627735, 7253.782386528202, 7342.559446433231, 7404.481686282124, 7631.885521717068, 10899.237053406503, 11141.832872506757, 11148.55405783792, 11501.079913606723, 11528.481218345027], "value": 9109.499879851042, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.5778824140996, 1498.8276348219954, 1688.5609741467215, 1817.6909925312696, 1878.5867109235962, 7769.689212431503, 8210.178982101786, 8212.0, 8226.712065077723, 8241.58792060396, 7280.089988751406, 7522.736704215354, 7538.472306938516, 7695.192004839495, 8029.598520073988, 2194.9341519754435, 2234.977650223493, 2235.2958817972367, 2239.2498512998163, 2242.921497747579, 2249.1790496468752, 2251.594712951668, 2266.3087758233733, 2321.9883900580558, 2325.500017496238, 2015.9819291257895, 2260.740014898283, 2261.9434514137197, 2286.074139973305, 2288.9084436622516, 2170.4899348653134, 2268.0134141648437, 2269.6822444857735, 2276.7950884420316, 2282.9200977965775, 2221.677856710768, 2255.041607316884, 2257.943551411228, 2265.8527195732227, 2268.7050683411217, 7865.016872890888, 8067.354611631055, 8071.878921816177, 8081.838363232761, 8085.95957020217, 4893.388326459192, 5059.595232381401, 5065.949340506585, 5075.264086707407, 5088.6946783193125, 3212.887548935776, 3367.225538126245, 3416.28258065804, 3422.366862130489, 3422.863085476578, 988.3723835364524, 1024.0425202435747, 1036.5491011409986, 1043.2644985285356, 1068.775557133003, 10224.539895704711, 10374.481275936248, 10375.273730838844, 10388.324758890649, 10476.47617619116, 4252.893677658083, 4507.864764057083, 4556.11155824611, 4562.064776720765, 4563.954360456353, 9192.954035229915, 9205.677801276923, 9213.078692130734, 9214.90785092154, 9244.075592440702, 5072.619553533426, 5077.568406685399, 5077.847664570068, 5082.567981721595, 5111.463296353903, 3889.727719059695, 4456.732596044248, 4577.404937358188, 4667.9766601166775, 4677.579017888406, 3545.592256890439, 3576.46353047045, 3612.7290453215587, 3641.471986561987, 3658.304922064799, 1167.7664467106442, 1197.9700507487207, 1198.2510930668332, 1206.6199147268583, 1212.248405988293, 801.9318357939524, 804.2239239134263, 886.0607755778894, 935.8348855674728, 944.7449188719007, 4467.932981005288, 4911.852644420673, 5277.551408130275, 5485.780568777204, 5530.087535556669, 423.9957600424018, 433.40839753735924, 446.5846762510896, 446.825737962195, 448.2872233149308, 3590.4075827488696, 3711.4247291669835, 3715.535558055243, 3833.923321533554, 3838.4626152338697, 9238.58426370815, 9684.176844968257, 9737.269704772028, 9744.658936937172, 9746.317757757031, 9698.466584337788, 9700.708978730649, 9713.417194968324, 9717.902820971842, 9724.0, 7161.4628902831455, 7499.287567681062, 7616.695332186761, 7622.809429764189, 7625.0, 5482.259894914136, 5663.830085097454, 5668.26312579362, 5692.231548741032, 5716.685582293014, 8783.0, 9003.414778039407, 9092.045335239705, 9155.13026262504, 9179.724608261762, 8351.498910065415, 8591.957040214758, 9153.725388238363, 9226.169644732006, 9379.624815007322, 5622.5501959842295, 7662.885056724042, 7667.808304792425, 7676.846463070819, 7691.1539730628465, 7373.373263272468, 7639.388848891964, 7735.613219338898, 7822.335101516434, 7828.217178282354, 5874.647521148574, 6683.9331606685255, 6823.28355522663, 6870.45036397097, 6950.20072691647, 6573.079768832272, 6719.428848547928, 6784.253732089367, 6811.693473793592, 6812.659367031728, 6404.327545607644, 6422.486201103807, 6509.153810004669, 6512.544121911421, 6517.837054073686, 4635.745034023161, 4660.580547750718, 4777.3072904429355, 4817.1810792164715, 4888.560029597211, 4611.79246933882, 4686.268445260315, 4769.117713223065, 4967.254911763264, 4986.900261994812], "value": 4213.377360219627, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.3667646515713, 341.8905950095969, 354.35507376574634, 364.6171519904103, 366.730453116959, 4071.0917519181585, 4565.086982603476, 4885.8534243972645, 5020.698758074509, 5045.924311135336, 4385.451818522684, 4549.294859296806, 4587.0137920347115, 4996.7751451184695, 5009.69941803492, 3685.5208822853124, 3834.386498160295, 3929.489166408377, 3930.78380689062, 3988.561258261589, 3310.3710295043984, 3354.698077173054, 3548.325818094567, 3616.7468277220605, 3840.6543411093, 3906.0820707133803, 3929.862454814082, 3939.8621048263317, 3949.308870947587, 3953.1815364932168, 3720.437416285167, 3946.0923987482897, 3948.9605103949166, 3961.445397644332, 3965.742226755266, 2958.6745457999605, 3359.9160020999425, 3422.6064002639764, 3453.0, 3481.4603736420895, 4243.745375277463, 4637.837675681335, 4786.458021064387, 4861.611071114302, 4881.511848815126, 3787.2993496203017, 4418.690691651585, 4453.953320969602, 4469.44131983502, 4476.149531588988, 4722.527747225285, 4901.926471102936, 5218.556422704075, 5227.843164705065, 5241.004209200278, 3827.770333779982, 3838.769673819552, 3842.3660096084113, 3846.307664620367, 3858.765195137557, 4526.366308716782, 4860.128850392624, 4883.096627123958, 5477.643953143033, 5512.531434828044, 3184.6656101109515, 3498.8950331490096, 3841.9231615367535, 3881.4760007399204, 3982.920341593152, 3401.1157099154398, 4010.21800748857, 4024.2353952748886, 4048.109415928491, 4065.2479291331197, 3871.922561548753, 4014.698897582693, 4478.283474644041, 4498.482674492409, 4502.594766470967, 4455.866324010285, 4827.948122048116, 5144.2283657450935, 5217.139172036572, 5244.659097158673, 1142.8913953465126, 1284.2679672586723, 1306.9869301307056, 1316.486570237608, 1318.2617734068951, 742.3652776875693, 794.3406972213049, 907.6233363154349, 935.6070450410843, 936.7330310861372, 4096.446979657768, 4660.4154587440435, 4679.4964693888605, 4690.437147542317, 4703.905921881543, 4669.595158493378, 5180.430152683201, 5203.16749320107, 5279.0, 5491.945080549143, 4539.0, 4981.476944920803, 4993.350864387679, 5006.774695138727, 5015.648904576645, 2372.0904671739418, 2422.297533715238, 2567.895804803915, 2611.738826117411, 2668.7731542818688, 4801.511531425269, 5265.394479634814, 5318.0, 5357.7053262070185, 5455.345358556999, 4303.278688524615, 4449.421575195204, 4722.6079745836705, 4874.683145595525, 4923.212286034217, 4414.381986521889, 5198.9740051299505, 5279.709615971082, 5283.550898173698, 5327.600429967691, 5109.565686916654, 5133.435322114489, 5159.380874295109, 5187.325647665779, 5206.869828254324, 5048.91448338609, 5085.8728531787, 5091.465396133352, 5097.572679649704, 5111.616628752784, 4481.775911204361, 4887.0714564232685, 5245.193821305583, 5288.3918349390315, 5321.9467805323, 3375.6118046423994, 3716.9814150929074, 3733.738638295293, 3744.307303148817, 3754.511913451343, 4440.689151759346, 4489.214387482243, 5115.4373018967135, 5202.60980426462, 5230.790768369223, 4341.978290108529, 4583.656225783013, 4877.853704379539, 5062.898742025065, 5135.457948315458, 4502.842400515966, 4713.410823647044, 4812.230043193073, 4972.152151652111, 4996.525330093636, 4432.534583868647, 4566.0, 4868.853934381974, 4917.631177661761, 4946.466595355451, 3972.6226008529143, 4342.9131417370845, 4533.911861153366, 4766.833160839493, 4958.578520825626, 4243.321068629005, 4902.7058376497525, 5106.642535022513, 5108.616853736059, 5170.767315470737], "value": 3804.1919779234468, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.8767840271146, 737.6311844077961, 739.8520295940813, 750.8535835512074, 805.2028491793127, 14613.488527901525, 15299.92350038251, 15354.385824567004, 15434.305456254468, 15451.381944722212, 15182.013169143998, 15844.683106337867, 15921.920390398032, 16253.106079165642, 16285.51143465695, 674.706502671337, 695.30816837247, 868.5917618719192, 894.7852515396323, 896.9013408525057, 718.3319512853045, 722.1081963774734, 723.3200791256229, 853.5262929074361, 877.627008521379, 918.1874041473277, 929.3076657889882, 929.330881765128, 930.7393929699695, 933.3932943586689, 883.5140672630092, 922.686286662538, 924.9491277979674, 925.0194793518858, 926.1201858234637, 540.7323374929396, 550.8294873394037, 661.1801366305795, 670.2627110178813, 700.2402393403164, 14839.10965342083, 15122.470713525085, 15412.768808467881, 15418.53744387659, 15420.306086226146, 13898.749112579917, 13921.512747053906, 13945.302734863217, 13969.650758731012, 14084.225367604779, 12855.228686278853, 12996.935015324863, 13066.934665326708, 13134.080614356999, 13594.592162235149, 4219.135077309144, 4275.636570891478, 4315.07225946423, 4342.544032876534, 4462.531434199427, 121354.0, 122024.0, 122575.0, 124341.0, 126123.47753044887, 10999.395033273087, 11094.500747466383, 11099.167562432849, 11100.777984440267, 11519.19365644397, 21077.78922210789, 21711.0, 22770.886145569166, 22775.430614234778, 22933.541329173324, 7772.84454310922, 8010.919890801134, 8041.718539851077, 8096.190380961974, 8312.20034076942, 4265.509466411402, 4338.891527711769, 4365.158660378846, 4377.0, 4547.704399214107, 3616.1321282891918, 3682.576503702055, 3704.8518059277326, 3711.7030637548933, 3741.5136032315627, 575.8905807896487, 576.224977405389, 586.8151532267323, 588.793922127252, 592.3454582686156, 616.7933742196325, 655.9472047364007, 659.9076129341896, 671.9025741267488, 680.2381332907175, 8499.852519909857, 8705.651773928972, 9324.393914395543, 9364.25085993119, 9412.388194767318, 621.3351713666334, 638.4987784589075, 653.8561516466369, 663.5288944849115, 667.9799606011827, 4336.869893903188, 4544.386507821402, 4558.361829343895, 4623.398958135421, 4724.480307166209, 85401.0, 89475.0, 105341.0, 111544.0, 117852.00862550826, 83266.16733832705, 100314.4984275074, 101309.0, 102743.4862825681, 103571.96428035774, 88990.09643601772, 90295.0, 90513.54743226242, 90984.0, 91069.08930910738, 8478.957605211934, 8789.208971192624, 8869.379143460154, 8897.28821694276, 9281.0, 36395.0, 52160.73919630377, 54872.176917345474, 56301.15548266861, 57488.1376779357, 74327.62836185785, 79920.60039699764, 82065.0, 82399.0, 82508.0, 11679.124065694938, 11734.589289374831, 11961.521539138337, 12022.458989345325, 12441.93779031099, 10513.737156570842, 12590.433430495832, 12618.305993170463, 12792.74414511686, 12815.231086134489, 11826.0, 12038.578649747216, 12071.336076515876, 12321.93839030799, 12610.180338277982, 12020.75958480843, 12227.755444890874, 12248.081393895316, 12448.377581120727, 12731.363431828186, 11873.287602743863, 11962.461689223832, 12361.690957725768, 12384.380780961095, 12532.310722909962, 9075.818483630423, 10053.69838904834, 10111.3427627204, 10442.477876106012, 10466.267361284637, 10156.74608134773, 10389.116925061455, 10396.688099357032, 10404.427756473164, 10420.583176673152], "value": 7469.316180947151, "unit": "score"}], "name": "dromaeo_css", "value": 6951.945232684488, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 106.0, 112.0, 134.0, 131.0, 138.0, 129.0, 110.0, 134.0, 111.0], "value": 125.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 184.0, 185.0, 186.0, 187.0, 181.0, 181.0, 184.0, 186.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 59.0, 86.0, 65.0, 61.0, 59.0, 59.0, 74.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 72.0, 86.0, 70.0, 69.0, 68.0, 83.0, 69.0, 70.0, 84.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 88.0, 84.0, 88.0, 86.0, 87.0, 83.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 113.0, 163.0, 97.0, 97.0, 99.0, 101.0, 98.0, 97.0], "value": 105.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 87.0, 88.0, 85.0, 86.0, 85.0, 88.0, 88.0, 81.0], "value": 86.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 56.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 73.0, 80.0, 74.0, 70.0, 72.0, 71.0, 71.0, 73.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 86.0, 90.0, 89.0, 87.0, 87.0, 90.0, 87.0, 92.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 151.0, 154.0, 151.0, 149.0, 138.0, 138.0, 138.0, 184.0, 151.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 175.0, 171.0, 174.0, 173.0, 173.0, 172.0, 174.0, 173.0, 179.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 67.0, 67.0, 68.0, 67.0, 66.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1450.0, "alertThreshold": 2.0}]} 07:56:54 INFO - Return code: 0 07:56:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:54 INFO - # TBPL SUCCESS # 07:56:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:56:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:56:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:56:54 INFO - 2016-12-22 07:56:54.310 screenresolution[1665:11596] starting screenresolution argv=screenresolution get 07:56:54 INFO - 2016-12-22 07:56:54.313 screenresolution[1665:11596] Display 0: 1600x1200x32@60 07:56:54 INFO - 2016-12-22 07:56:54.319 screenresolution[1666:11599] starting screenresolution argv=screenresolution list 07:56:54 INFO - Available Modes on Display 0 07:56:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:56:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:56:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:56:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:56:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:56:54 INFO - Intel Iris: 07:56:54 INFO - Chipset Model: Intel Iris 07:56:54 INFO - Type: GPU 07:56:54 INFO - Bus: Built-In 07:56:54 INFO - VRAM (Dynamic, Max): 1536 MB 07:56:54 INFO - Vendor: Intel (0x8086) 07:56:54 INFO - Device ID: 0x0a2e 07:56:54 INFO - Revision ID: 0x0009 07:56:54 INFO - Displays: 07:56:54 INFO - Display: 07:56:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:56:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:56:54 INFO - Display Serial Number: 1600x1200 60 07:56:54 INFO - Main Display: Yes 07:56:54 INFO - Mirror: Off 07:56:54 INFO - Online: Yes 07:56:54 INFO - Rotation: Supported 07:56:54 INFO - Return code: 0 07:56:54 INFO - Running post-action listener: _resource_record_post_action 07:56:54 INFO - [mozharness: 2016-12-22 15:56:54.554598Z] Finished run-tests step (success) 07:56:54 INFO - Running post-run listener: _resource_record_post_run 07:56:54 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 32316416; Write bytes: 552019968; Read time: 192; Write time: 1706 07:56:54 INFO - TinderboxPrint: CPU usage
53.7% 07:56:54 INFO - TinderboxPrint: I/O read bytes / time
32,316,416 / 192 07:56:54 INFO - TinderboxPrint: I/O write bytes / time
552,019,968 / 1,706 07:56:54 INFO - TinderboxPrint: CPU idle
2,225.2 (46.3%) 07:56:54 INFO - TinderboxPrint: CPU system
959.8 (20.0%) 07:56:54 INFO - TinderboxPrint: CPU user
1,624.7 (33.8%) 07:56:54 INFO - TinderboxPrint: Swap in / out
277,778,432 / 0 07:56:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 241498624; Write bytes: 235165184; Read time: 18209; Write time: 553 07:56:54 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30354432; Write bytes: 299250176; Read time: 176; Write time: 1113 07:56:55 INFO - Running post-run listener: _upload_blobber_files 07:56:55 INFO - Blob upload gear active. 07:56:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:56 INFO - (blobuploader) - INFO - Done attempting. 07:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:56:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:57 INFO - (blobuploader) - INFO - Done attempting. 07:56:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:56:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:56:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:58 INFO - (blobuploader) - INFO - Done attempting. 07:56:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:00 INFO - (blobuploader) - INFO - Done attempting. 07:57:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:00 INFO - Return code: 0 07:57:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c94d575f3a596af7f9160e2c742ad83923b2e72722a5e1efa4132053ac3ac4183219bd3eae5943686487f1d632e062347a2e932fea52dd073da005fa4460caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a09ca7b72bfc6a4f14787306d135c16ad214ed3754f35419b5db76914ee2aa42014423afc91b5f3a2626f0d3201ca61b4572eba2594e178c264b45484712689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58fa8dc9dc539bfa4ee73011e69323fa092a0d242b0b45761c0c3261e7d0f93ed00aa62efb3991d26c37129b6154af095c878988dcd527fb19f3192000b2f90e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5a6bdbf6c599d8515a6188fd70293e0e38dbe76f16b7cb89dfa800cb82a70998bf6d1beb147c7d0a11b65eccefa65a1ffd8056bb42f7bf01c8fcdf7acafbb4"} 07:57:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:00 INFO - Contents: 07:57:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c94d575f3a596af7f9160e2c742ad83923b2e72722a5e1efa4132053ac3ac4183219bd3eae5943686487f1d632e062347a2e932fea52dd073da005fa4460caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a09ca7b72bfc6a4f14787306d135c16ad214ed3754f35419b5db76914ee2aa42014423afc91b5f3a2626f0d3201ca61b4572eba2594e178c264b45484712689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58fa8dc9dc539bfa4ee73011e69323fa092a0d242b0b45761c0c3261e7d0f93ed00aa62efb3991d26c37129b6154af095c878988dcd527fb19f3192000b2f90e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5a6bdbf6c599d8515a6188fd70293e0e38dbe76f16b7cb89dfa800cb82a70998bf6d1beb147c7d0a11b65eccefa65a1ffd8056bb42f7bf01c8fcdf7acafbb4"} 07:57:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:00 INFO - Copying logs to upload dir... 07:57:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.289221 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-12-22 07:57:00.865492) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 07:57:00.868434) ========= 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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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/9c94d575f3a596af7f9160e2c742ad83923b2e72722a5e1efa4132053ac3ac4183219bd3eae5943686487f1d632e062347a2e932fea52dd073da005fa4460caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a09ca7b72bfc6a4f14787306d135c16ad214ed3754f35419b5db76914ee2aa42014423afc91b5f3a2626f0d3201ca61b4572eba2594e178c264b45484712689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58fa8dc9dc539bfa4ee73011e69323fa092a0d242b0b45761c0c3261e7d0f93ed00aa62efb3991d26c37129b6154af095c878988dcd527fb19f3192000b2f90e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5a6bdbf6c599d8515a6188fd70293e0e38dbe76f16b7cb89dfa800cb82a70998bf6d1beb147c7d0a11b65eccefa65a1ffd8056bb42f7bf01c8fcdf7acafbb4"} build_url:https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/d5JARtBDTLq5vu_zm2DMIg/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/9c94d575f3a596af7f9160e2c742ad83923b2e72722a5e1efa4132053ac3ac4183219bd3eae5943686487f1d632e062347a2e932fea52dd073da005fa4460caa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a09ca7b72bfc6a4f14787306d135c16ad214ed3754f35419b5db76914ee2aa42014423afc91b5f3a2626f0d3201ca61b4572eba2594e178c264b45484712689", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58fa8dc9dc539bfa4ee73011e69323fa092a0d242b0b45761c0c3261e7d0f93ed00aa62efb3991d26c37129b6154af095c878988dcd527fb19f3192000b2f90e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e5a6bdbf6c599d8515a6188fd70293e0e38dbe76f16b7cb89dfa800cb82a70998bf6d1beb147c7d0a11b65eccefa65a1ffd8056bb42f7bf01c8fcdf7acafbb4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 07:57:00.914306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:57:00.914642) ========= 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.iQNZ9Jk8zq/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.Nwj6OYYzNi/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.005152 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 07:57:00.962531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 07:57:00.962811) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 07:57:00.966101) ========= ========= Total master_lag: 0.31 =========