builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1484303198.43 results: success (0) buildid: 20170113012117 builduid: 3560bf5ac46c4f04a722ac1dc245ffe4 revision: 91f5293e9a89056565493ed5073c3842b0ee9fdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.434781) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.435247) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.435598) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.463320) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.463711) ========= 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.gIqeMUHUcw/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.icz1TK8hbT/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-13 02:26:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-01-13 02:26:38 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.619257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.619607) ========= 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.gIqeMUHUcw/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.icz1TK8hbT/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020088 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:38.668669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 02:26:38.669925) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 91f5293e9a89056565493ed5073c3842b0ee9fdc --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 91f5293e9a89056565493ed5073c3842b0ee9fdc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gIqeMUHUcw/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.icz1TK8hbT/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-13 02:26:38,812 truncating revision to first 12 chars 2017-01-13 02:26:38,812 Setting DEBUG logging. 2017-01-13 02:26:38,812 attempt 1/10 2017-01-13 02:26:38,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/91f5293e9a89?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-13 02:26:39,458 unpacking tar archive at: mozilla-central-91f5293e9a89/testing/mozharness/ program finished with exit code 0 elapsedTime=0.890994 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-13 02:26:39.733129) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:39.733445) ========= script_repo_revision: 91f5293e9a89056565493ed5073c3842b0ee9fdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:39.733850) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:39.734123) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-13 02:26:39.755520) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-13 02:26:39.755856) ========= /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.gIqeMUHUcw/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.icz1TK8hbT/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:26:40 INFO - MultiFileLogger online at 20170113 02:26:40 in /builds/slave/test 02:26:40 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 02:26:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:26:40 INFO - {'append_to_log': False, 02:26:40 INFO - 'base_work_dir': '/builds/slave/test', 02:26:40 INFO - 'blob_upload_branch': 'Firefox', 02:26:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:26:40 INFO - 'branch': 'Firefox', 02:26:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:26:40 INFO - 'config_files': ('talos/mac_config.py',), 02:26:40 INFO - 'default_actions': ('clobber', 02:26:40 INFO - 'read-buildbot-config', 02:26:40 INFO - 'download-and-extract', 02:26:40 INFO - 'populate-webroot', 02:26:40 INFO - 'create-virtualenv', 02:26:40 INFO - 'install', 02:26:40 INFO - 'run-tests'), 02:26:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:26:40 INFO - 'download_minidump_stackwalk': True, 02:26:40 INFO - 'download_symbols': 'ondemand', 02:26:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:26:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:26:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:26:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:26:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:26:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:26:40 INFO - 'installer_path': 'installer.exe', 02:26:40 INFO - 'log_level': 'info', 02:26:40 INFO - 'log_name': 'talos', 02:26:40 INFO - 'log_to_console': True, 02:26:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:26:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:26:40 INFO - 'opt_config_files': (), 02:26:40 INFO - 'pip_index': False, 02:26:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:26:40 INFO - 'cmd': ('bash', 02:26:40 INFO - '-c', 02:26:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:26:40 INFO - 'enabled': True, 02:26:40 INFO - 'halt_on_failure': False, 02:26:40 INFO - 'name': 'check_screen_resolution'},), 02:26:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:26:40 INFO - 'cmd': ('bash', 02:26:40 INFO - '-c', 02:26:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:26:40 INFO - 'enabled': True, 02:26:40 INFO - 'halt_on_failure': False, 02:26:40 INFO - 'name': 'check_screen_resolution'},), 02:26:40 INFO - 'run_cmd_checks_enabled': True, 02:26:40 INFO - 'sps_profile': False, 02:26:40 INFO - 'sps_profile_interval': 0, 02:26:40 INFO - 'suite': 'dromaeojs', 02:26:40 INFO - 'system_bits': '32', 02:26:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:26:40 INFO - 'title': 't-yosemite-r7-0114', 02:26:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:26:40 INFO - 'use_talos_json': True, 02:26:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:26:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:26:40 INFO - 'work_dir': 'build'} 02:26:40 INFO - [mozharness: 2017-01-13 10:26:40.055188Z] Running clobber step. 02:26:40 INFO - Running pre-action listener: _resource_record_pre_action 02:26:40 INFO - Running main action method: clobber 02:26:40 INFO - rmtree: /builds/slave/test/build 02:26:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:26:40 INFO - Running post-action listener: _resource_record_post_action 02:26:40 INFO - [mozharness: 2017-01-13 10:26:40.213746Z] Finished clobber step (success) 02:26:40 INFO - [mozharness: 2017-01-13 10:26:40.213911Z] Running read-buildbot-config step. 02:26:40 INFO - Running pre-action listener: _resource_record_pre_action 02:26:40 INFO - Running main action method: read_buildbot_config 02:26:40 INFO - Using buildbot properties: 02:26:40 INFO - { 02:26:40 INFO - "project": "", 02:26:40 INFO - "product": "firefox", 02:26:40 INFO - "script_repo_revision": "production", 02:26:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 02:26:40 INFO - "repository": "", 02:26:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 02:26:40 INFO - "buildid": "20170113012117", 02:26:40 INFO - "pgo_build": "False", 02:26:40 INFO - "basedir": "/builds/slave/test", 02:26:40 INFO - "buildnumber": 9, 02:26:40 INFO - "slavename": "t-yosemite-r7-0114", 02:26:40 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:26:40 INFO - "platform": "yosemite_r7", 02:26:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:26:40 INFO - "branch": "mozilla-central", 02:26:40 INFO - "repo_path": "mozilla-central", 02:26:40 INFO - "revision": "91f5293e9a89056565493ed5073c3842b0ee9fdc", 02:26:40 INFO - "stage_platform": "macosx64", 02:26:40 INFO - "builduid": "3560bf5ac46c4f04a722ac1dc245ffe4", 02:26:40 INFO - "slavebuilddir": "test" 02:26:40 INFO - } 02:26:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 02:26:40 INFO - Running post-action listener: _resource_record_post_action 02:26:40 INFO - [mozharness: 2017-01-13 10:26:40.217080Z] Finished read-buildbot-config step (success) 02:26:40 INFO - [mozharness: 2017-01-13 10:26:40.217214Z] Running download-and-extract step. 02:26:40 INFO - Running pre-action listener: _resource_record_pre_action 02:26:40 INFO - Running main action method: download_and_extract 02:26:40 INFO - mkdir: /builds/slave/test/build/tests 02:26: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')]} 02:26:40 INFO - trying https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 02:26:40 INFO - Downloading https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/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 02:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/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 02:26:41 INFO - Downloaded 1199 bytes. 02:26:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 02:26:41 INFO - Using the following test package requirements: 02:26:41 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:26:41 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 02:26:41 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 02:26:41 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'jsshell-mac.zip'], 02:26:41 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 02:26:41 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 02:26:41 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 02:26:41 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 02:26:41 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 02:26:41 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 02:26:41 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 02:26:41 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:26:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:26:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:26:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:26:42 INFO - Expected file size: 16316887 02:26:42 INFO - Obtained file size: 16316887 02:26:48 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 02:26:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 02:26:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:26:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 02:26:49 INFO - Expected file size: 16316887 02:26:49 INFO - Obtained file size: 16316887 02:26:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 02:26:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:26:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 02:26:57 INFO - Expected file size: 14403555 02:26:57 INFO - Obtained file size: 14403555 02:26:57 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')]} 02:26:57 INFO - trying https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:26:57 INFO - Downloading https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 02:26:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/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 02:26:59 INFO - Downloaded 70064047 bytes. 02:26:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:26:59 INFO - mkdir: /builds/slave/test/properties 02:26:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:59 INFO - Contents: 02:26:59 INFO - build_url:https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 02:27:00 INFO - Running post-action listener: _resource_record_post_action 02:27:00 INFO - Running post-action listener: set_extra_try_arguments 02:27:00 INFO - [mozharness: 2017-01-13 10:27:00.299910Z] Finished download-and-extract step (success) 02:27:00 INFO - [mozharness: 2017-01-13 10:27:00.300057Z] Running populate-webroot step. 02:27:00 INFO - Running pre-action listener: _resource_record_pre_action 02:27:00 INFO - Running main action method: populate_webroot 02:27:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:27:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:27:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:27:00 INFO - '--tppagecycles', 02:27:00 INFO - '7'], 02:27:00 INFO - 'tests': ['tsvgm']}}, 02:27:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:27:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:27:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:27:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:27:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:27:00 INFO - 'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:27:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:27:00 INFO - 'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['damp', 'tps']}, 02:27:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:27:00 INFO - 'tests': ['damp', 'tps']}, 02:27:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['dromaeo_dom']}, 02:27:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:27:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['basic_compositor_video']}, 02:27:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:27:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['a11yr', 02:27:00 INFO - 'ts_paint', 02:27:00 INFO - 'tpaint', 02:27:00 INFO - 'sessionrestore', 02:27:00 INFO - 'sessionrestore_no_auto_restore', 02:27:00 INFO - 'tabpaint']}, 02:27:00 INFO - 'other-e10s': {'tests': ['a11yr', 02:27:00 INFO - 'ts_paint', 02:27:00 INFO - 'tpaint', 02:27:00 INFO - 'sessionrestore', 02:27:00 INFO - 'sessionrestore_no_auto_restore', 02:27:00 INFO - 'tabpaint']}, 02:27:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:27:00 INFO - 'ts_paint', 02:27:00 INFO - 'tpaint', 02:27:00 INFO - 'sessionrestore', 02:27:00 INFO - 'sessionrestore_no_auto_restore', 02:27:00 INFO - 'tabpaint']}, 02:27:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:27:00 INFO - 'ts_paint', 02:27:00 INFO - 'tpaint', 02:27:00 INFO - 'sessionrestore', 02:27:00 INFO - 'sessionrestore_no_auto_restore', 02:27:00 INFO - 'tabpaint']}, 02:27:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['a11yr', 02:27:00 INFO - 'ts_paint', 02:27:00 INFO - 'tpaint', 02:27:00 INFO - 'sessionrestore', 02:27:00 INFO - 'sessionrestore_no_auto_restore', 02:27:00 INFO - 'tabpaint']}, 02:27:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['a11yr', 02:27:00 INFO - 'ts_paint', 02:27:00 INFO - 'tpaint', 02:27:00 INFO - 'sessionrestore', 02:27:00 INFO - 'sessionrestore_no_auto_restore', 02:27:00 INFO - 'tabpaint']}, 02:27:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['tsvgx', 02:27:00 INFO - 'tsvgr_opacity', 02:27:00 INFO - 'tart', 02:27:00 INFO - 'tscrollx', 02:27:00 INFO - 'cart', 02:27:00 INFO - 'tsvg_static']}, 02:27:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:27:00 INFO - 'tsvgr_opacity', 02:27:00 INFO - 'tart', 02:27:00 INFO - 'tscrollx', 02:27:00 INFO - 'cart', 02:27:00 INFO - 'tsvg_static']}, 02:27:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:27:00 INFO - 'talos_options': ['--disable-e10s'], 02:27:00 INFO - 'tests': ['tp5o']}, 02:27:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:27:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:27:00 INFO - 'talos_options': ['--disable-e10s', 02:27:00 INFO - '--xperf_path', 02:27:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:00 INFO - 'tests': ['tp5n']}, 02:27:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:27:00 INFO - 'talos_options': ['--xperf_path', 02:27:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:00 INFO - 'tests': ['tp5n']}}, 02:27:00 INFO - 'talos.zip': {'path': '', 02:27:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:27:00 INFO - Running post-action listener: _resource_record_post_action 02:27:00 INFO - [mozharness: 2017-01-13 10:27:00.318408Z] Finished populate-webroot step (success) 02:27:00 INFO - [mozharness: 2017-01-13 10:27:00.318550Z] Running create-virtualenv step. 02:27:00 INFO - Running pre-action listener: _resource_record_pre_action 02:27:00 INFO - Running main action method: create_virtualenv 02:27:00 INFO - Creating virtualenv /builds/slave/test/build/venv 02:27:00 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 02:27:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:27:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:27:00 INFO - Using real prefix '/tools/python27' 02:27:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:27:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:27:04 INFO - Installing pip.................done. 02:27:04 INFO - Return code: 0 02:27:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:27:04 INFO - Reading from file tmpfile_stdout 02:27:04 INFO - Output received: 02:27:04 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) 02:27:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:27:04 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')]} 02:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 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')]} 02:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:04 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 02:27:04 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 02:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:04 INFO - 'HOME': '/Users/cltbld', 02:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:04 INFO - 'LOGNAME': 'cltbld', 02:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:04 INFO - 'MOZ_NO_REMOTE': '1', 02:27:04 INFO - 'NO_EM_RESTART': '1', 02:27:04 INFO - 'PAGER': '/bin/cat', 02:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:04 INFO - 'PWD': '/builds/slave/test', 02:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:04 INFO - 'SHELL': '/bin/bash', 02:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:04 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:04 INFO - 'USER': 'cltbld', 02:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:04 INFO - 'XPC_FLAGS': '0x0', 02:27:04 INFO - 'XPC_SERVICE_NAME': '0', 02:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:04 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 02:27:04 INFO - Cleaning up... 02:27:04 INFO - Return code: 0 02:27:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:27:04 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')]} 02:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 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')]} 02:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:04 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 02:27:04 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 02:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:04 INFO - 'HOME': '/Users/cltbld', 02:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:04 INFO - 'LOGNAME': 'cltbld', 02:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:04 INFO - 'MOZ_NO_REMOTE': '1', 02:27:04 INFO - 'NO_EM_RESTART': '1', 02:27:04 INFO - 'PAGER': '/bin/cat', 02:27:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:04 INFO - 'PWD': '/builds/slave/test', 02:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:04 INFO - 'SHELL': '/bin/bash', 02:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:04 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:04 INFO - 'USER': 'cltbld', 02:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:04 INFO - 'XPC_FLAGS': '0x0', 02:27:04 INFO - 'XPC_SERVICE_NAME': '0', 02:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:05 INFO - Downloading/unpacking psutil>=3.1.1 02:27:05 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 02:27:05 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 02:27:05 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 02:27:05 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 02:27:05 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 02:27:05 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 02:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:09 INFO - Installing collected packages: psutil 02:27:09 INFO - Running setup.py install for psutil 02:27:09 INFO - building 'psutil._psutil_osx' extension 02:27:09 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 02:27:09 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 02:27:09 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 02:27:09 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 02:27:09 INFO - building 'psutil._psutil_posix' extension 02:27:09 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 02:27:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:27:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:27:09 INFO - ^ 02:27:09 INFO - 1 warning generated. 02:27:09 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 02:27:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:09 INFO - Successfully installed psutil 02:27:09 INFO - Cleaning up... 02:27:10 INFO - Return code: 0 02:27:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:27:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:27:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:10 INFO - 'HOME': '/Users/cltbld', 02:27:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:10 INFO - 'LOGNAME': 'cltbld', 02:27:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:10 INFO - 'MOZ_NO_REMOTE': '1', 02:27:10 INFO - 'NO_EM_RESTART': '1', 02:27:10 INFO - 'PAGER': '/bin/cat', 02:27:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:10 INFO - 'PWD': '/builds/slave/test', 02:27:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:10 INFO - 'SHELL': '/bin/bash', 02:27:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:10 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:10 INFO - 'USER': 'cltbld', 02:27:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:10 INFO - 'XPC_FLAGS': '0x0', 02:27:10 INFO - 'XPC_SERVICE_NAME': '0', 02:27:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:27:10 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 02:27:10 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 02:27:10 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 02:27:10 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 02:27:10 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 02:27:10 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 02:27:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:27:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:27:13 INFO - Installing collected packages: mozsystemmonitor 02:27:13 INFO - Running setup.py install for mozsystemmonitor 02:27:13 INFO - Successfully installed mozsystemmonitor 02:27:13 INFO - Cleaning up... 02:27:13 INFO - Return code: 0 02:27:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:27:13 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')]} 02:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:13 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')]} 02:27:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:13 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:13 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 02:27:13 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 02:27:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:13 INFO - 'HOME': '/Users/cltbld', 02:27:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:13 INFO - 'LOGNAME': 'cltbld', 02:27:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:13 INFO - 'MOZ_NO_REMOTE': '1', 02:27:13 INFO - 'NO_EM_RESTART': '1', 02:27:13 INFO - 'PAGER': '/bin/cat', 02:27:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:13 INFO - 'PWD': '/builds/slave/test', 02:27:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:13 INFO - 'SHELL': '/bin/bash', 02:27:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:13 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:13 INFO - 'USER': 'cltbld', 02:27:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:13 INFO - 'XPC_FLAGS': '0x0', 02:27:13 INFO - 'XPC_SERVICE_NAME': '0', 02:27:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:13 INFO - Downloading/unpacking jsonschema==2.5.1 02:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:16 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:17 INFO - warning: no files found matching '*.txt' 02:27:17 INFO - no previously-included directories found matching 'build' 02:27:17 INFO - no previously-included directories found matching 'dist' 02:27:17 INFO - no previously-included directories found matching '.git*' 02:27:17 INFO - Installing collected packages: jsonschema, functools32 02:27:17 INFO - Running setup.py install for functools32 02:27:17 INFO - warning: no files found matching '*.txt' 02:27:17 INFO - no previously-included directories found matching 'build' 02:27:17 INFO - no previously-included directories found matching 'dist' 02:27:17 INFO - no previously-included directories found matching '.git*' 02:27:17 INFO - Successfully installed jsonschema functools32 02:27:17 INFO - Cleaning up... 02:27:17 INFO - Return code: 0 02:27:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:27:17 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')]} 02:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:17 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')]} 02:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:17 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:17 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 02:27:17 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 02:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:17 INFO - 'HOME': '/Users/cltbld', 02:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:17 INFO - 'LOGNAME': 'cltbld', 02:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:17 INFO - 'MOZ_NO_REMOTE': '1', 02:27:17 INFO - 'NO_EM_RESTART': '1', 02:27:17 INFO - 'PAGER': '/bin/cat', 02:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:17 INFO - 'PWD': '/builds/slave/test', 02:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:17 INFO - 'SHELL': '/bin/bash', 02:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:17 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:17 INFO - 'USER': 'cltbld', 02:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:17 INFO - 'XPC_FLAGS': '0x0', 02:27:17 INFO - 'XPC_SERVICE_NAME': '0', 02:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:27:17 INFO - Cleaning up... 02:27:17 INFO - Return code: 0 02:27:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:27:17 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')]} 02:27:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:17 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')]} 02:27:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:17 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:17 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 02:27:17 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 02:27:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:17 INFO - 'HOME': '/Users/cltbld', 02:27:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:17 INFO - 'LOGNAME': 'cltbld', 02:27:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:17 INFO - 'MOZ_NO_REMOTE': '1', 02:27:17 INFO - 'NO_EM_RESTART': '1', 02:27:17 INFO - 'PAGER': '/bin/cat', 02:27:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:17 INFO - 'PWD': '/builds/slave/test', 02:27:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:17 INFO - 'SHELL': '/bin/bash', 02:27:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:17 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:17 INFO - 'USER': 'cltbld', 02:27:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:17 INFO - 'XPC_FLAGS': '0x0', 02:27:17 INFO - 'XPC_SERVICE_NAME': '0', 02:27:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:17 INFO - Downloading/unpacking blobuploader==1.2.4 02:27:17 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 02:27:17 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 02:27:17 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 02:27:17 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 02:27:17 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 02:27:17 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 02:27:20 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:20 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 02:27:20 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 02:27:20 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 02:27:20 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 02:27:20 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 02:27:20 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 02:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:21 INFO - Downloading docopt-0.6.1.tar.gz 02:27:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:22 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:22 INFO - Running setup.py install for blobuploader 02:27:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:22 INFO - Running setup.py install for requests 02:27:22 INFO - Running setup.py install for docopt 02:27:22 INFO - Successfully installed blobuploader requests docopt 02:27:22 INFO - Cleaning up... 02:27:22 INFO - Return code: 0 02:27:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27: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')]} 02:27:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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')]} 02:27:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:22 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:22 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 02:27:22 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 02:27:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:22 INFO - 'HOME': '/Users/cltbld', 02:27:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:22 INFO - 'LOGNAME': 'cltbld', 02:27:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:22 INFO - 'MOZ_NO_REMOTE': '1', 02:27:22 INFO - 'NO_EM_RESTART': '1', 02:27:22 INFO - 'PAGER': '/bin/cat', 02:27:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:22 INFO - 'PWD': '/builds/slave/test', 02:27:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:22 INFO - 'SHELL': '/bin/bash', 02:27:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:22 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:22 INFO - 'USER': 'cltbld', 02:27:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:22 INFO - 'XPC_FLAGS': '0x0', 02:27:22 INFO - 'XPC_SERVICE_NAME': '0', 02:27:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-aZJ44Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lHfh3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-NEZ3Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-iljg2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-o9wdyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-vuoUel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-opkxyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:23 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-h5p10h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-T5U5ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-VDDveB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-6EKD8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-08_HWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-1W853Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-d7B8Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ZuW5AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-jcg1Yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:24 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-tKnu_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:24 INFO - Running setup.py install for manifestparser 02:27:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:25 INFO - Running setup.py install for mozcrash 02:27:25 INFO - Running setup.py install for mozdebug 02:27:25 INFO - Running setup.py install for mozdevice 02:27:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:27:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:25 INFO - Running setup.py install for mozfile 02:27:25 INFO - Running setup.py install for mozhttpd 02:27:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:25 INFO - Running setup.py install for mozinfo 02:27:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:25 INFO - Running setup.py install for mozInstall 02:27:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Running setup.py install for mozleak 02:27:26 INFO - Running setup.py install for mozlog 02:27:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Running setup.py install for moznetwork 02:27:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Running setup.py install for mozprocess 02:27:26 INFO - Running setup.py install for mozprofile 02:27:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:27:26 INFO - Running setup.py install for mozrunner 02:27:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:27:27 INFO - Running setup.py install for mozscreenshot 02:27:27 INFO - Running setup.py install for moztest 02:27:27 INFO - Running setup.py install for mozversion 02:27:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:27:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:27:27 INFO - Cleaning up... 02:27:27 INFO - Return code: 0 02:27:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:27 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:27 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 02:27:27 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 02:27:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:27 INFO - 'HOME': '/Users/cltbld', 02:27:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:27 INFO - 'LOGNAME': 'cltbld', 02:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:27 INFO - 'MOZ_NO_REMOTE': '1', 02:27:27 INFO - 'NO_EM_RESTART': '1', 02:27:27 INFO - 'PAGER': '/bin/cat', 02:27:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:27 INFO - 'PWD': '/builds/slave/test', 02:27:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:27 INFO - 'SHELL': '/bin/bash', 02:27:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:27 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:27 INFO - 'USER': 'cltbld', 02:27:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:27 INFO - 'XPC_FLAGS': '0x0', 02:27:27 INFO - 'XPC_SERVICE_NAME': '0', 02:27:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:27 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ItyVUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:27 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)) 02:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:27 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-1QOvtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:27 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)) 02:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:27 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-wWy8KE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-tSkNzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-1aD6Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-PISULp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-dDQSgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-TUOSxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-IOeBFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ruZo3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-9kQaf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:28 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)) 02:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:28 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-HILSoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-TLKugo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:29 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)) 02:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-v6biWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:29 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)) 02:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kqMvoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:29 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)) 02:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-YO4Xcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:29 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lv_Q0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:29 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)) 02:27:29 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)) 02:27:29 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)) 02:27:29 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)) 02:27:29 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)) 02:27:29 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)) 02:27:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:32 INFO - Downloading blessings-1.6.tar.gz 02:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:27:32 INFO - Installing collected packages: blessings 02:27:32 INFO - Running setup.py install for blessings 02:27:32 INFO - Successfully installed blessings 02:27:32 INFO - Cleaning up... 02:27:32 INFO - Return code: 0 02:27:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:27:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:33 INFO - Reading from file tmpfile_stdout 02:27:33 INFO - Current package versions: 02:27:33 INFO - blessings == 1.6 02:27:33 INFO - blobuploader == 1.2.4 02:27:33 INFO - docopt == 0.6.1 02:27:33 INFO - functools32 == 3.2.3-2 02:27:33 INFO - jsonschema == 2.5.1 02:27:33 INFO - manifestparser == 1.1 02:27:33 INFO - mozInstall == 1.12 02:27:33 INFO - mozcrash == 1.0 02:27:33 INFO - mozdebug == 0.1 02:27:33 INFO - mozdevice == 0.49 02:27:33 INFO - mozfile == 1.2 02:27:33 INFO - mozhttpd == 0.7 02:27:33 INFO - mozinfo == 0.9 02:27:33 INFO - mozleak == 0.1 02:27:33 INFO - mozlog == 3.4 02:27:33 INFO - moznetwork == 0.27 02:27:33 INFO - mozprocess == 0.24 02:27:33 INFO - mozprofile == 0.28 02:27:33 INFO - mozrunner == 6.13 02:27:33 INFO - mozscreenshot == 0.1 02:27:33 INFO - mozsystemmonitor == 0.3 02:27:33 INFO - moztest == 0.8 02:27:33 INFO - mozversion == 1.4 02:27:33 INFO - psutil == 3.1.1 02:27:33 INFO - requests == 1.2.3 02:27:33 INFO - wsgiref == 0.1.2 02:27:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:33 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:33 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 02:27:33 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 02:27:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:33 INFO - 'HOME': '/Users/cltbld', 02:27:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:33 INFO - 'LOGNAME': 'cltbld', 02:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:33 INFO - 'MOZ_NO_REMOTE': '1', 02:27:33 INFO - 'NO_EM_RESTART': '1', 02:27:33 INFO - 'PAGER': '/bin/cat', 02:27:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:33 INFO - 'PWD': '/builds/slave/test', 02:27:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:33 INFO - 'SHELL': '/bin/bash', 02:27:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:33 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:33 INFO - 'USER': 'cltbld', 02:27:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:33 INFO - 'XPC_FLAGS': '0x0', 02:27:33 INFO - 'XPC_SERVICE_NAME': '0', 02:27:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 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)) 02:27:33 INFO - Cleaning up... 02:27:33 INFO - Return code: 0 02:27:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:27:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:33 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 0x106dd3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dd6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2c3ddbe90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, '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.gIqeMUHUcw/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.icz1TK8hbT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:27:33 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 02:27:33 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 02:27:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:33 INFO - 'HOME': '/Users/cltbld', 02:27:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:33 INFO - 'LOGNAME': 'cltbld', 02:27:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:33 INFO - 'MOZ_NO_REMOTE': '1', 02:27:33 INFO - 'NO_EM_RESTART': '1', 02:27:33 INFO - 'PAGER': '/bin/cat', 02:27:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:33 INFO - 'PWD': '/builds/slave/test', 02:27:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:33 INFO - 'SHELL': '/bin/bash', 02:27:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:33 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:33 INFO - 'USER': 'cltbld', 02:27:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:33 INFO - 'XPC_FLAGS': '0x0', 02:27:33 INFO - 'XPC_SERVICE_NAME': '0', 02:27:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:27:33 INFO - Cleaning up... 02:27:33 INFO - Return code: 0 02:27:33 INFO - Running post-action listener: _resource_record_post_action 02:27:33 INFO - Running post-action listener: _start_resource_monitoring 02:27:33 INFO - Starting resource monitoring. 02:27:33 INFO - [mozharness: 2017-01-13 10:27:33.787080Z] Finished create-virtualenv step (success) 02:27:33 INFO - [mozharness: 2017-01-13 10:27:33.788123Z] Running install step. 02:27:33 INFO - Running pre-action listener: _resource_record_pre_action 02:27:33 INFO - Running main action method: install 02:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:34 INFO - Reading from file tmpfile_stdout 02:27:34 INFO - Detecting whether we're running mozinstall >=1.0... 02:27:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:27:34 INFO - Reading from file tmpfile_stdout 02:27:34 INFO - Output received: 02:27:34 INFO - Usage: mozinstall [options] installer 02:27:34 INFO - Options: 02:27:34 INFO - -h, --help show this help message and exit 02:27:34 INFO - -d DEST, --destination=DEST 02:27:34 INFO - Directory to install application into. [default: 02:27:34 INFO - "/builds/slave/test"] 02:27:34 INFO - --app=APP Application being installed. [default: firefox] 02:27:34 INFO - mkdir: /builds/slave/test/build/application 02:27:34 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'] 02:27:34 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 02:27:55 INFO - Reading from file tmpfile_stdout 02:27:55 INFO - Output received: 02:27:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:27:55 INFO - Running post-action listener: _resource_record_post_action 02:27:55 INFO - [mozharness: 2017-01-13 10:27:55.813282Z] Finished install step (success) 02:27:55 INFO - [mozharness: 2017-01-13 10:27:55.813424Z] Running run-tests step. 02:27:55 INFO - Running pre-action listener: _resource_record_pre_action 02:27:55 INFO - Running main action method: run_tests 02:27:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:27:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:27:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:27:55 INFO - 2017-01-13 02:27:55.828 screenresolution[1892:9846] starting screenresolution argv=screenresolution get 02:27:55 INFO - 2017-01-13 02:27:55.831 screenresolution[1892:9846] Display 0: 1600x1200x32@60 02:27:55 INFO - 2017-01-13 02:27:55.836 screenresolution[1893:9848] starting screenresolution argv=screenresolution list 02:27:55 INFO - Available Modes on Display 0 02:27:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:27:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:27:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:27:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:27:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:27:56 INFO - Intel Iris: 02:27:56 INFO - Chipset Model: Intel Iris 02:27:56 INFO - Type: GPU 02:27:56 INFO - Bus: Built-In 02:27:56 INFO - VRAM (Dynamic, Max): 1536 MB 02:27:56 INFO - Vendor: Intel (0x8086) 02:27:56 INFO - Device ID: 0x0a2e 02:27:56 INFO - Revision ID: 0x0009 02:27:56 INFO - Displays: 02:27:56 INFO - Display: 02:27:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:27:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:27:56 INFO - Display Serial Number: 1600x1200 60 02:27:56 INFO - Main Display: Yes 02:27:56 INFO - Mirror: Off 02:27:56 INFO - Online: Yes 02:27:56 INFO - Rotation: Supported 02:27:56 INFO - Return code: 0 02:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:27:56 INFO - Python 2.7.3 02:27:56 INFO - Return code: 0 02:27:56 INFO - grabbing minidump binary from tooltool 02:27: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')]} 02:27:56 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 0x106bb1d30>, '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 0x106ad8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ba6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:27:56 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 02:27:56 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 02:27:56 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 02:27:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:27:56 INFO - Return code: 0 02:27:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:27:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:27:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:27:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:27:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gIqeMUHUcw/Render', 02:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:27:56 INFO - 'HOME': '/Users/cltbld', 02:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:27:56 INFO - 'LOGNAME': 'cltbld', 02:27:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:27:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:56 INFO - 'MOZ_NO_REMOTE': '1', 02:27:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:27:56 INFO - 'NO_EM_RESTART': '1', 02:27:56 INFO - 'PAGER': '/bin/cat', 02:27:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:56 INFO - 'PWD': '/builds/slave/test', 02:27:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:27:56 INFO - 'SHELL': '/bin/bash', 02:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.icz1TK8hbT/Listeners', 02:27:56 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 02:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:27:56 INFO - 'USER': 'cltbld', 02:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:56 INFO - 'XPC_FLAGS': '0x0', 02:27:56 INFO - 'XPC_SERVICE_NAME': '0', 02:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:27:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:27:56 INFO - mozversion application_buildid: 20170113012117 02:27:56 INFO - mozversion application_changeset: 91f5293e9a89056565493ed5073c3842b0ee9fdc 02:27:56 INFO - mozversion application_display_name: Nightly 02:27:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:27:56 INFO - mozversion application_name: Firefox 02:27:56 INFO - mozversion application_remotingname: firefox 02:27:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:27:56 INFO - mozversion application_vendor: Mozilla 02:27:56 INFO - mozversion application_version: 53.0a1 02:27:56 INFO - mozversion platform_buildid: 20170113012117 02:27:56 INFO - mozversion platform_changeset: 91f5293e9a89056565493ed5073c3842b0ee9fdc 02:27:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:27:56 INFO - mozversion platform_version: 53.0a1 02:27:56 INFO - using testdate: 1484303276 02:27:56 INFO - actual date: 1484303276 02:27:56 INFO - starting webserver on 'localhost:49323' 02:27:56 INFO - SUITE-START | Running 2 tests 02:27:56 INFO - TEST-START | dromaeo_css 02:27:56 INFO - operating with platform_type : mac_ 02:27:56 INFO - Initialising browser for dromaeo_css test... 02:27:56 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpJo93c3/profile http://localhost:49323/getInfo.html) 02:27:58 INFO - PROCESS | 1903 | __metrics Screen width/height:1600/1200 02:27:58 INFO - PROCESS | 1903 | colorDepth:24 02:27:58 INFO - PROCESS | 1903 | Browser inner width/height: 1024/689 02:27:58 INFO - PROCESS | 1903 | __metrics 02:27:58 INFO - PROCESS | 1903 | 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" 02:27:58 INFO - PROCESS | 1903 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:59 INFO - TEST-INFO | 1903: exit 0 02:27:59 INFO - Browser initialized. 02:27:59 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:59 INFO - TEST-INFO | started process 1906 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpJo93c3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:11 INFO - PROCESS | 1906 | RSS: Main: 235307008 02:28:11 INFO - PROCESS | 1906 | 02:31:14 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49323/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49323/tests/dromaeo/cssquery-ext.html) 02:31:16 INFO - PROCESS | 1906 | RSS: Main: 388857856 02:31:16 INFO - PROCESS | 1906 | 02:33:01 INFO - PROCESS | 1906 | ************************* 02:33:01 INFO - PROCESS | 1906 | A coding exception was thrown and uncaught in a Task. 02:33:01 INFO - PROCESS | 1906 | 02:33:01 ERROR - PROCESS | 1906 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:33:01 INFO - PROCESS | 1906 | Full stack: 02:33:01 INFO - PROCESS | 1906 | ************************* 02:34:19 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49323/tests/dromaeo/cssquery-ext.html (next: http://localhost:49323/tests/dromaeo/cssquery-jquery.html) 02:34:20 INFO - PROCESS | 1906 | RSS: Main: 370081792 02:34:20 INFO - PROCESS | 1906 | 02:37:22 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49323/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49323/tests/dromaeo/cssquery-mootools.html) 02:37:23 INFO - PROCESS | 1906 | RSS: Main: 360341504 02:37:23 INFO - PROCESS | 1906 | 02:40:25 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49323/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49323/tests/dromaeo/cssquery-prototype.html) 02:40:26 INFO - PROCESS | 1906 | RSS: Main: 337055744 02:40:26 INFO - PROCESS | 1906 | 02:43:29 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49323/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49323/tests/dromaeo/cssquery-yui.html) 02:43:30 INFO - PROCESS | 1906 | RSS: Main: 324313088 02:43:30 INFO - PROCESS | 1906 | 02:46:33 INFO - PROCESS | 1906 | Cycle 1(1): loaded http://localhost:49323/tests/dromaeo/cssquery-yui.html (next: http://localhost:49323/tests/dromaeo/cssquery-dojo.html) 02:46:33 INFO - PROCESS | 1906 | RSS: Main: 439058432 02:46:33 INFO - PROCESS | 1906 | 02:46:33 INFO - PROCESS | 1906 | __start_tp_report 02:46:33 INFO - PROCESS | 1906 | _x_x_mozilla_page_load 02:46:33 INFO - PROCESS | 1906 | _x_x_mozilla_page_load_details 02:46:33 INFO - PROCESS | 1906 | |i|pagename|runs| 02:46:33 INFO - PROCESS | 1906 | |0;dojo.html;3302.8843990460336;3324.9002529924096;3328.0681409205417;3343.9331213375717;3388.474786408106;5561.221428999933;5627.577931655132;5628.409017053206;5637.041702910505;5679.375268720442;5632.746526406311;5687.7156142192825;5758.5393168546525;5774.2782152230975;5802.680852553108;5112.769925353368;5136.794528218867;5153.742312884359;5197.168453047513;5270.631055826094;5297.867553311159;5298.947010529903;5299.099153143975;5314.973425132869;5333.653312534692;5093.745312734349;5108.846734597968;5254.448282930313;5271.789128434877;5283.788648454057;5159.329287192641;5182.222666600041;5232.293640358579;5238.188080847474;5310.150375939869;5194.844154675328;5204.7918083277;5215.295935048795;5233.633645644806;5233.738313084368;5718.456746609066;5728.112142617901;5735.741891614887;5742.167385729088;5751.281089863767;6112.208004058196;6166.414190651925;6206.875862482771;6269.498440124779;6274.937250627481;6301.306856245809;6355.968220158916;6357.07822365759;6371.458426033792;6396.680165991728;5881.323647780518;5886.352501224862;5886.941130588725;5908.202392676976;5931.911021334683;6240.500759939194;6253;6286.5599408041;6311.810645680637;6339.587926784744;6136.355682653347;6197.287311959092;6203;6227.439530442282;6228.190335256479;6135.796305541688;6328.240611126695;6332.240131184288;6337.081123237105;6342.334054924258;6117.857853872152;6120.050983828535;6177.567570270038;6224.128621992924;6233.750649974041;6303.653299068504;6304.621722696653;6325.778597749057;6326.335734747877;6340.682965851689;4953.752312384367;4989;4991.450940396553;4992.251162325608;4998.075356059141;4322.502912165079;4362.1493808707;4364.54172311909;4425.690201685916;4492.932606010912;5734.971325143431;5779.8555036124435;5782.971085144547;5788.102844059177;5825.446582574648;5526.894621075801;6321.462675672527;6340.397662222082;6354.269259035178;6355.523335749837;5475.315585551806;5533.22534845122;5755.798547050833;5759.481646651738;5803.941960580424;5298.417174110845;5383.730813459311;5396.892062158735;5407.107827208467;5439.918401223985;6334;6343.429091381798;6349.555531112777;6350.333215012357;6355.682215889095;6297.4017468340435;6302.905456418066;6304.022876454157;6306.46395056407;6323.20959880015;6257.092721555258;6264.5301602379095;6268.1851359323;6293.370662933853;6348.365163483615;6243.406876346739;6258.061290806233;6268.404501572343;6288.779892703734;6297.622142671455;6320.968395158179;6325.493960483058;6328.335524770017;6331.620102793847;6335.018072198816;6003.189569408074;6071.483923866521;6071.7571297147615;6101.7559297627595;6131.938680613137;6121.178620693132;6136.55661555374;6141.8637552053015;6151.415615516519;6168.599041062316;5785.103308987113;5797.971010145091;5848.093545500455;5928.67392293428;5950.19672344228;6045.153678485103;6085.574009819447;6089.54328425361;6093.817185484442;6129.172561704113;5880.382559831327;5954.19618351517;5996.2504686914135;6000;6014.188084608697 02:46:34 INFO - PROCESS | 1906 | |1;ext.html;448.9977550112249;474.90501899620074;489.51293463004316;490.6638952317665;528.651090280415;30723.539146912815;33887.322253554914;39642.60357396429;41321.99999999996;41427.58572414275;41931.79034104833;42213.7889310553;42272.365914511305;42320;42327;9126.726198214048;9345.018773028836;9348.57931393089;9353.812923741521;9369;8296.626651800654;8525.31797456202;10986.945065274662;11249.887501125007;11280.887191128108;11267.830982535268;11352.035077018463;11359.091272698164;11386.259893106962;11387.089032877391;8319.8336033279;10488.632897848538;11234.32594044356;11274;11307.434628268553;8408.537530435824;10839.566417343296;11118.22172447929;11136.888631113747;11319.660410187707;39802.60197398047;40137.79242141681;40223.396649050286;40224.79887600573;40246.59136930193;4024.979875100635;4025.9798701006307;4030.435738996543;4036.2129384769983;4187.769672668002;28951.367781155124;29773.553396699066;30272.697273027206;30575.929842455407;30608.693913060808;3094.938101237985;3122.281875168724;3273.2307907641684;3312.287858110518;3315.8673653053847;471051;477081;477150;477697;478754;58320.4167958315;58465;58877;59084;59097.40902591005;59443.40556594465;59483.70258148682;59590.70204648949;59672;59697;15268.541943741706;15929.203539823195;15933.840661593467;15960.36158553668;15961.281742321624;11122.61070862516;11411.60059397917;12317.384130793425;12386.81419778704;12408.75182496345;13775.311234438239;15127;15344.386224551115;15463.690726185414;15870.222711025524;6258.499320054385;6267.96866015667;6294.583718663355;6309.842253943596;6337.081123237105;854.7008547008497;855.6449073634496;862.3920136303891;880.3881302494705;903.4714691905177;29187.7081229185;29309.267268318035;29592.408151836844;29958;29990;952.4428209497521;1046.1839764983324;1047.554789214596;1068.9572417103384;1097.1497089755503;14703.044302120541;15277.770833437507;15346.923265383824;15542.923076157918;15722.68554628901;578723;586055;586923.0653846789;588207;590935;58690.706546466994;58740;58866.7056664714;58934;59088.70455647694;1410.4076287959083;1450.7968884356198;1458.176130486293;1460.5180290503895;1460.9415623374946;26490.735092649596;28855.56716649294;29112.071334016375;29181.70818291875;29553.408931820813;48091.5190848087;48434.515654843;48476.03047939092;48481;48484;504900;507245;509800;510068.4496577493;510867;25153.119640813216;25375.492490150464;25702;25713;25728.883378659324;46173;47121;47160.52839471561;47799.5220047809;47894;35863.64136358603;36585.817070914476;38193.42709859299;39039.60960390473;39600.40599390954;27443.862780686766;34734.826325868205;34779.30441391208;36003.639963601076;36173.81913090418;35060.12349691278;35571.64428355787;35795.64204357923;35978.28043439064;36024.81987590045;29324.853375732986;30126;30702.385952280383;30838;31154.532682010242;21560.353189404344;23306.53386932286;23644.645330319716;23736;24103.51792964166 02:46:34 INFO - PROCESS | 1906 | |2;jquery.html;372.53061142959865;398.7149188330345;401.41994817488734;409.48813982521847;428.66992415839803;14443.71112577749;16628.334866605335;21213.787862121393;21601.67597486039;21844.12623495062;21284.36146915595;21493.462663433424;22030;22070.88964555179;22422.439439014033;5238.423773384944;5937;6085.265699275707;6183.969080154616;6196.535259855506;4240.448741663579;4472.619827314666;6010.12853136295;6116.571839971204;6119.1739115219325;6440.5491615586925;6730.394264516192;6804.693788779517;6846.760363387282;6880.139982502187;6575.473962083021;6749.392554670054;6820.31796820319;6828.897566536506;6887.414569761526;5710.8001219957105;5967.552433567456;5968.164456975984;5971;5990.251218597676;26772.866135669196;26980;27070;27325.770340334733;27416.177514674593;2418.9395265118337;2725.6592925884265;2755.4626847764694;2757.393373457836;2763.585462180669;14248.715025699428;16028.75956860648;16049.197540122947;16109.83890161095;16385.262663180187;1675.8156602773686;1892.630936967292;1901.372547059481;1902.1630482587618;1933.1107690462404;126204.84487887785;129792.35103824515;130372;133738;134050;11373.952688515981;11387.943060284646;11481.885181148082;11497.712557186138;11603.825942610867;14911.701765964837;14918.552443426715;14929.70140597182;14944.70110597782;14954.401823927139;8521;8810.691625793066;8821.250193733476;8940.32947528938;8958.731238062868;8359.874601880976;8705.173008564176;8709.433886797338;8897.243734282529;8899.243564296978;7336.523125996793;7456.3662088721985;7487.41684118989;7517.962410188024;7538.962305188439;1654.3465331194352;1837.4579499047813;1927.7686677598779;1958.1677786940493;1966.8819870807797;797.314309693663;820.6553247635887;895.3642913531465;895.8790563273875;897.2014906733012;21964.45088872759;22194;22228.88885555562;22411.32766017022;22772.544549108927;691.9550229235184;861.2765277167209;917.4816228830689;926.6108234541508;935.933036338561;11546;11645.6506304811;11793.157902577877;11889.70275743096;11895.643130706092;696154;696613;707547.7074907061;708124;726583;87971;125362;125981;126268;128383;998.0936411454088;1000.0699349604791;1041.317936751429;1041.4948749856314;1048.8217003109337;19329;19493.8050619492;19734;19741.901290493457;20080.39758807238;55363.44636553583;55727.72136139456;56011.159832603356;56069;57169.71415143064;83554;83867.5806620963;86434.13565864513;87306.21366115747;95432;8192.139825318256;8359.122292159478;8710.259627931697;8736.039035706195;8752.431091979;12586.370681465707;13423.865761342653;13563;13959.441622334993;14007.949403794551;11395.373254471084;11480.425978701198;11923.701907452383;11953.282803031845;12091.395430228278;11416.94291528537;11423.371714555778;11551.884481155417;11705.356205408785;11947.641570752892;11495.195336326376;11628.825567616661;12068.155229133876;12103.818442723543;12117.75764484723;7094.361507464353;7413.666385012795;8072.838543228985;8359.832803344021;8524.977002759708;7001.264867188872;10448.68653940383;11649.650510484698;11932.821007684717;12005.81991270149 02:46:34 INFO - PROCESS | 1906 | |3;mootools.html;1437.856214378563;1452.5351887396032;1459.5256541623976;1483.1471903655402;1490.6422458609934;8116.8782468263025;8515.744527664172;8533.18934701204;8535.743927682171;8543.743687689364;7437.293457121578;7697.807554811133;7728.961355193216;8125.91874081259;8380.245777879989;2293.3463962770616;2328.3946173994714;2333.591621466245;2334.3930578049744;2337.742848286687;2319.547688200793;2351.811855051592;2354.81161507079;2357.446000189954;2359.528094381122;2292.33522278539;2296.9655455168186;2309.3418375762913;2340.625499920013;2342.156823543523;2168.739751229855;2186.835987300959;2189.627763280246;2191.233068426054;2201.0315461197024;2105.3789132206034;2251.133313674231;2257.0407576779967;2263.9434014149615;2273.9204127855446;8493.405461617689;8549.059603443678;8550.657973681045;8556.315494760403;8592;5051;5225.085610018232;5227.529522343008;5227.973860130675;5240.659357141773;3270.725065584076;3313.867445302185;3444.9311013779834;3500.562429696288;3502.2995400919663;1192.8926396624258;1195.2231049817688;1195.7907366210877;1223.2354778263584;1252.1360261419682;10570.154387648892;10834.133269338434;10930.485988222674;10932.305492648653;10940.343579385182;4377.715448495837;4611.584957353854;4616;4698.553637404441;4719.457262414798;9613.855792163124;9622.51887405641;9625.32622716417;9638.325317227727;9643;5273.077211487975;5274.630775845654;5274.657147285491;5279.656822306538;5297.496737809902;4024.6981476389387;4195.643370313496;4772.427308722976;4852.490488498727;4872.78072486739;3800.315943130208;3815.008097894512;3881.029742564359;3886.106195575034;3922.0391004204153;1081.3457857995957;1246.4827096754746;1265.221888538542;1267.33464930912;1277.1251692590606;702.6592102830124;880.2649787427441;925.6667599664115;936.8828896387952;951.5242378810594;5697.943020569741;5745.253117094751;5762.30852297727;5773.509251713652;6026.246719160105;981.9165370943407;995.1889210293588;995.5121990224883;997.3218211616025;1010.7473131717071;3714.832832522543;3779.5842457329672;3869.245497128033;3964.742291751027;3987.401889716508;9545.952270238604;10161.796764064677;10238.18094552434;10297.588096476056;10344.896551034393;8223.424360294723;9942.502874856229;10034.849477257847;10066.547005384775;10243.183124640784;7764.107127680276;7998.160193179749;8004.559749213733;8023.959880200561;8024.919750802534;5374.355077390738;5443.945560544344;5473.425290344457;5475.342958844964;5535.972320138373;7730.536167829948;9144.817103657757;9196.172344489029;9289.86065209036;9491.952540237255;9423.528823558932;9531.952340238255;9594.66418675343;9616.326857120213;9653.517324133625;5466.742649190788;6579.046038324512;6599.571027883172;6832.487563432663;6962.408195303456;7800.609969501389;8051.1546287641295;8097.8380432392205;8197.549134797644;8222.876656850032;7032.613206273704;7114.110736157981;7294.088238970129;7355.8161045974275;7405.2224516425;7050.189228238818;7148.535345202546;7168;7302.890456643048;7359.337659610446;6359.07793369968;6441.291457939717;6509.707063182263;6511.2512061113575;6517.641529715911;4666.929996049994;4938.308636790924;4968.342904469964;5094.847154585368;5118.3090282811345;4976.427710813303;5006.69959802413;5169.302144210634;5188.481151884781;5272.894542109059 02:46:34 INFO - PROCESS | 1906 | |4;prototype.html;357.84791463627954;362.8330967754833;369.1896287648611;380.04797981057465;382.96744776694015;4205.85279515217;4373.4095897053885;5226.111561034624;5227.660202086867;5323.787048518055;4708.646851486135;4955.876103097425;5102.948970510303;5117.923231151526;5252.579793616511;3439;3532.629073947237;3605.387084195693;4101.323281658538;4122.814473348706;3376.1390845334404;3875.186210895701;4063.634272915437;4092.529359123709;4116.917661646765;3748.83130259139;3753.774773513598;3925.2934471795065;4110.4656394668655;4144.233316836395;3375.8480868360984;3867.8839634811;3900.902477438058;3942.172143849795;3978.930955902929;2977.344984103494;3412.9829350853333;3439.208981934169;3440.2947395783804;3455.531399155349;4322;4981.9750901245625;5031.77357018935;5042.773075211588;5069.619778516626;4385.978070109661;4403.207422663919;4499.6400287976885;4529.184746745585;4548.909021819545;5165.690058596496;5490.325450737523;5495.890082198373;5514.283143191399;5521.613487055867;3342.381659392996;3500.8249587520777;3607.971728057491;3762.5484941806885;3818.579956204815;4873.610111191097;5316.6544174628525;5358.008768377863;5728.971355143198;5875.618084824473;3236.336551007038;3454.5336379588434;3518.3315170117594;3579.89023402746;3767.981160094182;3437.4703257050874;3497.880678182957;3615.37885033354;3813.1992281620614;3834.367329390675;3964.920701585952;4069.877903662895;4146.212219678251;4445.266531022345;4461.754603496839;5169.870753231199;5524.696141712245;5533.1976863354585;5566.944330556724;5609.214709940612;1144.9370284634258;1226.3566820460626;1235.7960936445386;1242.372601836085;1243.5150291386367;711.32424197012;738.9963050184822;796.74902405742;837.9525593008739;851.8083431228048;4577.656675749266;4774.665773395829;4813.326134341195;4851.975740121276;4881.219004959189;4624.838130665411;4860.781264843091;5334.973325133427;5343.782330332946;5399.326208875261;4574.359589657451;4688.89721493693;4769.284607308862;4810.903781924412;4848.927266091011;2359.8702071385896;2764.4471105778925;2781.276868014331;2803.8598070096414;2819.182437093261;4276.636485898671;5053.184845441741;5403.540699040547;5470.8085217017215;5474.39781624021;4317.676174286941;5215.739213039333;5226.817061402909;5244.763985620656;5359.472550323139;4462.482755863022;5397.379301380313;5419.972900135474;5469.617126801086;5474.534664553557;4400.493943196573;4707.128651522637;4915.18899381598;5009.847735020892;5286.577073834161;4315.805788739452;4536.909261814679;4969.950300496948;5216.295800066942;5247.580193584427;4762.714237145782;4890.24201248807;5273.34083239595;5423.945760542502;5464.3442786865835;3029.6518049467777;3270.6402295747926;3345.7750595853486;3572.4102774266244;3574.8531703224135;4816.494268101939;4949.455559888482;4997.550220480029;5013.774380152829;5314.681119132864;4629.911970686953;4630.467496237976;5090.440051594395;5119.48805119485;5149.138146390207;4580.625812256243;4744.762761861962;4781.521847815191;5122.948770512397;5143.627916271289;4457.933131002973;4765.166095933268;4963.801447942042;4987.501249874984;5036.974815125901;4440.555944405663;5109;5281.940043383161;5364.356277246756;5420.4850539198715;4945.9366236259375;4995.8751031223055;5183.688978661293;5327.334083239595;5327.48166772468 02:46:34 INFO - PROCESS | 1906 | |5;yui.html;723.4790950515627;755.6108604068902;774.3069952392609;809.4333966223643;812.46377390922;14767.630809229775;15728.921355393235;15751;15779.447719329826;15795.447159349425;14436.566902992927;14622.48821291255;14642.707145857103;14654.853451465482;14659.560213193594;677.3159109299594;700.1493185779277;702.8242939265184;857.695518091078;884.8186121845006;877.9473231606092;884.783228109111;885.8804061451686;887.8002449448887;891.1623074310128;945.0313428735533;946.8343039968013;947.4694171264114;948.9335746497748;950.1591091883664;716.4984510842431;734.5225603357807;740.1968863782802;742.3838214282187;947.981040379192;545.7135004122828;685.8765422223997;702.7329614746363;710.1620088295809;712.7790384980673;15017.774733379008;15243.542693719206;15281.61795955099;15293.235338233044;15317.770233446396;12511;12880.484780608764;12935.870641293655;13449.05856590039;13826;12469;12552.435140418704;12648.810267845989;12667.049971252192;12880.80678789819;4456.77716114193;4458.955410445887;4462.709923854939;4479.440069991251;4650.162970665279;104669.42995855068;106652;106753.46623266835;106830.46584767026;107583.46208268909;9071.818563628822;10639.308444951053;10792.94603526993;10813.243072984815;10987.835182472269;20609;21083.262085826922;21170.470738231666;21239.93800310009;21252.468688282916;7477.85044299111;7553.244675532403;7639.809004774925;7652.196519365387;7761.495502792301;4205.432266643964;4215.641670457984;4270.701050926467;4295.656347492193;4374.868753937387;3448.620651728308;3449.706774924109;3469.271452994849;3511.719062474996;3528.9823550882593;599.637219482207;604.6251324179037;617.0651463033507;622.5175488995974;624.4255285137684;539.4255118299077;542.9837104886859;549.4587830986555;559.725734390154;565.7538970547743;9678.564464598969;9696.127348538665;9738.853917191247;9931.702048938543;9954.552045157985;622.8411755002445;651.3356376495948;654.4927681047227;657.9309172536911;671.358852296056;4734.218853889139;4779.354787103766;4781.737004464788;4785.688930219525;4797.352357431771;105961.41057884137;107565.4621726902;107922.8415431687;108319.91680083257;110472.4476377629;94368.52815735877;94443.52778236064;97376.51311743537;98294;99432.50851237237;70120;70910;73718.63140684263;76580;78560.60719696365;9171.31215158879;10495.265331426726;11014.779704406028;11223.66329010131;11292.49183786748;44898;45813.541864580926;52404.567177906814;54450.45549544612;55091.724541377036;59115.704421479335;65985;67176.65646687137;67237.66381168063;69433;13759.931200343934;13920.721585568435;13973.580792576238;14242.643933901736;14505.419783208554;14801.259937003322;14937.103773773608;14956;15432.074075555503;15522.611934701272;13964.790528141883;14029.579112626638;14091.506797262047;14112.082714623517;14143.929280353532;13527.188368697909;13683.726325473634;13802.930985345009;13991.300434978413;14527.34626941769;13474.393652285475;13931;13971.930140349234;14232.273253262008;14315.642108947359;10884.292520986111;10938.835917461403;10948.343099413742;11592.6522204334;11924.284542927453;10795.19036072282;10934.850933463036;10969.780604388026;11098.61154859576;11113.499892505019 02:46:34 INFO - PROCESS | 1906 | __end_tp_report 02:46:34 INFO - PROCESS | 1906 | __start_cc_report 02:46:34 INFO - PROCESS | 1906 | _x_x_mozilla_cycle_collect,1681 02:46:34 INFO - PROCESS | 1906 | __end_cc_report 02:46:34 INFO - PROCESS | 1906 | __startTimestamp1484304393995__endTimestamp 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - PROCESS | 1906 | ------- Summary: start ------- 02:46:34 INFO - PROCESS | 1906 | Number of tests: 6 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - PROCESS | 1906 | [#0] dojo.html Cycles:165 Average:5768.59 Median:5954.20 stddev:653.93 (11.0%) stddev-sans-first:626.68 02:46:34 INFO - PROCESS | 1906 | Values: 3302.9 3324.9 3328.1 3343.9 3388.5 5561.2 5627.6 5628.4 5637.0 5679.4 5632.7 5687.7 5758.5 5774.3 5802.7 5112.8 5136.8 5153.7 5197.2 5270.6 5297.9 5298.9 5299.1 5315.0 5333.7 5093.7 5108.8 5254.4 5271.8 5283.8 5159.3 5182.2 5232.3 5238.2 5310.2 5194.8 5204.8 5215.3 5233.6 5233.7 5718.5 5728.1 5735.7 5742.2 5751.3 6112.2 6166.4 6206.9 6269.5 6274.9 6301.3 6356.0 6357.1 6371.5 6396.7 5881.3 5886.4 5886.9 5908.2 5931.9 6240.5 6253.0 6286.6 6311.8 6339.6 6136.4 6197.3 6203.0 6227.4 6228.2 6135.8 6328.2 6332.2 6337.1 6342.3 6117.9 6120.1 6177.6 6224.1 6233.8 6303.7 6304.6 6325.8 6326.3 6340.7 4953.8 4989.0 4991.5 4992.3 4998.1 4322.5 4362.1 4364.5 4425.7 4492.9 5735.0 5779.9 5783.0 5788.1 5825.4 5526.9 6321.5 6340.4 6354.3 6355.5 5475.3 5533.2 5755.8 5759.5 5803.9 5298.4 5383.7 5396.9 5407.1 5439.9 6334.0 6343.4 6349.6 6350.3 6355.7 6297.4 6302.9 6304.0 6306.5 6323.2 6257.1 6264.5 6268.2 6293.4 6348.4 6243.4 6258.1 6268.4 6288.8 6297.6 6321.0 6325.5 6328.3 6331.6 6335.0 6003.2 6071.5 6071.8 6101.8 6131.9 6121.2 6136.6 6141.9 6151.4 6168.6 5785.1 5798.0 5848.1 5928.7 5950.2 6045.2 6085.6 6089.5 6093.8 6129.2 5880.4 5954.2 5996.3 6000.0 6014.2 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - PROCESS | 1906 | [#1] ext.html Cycles:180 Average:65721.38 Median:36014.23 stddev:140190.42 (389.3%) stddev-sans-first:140498.03 02:46:34 INFO - PROCESS | 1906 | Values: 449.0 474.9 489.5 490.7 528.7 30723.5 33887.3 39642.6 41322.0 41427.6 41931.8 42213.8 42272.4 42320.0 42327.0 9126.7 9345.0 9348.6 9353.8 9369.0 8296.6 8525.3 10986.9 11249.9 11280.9 11267.8 11352.0 11359.1 11386.3 11387.1 8319.8 10488.6 11234.3 11274.0 11307.4 8408.5 10839.6 11118.2 11136.9 11319.7 39802.6 40137.8 40223.4 40224.8 40246.6 4025.0 4026.0 4030.4 4036.2 4187.8 28951.4 29773.6 30272.7 30575.9 30608.7 3094.9 3122.3 3273.2 3312.3 3315.9 471051.0 477081.0 477150.0 477697.0 478754.0 58320.4 58465.0 58877.0 59084.0 59097.4 59443.4 59483.7 59590.7 59672.0 59697.0 15268.5 15929.2 15933.8 15960.4 15961.3 11122.6 11411.6 12317.4 12386.8 12408.8 13775.3 15127.0 15344.4 15463.7 15870.2 6258.5 6268.0 6294.6 6309.8 6337.1 854.7 855.6 862.4 880.4 903.5 29187.7 29309.3 29592.4 29958.0 29990.0 952.4 1046.2 1047.6 1069.0 1097.1 14703.0 15277.8 15346.9 15542.9 15722.7 578723.0 586055.0 586923.1 588207.0 590935.0 58690.7 58740.0 58866.7 58934.0 59088.7 1410.4 1450.8 1458.2 1460.5 1460.9 26490.7 28855.6 29112.1 29181.7 29553.4 48091.5 48434.5 48476.0 48481.0 48484.0 504900.0 507245.0 509800.0 510068.4 510867.0 25153.1 25375.5 25702.0 25713.0 25728.9 46173.0 47121.0 47160.5 47799.5 47894.0 35863.6 36585.8 38193.4 39039.6 39600.4 27443.9 34734.8 34779.3 36003.6 36173.8 35060.1 35571.6 35795.6 35978.3 36024.8 29324.9 30126.0 30702.4 30838.0 31154.5 21560.4 23306.5 23644.6 23736.0 24103.5 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - PROCESS | 1906 | [#2] jquery.html Cycles:180 Average:39032.80 Median:14897.83 stddev:117215.69 (786.8%) stddev-sans-first:117508.56 02:46:34 INFO - PROCESS | 1906 | Values: 372.5 398.7 401.4 409.5 428.7 14443.7 16628.3 21213.8 21601.7 21844.1 21284.4 21493.5 22030.0 22070.9 22422.4 5238.4 5937.0 6085.3 6184.0 6196.5 4240.4 4472.6 6010.1 6116.6 6119.2 6440.5 6730.4 6804.7 6846.8 6880.1 6575.5 6749.4 6820.3 6828.9 6887.4 5710.8 5967.6 5968.2 5971.0 5990.3 26772.9 26980.0 27070.0 27325.8 27416.2 2418.9 2725.7 2755.5 2757.4 2763.6 14248.7 16028.8 16049.2 16109.8 16385.3 1675.8 1892.6 1901.4 1902.2 1933.1 126204.8 129792.4 130372.0 133738.0 134050.0 11374.0 11387.9 11481.9 11497.7 11603.8 14911.7 14918.6 14929.7 14944.7 14954.4 8521.0 8810.7 8821.3 8940.3 8958.7 8359.9 8705.2 8709.4 8897.2 8899.2 7336.5 7456.4 7487.4 7518.0 7539.0 1654.3 1837.5 1927.8 1958.2 1966.9 797.3 820.7 895.4 895.9 897.2 21964.5 22194.0 22228.9 22411.3 22772.5 692.0 861.3 917.5 926.6 935.9 11546.0 11645.7 11793.2 11889.7 11895.6 696154.0 696613.0 707547.7 708124.0 726583.0 87971.0 125362.0 125981.0 126268.0 128383.0 998.1 1000.1 1041.3 1041.5 1048.8 19329.0 19493.8 19734.0 19741.9 20080.4 55363.4 55727.7 56011.2 56069.0 57169.7 83554.0 83867.6 86434.1 87306.2 95432.0 8192.1 8359.1 8710.3 8736.0 8752.4 12586.4 13423.9 13563.0 13959.4 14007.9 11395.4 11480.4 11923.7 11953.3 12091.4 11416.9 11423.4 11551.9 11705.4 11947.6 11495.2 11628.8 12068.2 12103.8 12117.8 7094.4 7413.7 8072.8 8359.8 8525.0 7001.3 10448.7 11649.7 11932.8 12005.8 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - PROCESS | 1906 | [#3] mootools.html Cycles:180 Average:5456.05 Median:5234.32 stddev:2978.17 (56.9%) stddev-sans-first:2971.22 02:46:34 INFO - PROCESS | 1906 | Values: 1437.9 1452.5 1459.5 1483.1 1490.6 8116.9 8515.7 8533.2 8535.7 8543.7 7437.3 7697.8 7729.0 8125.9 8380.2 2293.3 2328.4 2333.6 2334.4 2337.7 2319.5 2351.8 2354.8 2357.4 2359.5 2292.3 2297.0 2309.3 2340.6 2342.2 2168.7 2186.8 2189.6 2191.2 2201.0 2105.4 2251.1 2257.0 2263.9 2273.9 8493.4 8549.1 8550.7 8556.3 8592.0 5051.0 5225.1 5227.5 5228.0 5240.7 3270.7 3313.9 3444.9 3500.6 3502.3 1192.9 1195.2 1195.8 1223.2 1252.1 10570.2 10834.1 10930.5 10932.3 10940.3 4377.7 4611.6 4616.0 4698.6 4719.5 9613.9 9622.5 9625.3 9638.3 9643.0 5273.1 5274.6 5274.7 5279.7 5297.5 4024.7 4195.6 4772.4 4852.5 4872.8 3800.3 3815.0 3881.0 3886.1 3922.0 1081.3 1246.5 1265.2 1267.3 1277.1 702.7 880.3 925.7 936.9 951.5 5697.9 5745.3 5762.3 5773.5 6026.2 981.9 995.2 995.5 997.3 1010.7 3714.8 3779.6 3869.2 3964.7 3987.4 9546.0 10161.8 10238.2 10297.6 10344.9 8223.4 9942.5 10034.8 10066.5 10243.2 7764.1 7998.2 8004.6 8024.0 8024.9 5374.4 5443.9 5473.4 5475.3 5536.0 7730.5 9144.8 9196.2 9289.9 9492.0 9423.5 9532.0 9594.7 9616.3 9653.5 5466.7 6579.0 6599.6 6832.5 6962.4 7800.6 8051.2 8097.8 8197.5 8222.9 7032.6 7114.1 7294.1 7355.8 7405.2 7050.2 7148.5 7168.0 7302.9 7359.3 6359.1 6441.3 6509.7 6511.3 6517.6 4666.9 4938.3 4968.3 5094.8 5118.3 4976.4 5006.7 5169.3 5188.5 5272.9 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - PROCESS | 1906 | [#4] prototype.html Cycles:180 Average:4241.50 Median:4753.74 stddev:1282.65 (27.0%) stddev-sans-first:1252.68 02:46:34 INFO - PROCESS | 1906 | Values: 357.8 362.8 369.2 380.0 383.0 4205.9 4373.4 5226.1 5227.7 5323.8 4708.6 4955.9 5102.9 5117.9 5252.6 3439.0 3532.6 3605.4 4101.3 4122.8 3376.1 3875.2 4063.6 4092.5 4116.9 3748.8 3753.8 3925.3 4110.5 4144.2 3375.8 3867.9 3900.9 3942.2 3978.9 2977.3 3413.0 3439.2 3440.3 3455.5 4322.0 4982.0 5031.8 5042.8 5069.6 4386.0 4403.2 4499.6 4529.2 4548.9 5165.7 5490.3 5495.9 5514.3 5521.6 3342.4 3500.8 3608.0 3762.5 3818.6 4873.6 5316.7 5358.0 5729.0 5875.6 3236.3 3454.5 3518.3 3579.9 3768.0 3437.5 3497.9 3615.4 3813.2 3834.4 3964.9 4069.9 4146.2 4445.3 4461.8 5169.9 5524.7 5533.2 5566.9 5609.2 1144.9 1226.4 1235.8 1242.4 1243.5 711.3 739.0 796.7 838.0 851.8 4577.7 4774.7 4813.3 4852.0 4881.2 4624.8 4860.8 5335.0 5343.8 5399.3 4574.4 4688.9 4769.3 4810.9 4848.9 2359.9 2764.4 2781.3 2803.9 2819.2 4276.6 5053.2 5403.5 5470.8 5474.4 4317.7 5215.7 5226.8 5244.8 5359.5 4462.5 5397.4 5420.0 5469.6 5474.5 4400.5 4707.1 4915.2 5009.8 5286.6 4315.8 4536.9 4970.0 5216.3 5247.6 4762.7 4890.2 5273.3 5423.9 5464.3 3029.7 3270.6 3345.8 3572.4 3574.9 4816.5 4949.5 4997.6 5013.8 5314.7 4629.9 4630.5 5090.4 5119.5 5149.1 4580.6 4744.8 4781.5 5122.9 5143.6 4457.9 4765.2 4963.8 4987.5 5037.0 4440.6 5109.0 5281.9 5364.4 5420.5 4945.9 4995.9 5183.7 5327.3 5327.5 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - PROCESS | 1906 | [#5] yui.html Cycles:180 Average:20818.29 Median:4283.18 stddev:30067.99 (702.0%) stddev-sans-first:30114.48 02:46:34 INFO - PROCESS | 1906 | Values: 723.5 755.6 774.3 809.4 812.5 14767.6 15728.9 15751.0 15779.4 15795.4 14436.6 14622.5 14642.7 14654.9 14659.6 677.3 700.1 702.8 857.7 884.8 877.9 884.8 885.9 887.8 891.2 945.0 946.8 947.5 948.9 950.2 716.5 734.5 740.2 742.4 948.0 545.7 685.9 702.7 710.2 712.8 15017.8 15243.5 15281.6 15293.2 15317.8 12511.0 12880.5 12935.9 13449.1 13826.0 12469.0 12552.4 12648.8 12667.0 12880.8 4456.8 4459.0 4462.7 4479.4 4650.2 104669.4 106652.0 106753.5 106830.5 107583.5 9071.8 10639.3 10792.9 10813.2 10987.8 20609.0 21083.3 21170.5 21239.9 21252.5 7477.9 7553.2 7639.8 7652.2 7761.5 4205.4 4215.6 4270.7 4295.7 4374.9 3448.6 3449.7 3469.3 3511.7 3529.0 599.6 604.6 617.1 622.5 624.4 539.4 543.0 549.5 559.7 565.8 9678.6 9696.1 9738.9 9931.7 9954.6 622.8 651.3 654.5 657.9 671.4 4734.2 4779.4 4781.7 4785.7 4797.4 105961.4 107565.5 107922.8 108319.9 110472.4 94368.5 94443.5 97376.5 98294.0 99432.5 70120.0 70910.0 73718.6 76580.0 78560.6 9171.3 10495.3 11014.8 11223.7 11292.5 44898.0 45813.5 52404.6 54450.5 55091.7 59115.7 65985.0 67176.7 67237.7 69433.0 13759.9 13920.7 13973.6 14242.6 14505.4 14801.3 14937.1 14956.0 15432.1 15522.6 13964.8 14029.6 14091.5 14112.1 14143.9 13527.2 13683.7 13802.9 13991.3 14527.3 13474.4 13931.0 13971.9 14232.3 14315.6 10884.3 10938.8 10948.3 11592.7 11924.3 10795.2 10934.9 10969.8 11098.6 11113.5 02:46:34 INFO - PROCESS | 1906 | -------- Summary: end -------- 02:46:34 INFO - PROCESS | 1906 | 02:46:34 INFO - TEST-INFO | 1906: exit 0 02:46:34 INFO - TEST-OK | dromaeo_css | took 1118205ms 02:46:34 INFO - TEST-START | kraken 02:46:34 INFO - operating with platform_type : mac_ 02:46:34 INFO - Initialising browser for kraken test... 02:46:34 INFO - TEST-INFO | started process 1912 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpDqpSA7/profile http://localhost:49323/getInfo.html) 02:46:36 INFO - PROCESS | 1912 | __metrics Screen width/height:1600/1200 02:46:36 INFO - PROCESS | 1912 | colorDepth:24 02:46:36 INFO - PROCESS | 1912 | Browser inner width/height: 1024/689 02:46:36 INFO - PROCESS | 1912 | __metrics 02:46:36 INFO - PROCESS | 1912 | 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" 02:46:36 INFO - PROCESS | 1912 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:46:37 INFO - TEST-INFO | 1912: exit 0 02:46:37 INFO - Browser initialized. 02:46:37 INFO - Running cycle 1/1 for kraken test... 02:46:37 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpDqpSA7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:49 INFO - PROCESS | 1913 | RSS: Main: 235429888 02:46:49 INFO - PROCESS | 1913 | 02:46:52 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49323/tests/kraken/driver.html?testName=audio-beat-detection) 02:46:53 INFO - PROCESS | 1913 | RSS: Main: 286892032 02:46:53 INFO - PROCESS | 1913 | 02:46:56 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49323/tests/kraken/driver.html?testName=audio-dft) 02:46:56 INFO - PROCESS | 1913 | RSS: Main: 286519296 02:46:56 INFO - PROCESS | 1913 | 02:47:00 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49323/tests/kraken/driver.html?testName=audio-fft) 02:47:00 INFO - PROCESS | 1913 | RSS: Main: 379502592 02:47:00 INFO - PROCESS | 1913 | 02:47:02 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49323/tests/kraken/driver.html?testName=audio-oscillator) 02:47:03 INFO - PROCESS | 1913 | RSS: Main: 282587136 02:47:03 INFO - PROCESS | 1913 | 02:47:05 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49323/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:06 INFO - PROCESS | 1913 | RSS: Main: 286453760 02:47:06 INFO - PROCESS | 1913 | 02:47:08 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49323/tests/kraken/driver.html?testName=imaging-darkroom) 02:47:09 INFO - PROCESS | 1913 | RSS: Main: 330240000 02:47:09 INFO - PROCESS | 1913 | 02:47:12 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49323/tests/kraken/driver.html?testName=imaging-desaturate) 02:47:13 INFO - PROCESS | 1913 | RSS: Main: 329252864 02:47:13 INFO - PROCESS | 1913 | 02:47:15 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49323/tests/kraken/driver.html?testName=json-parse-financial) 02:47:16 INFO - PROCESS | 1913 | RSS: Main: 327094272 02:47:16 INFO - PROCESS | 1913 | 02:47:18 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49323/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:47:18 INFO - PROCESS | 1913 | RSS: Main: 303341568 02:47:18 INFO - PROCESS | 1913 | 02:47:20 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:47:21 INFO - PROCESS | 1913 | RSS: Main: 306483200 02:47:21 INFO - PROCESS | 1913 | 02:47:23 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:47:24 INFO - PROCESS | 1913 | RSS: Main: 310382592 02:47:24 INFO - PROCESS | 1913 | 02:47:27 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:47:27 INFO - PROCESS | 1913 | RSS: Main: 324288512 02:47:27 INFO - PROCESS | 1913 | 02:47:30 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:47:31 INFO - PROCESS | 1913 | RSS: Main: 318304256 02:47:31 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | Cycle 1(1): loaded http://localhost:49323/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49323/tests/kraken/driver.html?testName=ai-astar) 02:47:33 INFO - PROCESS | 1913 | RSS: Main: 362311680 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | __start_tp_report 02:47:33 INFO - PROCESS | 1913 | _x_x_mozilla_page_load 02:47:33 INFO - PROCESS | 1913 | _x_x_mozilla_page_load_details 02:47:33 INFO - PROCESS | 1913 | |i|pagename|runs| 02:47:33 INFO - PROCESS | 1913 | |0;ai-astar;113;116;116;114;114;114;114;114;114;111 02:47:33 INFO - PROCESS | 1913 | |1;audio-beat-detection;146;110;132;151;113;112;111;111;131;112 02:47:33 INFO - PROCESS | 1913 | |2;audio-dft;185;185;185;184;186;181;185;184;185;184 02:47:33 INFO - PROCESS | 1913 | |3;audio-fft;82;59;63;108;86;82;82;59;74;60 02:47:33 INFO - PROCESS | 1913 | |4;audio-oscillator;87;72;86;71;69;69;83;68;73;105 02:47:33 INFO - PROCESS | 1913 | |5;imaging-gaussian-blur;88;84;87;85;86;83;86;84;87;84 02:47:33 INFO - PROCESS | 1913 | |6;imaging-darkroom;94;94;94;92;93;93;94;93;93;93 02:47:33 INFO - PROCESS | 1913 | |7;imaging-desaturate;85;85;85;85;85;86;87;86;87;87 02:47:33 INFO - PROCESS | 1913 | |8;json-parse-financial;59;59;59;56;59;59;59;58;58;58 02:47:33 INFO - PROCESS | 1913 | |9;json-stringify-tinderbox;58;79;103;111;87;70;71;70;70;72 02:47:33 INFO - PROCESS | 1913 | |10;stanford-crypto-aes;92;91;90;86;87;88;89;84;96;110 02:47:33 INFO - PROCESS | 1913 | |11;stanford-crypto-ccm;139;141;144;141;139;137;140;140;181;134 02:47:33 INFO - PROCESS | 1913 | |12;stanford-crypto-pbkdf2;175;176;176;175;176;173;171;173;178;177 02:47:33 INFO - PROCESS | 1913 | |13;stanford-crypto-sha256-iterative;67;68;68;68;68;68;67;66;66;67 02:47:33 INFO - PROCESS | 1913 | __end_tp_report 02:47:33 INFO - PROCESS | 1913 | __start_cc_report 02:47:33 INFO - PROCESS | 1913 | _x_x_mozilla_cycle_collect,2052 02:47:33 INFO - PROCESS | 1913 | __end_cc_report 02:47:33 INFO - PROCESS | 1913 | __startTimestamp1484304453453__endTimestamp 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | ------- Summary: start ------- 02:47:33 INFO - PROCESS | 1913 | Number of tests: 14 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:1.41 (1.2%) stddev-sans-first:1.45 02:47:33 INFO - PROCESS | 1913 | Values: 113.0 116.0 116.0 114.0 114.0 114.0 114.0 114.0 114.0 111.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#1] audio-beat-detection Cycles:10 Average:122.90 Median:122.00 stddev:15.84 (13.0%) stddev-sans-first:14.42 02:47:33 INFO - PROCESS | 1913 | Values: 146.0 110.0 132.0 151.0 113.0 112.0 111.0 111.0 131.0 112.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.35 (0.7%) stddev-sans-first:1.41 02:47:33 INFO - PROCESS | 1913 | Values: 185.0 185.0 185.0 184.0 186.0 181.0 185.0 184.0 185.0 184.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#3] audio-fft Cycles:10 Average:75.50 Median:78.00 stddev:15.76 (20.2%) stddev-sans-first:16.54 02:47:33 INFO - PROCESS | 1913 | Values: 82.0 59.0 63.0 108.0 86.0 82.0 82.0 59.0 74.0 60.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#4] audio-oscillator Cycles:10 Average:78.30 Median:72.50 stddev:11.88 (16.4%) stddev-sans-first:12.18 02:47:33 INFO - PROCESS | 1913 | Values: 87.0 72.0 86.0 71.0 69.0 69.0 83.0 68.0 73.0 105.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#5] imaging-gaussian-blur Cycles:10 Average:85.40 Median:86.00 stddev:1.65 (1.9%) stddev-sans-first:1.45 02:47:33 INFO - PROCESS | 1913 | Values: 88.0 84.0 87.0 85.0 86.0 83.0 86.0 84.0 87.0 84.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 02:47:33 INFO - PROCESS | 1913 | Values: 94.0 94.0 94.0 92.0 93.0 93.0 94.0 93.0 93.0 93.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 02:47:33 INFO - PROCESS | 1913 | Values: 85.0 85.0 85.0 85.0 85.0 86.0 87.0 86.0 87.0 87.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:59.00 stddev:0.97 (1.6%) stddev-sans-first:1.00 02:47:33 INFO - PROCESS | 1913 | Values: 59.0 59.0 59.0 56.0 59.0 59.0 59.0 58.0 58.0 58.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#9] json-stringify-tinderbox Cycles:10 Average:79.10 Median:70.50 stddev:16.54 (23.5%) stddev-sans-first:15.68 02:47:33 INFO - PROCESS | 1913 | Values: 58.0 79.0 103.0 111.0 87.0 70.0 71.0 70.0 70.0 72.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#10] stanford-crypto-aes Cycles:10 Average:91.30 Median:89.50 stddev:7.38 (8.2%) stddev-sans-first:7.82 02:47:33 INFO - PROCESS | 1913 | Values: 92.0 91.0 90.0 86.0 87.0 88.0 89.0 84.0 96.0 110.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:140.50 stddev:13.40 (9.5%) stddev-sans-first:14.11 02:47:33 INFO - PROCESS | 1913 | Values: 139.0 141.0 144.0 141.0 139.0 137.0 140.0 140.0 181.0 134.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.00 Median:176.00 stddev:2.11 (1.2%) stddev-sans-first:2.24 02:47:33 INFO - PROCESS | 1913 | Values: 175.0 176.0 176.0 175.0 176.0 173.0 171.0 173.0 178.0 177.0 02:47:33 INFO - PROCESS | 1913 | 02:47:33 INFO - PROCESS | 1913 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 02:47:33 INFO - PROCESS | 1913 | Values: 67.0 68.0 68.0 68.0 68.0 68.0 67.0 66.0 66.0 67.0 02:47:33 INFO - PROCESS | 1913 | -------- Summary: end -------- 02:47:33 INFO - PROCESS | 1913 | 02:47:34 INFO - TEST-INFO | 1913: exit 0 02:47:34 INFO - TEST-OK | kraken | took 59727ms 02:47:34 INFO - SUITE-END | took 1177s 02:47:34 INFO - Completed test suite (00:19:38) 02:47:34 INFO - javascript benchmark 02:47:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3302.8843990460336, 3324.9002529924096, 3328.0681409205417, 3343.9331213375717, 3388.474786408106, 5561.221428999933, 5627.577931655132, 5628.409017053206, 5637.041702910505, 5679.375268720442, 5632.746526406311, 5687.7156142192825, 5758.5393168546525, 5774.2782152230975, 5802.680852553108, 5112.769925353368, 5136.794528218867, 5153.742312884359, 5197.168453047513, 5270.631055826094, 5297.867553311159, 5298.947010529903, 5299.099153143975, 5314.973425132869, 5333.653312534692, 5093.745312734349, 5108.846734597968, 5254.448282930313, 5271.789128434877, 5283.788648454057, 5159.329287192641, 5182.222666600041, 5232.293640358579, 5238.188080847474, 5310.150375939869, 5194.844154675328, 5204.7918083277, 5215.295935048795, 5233.633645644806, 5233.738313084368, 5718.456746609066, 5728.112142617901, 5735.741891614887, 5742.167385729088, 5751.281089863767, 6112.208004058196, 6166.414190651925, 6206.875862482771, 6269.498440124779, 6274.937250627481, 6301.306856245809, 6355.968220158916, 6357.07822365759, 6371.458426033792, 6396.680165991728, 5881.323647780518, 5886.352501224862, 5886.941130588725, 5908.202392676976, 5931.911021334683, 6240.500759939194, 6253.0, 6286.5599408041, 6311.810645680637, 6339.587926784744, 6136.355682653347, 6197.287311959092, 6203.0, 6227.439530442282, 6228.190335256479, 6135.796305541688, 6328.240611126695, 6332.240131184288, 6337.081123237105, 6342.334054924258, 6117.857853872152, 6120.050983828535, 6177.567570270038, 6224.128621992924, 6233.750649974041, 6303.653299068504, 6304.621722696653, 6325.778597749057, 6326.335734747877, 6340.682965851689, 4953.752312384367, 4989.0, 4991.450940396553, 4992.251162325608, 4998.075356059141, 4322.502912165079, 4362.1493808707, 4364.54172311909, 4425.690201685916, 4492.932606010912, 5734.971325143431, 5779.8555036124435, 5782.971085144547, 5788.102844059177, 5825.446582574648, 5526.894621075801, 6321.462675672527, 6340.397662222082, 6354.269259035178, 6355.523335749837, 5475.315585551806, 5533.22534845122, 5755.798547050833, 5759.481646651738, 5803.941960580424, 5298.417174110845, 5383.730813459311, 5396.892062158735, 5407.107827208467, 5439.918401223985, 6334.0, 6343.429091381798, 6349.555531112777, 6350.333215012357, 6355.682215889095, 6297.4017468340435, 6302.905456418066, 6304.022876454157, 6306.46395056407, 6323.20959880015, 6257.092721555258, 6264.5301602379095, 6268.1851359323, 6293.370662933853, 6348.365163483615, 6243.406876346739, 6258.061290806233, 6268.404501572343, 6288.779892703734, 6297.622142671455, 6320.968395158179, 6325.493960483058, 6328.335524770017, 6331.620102793847, 6335.018072198816, 6003.189569408074, 6071.483923866521, 6071.7571297147615, 6101.7559297627595, 6131.938680613137, 6121.178620693132, 6136.55661555374, 6141.8637552053015, 6151.415615516519, 6168.599041062316, 5785.103308987113, 5797.971010145091, 5848.093545500455, 5928.67392293428, 5950.19672344228, 6045.153678485103, 6085.574009819447, 6089.54328425361, 6093.817185484442, 6129.172561704113, 5880.382559831327, 5954.19618351517, 5996.2504686914135, 6000.0, 6014.188084608697], "value": 5725.054876553839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.9977550112249, 474.90501899620074, 489.51293463004316, 490.6638952317665, 528.651090280415, 30723.539146912815, 33887.322253554914, 39642.60357396429, 41321.99999999996, 41427.58572414275, 41931.79034104833, 42213.7889310553, 42272.365914511305, 42320.0, 42327.0, 9126.726198214048, 9345.018773028836, 9348.57931393089, 9353.812923741521, 9369.0, 8296.626651800654, 8525.31797456202, 10986.945065274662, 11249.887501125007, 11280.887191128108, 11267.830982535268, 11352.035077018463, 11359.091272698164, 11386.259893106962, 11387.089032877391, 8319.8336033279, 10488.632897848538, 11234.32594044356, 11274.0, 11307.434628268553, 8408.537530435824, 10839.566417343296, 11118.22172447929, 11136.888631113747, 11319.660410187707, 39802.60197398047, 40137.79242141681, 40223.396649050286, 40224.79887600573, 40246.59136930193, 4024.979875100635, 4025.9798701006307, 4030.435738996543, 4036.2129384769983, 4187.769672668002, 28951.367781155124, 29773.553396699066, 30272.697273027206, 30575.929842455407, 30608.693913060808, 3094.938101237985, 3122.281875168724, 3273.2307907641684, 3312.287858110518, 3315.8673653053847, 471051.0, 477081.0, 477150.0, 477697.0, 478754.0, 58320.4167958315, 58465.0, 58877.0, 59084.0, 59097.40902591005, 59443.40556594465, 59483.70258148682, 59590.70204648949, 59672.0, 59697.0, 15268.541943741706, 15929.203539823195, 15933.840661593467, 15960.36158553668, 15961.281742321624, 11122.61070862516, 11411.60059397917, 12317.384130793425, 12386.81419778704, 12408.75182496345, 13775.311234438239, 15127.0, 15344.386224551115, 15463.690726185414, 15870.222711025524, 6258.499320054385, 6267.96866015667, 6294.583718663355, 6309.842253943596, 6337.081123237105, 854.7008547008497, 855.6449073634496, 862.3920136303891, 880.3881302494705, 903.4714691905177, 29187.7081229185, 29309.267268318035, 29592.408151836844, 29958.0, 29990.0, 952.4428209497521, 1046.1839764983324, 1047.554789214596, 1068.9572417103384, 1097.1497089755503, 14703.044302120541, 15277.770833437507, 15346.923265383824, 15542.923076157918, 15722.68554628901, 578723.0, 586055.0, 586923.0653846789, 588207.0, 590935.0, 58690.706546466994, 58740.0, 58866.7056664714, 58934.0, 59088.70455647694, 1410.4076287959083, 1450.7968884356198, 1458.176130486293, 1460.5180290503895, 1460.9415623374946, 26490.735092649596, 28855.56716649294, 29112.071334016375, 29181.70818291875, 29553.408931820813, 48091.5190848087, 48434.515654843, 48476.03047939092, 48481.0, 48484.0, 504900.0, 507245.0, 509800.0, 510068.4496577493, 510867.0, 25153.119640813216, 25375.492490150464, 25702.0, 25713.0, 25728.883378659324, 46173.0, 47121.0, 47160.52839471561, 47799.5220047809, 47894.0, 35863.64136358603, 36585.817070914476, 38193.42709859299, 39039.60960390473, 39600.40599390954, 27443.862780686766, 34734.826325868205, 34779.30441391208, 36003.639963601076, 36173.81913090418, 35060.12349691278, 35571.64428355787, 35795.64204357923, 35978.28043439064, 36024.81987590045, 29324.853375732986, 30126.0, 30702.385952280383, 30838.0, 31154.532682010242, 21560.353189404344, 23306.53386932286, 23644.645330319716, 23736.0, 24103.51792964166], "value": 19433.24494638124, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.53061142959865, 398.7149188330345, 401.41994817488734, 409.48813982521847, 428.66992415839803, 14443.71112577749, 16628.334866605335, 21213.787862121393, 21601.67597486039, 21844.12623495062, 21284.36146915595, 21493.462663433424, 22030.0, 22070.88964555179, 22422.439439014033, 5238.423773384944, 5937.0, 6085.265699275707, 6183.969080154616, 6196.535259855506, 4240.448741663579, 4472.619827314666, 6010.12853136295, 6116.571839971204, 6119.1739115219325, 6440.5491615586925, 6730.394264516192, 6804.693788779517, 6846.760363387282, 6880.139982502187, 6575.473962083021, 6749.392554670054, 6820.31796820319, 6828.897566536506, 6887.414569761526, 5710.8001219957105, 5967.552433567456, 5968.164456975984, 5971.0, 5990.251218597676, 26772.866135669196, 26980.0, 27070.0, 27325.770340334733, 27416.177514674593, 2418.9395265118337, 2725.6592925884265, 2755.4626847764694, 2757.393373457836, 2763.585462180669, 14248.715025699428, 16028.75956860648, 16049.197540122947, 16109.83890161095, 16385.262663180187, 1675.8156602773686, 1892.630936967292, 1901.372547059481, 1902.1630482587618, 1933.1107690462404, 126204.84487887785, 129792.35103824515, 130372.0, 133738.0, 134050.0, 11373.952688515981, 11387.943060284646, 11481.885181148082, 11497.712557186138, 11603.825942610867, 14911.701765964837, 14918.552443426715, 14929.70140597182, 14944.70110597782, 14954.401823927139, 8521.0, 8810.691625793066, 8821.250193733476, 8940.32947528938, 8958.731238062868, 8359.874601880976, 8705.173008564176, 8709.433886797338, 8897.243734282529, 8899.243564296978, 7336.523125996793, 7456.3662088721985, 7487.41684118989, 7517.962410188024, 7538.962305188439, 1654.3465331194352, 1837.4579499047813, 1927.7686677598779, 1958.1677786940493, 1966.8819870807797, 797.314309693663, 820.6553247635887, 895.3642913531465, 895.8790563273875, 897.2014906733012, 21964.45088872759, 22194.0, 22228.88885555562, 22411.32766017022, 22772.544549108927, 691.9550229235184, 861.2765277167209, 917.4816228830689, 926.6108234541508, 935.933036338561, 11546.0, 11645.6506304811, 11793.157902577877, 11889.70275743096, 11895.643130706092, 696154.0, 696613.0, 707547.7074907061, 708124.0, 726583.0, 87971.0, 125362.0, 125981.0, 126268.0, 128383.0, 998.0936411454088, 1000.0699349604791, 1041.317936751429, 1041.4948749856314, 1048.8217003109337, 19329.0, 19493.8050619492, 19734.0, 19741.901290493457, 20080.39758807238, 55363.44636553583, 55727.72136139456, 56011.159832603356, 56069.0, 57169.71415143064, 83554.0, 83867.5806620963, 86434.13565864513, 87306.21366115747, 95432.0, 8192.139825318256, 8359.122292159478, 8710.259627931697, 8736.039035706195, 8752.431091979, 12586.370681465707, 13423.865761342653, 13563.0, 13959.441622334993, 14007.949403794551, 11395.373254471084, 11480.425978701198, 11923.701907452383, 11953.282803031845, 12091.395430228278, 11416.94291528537, 11423.371714555778, 11551.884481155417, 11705.356205408785, 11947.641570752892, 11495.195336326376, 11628.825567616661, 12068.155229133876, 12103.818442723543, 12117.75764484723, 7094.361507464353, 7413.666385012795, 8072.838543228985, 8359.832803344021, 8524.977002759708, 7001.264867188872, 10448.68653940383, 11649.650510484698, 11932.821007684717, 12005.81991270149], "value": 10181.885595591886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.856214378563, 1452.5351887396032, 1459.5256541623976, 1483.1471903655402, 1490.6422458609934, 8116.8782468263025, 8515.744527664172, 8533.18934701204, 8535.743927682171, 8543.743687689364, 7437.293457121578, 7697.807554811133, 7728.961355193216, 8125.91874081259, 8380.245777879989, 2293.3463962770616, 2328.3946173994714, 2333.591621466245, 2334.3930578049744, 2337.742848286687, 2319.547688200793, 2351.811855051592, 2354.81161507079, 2357.446000189954, 2359.528094381122, 2292.33522278539, 2296.9655455168186, 2309.3418375762913, 2340.625499920013, 2342.156823543523, 2168.739751229855, 2186.835987300959, 2189.627763280246, 2191.233068426054, 2201.0315461197024, 2105.3789132206034, 2251.133313674231, 2257.0407576779967, 2263.9434014149615, 2273.9204127855446, 8493.405461617689, 8549.059603443678, 8550.657973681045, 8556.315494760403, 8592.0, 5051.0, 5225.085610018232, 5227.529522343008, 5227.973860130675, 5240.659357141773, 3270.725065584076, 3313.867445302185, 3444.9311013779834, 3500.562429696288, 3502.2995400919663, 1192.8926396624258, 1195.2231049817688, 1195.7907366210877, 1223.2354778263584, 1252.1360261419682, 10570.154387648892, 10834.133269338434, 10930.485988222674, 10932.305492648653, 10940.343579385182, 4377.715448495837, 4611.584957353854, 4616.0, 4698.553637404441, 4719.457262414798, 9613.855792163124, 9622.51887405641, 9625.32622716417, 9638.325317227727, 9643.0, 5273.077211487975, 5274.630775845654, 5274.657147285491, 5279.656822306538, 5297.496737809902, 4024.6981476389387, 4195.643370313496, 4772.427308722976, 4852.490488498727, 4872.78072486739, 3800.315943130208, 3815.008097894512, 3881.029742564359, 3886.106195575034, 3922.0391004204153, 1081.3457857995957, 1246.4827096754746, 1265.221888538542, 1267.33464930912, 1277.1251692590606, 702.6592102830124, 880.2649787427441, 925.6667599664115, 936.8828896387952, 951.5242378810594, 5697.943020569741, 5745.253117094751, 5762.30852297727, 5773.509251713652, 6026.246719160105, 981.9165370943407, 995.1889210293588, 995.5121990224883, 997.3218211616025, 1010.7473131717071, 3714.832832522543, 3779.5842457329672, 3869.245497128033, 3964.742291751027, 3987.401889716508, 9545.952270238604, 10161.796764064677, 10238.18094552434, 10297.588096476056, 10344.896551034393, 8223.424360294723, 9942.502874856229, 10034.849477257847, 10066.547005384775, 10243.183124640784, 7764.107127680276, 7998.160193179749, 8004.559749213733, 8023.959880200561, 8024.919750802534, 5374.355077390738, 5443.945560544344, 5473.425290344457, 5475.342958844964, 5535.972320138373, 7730.536167829948, 9144.817103657757, 9196.172344489029, 9289.86065209036, 9491.952540237255, 9423.528823558932, 9531.952340238255, 9594.66418675343, 9616.326857120213, 9653.517324133625, 5466.742649190788, 6579.046038324512, 6599.571027883172, 6832.487563432663, 6962.408195303456, 7800.609969501389, 8051.1546287641295, 8097.8380432392205, 8197.549134797644, 8222.876656850032, 7032.613206273704, 7114.110736157981, 7294.088238970129, 7355.8161045974275, 7405.2224516425, 7050.189228238818, 7148.535345202546, 7168.0, 7302.890456643048, 7359.337659610446, 6359.07793369968, 6441.291457939717, 6509.707063182263, 6511.2512061113575, 6517.641529715911, 4666.929996049994, 4938.308636790924, 4968.342904469964, 5094.847154585368, 5118.3090282811345, 4976.427710813303, 5006.69959802413, 5169.302144210634, 5188.481151884781, 5272.894542109059], "value": 4435.516757015778, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.84791463627954, 362.8330967754833, 369.1896287648611, 380.04797981057465, 382.96744776694015, 4205.85279515217, 4373.4095897053885, 5226.111561034624, 5227.660202086867, 5323.787048518055, 4708.646851486135, 4955.876103097425, 5102.948970510303, 5117.923231151526, 5252.579793616511, 3439.0, 3532.629073947237, 3605.387084195693, 4101.323281658538, 4122.814473348706, 3376.1390845334404, 3875.186210895701, 4063.634272915437, 4092.529359123709, 4116.917661646765, 3748.83130259139, 3753.774773513598, 3925.2934471795065, 4110.4656394668655, 4144.233316836395, 3375.8480868360984, 3867.8839634811, 3900.902477438058, 3942.172143849795, 3978.930955902929, 2977.344984103494, 3412.9829350853333, 3439.208981934169, 3440.2947395783804, 3455.531399155349, 4322.0, 4981.9750901245625, 5031.77357018935, 5042.773075211588, 5069.619778516626, 4385.978070109661, 4403.207422663919, 4499.6400287976885, 4529.184746745585, 4548.909021819545, 5165.690058596496, 5490.325450737523, 5495.890082198373, 5514.283143191399, 5521.613487055867, 3342.381659392996, 3500.8249587520777, 3607.971728057491, 3762.5484941806885, 3818.579956204815, 4873.610111191097, 5316.6544174628525, 5358.008768377863, 5728.971355143198, 5875.618084824473, 3236.336551007038, 3454.5336379588434, 3518.3315170117594, 3579.89023402746, 3767.981160094182, 3437.4703257050874, 3497.880678182957, 3615.37885033354, 3813.1992281620614, 3834.367329390675, 3964.920701585952, 4069.877903662895, 4146.212219678251, 4445.266531022345, 4461.754603496839, 5169.870753231199, 5524.696141712245, 5533.1976863354585, 5566.944330556724, 5609.214709940612, 1144.9370284634258, 1226.3566820460626, 1235.7960936445386, 1242.372601836085, 1243.5150291386367, 711.32424197012, 738.9963050184822, 796.74902405742, 837.9525593008739, 851.8083431228048, 4577.656675749266, 4774.665773395829, 4813.326134341195, 4851.975740121276, 4881.219004959189, 4624.838130665411, 4860.781264843091, 5334.973325133427, 5343.782330332946, 5399.326208875261, 4574.359589657451, 4688.89721493693, 4769.284607308862, 4810.903781924412, 4848.927266091011, 2359.8702071385896, 2764.4471105778925, 2781.276868014331, 2803.8598070096414, 2819.182437093261, 4276.636485898671, 5053.184845441741, 5403.540699040547, 5470.8085217017215, 5474.39781624021, 4317.676174286941, 5215.739213039333, 5226.817061402909, 5244.763985620656, 5359.472550323139, 4462.482755863022, 5397.379301380313, 5419.972900135474, 5469.617126801086, 5474.534664553557, 4400.493943196573, 4707.128651522637, 4915.18899381598, 5009.847735020892, 5286.577073834161, 4315.805788739452, 4536.909261814679, 4969.950300496948, 5216.295800066942, 5247.580193584427, 4762.714237145782, 4890.24201248807, 5273.34083239595, 5423.945760542502, 5464.3442786865835, 3029.6518049467777, 3270.6402295747926, 3345.7750595853486, 3572.4102774266244, 3574.8531703224135, 4816.494268101939, 4949.455559888482, 4997.550220480029, 5013.774380152829, 5314.681119132864, 4629.911970686953, 4630.467496237976, 5090.440051594395, 5119.48805119485, 5149.138146390207, 4580.625812256243, 4744.762761861962, 4781.521847815191, 5122.948770512397, 5143.627916271289, 4457.933131002973, 4765.166095933268, 4963.801447942042, 4987.501249874984, 5036.974815125901, 4440.555944405663, 5109.0, 5281.940043383161, 5364.356277246756, 5420.4850539198715, 4945.9366236259375, 4995.8751031223055, 5183.688978661293, 5327.334083239595, 5327.48166772468], "value": 3850.4088408161815, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.4790950515627, 755.6108604068902, 774.3069952392609, 809.4333966223643, 812.46377390922, 14767.630809229775, 15728.921355393235, 15751.0, 15779.447719329826, 15795.447159349425, 14436.566902992927, 14622.48821291255, 14642.707145857103, 14654.853451465482, 14659.560213193594, 677.3159109299594, 700.1493185779277, 702.8242939265184, 857.695518091078, 884.8186121845006, 877.9473231606092, 884.783228109111, 885.8804061451686, 887.8002449448887, 891.1623074310128, 945.0313428735533, 946.8343039968013, 947.4694171264114, 948.9335746497748, 950.1591091883664, 716.4984510842431, 734.5225603357807, 740.1968863782802, 742.3838214282187, 947.981040379192, 545.7135004122828, 685.8765422223997, 702.7329614746363, 710.1620088295809, 712.7790384980673, 15017.774733379008, 15243.542693719206, 15281.61795955099, 15293.235338233044, 15317.770233446396, 12511.0, 12880.484780608764, 12935.870641293655, 13449.05856590039, 13826.0, 12469.0, 12552.435140418704, 12648.810267845989, 12667.049971252192, 12880.80678789819, 4456.77716114193, 4458.955410445887, 4462.709923854939, 4479.440069991251, 4650.162970665279, 104669.42995855068, 106652.0, 106753.46623266835, 106830.46584767026, 107583.46208268909, 9071.818563628822, 10639.308444951053, 10792.94603526993, 10813.243072984815, 10987.835182472269, 20609.0, 21083.262085826922, 21170.470738231666, 21239.93800310009, 21252.468688282916, 7477.85044299111, 7553.244675532403, 7639.809004774925, 7652.196519365387, 7761.495502792301, 4205.432266643964, 4215.641670457984, 4270.701050926467, 4295.656347492193, 4374.868753937387, 3448.620651728308, 3449.706774924109, 3469.271452994849, 3511.719062474996, 3528.9823550882593, 599.637219482207, 604.6251324179037, 617.0651463033507, 622.5175488995974, 624.4255285137684, 539.4255118299077, 542.9837104886859, 549.4587830986555, 559.725734390154, 565.7538970547743, 9678.564464598969, 9696.127348538665, 9738.853917191247, 9931.702048938543, 9954.552045157985, 622.8411755002445, 651.3356376495948, 654.4927681047227, 657.9309172536911, 671.358852296056, 4734.218853889139, 4779.354787103766, 4781.737004464788, 4785.688930219525, 4797.352357431771, 105961.41057884137, 107565.4621726902, 107922.8415431687, 108319.91680083257, 110472.4476377629, 94368.52815735877, 94443.52778236064, 97376.51311743537, 98294.0, 99432.50851237237, 70120.0, 70910.0, 73718.63140684263, 76580.0, 78560.60719696365, 9171.31215158879, 10495.265331426726, 11014.779704406028, 11223.66329010131, 11292.49183786748, 44898.0, 45813.541864580926, 52404.567177906814, 54450.45549544612, 55091.724541377036, 59115.704421479335, 65985.0, 67176.65646687137, 67237.66381168063, 69433.0, 13759.931200343934, 13920.721585568435, 13973.580792576238, 14242.643933901736, 14505.419783208554, 14801.259937003322, 14937.103773773608, 14956.0, 15432.074075555503, 15522.611934701272, 13964.790528141883, 14029.579112626638, 14091.506797262047, 14112.082714623517, 14143.929280353532, 13527.188368697909, 13683.726325473634, 13802.930985345009, 13991.300434978413, 14527.34626941769, 13474.393652285475, 13931.0, 13971.930140349234, 14232.273253262008, 14315.642108947359, 10884.292520986111, 10938.835917461403, 10948.343099413742, 11592.6522204334, 11924.284542927453, 10795.19036072282, 10934.850933463036, 10969.780604388026, 11098.61154859576, 11113.499892505019], "value": 7529.684682348179, "unit": "score"}], "name": "dromaeo_css", "value": 7253.9046546356685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 111.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 132.0, 151.0, 113.0, 112.0, 111.0, 111.0, 131.0, 112.0], "value": 122.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 185.0, 184.0, 186.0, 181.0, 185.0, 184.0, 185.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 63.0, 108.0, 86.0, 82.0, 82.0, 59.0, 74.0, 60.0], "value": 75.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 86.0, 71.0, 69.0, 69.0, 83.0, 68.0, 73.0, 105.0], "value": 78.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 86.0, 83.0, 86.0, 84.0, 87.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 92.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 87.0, 86.0, 87.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 56.0, 59.0, 59.0, 59.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 79.0, 103.0, 111.0, 87.0, 70.0, 71.0, 70.0, 70.0, 72.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 90.0, 86.0, 87.0, 88.0, 89.0, 84.0, 96.0, 110.0], "value": 91.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 144.0, 141.0, 139.0, 137.0, 140.0, 140.0, 181.0, 134.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 176.0, 175.0, 176.0, 173.0, 171.0, 173.0, 178.0, 177.0], "value": 175.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 66.0, 66.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1454.2999999999997, "alertThreshold": 2.0}]} 02:47:34 INFO - Return code: 0 02:47:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:47:34 ERROR - # TBPL SUCCESS # 02:47:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:47:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:47:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:47:34 INFO - 2017-01-13 02:47:34.792 screenresolution[1917:11848] starting screenresolution argv=screenresolution get 02:47:34 INFO - 2017-01-13 02:47:34.795 screenresolution[1917:11848] Display 0: 1600x1200x32@60 02:47:34 INFO - 2017-01-13 02:47:34.802 screenresolution[1918:11851] starting screenresolution argv=screenresolution list 02:47:34 INFO - Available Modes on Display 0 02:47:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:47:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:47:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:47:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:47:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:47:35 INFO - Intel Iris: 02:47:35 INFO - Chipset Model: Intel Iris 02:47:35 INFO - Type: GPU 02:47:35 INFO - Bus: Built-In 02:47:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:47:35 INFO - Vendor: Intel (0x8086) 02:47:35 INFO - Device ID: 0x0a2e 02:47:35 INFO - Revision ID: 0x0009 02:47:35 INFO - Displays: 02:47:35 INFO - Display: 02:47:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:47:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:47:35 INFO - Display Serial Number: 1600x1200 60 02:47:35 INFO - Main Display: Yes 02:47:35 INFO - Mirror: Off 02:47:35 INFO - Online: Yes 02:47:35 INFO - Rotation: Supported 02:47:35 INFO - Return code: 0 02:47:35 INFO - Running post-action listener: _resource_record_post_action 02:47:35 INFO - [mozharness: 2017-01-13 10:47:35.035899Z] Finished run-tests step (success) 02:47:35 INFO - Running post-run listener: _resource_record_post_run 02:47:35 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 29265920; Write bytes: 550394368; Read time: 269; Write time: 2021 02:47:35 INFO - TinderboxPrint: CPU usage
53.7% 02:47:35 INFO - TinderboxPrint: I/O read bytes / time
29,265,920 / 269 02:47:35 INFO - TinderboxPrint: I/O write bytes / time
550,394,368 / 2,021 02:47:35 INFO - TinderboxPrint: CPU idle
2,224.8 (46.3%) 02:47:35 INFO - TinderboxPrint: CPU system
954.9 (19.9%) 02:47:35 INFO - TinderboxPrint: CPU user
1,622.2 (33.8%) 02:47:35 INFO - TinderboxPrint: Swap in / out
274,202,624 / 0 02:47:35 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252230144; Write bytes: 253222400; Read time: 18155; Write time: 518 02:47:35 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 28364800; Write bytes: 295660544; Read time: 265; Write time: 1497 02:47:35 INFO - Running post-run listener: _upload_blobber_files 02:47:35 INFO - Blob upload gear active. 02:47:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:47:35 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 02:47:35 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'] 02:47:35 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 02:47:35 INFO - (blobuploader) - INFO - Open directory for files ... 02:47:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:47:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:47:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:36 INFO - (blobuploader) - INFO - Done attempting. 02:47:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:47:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:47:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:37 INFO - (blobuploader) - INFO - Done attempting. 02:47:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:47:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:47:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:38 INFO - (blobuploader) - INFO - Done attempting. 02:47:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:47:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:47:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:40 INFO - (blobuploader) - INFO - Done attempting. 02:47:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:47:40 INFO - Return code: 0 02:47:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:47:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:47:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0888fac03795f0e72a5bdc127e27396da36ee2bed0ab516f939cdfb76d81d23a1471ac5767d5ba34cabbd7642d91d455914c08472791fe83bd6035dbd38c4ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fe9df3f1d19825f63a48ea532c24088ac4569461ce18ff2e3f761cfbc962f2365164808433d2b4d35865f7bebadc7590f0f124eb8798e3df94eddc2508e0ddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22df2796c3ae41eaf833d1d37aa1df0b63f548bd5cc6513eabd616500ff27304000f1580d1ad1a56f3675e1695860cda94f763009e4f5c649a527f9cd6c21f81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe08b15e8dd42add374c5e609ff680a383abf2ce2889169090e0e68f1b003713b8a5d8e371607da91f4c16a9fe803ca6317cfef08689f090f9f27a623cc7073"} 02:47:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:47:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:47:40 INFO - Contents: 02:47:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0888fac03795f0e72a5bdc127e27396da36ee2bed0ab516f939cdfb76d81d23a1471ac5767d5ba34cabbd7642d91d455914c08472791fe83bd6035dbd38c4ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fe9df3f1d19825f63a48ea532c24088ac4569461ce18ff2e3f761cfbc962f2365164808433d2b4d35865f7bebadc7590f0f124eb8798e3df94eddc2508e0ddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22df2796c3ae41eaf833d1d37aa1df0b63f548bd5cc6513eabd616500ff27304000f1580d1ad1a56f3675e1695860cda94f763009e4f5c649a527f9cd6c21f81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe08b15e8dd42add374c5e609ff680a383abf2ce2889169090e0e68f1b003713b8a5d8e371607da91f4c16a9fe803ca6317cfef08689f090f9f27a623cc7073"} 02:47:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:47:40 INFO - Copying logs to upload dir... 02:47:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:47:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.144749 ========= master_lag: 0.77 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-13 02:47:41.670384) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 02:47:41.674190) ========= 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.gIqeMUHUcw/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.icz1TK8hbT/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0888fac03795f0e72a5bdc127e27396da36ee2bed0ab516f939cdfb76d81d23a1471ac5767d5ba34cabbd7642d91d455914c08472791fe83bd6035dbd38c4ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fe9df3f1d19825f63a48ea532c24088ac4569461ce18ff2e3f761cfbc962f2365164808433d2b4d35865f7bebadc7590f0f124eb8798e3df94eddc2508e0ddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22df2796c3ae41eaf833d1d37aa1df0b63f548bd5cc6513eabd616500ff27304000f1580d1ad1a56f3675e1695860cda94f763009e4f5c649a527f9cd6c21f81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe08b15e8dd42add374c5e609ff680a383abf2ce2889169090e0e68f1b003713b8a5d8e371607da91f4c16a9fe803ca6317cfef08689f090f9f27a623cc7073"} build_url:https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011140 build_url: 'https://queue.taskcluster.net/v1/task/ZemnR4nPR9a-IsghIsq2CA/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/0888fac03795f0e72a5bdc127e27396da36ee2bed0ab516f939cdfb76d81d23a1471ac5767d5ba34cabbd7642d91d455914c08472791fe83bd6035dbd38c4ba1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fe9df3f1d19825f63a48ea532c24088ac4569461ce18ff2e3f761cfbc962f2365164808433d2b4d35865f7bebadc7590f0f124eb8798e3df94eddc2508e0ddf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22df2796c3ae41eaf833d1d37aa1df0b63f548bd5cc6513eabd616500ff27304000f1580d1ad1a56f3675e1695860cda94f763009e4f5c649a527f9cd6c21f81", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe08b15e8dd42add374c5e609ff680a383abf2ce2889169090e0e68f1b003713b8a5d8e371607da91f4c16a9fe803ca6317cfef08689f090f9f27a623cc7073"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-13 02:47:41.713725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:47:41.714063) ========= 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.gIqeMUHUcw/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.icz1TK8hbT/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005362 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-13 02:47:41.763119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 02:47:41.763441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-13 02:47:41.763766) ========= ========= Total master_lag: 1.07 =========