builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0352 starttime: 1495649857.05 results: success (0) buildid: 20170524100420 builduid: a63016b17b0241788f1571fb9c75c496 revision: f7c942b561d57638df5c1c2542dd3d946dc71907 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.049875) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.050380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.050694) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.076880) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.077330) ========= 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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-05-24 11:17:37-- 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% 16.3M=0.001s 2017-05-24 11:17:37 (16.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133616 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.234674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.235041) ========= 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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.028139 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:37.285872) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 11:17:37.286282) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f7c942b561d57638df5c1c2542dd3d946dc71907 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f7c942b561d57638df5c1c2542dd3d946dc71907 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zWYYyIVtQk/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.WPYjcXPpBg/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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-05-24 11:17:37,384 truncating revision to first 12 chars 2017-05-24 11:17:37,384 Setting DEBUG logging. 2017-05-24 11:17:37,384 attempt 1/10 2017-05-24 11:17:37,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f7c942b561d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 11:17:38,293 unpacking tar archive at: mozilla-beta-f7c942b561d5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.179675 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 11:17:38.489134) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:38.489501) ========= script_repo_revision: f7c942b561d57638df5c1c2542dd3d946dc71907 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:38.489941) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:38.490263) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 11:17:38.509714) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-24 11:17:38.510169) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zWYYyIVtQk/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.WPYjcXPpBg/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:17:38 INFO - MultiFileLogger online at 20170524 11:17:38 in /builds/slave/test 11:17:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 11:17:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:17:38 INFO - {'append_to_log': False, 11:17:38 INFO - 'base_work_dir': '/builds/slave/test', 11:17:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 11:17:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:17:38 INFO - 'branch': 'Mozilla-Beta', 11:17:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:17:38 INFO - 'config_files': ('talos/mac_config.py',), 11:17:38 INFO - 'default_actions': ('clobber', 11:17:38 INFO - 'read-buildbot-config', 11:17:38 INFO - 'download-and-extract', 11:17:38 INFO - 'populate-webroot', 11:17:38 INFO - 'create-virtualenv', 11:17:38 INFO - 'install', 11:17:38 INFO - 'run-tests'), 11:17:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:17:38 INFO - 'download_minidump_stackwalk': True, 11:17:38 INFO - 'download_symbols': 'ondemand', 11:17:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:17:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:17:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:17:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:17:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:17:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:17:38 INFO - 'gecko_profile': False, 11:17:38 INFO - 'gecko_profile_interval': 0, 11:17:38 INFO - 'installer_path': 'installer.exe', 11:17:38 INFO - 'log_level': 'info', 11:17:38 INFO - 'log_name': 'talos', 11:17:38 INFO - 'log_to_console': True, 11:17:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:17:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:17:38 INFO - 'opt_config_files': (), 11:17:38 INFO - 'pip_index': False, 11:17:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:17:38 INFO - 'cmd': ('bash', 11:17:38 INFO - '-c', 11:17:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:17:38 INFO - 'enabled': True, 11:17:38 INFO - 'halt_on_failure': False, 11:17:38 INFO - 'name': 'check_screen_resolution'},), 11:17:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:17:38 INFO - 'cmd': ('bash', 11:17:38 INFO - '-c', 11:17:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:17:38 INFO - 'enabled': True, 11:17:38 INFO - 'halt_on_failure': False, 11:17:38 INFO - 'name': 'check_screen_resolution'},), 11:17:38 INFO - 'run_cmd_checks_enabled': True, 11:17:38 INFO - 'suite': 'dromaeojs', 11:17:38 INFO - 'system_bits': '32', 11:17:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:17:38 INFO - 'title': 't-yosemite-r7-0352', 11:17:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:17:38 INFO - 'use_talos_json': True, 11:17:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:17:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:17:38 INFO - 'work_dir': 'build'} 11:17:38 INFO - [mozharness: 2017-05-24 18:17:38.714409Z] Running clobber step. 11:17:38 INFO - Running pre-action listener: _resource_record_pre_action 11:17:38 INFO - Running main action method: clobber 11:17:38 INFO - rmtree: /builds/slave/test/build 11:17:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:17:41 INFO - Running post-action listener: _resource_record_post_action 11:17:41 INFO - [mozharness: 2017-05-24 18:17:41.284677Z] Finished clobber step (success) 11:17:41 INFO - [mozharness: 2017-05-24 18:17:41.284807Z] Running read-buildbot-config step. 11:17:41 INFO - Running pre-action listener: _resource_record_pre_action 11:17:41 INFO - Running main action method: read_buildbot_config 11:17:41 INFO - Using buildbot properties: 11:17:41 INFO - { 11:17:41 INFO - "project": "", 11:17:41 INFO - "product": "firefox", 11:17:41 INFO - "script_repo_revision": "production", 11:17:41 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 11:17:41 INFO - "repository": "", 11:17:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 11:17:41 INFO - "buildid": "20170524100420", 11:17:41 INFO - "pgo_build": "False", 11:17:41 INFO - "basedir": "/builds/slave/test", 11:17:41 INFO - "buildnumber": 4, 11:17:41 INFO - "slavename": "t-yosemite-r7-0352", 11:17:41 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:17:41 INFO - "platform": "yosemite_r7", 11:17:41 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 11:17:41 INFO - "branch": "mozilla-beta", 11:17:41 INFO - "repo_path": "releases/mozilla-beta", 11:17:41 INFO - "revision": "f7c942b561d57638df5c1c2542dd3d946dc71907", 11:17:41 INFO - "stage_platform": "macosx64", 11:17:41 INFO - "builduid": "a63016b17b0241788f1571fb9c75c496", 11:17:41 INFO - "slavebuilddir": "test" 11:17:41 INFO - } 11:17:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 11:17:41 INFO - Running post-action listener: _resource_record_post_action 11:17:41 INFO - [mozharness: 2017-05-24 18:17:41.288081Z] Finished read-buildbot-config step (success) 11:17:41 INFO - [mozharness: 2017-05-24 18:17:41.288223Z] Running download-and-extract step. 11:17:41 INFO - Running pre-action listener: _resource_record_pre_action 11:17:41 INFO - Running main action method: download_and_extract 11:17:41 INFO - mkdir: /builds/slave/test/build/tests 11:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:17:41 INFO - trying https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 11:17:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:17:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 11:17:42 INFO - Downloaded 1287 bytes. 11:17:42 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 11:17:42 INFO - Using the following test package requirements: 11:17:42 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 11:17:42 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:17:42 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 11:17:42 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 11:17:42 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 11:17:42 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 11:17:42 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 11:17:42 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 11:17:42 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 11:17:42 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 11:17:42 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 11:17:42 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 11:17:42 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 11:17:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:17:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:17:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:17:43 INFO - Expected file size: 51393554 11:17:43 INFO - Obtained file size: 51393554 11:17:59 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 11:17:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 11:17:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 11:17:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 11:18:01 INFO - Expected file size: 51393554 11:18:01 INFO - Obtained file size: 51393554 11:18:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 11:18:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 11:18:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 11:18:17 INFO - Expected file size: 14404449 11:18:17 INFO - Obtained file size: 14404449 11:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:17 INFO - trying https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:18:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 11:18:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 11:18:19 INFO - Downloaded 59645134 bytes. 11:18:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:18:19 INFO - mkdir: /builds/slave/test/properties 11:18:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:19 INFO - Contents: 11:18:19 INFO - build_url:https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg 11:18:20 INFO - Running post-action listener: _resource_record_post_action 11:18:20 INFO - Running post-action listener: set_extra_try_arguments 11:18:20 INFO - [mozharness: 2017-05-24 18:18:20.231774Z] Finished download-and-extract step (success) 11:18:20 INFO - [mozharness: 2017-05-24 18:18:20.231896Z] Running populate-webroot step. 11:18:20 INFO - Running pre-action listener: _resource_record_pre_action 11:18:20 INFO - Running main action method: populate_webroot 11:18:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:20 INFO - '--tppagecycles', 11:18:20 INFO - '7'], 11:18:20 INFO - 'tests': ['tsvgm']}}, 11:18:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:18:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:18:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:18:20 INFO - 'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:18:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:18:20 INFO - 'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['damp', 'tps']}, 11:18:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:18:20 INFO - 'tests': ['damp', 'tps']}, 11:18:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['dromaeo_dom']}, 11:18:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['basic_compositor_video']}, 11:18:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:18:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['a11yr', 11:18:20 INFO - 'ts_paint', 11:18:20 INFO - 'tpaint', 11:18:20 INFO - 'sessionrestore', 11:18:20 INFO - 'sessionrestore_no_auto_restore', 11:18:20 INFO - 'tabpaint']}, 11:18:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:18:20 INFO - 'ts_paint', 11:18:20 INFO - 'tpaint', 11:18:20 INFO - 'sessionrestore', 11:18:20 INFO - 'sessionrestore_no_auto_restore', 11:18:20 INFO - 'tabpaint']}, 11:18:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:18:20 INFO - 'ts_paint', 11:18:20 INFO - 'tpaint', 11:18:20 INFO - 'sessionrestore', 11:18:20 INFO - 'sessionrestore_no_auto_restore', 11:18:20 INFO - 'tabpaint']}, 11:18:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:18:20 INFO - 'ts_paint', 11:18:20 INFO - 'tpaint', 11:18:20 INFO - 'sessionrestore', 11:18:20 INFO - 'sessionrestore_no_auto_restore', 11:18:20 INFO - 'tabpaint']}, 11:18:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['a11yr', 11:18:20 INFO - 'ts_paint', 11:18:20 INFO - 'tpaint', 11:18:20 INFO - 'sessionrestore', 11:18:20 INFO - 'sessionrestore_no_auto_restore', 11:18:20 INFO - 'tabpaint']}, 11:18:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['a11yr', 11:18:20 INFO - 'ts_paint', 11:18:20 INFO - 'tpaint', 11:18:20 INFO - 'sessionrestore', 11:18:20 INFO - 'sessionrestore_no_auto_restore', 11:18:20 INFO - 'tabpaint']}, 11:18:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['tsvgx', 11:18:20 INFO - 'tsvgr_opacity', 11:18:20 INFO - 'tart', 11:18:20 INFO - 'tscrollx', 11:18:20 INFO - 'cart', 11:18:20 INFO - 'tsvg_static']}, 11:18:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:18:20 INFO - 'tsvgr_opacity', 11:18:20 INFO - 'tart', 11:18:20 INFO - 'tscrollx', 11:18:20 INFO - 'cart', 11:18:20 INFO - 'tsvg_static']}, 11:18:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:18:20 INFO - 'talos_options': ['--disable-e10s'], 11:18:20 INFO - 'tests': ['tp5o']}, 11:18:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:18:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:18:20 INFO - 'talos_options': ['--disable-e10s', 11:18:20 INFO - '--xperf_path', 11:18:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:20 INFO - 'tests': ['tp5n']}, 11:18:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:18:20 INFO - 'talos_options': ['--xperf_path', 11:18:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:20 INFO - 'tests': ['tp5n']}}, 11:18:20 INFO - 'talos.zip': {'path': '', 11:18:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:20 INFO - Running post-action listener: _resource_record_post_action 11:18:20 INFO - [mozharness: 2017-05-24 18:18:20.250721Z] Finished populate-webroot step (success) 11:18:20 INFO - [mozharness: 2017-05-24 18:18:20.250836Z] Running create-virtualenv step. 11:18:20 INFO - Running pre-action listener: _resource_record_pre_action 11:18:20 INFO - Running main action method: create_virtualenv 11:18:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:20 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 11:18:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:20 INFO - Using real prefix '/tools/python27' 11:18:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:23 INFO - Installing pip.................done. 11:18:23 INFO - Return code: 0 11:18:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:18:24 INFO - Reading from file tmpfile_stdout 11:18:24 INFO - Output received: 11:18:24 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) 11:18:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:24 INFO - 'HOME': '/Users/cltbld', 11:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:24 INFO - 'LOGNAME': 'cltbld', 11:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:24 INFO - 'MOZ_NO_REMOTE': '1', 11:18:24 INFO - 'NO_EM_RESTART': '1', 11:18:24 INFO - 'PAGER': '/bin/cat', 11:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:24 INFO - 'PWD': '/builds/slave/test', 11:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:24 INFO - 'SHELL': '/bin/bash', 11:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:24 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:24 INFO - 'USER': 'cltbld', 11:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:24 INFO - 'XPC_FLAGS': '0x0', 11:18:24 INFO - 'XPC_SERVICE_NAME': '0', 11:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:24 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 11:18:24 INFO - Cleaning up... 11:18:24 INFO - Return code: 0 11:18:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:24 INFO - 'HOME': '/Users/cltbld', 11:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:24 INFO - 'LOGNAME': 'cltbld', 11:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:24 INFO - 'MOZ_NO_REMOTE': '1', 11:18:24 INFO - 'NO_EM_RESTART': '1', 11:18:24 INFO - 'PAGER': '/bin/cat', 11:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:24 INFO - 'PWD': '/builds/slave/test', 11:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:24 INFO - 'SHELL': '/bin/bash', 11:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:24 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:24 INFO - 'USER': 'cltbld', 11:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:24 INFO - 'XPC_FLAGS': '0x0', 11:18:24 INFO - 'XPC_SERVICE_NAME': '0', 11:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:24 INFO - Downloading/unpacking psutil>=3.1.1 11:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:26 INFO - Installing collected packages: psutil 11:18:26 INFO - Running setup.py install for psutil 11:18:26 INFO - building 'psutil._psutil_osx' extension 11:18:26 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 11:18:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 11:18:27 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 11:18:27 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 11:18:27 INFO - building 'psutil._psutil_posix' extension 11:18:27 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 11:18:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:18:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:18:27 INFO - ^ 11:18:27 INFO - 1 warning generated. 11:18:27 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 11:18:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:27 INFO - Successfully installed psutil 11:18:27 INFO - Cleaning up... 11:18:27 INFO - Return code: 0 11:18:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:27 INFO - 'HOME': '/Users/cltbld', 11:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:27 INFO - 'LOGNAME': 'cltbld', 11:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:27 INFO - 'MOZ_NO_REMOTE': '1', 11:18:27 INFO - 'NO_EM_RESTART': '1', 11:18:27 INFO - 'PAGER': '/bin/cat', 11:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:27 INFO - 'PWD': '/builds/slave/test', 11:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:27 INFO - 'SHELL': '/bin/bash', 11:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:27 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:27 INFO - 'USER': 'cltbld', 11:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:27 INFO - 'XPC_FLAGS': '0x0', 11:18:27 INFO - 'XPC_SERVICE_NAME': '0', 11:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:18:29 INFO - Installing collected packages: mozsystemmonitor 11:18:29 INFO - Running setup.py install for mozsystemmonitor 11:18:29 INFO - Successfully installed mozsystemmonitor 11:18:29 INFO - Cleaning up... 11:18:29 INFO - Return code: 0 11:18:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:29 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/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:18:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:18:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:29 INFO - 'HOME': '/Users/cltbld', 11:18:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:29 INFO - 'LOGNAME': 'cltbld', 11:18:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:29 INFO - 'MOZ_NO_REMOTE': '1', 11:18:29 INFO - 'NO_EM_RESTART': '1', 11:18:29 INFO - 'PAGER': '/bin/cat', 11:18:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:29 INFO - 'PWD': '/builds/slave/test', 11:18:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:29 INFO - 'SHELL': '/bin/bash', 11:18:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:29 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:29 INFO - 'USER': 'cltbld', 11:18:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:29 INFO - 'XPC_FLAGS': '0x0', 11:18:29 INFO - 'XPC_SERVICE_NAME': '0', 11:18:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:30 INFO - Downloading/unpacking jsonschema==2.5.1 11:18:30 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 11:18:30 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 11:18:30 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 11:18:30 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 11:18:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:31 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:31 INFO - warning: no files found matching '*.txt' 11:18:31 INFO - no previously-included directories found matching 'build' 11:18:31 INFO - no previously-included directories found matching 'dist' 11:18:31 INFO - no previously-included directories found matching '.git*' 11:18:31 INFO - Installing collected packages: jsonschema, functools32 11:18:31 INFO - Running setup.py install for functools32 11:18:32 INFO - warning: no files found matching '*.txt' 11:18:32 INFO - no previously-included directories found matching 'build' 11:18:32 INFO - no previously-included directories found matching 'dist' 11:18:32 INFO - no previously-included directories found matching '.git*' 11:18:32 INFO - Successfully installed jsonschema functools32 11:18:32 INFO - Cleaning up... 11:18:32 INFO - Return code: 0 11:18:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:32 INFO - 'HOME': '/Users/cltbld', 11:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:32 INFO - 'LOGNAME': 'cltbld', 11:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:32 INFO - 'MOZ_NO_REMOTE': '1', 11:18:32 INFO - 'NO_EM_RESTART': '1', 11:18:32 INFO - 'PAGER': '/bin/cat', 11:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:32 INFO - 'PWD': '/builds/slave/test', 11:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:32 INFO - 'SHELL': '/bin/bash', 11:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:32 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:32 INFO - 'USER': 'cltbld', 11:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:32 INFO - 'XPC_FLAGS': '0x0', 11:18:32 INFO - 'XPC_SERVICE_NAME': '0', 11:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:18:32 INFO - Cleaning up... 11:18:32 INFO - Return code: 0 11:18:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 11:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:32 INFO - 'HOME': '/Users/cltbld', 11:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:32 INFO - 'LOGNAME': 'cltbld', 11:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:32 INFO - 'MOZ_NO_REMOTE': '1', 11:18:32 INFO - 'NO_EM_RESTART': '1', 11:18:32 INFO - 'PAGER': '/bin/cat', 11:18:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:32 INFO - 'PWD': '/builds/slave/test', 11:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:32 INFO - 'SHELL': '/bin/bash', 11:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:32 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:32 INFO - 'USER': 'cltbld', 11:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:32 INFO - 'XPC_FLAGS': '0x0', 11:18:32 INFO - 'XPC_SERVICE_NAME': '0', 11:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:32 INFO - Downloading/unpacking blobuploader==1.2.4 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:34 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:35 INFO - Downloading docopt-0.6.1.tar.gz 11:18:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:35 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:35 INFO - Running setup.py install for blobuploader 11:18:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:35 INFO - Running setup.py install for requests 11:18:35 INFO - Running setup.py install for docopt 11:18:35 INFO - Successfully installed blobuploader requests docopt 11:18:35 INFO - Cleaning up... 11:18:35 INFO - Return code: 0 11:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:36 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/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:36 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:18:36 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:36 INFO - 'HOME': '/Users/cltbld', 11:18:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:36 INFO - 'LOGNAME': 'cltbld', 11:18:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:36 INFO - 'MOZ_NO_REMOTE': '1', 11:18:36 INFO - 'NO_EM_RESTART': '1', 11:18:36 INFO - 'PAGER': '/bin/cat', 11:18:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:36 INFO - 'PWD': '/builds/slave/test', 11:18:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:36 INFO - 'SHELL': '/bin/bash', 11:18:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:36 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:36 INFO - 'USER': 'cltbld', 11:18:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:36 INFO - 'XPC_FLAGS': '0x0', 11:18:36 INFO - 'XPC_SERVICE_NAME': '0', 11:18:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:36 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ju9H1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-I1eWtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-4ZMVpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-2WgzbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-T5hRDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-RV6Cec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-PsIAP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-m6LvGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ZpPMVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-Ek8whe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:37 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-PkxkyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:38 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ziv_Cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:38 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-fzXWG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:38 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-bgs6lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:38 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-VLT3Em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:38 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-D3rHsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:38 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-i1yTdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:38 INFO - Running setup.py install for manifestparser 11:18:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:38 INFO - Running setup.py install for mozcrash 11:18:38 INFO - Running setup.py install for mozdebug 11:18:39 INFO - Running setup.py install for mozdevice 11:18:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Running setup.py install for mozfile 11:18:39 INFO - Running setup.py install for mozhttpd 11:18:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Running setup.py install for mozinfo 11:18:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Running setup.py install for mozInstall 11:18:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:39 INFO - Running setup.py install for mozleak 11:18:40 INFO - Running setup.py install for mozlog 11:18:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:40 INFO - Running setup.py install for moznetwork 11:18:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:40 INFO - Running setup.py install for mozprocess 11:18:40 INFO - Running setup.py install for mozprofile 11:18:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:40 INFO - Running setup.py install for mozrunner 11:18:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:40 INFO - Running setup.py install for mozscreenshot 11:18:40 INFO - Running setup.py install for moztest 11:18:41 INFO - Running setup.py install for mozversion 11:18:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:41 INFO - Cleaning up... 11:18:41 INFO - Return code: 0 11:18:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:41 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/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:41 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:18:41 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:41 INFO - 'HOME': '/Users/cltbld', 11:18:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:41 INFO - 'LOGNAME': 'cltbld', 11:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:41 INFO - 'MOZ_NO_REMOTE': '1', 11:18:41 INFO - 'NO_EM_RESTART': '1', 11:18:41 INFO - 'PAGER': '/bin/cat', 11:18:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:41 INFO - 'PWD': '/builds/slave/test', 11:18:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:41 INFO - 'SHELL': '/bin/bash', 11:18:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:41 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:41 INFO - 'USER': 'cltbld', 11:18:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:41 INFO - 'XPC_FLAGS': '0x0', 11:18:41 INFO - 'XPC_SERVICE_NAME': '0', 11:18:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:41 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-DbtMu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-tCFT7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-tAMJvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-iidsfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ZZxp70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-jJGIQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-8aTIKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-CybnfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-d4BoOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ogzj1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:42 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)) 11:18:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:42 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-rOTxUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:43 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)) 11:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:43 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-2VquFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 11:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:43 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-q1KwGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:43 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)) 11:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:43 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-pIq26z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:43 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)) 11:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:43 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-vRDAy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:43 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)) 11:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:43 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-a8LwGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:43 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)) 11:18:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:43 INFO - Running setup.py (path:/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/pip-ANrexu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:43 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)) 11:18:43 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)) 11:18:43 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)) 11:18:43 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)) 11:18:43 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)) 11:18:43 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)) 11:18:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:43 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 11:18:43 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 11:18:43 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 11:18:43 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 11:18:45 INFO - Downloading blessings-1.6.tar.gz 11:18:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:45 INFO - Installing collected packages: blessings 11:18:45 INFO - Running setup.py install for blessings 11:18:45 INFO - Successfully installed blessings 11:18:45 INFO - Cleaning up... 11:18:45 INFO - Return code: 0 11:18:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:46 INFO - Reading from file tmpfile_stdout 11:18:46 INFO - Current package versions: 11:18:46 INFO - blessings == 1.6 11:18:46 INFO - blobuploader == 1.2.4 11:18:46 INFO - docopt == 0.6.1 11:18:46 INFO - functools32 == 3.2.3-2 11:18:46 INFO - jsonschema == 2.5.1 11:18:46 INFO - manifestparser == 1.1 11:18:46 INFO - mozInstall == 1.12 11:18:46 INFO - mozcrash == 1.0 11:18:46 INFO - mozdebug == 0.1 11:18:46 INFO - mozdevice == 0.49 11:18:46 INFO - mozfile == 1.2 11:18:46 INFO - mozhttpd == 0.7 11:18:46 INFO - mozinfo == 0.9 11:18:46 INFO - mozleak == 0.1 11:18:46 INFO - mozlog == 3.4 11:18:46 INFO - moznetwork == 0.27 11:18:46 INFO - mozprocess == 0.25 11:18:46 INFO - mozprofile == 0.28 11:18:46 INFO - mozrunner == 6.13 11:18:46 INFO - mozscreenshot == 0.1 11:18:46 INFO - mozsystemmonitor == 0.3 11:18:46 INFO - moztest == 0.8 11:18:46 INFO - mozversion == 1.4 11:18:46 INFO - psutil == 3.1.1 11:18:46 INFO - requests == 1.2.3 11:18:46 INFO - wsgiref == 0.1.2 11:18:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:46 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/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:46 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:18:46 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:46 INFO - 'HOME': '/Users/cltbld', 11:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:46 INFO - 'LOGNAME': 'cltbld', 11:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:46 INFO - 'MOZ_NO_REMOTE': '1', 11:18:46 INFO - 'NO_EM_RESTART': '1', 11:18:46 INFO - 'PAGER': '/bin/cat', 11:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:46 INFO - 'PWD': '/builds/slave/test', 11:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:46 INFO - 'SHELL': '/bin/bash', 11:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:46 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:46 INFO - 'USER': 'cltbld', 11:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:46 INFO - 'XPC_FLAGS': '0x0', 11:18:46 INFO - 'XPC_SERVICE_NAME': '0', 11:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 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)) 11:18:46 INFO - Cleaning up... 11:18:46 INFO - Return code: 0 11:18:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:18:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:46 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/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 0x10e26bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e26e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7fb2574e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, '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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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 11:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:46 INFO - 'HOME': '/Users/cltbld', 11:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:46 INFO - 'LOGNAME': 'cltbld', 11:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:46 INFO - 'MOZ_NO_REMOTE': '1', 11:18:46 INFO - 'NO_EM_RESTART': '1', 11:18:46 INFO - 'PAGER': '/bin/cat', 11:18:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:46 INFO - 'PWD': '/builds/slave/test', 11:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:46 INFO - 'SHELL': '/bin/bash', 11:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:18:46 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:46 INFO - 'USER': 'cltbld', 11:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:46 INFO - 'XPC_FLAGS': '0x0', 11:18:46 INFO - 'XPC_SERVICE_NAME': '0', 11:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:18:46 INFO - Cleaning up... 11:18:46 INFO - Return code: 0 11:18:46 INFO - Running post-action listener: _resource_record_post_action 11:18:46 INFO - Running post-action listener: _start_resource_monitoring 11:18:46 INFO - Starting resource monitoring. 11:18:46 INFO - [mozharness: 2017-05-24 18:18:46.671598Z] Finished create-virtualenv step (success) 11:18:46 INFO - [mozharness: 2017-05-24 18:18:46.672562Z] Running install step. 11:18:46 INFO - Running pre-action listener: _resource_record_pre_action 11:18:46 INFO - Running main action method: install 11:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:46 INFO - Reading from file tmpfile_stdout 11:18:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:47 INFO - Reading from file tmpfile_stdout 11:18:47 INFO - Output received: 11:18:47 INFO - Usage: mozinstall [options] installer 11:18:47 INFO - Options: 11:18:47 INFO - -h, --help show this help message and exit 11:18:47 INFO - -d DEST, --destination=DEST 11:18:47 INFO - Directory to install application into. [default: 11:18:47 INFO - "/builds/slave/test"] 11:18:47 INFO - --app=APP Application being installed. [default: firefox] 11:18:47 INFO - mkdir: /builds/slave/test/build/application 11:18:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:18:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 11:19:02 INFO - Reading from file tmpfile_stdout 11:19:02 INFO - Output received: 11:19:02 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 11:19:02 INFO - Running post-action listener: _resource_record_post_action 11:19:02 INFO - [mozharness: 2017-05-24 18:19:02.027502Z] Finished install step (success) 11:19:02 INFO - [mozharness: 2017-05-24 18:19:02.027637Z] Running run-tests step. 11:19:02 INFO - Running pre-action listener: _resource_record_pre_action 11:19:02 INFO - Running main action method: run_tests 11:19:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:19:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:19:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:19:02 INFO - 2017-05-24 11:19:02.042 screenresolution[1628:7589] starting screenresolution argv=screenresolution get 11:19:02 INFO - 2017-05-24 11:19:02.044 screenresolution[1628:7589] Display 0: 1600x1200x32@60 11:19:02 INFO - 2017-05-24 11:19:02.050 screenresolution[1629:7591] starting screenresolution argv=screenresolution list 11:19:02 INFO - Available Modes on Display 0 11:19:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:19:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:19:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:19:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:19:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:19:02 INFO - Intel Iris: 11:19:02 INFO - Chipset Model: Intel Iris 11:19:02 INFO - Type: GPU 11:19:02 INFO - Bus: Built-In 11:19:02 INFO - VRAM (Dynamic, Max): 1536 MB 11:19:02 INFO - Vendor: Intel (0x8086) 11:19:02 INFO - Device ID: 0x0a2e 11:19:02 INFO - Revision ID: 0x0009 11:19:02 INFO - Displays: 11:19:02 INFO - Display: 11:19:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:19:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:19:02 INFO - Display Serial Number: 1600x1200 60 11:19:02 INFO - Main Display: Yes 11:19:02 INFO - Mirror: Off 11:19:02 INFO - Online: Yes 11:19:02 INFO - Rotation: Supported 11:19:02 INFO - Return code: 0 11:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:02 INFO - Python 2.7.3 11:19:02 INFO - Return code: 0 11:19:02 INFO - grabbing minidump binary from tooltool 11:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 11:19:02 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 0x10e049d30>, '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 0x10df70db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e03ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:02 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 11:19:02 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 11:19:02 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 11:19:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:02 INFO - Return code: 0 11:19:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:19:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:02 INFO - ENV: RUST_BACKTRACE is now 1 11:19:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:19:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 11:19:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0352 --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 11:19:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zWYYyIVtQk/Render', 11:19:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:02 INFO - 'HOME': '/Users/cltbld', 11:19:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:02 INFO - 'LOGNAME': 'cltbld', 11:19:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:19:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:02 INFO - 'MOZ_NO_REMOTE': '1', 11:19:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:02 INFO - 'NO_EM_RESTART': '1', 11:19:02 INFO - 'PAGER': '/bin/cat', 11:19:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:02 INFO - 'PWD': '/builds/slave/test', 11:19:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:02 INFO - 'RUST_BACKTRACE': '1', 11:19:02 INFO - 'SHELL': '/bin/bash', 11:19:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WPYjcXPpBg/Listeners', 11:19:02 INFO - 'TMPDIR': '/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/', 11:19:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:02 INFO - 'USER': 'cltbld', 11:19:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:02 INFO - 'XPC_FLAGS': '0x0', 11:19:02 INFO - 'XPC_SERVICE_NAME': '0', 11:19:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0352', '--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 11:19:02 INFO - mozversion application_buildid: 20170524100420 11:19:02 INFO - mozversion application_changeset: f7c942b561d57638df5c1c2542dd3d946dc71907 11:19:02 INFO - mozversion application_display_name: Firefox 11:19:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:02 INFO - mozversion application_name: Firefox 11:19:02 INFO - mozversion application_remotingname: firefox 11:19:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:19:02 INFO - mozversion application_vendor: Mozilla 11:19:02 INFO - mozversion application_version: 54.0 11:19:02 INFO - mozversion platform_buildid: 20170524100420 11:19:02 INFO - mozversion platform_changeset: f7c942b561d57638df5c1c2542dd3d946dc71907 11:19:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:19:02 INFO - mozversion platform_version: 54.0 11:19:02 INFO - using testdate: 1495649942 11:19:02 INFO - actual date: 1495649942 11:19:02 INFO - starting webserver on 'localhost:49223' 11:19:02 INFO - SUITE-START | Running 2 tests 11:19:02 INFO - TEST-START | dromaeo_css 11:19:02 INFO - operating with platform_type : mac_ 11:19:02 INFO - Initialising browser for dromaeo_css test... 11:19:02 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmp08Idwc/profile http://localhost:49223/getInfo.html) 11:19:05 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 11:19:05 INFO - PROCESS | 1639 | colorDepth:24 11:19:05 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 11:19:05 INFO - PROCESS | 1639 | __metrics 11:19:05 INFO - PROCESS | 1639 | 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" 11:19:05 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:19:06 INFO - TEST-INFO | 1639: exit 0 11:19:06 INFO - Browser initialized. 11:19:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:06 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmp08Idwc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:18 INFO - PROCESS | 1642 | RSS: Main: 165056512 11:19:18 INFO - PROCESS | 1642 | 11:22:21 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49223/tests/dromaeo/cssquery-ext.html) 11:22:23 INFO - PROCESS | 1642 | RSS: Main: 304455680 11:22:23 INFO - PROCESS | 1642 | 11:25:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49223/tests/dromaeo/cssquery-ext.html (next: http://localhost:49223/tests/dromaeo/cssquery-jquery.html) 11:25:26 INFO - PROCESS | 1642 | RSS: Main: 298819584 11:25:26 INFO - PROCESS | 1642 | 11:28:28 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49223/tests/dromaeo/cssquery-mootools.html) 11:28:29 INFO - PROCESS | 1642 | RSS: Main: 291233792 11:28:29 INFO - PROCESS | 1642 | 11:31:31 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49223/tests/dromaeo/cssquery-prototype.html) 11:31:32 INFO - PROCESS | 1642 | RSS: Main: 278945792 11:31:32 INFO - PROCESS | 1642 | 11:34:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49223/tests/dromaeo/cssquery-yui.html) 11:34:36 INFO - PROCESS | 1642 | RSS: Main: 271347712 11:34:36 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49223/tests/dromaeo/cssquery-yui.html (next: http://localhost:49223/tests/dromaeo/cssquery-dojo.html) 11:37:40 INFO - PROCESS | 1642 | RSS: Main: 327557120 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | __start_tp_report 11:37:40 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 11:37:40 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 11:37:40 INFO - PROCESS | 1642 | |i|pagename|runs| 11:37:40 INFO - PROCESS | 1642 | |0;dojo.html;2878.8848446062157;3049.2224482756897;3564.7682900611444;3570.428731402976;3587.623299553547;6107.297660769007;6108.808782287456;6133.723982420791;6171.845703857406;6177.135201071842;6144;6187.783427580036;6200.255969283681;6203.379662033794;6220.03589443637;5502.449755024496;5514.6139770216105;5551.1118221084635;5567.55459563236;5675.460831221028;5362.088444964346;5371.838844834661;5384.057789886754;5655.123455864347;5674.517665998395;5472.2338872557875;5473.17902314654;5482.013237617227;5482.780688772445;5504.146857237115;5544.889102217953;5589.608727389084;5615.803446879339;5628.605997580171;5643.520300774439;5472.972635136839;5565.526930210937;5576.442355764391;5578.497935185812;5588.580856435743;5561.916571251434;5828.41715828418;5874.1776151338845;6247;6279.748810047593;6333.8416539586415;6344.460720838734;6348.968255158695;6371;6384.297727249998;6489.610623362566;6540.93459065408;6556.344365563453;6563.212414510289;6565.409113179789;6218.844528886769;6290.402411770874;6292.33930437302;6302.054691796176;6308.842278943017;6315.210598675166;6365.745370185141;6525.184351956005;6591.703373348211;6681.665916704145;6360.0777887206095;6383.106365108889;6391.872162556723;6400.295967443578;6403.839904002437;6465.935340646533;6482.740690372332;6522.804315870531;6530.706118224692;6534.313897040837;6285.151504546828;6305.3379395163765;6316.115743795872;6421.5825971311715;6432.807015789534;6268.310485846553;6423.0686550450855;6424.743010279536;6428.0357946307495;6438.25960014595;5034.748262586856;5106.795728170906;5112.437631860493;5225.895482090337;5230.947690523046;4664.39362882823;4693.882652933704;4715.4577223619035;4719.38647975761;4778.522147785194;5125.461826508237;5881.088431293157;5911.290645122613;6195.070739389038;6205.379462053758;6321.336259692758;6358.395952384516;6419.454346380517;6498.090267362573;6535.150430444012;6181.721822517908;6210.534209934182;6214.689265536705;6214.782482613087;6232.439080482778;5684.175794509855;5710.057840456361;5717.199592057115;5723.255976723;5761.48146666802;6337.524685648595;6400.679966001681;6572.80281591553;6677.69950352245;6737.966310168418;6397.424231819158;6493.123428337303;6498.707558159988;6509.316521765147;6522.28254891971;6233.2208473940755;6737.966310168418;6741.426978706865;6745.3591908768585;6745.898811517929;5968.432998865101;6273.96863015682;6305.779297724557;6312.14786003902;6352.205974253218;6472.385123413268;6521.7065232065615;6525.967370163119;6527.706253218712;6537.640429776408;6312.210973628296;6346.587471814318;6357.841053973688;6361.968190159019;6364.427201551883;6199.411055949678;6244.0321750128805;6283.214598175228;6297.086922396135;6343.270523889812;5537.390887002346;6256.311805701278;6296.811095667137;6306.243250809932;6308.022256550242;6382.585131966407;6388.744450221939;6391.552591318563;6395.296517383177;6409.903851442139;6121;6121.8493044937295;6144.600600960924;6265.185525881606;6313.305536391085 11:37:40 INFO - PROCESS | 1642 | |1;ext.html;785.7249962513117;819.1235378145385;840.3865178419752;908.5048648486578;922.7600823785814;29508.704912950863;41146.38280425796;41351.37972930405;43591.12817743643;43810.56189438105;43140.56859431405;43325.91685207871;43382;43437.78281108598;43494.78252608733;7920.128785833554;9727.805443891119;9888.950555247213;9914.553845076953;9925.205983521337;7953.681852725884;11767.823482647767;11918.880811191864;11927.821082683766;11930.522779088826;12065.758684826298;12114.575989840358;12130.575429859957;12148.088893332992;12160.817587736146;12031.278123312586;12037.879621203763;12047.879521204763;12066.396680165957;12068.879311206863;11755.471003804763;11827.822582661267;11838.704032399173;11843.111766617452;11865.5847045353;41005.79497102495;41253.381199282034;41283.1743365134;41331.76004719863;41369.79315103405;4027.8791636250958;4071.2671719090554;4091.631753142202;4102.856400026015;4122.814473348676;28825.71174288251;29072.69172887204;30098.097057088322;30973.690263097305;31100.688993110005;3137.748980081588;3294.769366144347;3296.324253528021;3332.216929021678;3361.3277344531193;351415;356978;357177;358516;358583;54323.45676543263;54476.182857257176;54609.72695136578;54645.45354546483;54741.452585474435;56404;56547.43452565504;56570.15144772832;56639.71680141573;56695;15607.765883511756;15982.920085399499;15988.120653364176;15989.200539972955;16022.439214627431;12092.87907120935;12134.089943254292;13752.449902004008;13755.724885502234;13757;10684.51919663617;11845.940770296093;11957.581484647995;12057.276563406223;12192;4712.929306060412;5492.176173573996;5536.169574563848;5536.446355364512;5557.72211389437;1055.472263868066;1076.445630500293;1076.4563895232857;1076.8653918260218;1118.2395970739974;28390.43219135647;28457.857710711727;28578.571321430194;28848.423031539252;28849.56725649117;887;1177.8704342522315;1181.1141643767176;1248.7477807202786;1257.4530079415483;14144.36350364236;14284.928575357057;14585.708285834224;14615.634609134644;14617.634559135893;484144;554239;561665;562838;563096;51634;52102.47897521052;52230.47769522332;52443;52580.21129683058;1450.840407555168;1508.6907184027248;1508.9773653395428;1510.124128005754;1518.2864053894652;27333.809578522752;27450.313742156606;27935.441291173654;28284.71715282903;28498.57252141261;30667.539986899767;41720.37419438772;41748.956276092125;41847.1630567393;41956.58043419649;450780;451534;452150;452472;453820;28775.85612071926;29361.706382935896;29472.11583652494;30047.549286760277;30145.976356292053;39964.40053399259;40029;40047;40254;40431.59568404278;22242.77757222407;28024.43951121007;28347.433051338445;28469.857650711612;29269;27232.183034508995;28413.147605571867;29451.41097178087;29498.852505737334;29522.55716164302;33478.66521334756;33955.66044339525;34207;34216.657833422345;34229.973100807016;28656;28715.569266461436;28992.710072899;29200.560174011873;29377.971770988766;23156.88421557949;23333.41666458352;23552.17567385202;23553;23574.410639734146 11:37:40 INFO - PROCESS | 1642 | |2;jquery.html;430.36735998082844;431.7387980271935;437.07994671217097;444.2580889913844;448.1708838648499;20313.1874725011;22409.55180896381;22792.430189245235;22883.19908803192;22891.427714307152;21447.892760536215;22543.872806359697;23295.534089318204;24002.87998560009;24281.514369712597;6739.292374300701;6819.045333653293;6911.827204319907;7093;7102.112235970504;6734.225564060122;6813.182418109809;6842.623655698934;6860.485463590251;6864.931350686479;6559.508036897228;6816.659167041628;6855.622940738257;6888.311168883097;6901.482388820833;6586.670666466705;6820.761273355433;6892.965535172342;6908.689108990083;6954.965225173842;6850.588964662136;6863.588184708883;6869.347411995853;6875.449964002868;6878;26455.47089058208;26703.332416689544;28417.57373639397;28586.285342866595;28638.19524544254;3062.800917940349;3103.379324135182;3124.8437578121;3128.7340576051065;3263.086335825949;16012.439564615182;16953.152342382833;16958.576035599086;17367.826321736746;17381.391651292142;2011.6680747676617;2051.887146206958;2094.068139677844;2104.8737075775502;2114.947126321839;133166;142848;162892;165972.17013914854;168652.99999999878;19038.238470461027;20155.496112597302;20230;20387.694184587242;20573;26483;33197.50203746946;33233.33533329368;33235.335293293996;33273;10446.843297350546;10532.65121877822;10886.346819190874;10895.727606809893;11070.889291107147;9057.365984381162;9082.775614656834;9100;9253.398529095588;9268.25853931684;9313.720588382359;9450.763730906783;9451.243900487945;9512.429254244767;9533.380330278509;3212.9839350803095;3740.7007439404783;3810.8094595270127;3815.5802861685193;3821.7324787264624;1053.6680945502142;1055.8574592430077;1063.3194755356578;1073.1682945716975;1103.7626910214342;22233.55481893672;22426.88786556057;22748.31755047351;22771.886140569524;22836.42908927257;935.9657578375933;1030.253066526762;1081.648464249122;1082.983755243672;1127.8984891359653;9871.703848884545;11591.710207244887;11595.652130436101;11632;11632.825507617392;788898;790356.0482197552;801395;811073;831718;73260;113336;114158;115113;144516;1147.71880889181;1217.9330136842382;1263.7788387032233;1265.1586694847824;1271.3516106785605;20300.695489567963;20383.388498345073;20443.38669839907;20478.897605511876;20701;60439.69780151071;60936.69531652491;61450.99999999821;61729.382706172364;61844;87822;88771.55614221888;89325;90640.51663233718;90843;7873.763787086396;9437.669681561112;9580.28147888925;11770.469838920886;11891.643250702493;13116.08187426871;13190.934045329712;13339.266340351374;13621.931890340486;13656;10344.793104138025;10952.671419857099;11482.82775758381;11491.195616306779;11867.228630139014;10494;10501.474926253504;10609.20430967665;10729.570817167227;10793.352398856094;11527.538898443969;11591.411195233957;11878.346690932081;11981.161318707607;12030.578929737418;11515.654530364103;11616.709582260173;11635.301881887113;11880;11896.643100706993;11285.492152853305;11651.88348116508;11661.6501504955;11691.415429228675;11770.058395328524 11:37:40 INFO - PROCESS | 1642 | |3;mootools.html;1619.5384315470087;1638.2382192280588;1647.1105602974387;1661.2690416216867;1662.2519866060272;10742.194335424845;11274.985251327378;11597.652070437889;11605.709857253572;11628.302301861884;11343.716407089807;11560.306381617109;11576.53693852245;11580.59467918621;11584.304941703482;2034.888081155536;2547.465032343201;2547.7707006369424;2549.7067837198774;2551.0306083688174;2469.826832254683;2475.195561442529;2506.0477018732854;2515.107136966378;2515.1825656661567;2118.237434523578;2470.938226544342;2505.1232068775876;2540.0347867810297;2543.656606358146;2451.901923923041;2465.778079972811;2485.092941076512;2492.190038237562;2500.6999160100813;2439.780419762212;2464.581021226396;2467.7038755349295;2469.987650061756;2472.184179220853;11294.943525282402;11562.306261624246;11563.42182890852;11577.94211028948;11578.594749183821;5969.283685957669;6149.13912052313;6174.5060395168275;6177.505799536027;6197.101420294032;3691.9077023074638;3766.39737641976;3819.9427008594894;3837.2325534893134;3915.353966595508;1231.347385885482;1270.8602053774077;1283.1980012492193;1290.8394907860845;1318.1827267094463;13733.969952253521;14008.36962336687;14380.137191768423;15957.12235827029;16118.274677639534;4144.647704945053;4414.139242847678;4807.519248075165;4953.430355509163;4962.15643340633;10782.730431739112;11695.064394848392;12200.938995304967;12206.267623942593;12219.877801222052;5192.948070519322;5346.705931173745;5898.675572843449;6015.6691381974415;6152.907706384408;5482;5676.035074037423;5678.290213723285;5698;5733.025385684444;4012.0972781124597;4039.2931237033404;4121.196366708523;4143.129942712004;4152.667786577066;1067.386252904583;1084.4469320646526;1088.6065835730278;1103.150574057987;1104.2987702808614;958.6453012385323;963.349738926222;975.858500517421;984.6455276100598;998.4175082494328;6491.123698300669;6549;6581.3747693969;6627.1716035495565;6679.899801502981;905.158202871336;935.3919952031098;941.3598752847992;990.5641517732175;1053.7312985188728;3289.276359200972;4056;4186.434831297796;4238.406623072772;4239.109786944776;13843.30783460823;14506.492272770402;14514;14523.273836308354;14525.201113938834;13734.381952812148;14028.018038737395;14258.643533911527;14261.500847470288;14282.285885705673;9249.583768730423;10253.7436564085;10377.11794497461;10395.94802026;10506.894931050592;6439.291677915519;6512.6092434454085;6579.572327798678;6605.900911486236;6613.636250006103;12181.390930453264;12452.81320780171;12608.621741347773;12610.684732881751;12649.557265495663;12631.684207894508;12675.049371297006;12816.55142070023;12867.806982895077;12972.481100755864;8678.522681252593;9164.358494905293;9441.055894410778;9678.85481717789;9709.6601618943;10737.14102871784;10752.784944301227;10759.193060520649;10876.238663293494;10936.835947460953;8775.91224087751;9042.321825863219;9110.134537218953;9173.40372875761;9183.908160918305;7529.8117547061765;8740.825183496167;8884.422512536665;8891.822163556822;8893.911060889308;6967.1291088613925;7476.691578973767;8115.229053239933;8139.389545784208;8206.712765053195;5650.152477128299;5956.374580668968;6015.338312785502;6043;6114.449699527064;5645.4072322405555;5738.282714660668;5743.770249189985;5766.163906233489;5831.7667293307795 11:37:40 INFO - PROCESS | 1642 | |4;prototype.html;362.15075647606363;391.9764814111152;394.2469882524379;400.6074047433517;401.29172011399885;4396.010528050661;4825;4871.585915197208;4987.959752600387;5116.232565115234;3927.6465118139363;4388.912221755563;4640.303954406832;4952.097423550686;4983.825566105187;3363.882264120756;3598.8689839839376;3646.8723594674193;3663.6153203913605;4002.559718430985;3886.173498455721;3995.6603688686496;3999.280129576675;3999.320115580358;4024.2353952748886;3630.6929505378043;3696.445533170019;3978.3236849735613;3986.4817573715377;4015.678745700337;3505.8422370993367;3773.0568757090123;3911.7261791674596;3921.3529767588598;3970.563238043813;3557.3596752584785;3566.2154326048226;3569.714422846166;3589.2412717768366;3597.2660777809056;4194.622483976426;4639.164950308943;4691.812327506896;4901.779419926112;4949.826756063557;3780.9621903780885;3800.6769424598942;4324.248679284895;4583.633309335279;4661;5410.3507579090365;5426.321709786277;5431;5474.945250547484;5502.5597952164135;3985.20295940813;4017.4978127734034;4182.623563879235;4283.993261583525;4396.934045989313;4943.011397720435;5284.2866213061125;5314.441983591706;5322.574194064466;5574.777008919638;3777.9244415111543;3972.880813575597;4009.599040095967;4276.893077673021;4500.572445617661;4583.289590113471;4585.266357382803;4595.071214111953;4604.516525764813;4620.020087043905;4312.029793296483;4332.848350307724;4771.928421073687;4877.268409738567;4923.433805112386;4374.103308821747;4390.8902277442685;4890.804367825318;5309.097453432925;5423.616977670668;1442.9826971984726;1470.3456961651962;1550.6976139652886;1551.4027099566747;1553.6115971007248;1084.6366467233408;1161.7269941563725;1162.8662703789003;1172.9120315976336;1185.4606154199992;4870.391201099792;5079.31429257053;5088.796448142107;5106.361704786902;5108.66793658411;4851.587615052689;4949.045127174746;5642;5647.943520564741;5657.20799088128;3958.247932892741;4498.550144985541;4589.990202155521;4868;5093.694378337237;2337.64935259709;2350.200931683236;2602.5705758550007;2652.774514166279;2763.7927155463017;5232.712200828991;5362.91955620666;5574.916376254359;5763.538916886639;5829.708514574254;5118.795248190105;5466.835994920159;5733.713314334266;5757.8560535986935;5764.184281951172;4833.3958255218095;4969.211084009754;5719.056355701346;5781.88436231273;5797.652140871562;4925.601848847778;5340.866478338073;5537.280153580009;5593.049181639212;5627.324721033502;4788.307458690572;5118.00198961199;5374.3013408256675;5525.254090697865;5576.693281869374;5006.549410553068;5097.278986339918;5174.663646862942;5512.972435137799;5611.438856114356;3432.3306955143507;3946.329124048976;4419.447569053868;4459.910801784011;4466.012624382119;4198.690720103869;4832.468428472936;5130.333056702605;5146.904564481062;5470.945290547203;4928.778204980713;4962.851114466572;5475.260839786578;5477.370102438271;5508.724563771715;4362.672799540111;5048.925829541287;5059.468755780737;5414.891702166014;5452.781888724407;5061.924071138862;5106.387233532;5267.155735902723;5299.8410047698635;5302.250257414967;5186.481351864783;5252.032601580095;5459.208414779914;5472.50747432733;5501.504864562208;4476;5280.524752772269;5285.709285989307;5321.206366657536;5334.599905007218 11:37:40 INFO - PROCESS | 1642 | |5;yui.html;773.176566956192;784.7371130671224;802.9859180062156;848.2620120495169;912.7672443526902;15244.695106097872;16454.588635284123;17608.29566817329;17664.55838604034;17687.380941667045;15444.922775386136;15683.137427441487;15716.764248536281;15851.603709907258;15858;973.1728031173517;1003.7691330993857;1030.5259580592935;1034.974125646861;1035.3942943378133;897.6768363389175;921.5668635741191;991.8115558043985;1032.989670103297;1033.3076838518211;1086.5708045322092;1086.945652717365;1087.3475914451305;1089.4661615808236;1091.6561283195767;1082.161324973148;1083.1389045708681;1083.377058191543;1083.5990683447096;1085.7502774361863;808.7573727881671;809.2029351089172;809.6761295481796;809.9996504317163;810.1898101898101;16903;16932.915335423244;16976.151192440328;17455.825441745546;17702.203400846865;14177.291135443187;14240.857591424057;14831.480898168513;14835.480758173411;14869.479568215169;12192.451339689647;12201;12247.203931744409;12279.877201227962;12638.810417843648;3826.8660596879254;3864.0533069397898;3869.690424766012;3901.955929685566;4019.1760689058674;96792.51603741937;99066.50466747693;107852;111304;118551;11957.940210298893;11988.220765650205;12035.879641203475;12243.20419172751;12300.077494187972;26579.468410631678;27132.186034419;27152.592711109348;27185.45629087407;27191.45617087647;8289.917100828914;8327.849237212133;8602.31181505478;8653.307735381155;8831.381803273838;4336.9783151084675;4500.212462818994;4537.296719008559;4573.245414506569;4704.764761761899;3463.688268055887;3736.7384283099923;3740.8877733668032;3745.6254374562327;3751.0997360633796;656.8981807819796;670.6814263225027;693.6577027805971;703.6516924122592;704.7145905908116;670.8825955457776;675.7060678604724;687;706.593708617547;733.3216774483582;8818.382713210141;10182.643607473703;10636.787264254672;11560.434077585132;11624.476898539586;579.3858509979435;580.3963877567367;631.7125707802938;670.9664516774142;742.4459858088267;4720.409948756405;4872.82945096927;4877.878053048631;4886.682365646222;4888.242322440027;96171;96462;97323;99928.50035749775;102835.48582257041;47576.04847903023;69974;83873.58063209645;87268.12731872727;93945.59081613782;71019.64490177722;71354.28645713581;80708.19291807125;82894.75657865137;84365.57817210874;11286.49210785533;11289.830652540055;11409.885901140882;11491.195616307112;11600.883991160317;47897.521024789305;48465.03069938652;52136.47863521468;54463;54825;55862.72068639631;65063.67468162629;67045.66477167583;69629.65185174042;70027.94958075735;12388;12681.365931703562;13028.674283142997;13220.405081771536;13321.733565328834;14263.857361426253;14594.635134121732;14869.546524823283;15468.613284667523;15515.76726349083;13447.327633618084;14388.496402625859;14393.496227631982;14446.783298250744;14543.272836357928;12951.935240323737;14126.858731412554;14207.147571145764;14315.284235788376;14492;13660.86339136596;13762.931185344009;14062.085964412281;14384.784228236376;14571.635709107357;10214.336068155844;10512.316699414514;10653.147748179972;11016.944915275693;11066.833997489883;11266.267692599955;11469.770604588028;11637.592684256011;11642.359670218219;11667.59163429276 11:37:40 INFO - PROCESS | 1642 | __end_tp_report 11:37:40 INFO - PROCESS | 1642 | __start_cc_report 11:37:40 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1405 11:37:40 INFO - PROCESS | 1642 | __end_cc_report 11:37:40 INFO - PROCESS | 1642 | __startTimestamp1495651060498__endTimestamp 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | ------- Summary: start ------- 11:37:40 INFO - PROCESS | 1642 | Number of tests: 6 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:6014.94 Median:6279.75 stddev:668.54 (10.6%) stddev-sans-first:623.69 11:37:40 INFO - PROCESS | 1642 | Values: 2878.9 3049.2 3564.8 3570.4 3587.6 6107.3 6108.8 6133.7 6171.8 6177.1 6144.0 6187.8 6200.3 6203.4 6220.0 5502.4 5514.6 5551.1 5567.6 5675.5 5362.1 5371.8 5384.1 5655.1 5674.5 5472.2 5473.2 5482.0 5482.8 5504.1 5544.9 5589.6 5615.8 5628.6 5643.5 5473.0 5565.5 5576.4 5578.5 5588.6 5561.9 5828.4 5874.2 6247.0 6279.7 6333.8 6344.5 6349.0 6371.0 6384.3 6489.6 6540.9 6556.3 6563.2 6565.4 6218.8 6290.4 6292.3 6302.1 6308.8 6315.2 6365.7 6525.2 6591.7 6681.7 6360.1 6383.1 6391.9 6400.3 6403.8 6465.9 6482.7 6522.8 6530.7 6534.3 6285.2 6305.3 6316.1 6421.6 6432.8 6268.3 6423.1 6424.7 6428.0 6438.3 5034.7 5106.8 5112.4 5225.9 5230.9 4664.4 4693.9 4715.5 4719.4 4778.5 5125.5 5881.1 5911.3 6195.1 6205.4 6321.3 6358.4 6419.5 6498.1 6535.2 6181.7 6210.5 6214.7 6214.8 6232.4 5684.2 5710.1 5717.2 5723.3 5761.5 6337.5 6400.7 6572.8 6677.7 6738.0 6397.4 6493.1 6498.7 6509.3 6522.3 6233.2 6738.0 6741.4 6745.4 6745.9 5968.4 6274.0 6305.8 6312.1 6352.2 6472.4 6521.7 6526.0 6527.7 6537.6 6312.2 6346.6 6357.8 6362.0 6364.4 6199.4 6244.0 6283.2 6297.1 6343.3 5537.4 6256.3 6296.8 6306.2 6308.0 6382.6 6388.7 6391.6 6395.3 6409.9 6121.0 6121.8 6144.6 6265.2 6313.3 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:58588.19 Median:30122.04 stddev:121955.63 (404.9%) stddev-sans-first:122220.53 11:37:40 INFO - PROCESS | 1642 | Values: 785.7 819.1 840.4 908.5 922.8 29508.7 41146.4 41351.4 43591.1 43810.6 43140.6 43325.9 43382.0 43437.8 43494.8 7920.1 9727.8 9889.0 9914.6 9925.2 7953.7 11767.8 11918.9 11927.8 11930.5 12065.8 12114.6 12130.6 12148.1 12160.8 12031.3 12037.9 12047.9 12066.4 12068.9 11755.5 11827.8 11838.7 11843.1 11865.6 41005.8 41253.4 41283.2 41331.8 41369.8 4027.9 4071.3 4091.6 4102.9 4122.8 28825.7 29072.7 30098.1 30973.7 31100.7 3137.7 3294.8 3296.3 3332.2 3361.3 351415.0 356978.0 357177.0 358516.0 358583.0 54323.5 54476.2 54609.7 54645.5 54741.5 56404.0 56547.4 56570.2 56639.7 56695.0 15607.8 15982.9 15988.1 15989.2 16022.4 12092.9 12134.1 13752.4 13755.7 13757.0 10684.5 11845.9 11957.6 12057.3 12192.0 4712.9 5492.2 5536.2 5536.4 5557.7 1055.5 1076.4 1076.5 1076.9 1118.2 28390.4 28457.9 28578.6 28848.4 28849.6 887.0 1177.9 1181.1 1248.7 1257.5 14144.4 14284.9 14585.7 14615.6 14617.6 484144.0 554239.0 561665.0 562838.0 563096.0 51634.0 52102.5 52230.5 52443.0 52580.2 1450.8 1508.7 1509.0 1510.1 1518.3 27333.8 27450.3 27935.4 28284.7 28498.6 30667.5 41720.4 41749.0 41847.2 41956.6 450780.0 451534.0 452150.0 452472.0 453820.0 28775.9 29361.7 29472.1 30047.5 30146.0 39964.4 40029.0 40047.0 40254.0 40431.6 22242.8 28024.4 28347.4 28469.9 29269.0 27232.2 28413.1 29451.4 29498.9 29522.6 33478.7 33955.7 34207.0 34216.7 34230.0 28656.0 28715.6 28992.7 29200.6 29378.0 23156.9 23333.4 23552.2 23553.0 23574.4 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:43760.52 Median:22760.10 stddev:133063.14 (584.6%) stddev-sans-first:133396.64 11:37:40 INFO - PROCESS | 1642 | Values: 430.4 431.7 437.1 444.3 448.2 20313.2 22409.6 22792.4 22883.2 22891.4 21447.9 22543.9 23295.5 24002.9 24281.5 6739.3 6819.0 6911.8 7093.0 7102.1 6734.2 6813.2 6842.6 6860.5 6864.9 6559.5 6816.7 6855.6 6888.3 6901.5 6586.7 6820.8 6893.0 6908.7 6955.0 6850.6 6863.6 6869.3 6875.4 6878.0 26455.5 26703.3 28417.6 28586.3 28638.2 3062.8 3103.4 3124.8 3128.7 3263.1 16012.4 16953.2 16958.6 17367.8 17381.4 2011.7 2051.9 2094.1 2104.9 2114.9 133166.0 142848.0 162892.0 165972.2 168653.0 19038.2 20155.5 20230.0 20387.7 20573.0 26483.0 33197.5 33233.3 33235.3 33273.0 10446.8 10532.7 10886.3 10895.7 11070.9 9057.4 9082.8 9100.0 9253.4 9268.3 9313.7 9450.8 9451.2 9512.4 9533.4 3213.0 3740.7 3810.8 3815.6 3821.7 1053.7 1055.9 1063.3 1073.2 1103.8 22233.6 22426.9 22748.3 22771.9 22836.4 936.0 1030.3 1081.6 1083.0 1127.9 9871.7 11591.7 11595.7 11632.0 11632.8 788898.0 790356.0 801395.0 811073.0 831718.0 73260.0 113336.0 114158.0 115113.0 144516.0 1147.7 1217.9 1263.8 1265.2 1271.4 20300.7 20383.4 20443.4 20478.9 20701.0 60439.7 60936.7 61451.0 61729.4 61844.0 87822.0 88771.6 89325.0 90640.5 90843.0 7873.8 9437.7 9580.3 11770.5 11891.6 13116.1 13190.9 13339.3 13621.9 13656.0 10344.8 10952.7 11482.8 11491.2 11867.2 10494.0 10501.5 10609.2 10729.6 10793.4 11527.5 11591.4 11878.3 11981.2 12030.6 11515.7 11616.7 11635.3 11880.0 11896.6 11285.5 11651.9 11661.7 11691.4 11770.1 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6882.57 Median:2545.56 stddev:4312.30 (169.4%) stddev-sans-first:4306.27 11:37:40 INFO - PROCESS | 1642 | Values: 1619.5 1638.2 1647.1 1661.3 1662.3 10742.2 11275.0 11597.7 11605.7 11628.3 11343.7 11560.3 11576.5 11580.6 11584.3 2034.9 2547.5 2547.8 2549.7 2551.0 2469.8 2475.2 2506.0 2515.1 2515.2 2118.2 2470.9 2505.1 2540.0 2543.7 2451.9 2465.8 2485.1 2492.2 2500.7 2439.8 2464.6 2467.7 2470.0 2472.2 11294.9 11562.3 11563.4 11577.9 11578.6 5969.3 6149.1 6174.5 6177.5 6197.1 3691.9 3766.4 3819.9 3837.2 3915.4 1231.3 1270.9 1283.2 1290.8 1318.2 13734.0 14008.4 14380.1 15957.1 16118.3 4144.6 4414.1 4807.5 4953.4 4962.2 10782.7 11695.1 12200.9 12206.3 12219.9 5192.9 5346.7 5898.7 6015.7 6152.9 5482.0 5676.0 5678.3 5698.0 5733.0 4012.1 4039.3 4121.2 4143.1 4152.7 1067.4 1084.4 1088.6 1103.2 1104.3 958.6 963.3 975.9 984.6 998.4 6491.1 6549.0 6581.4 6627.2 6679.9 905.2 935.4 941.4 990.6 1053.7 3289.3 4056.0 4186.4 4238.4 4239.1 13843.3 14506.5 14514.0 14523.3 14525.2 13734.4 14028.0 14258.6 14261.5 14282.3 9249.6 10253.7 10377.1 10395.9 10506.9 6439.3 6512.6 6579.6 6605.9 6613.6 12181.4 12452.8 12608.6 12610.7 12649.6 12631.7 12675.0 12816.6 12867.8 12972.5 8678.5 9164.4 9441.1 9678.9 9709.7 10737.1 10752.8 10759.2 10876.2 10936.8 8775.9 9042.3 9110.1 9173.4 9183.9 7529.8 8740.8 8884.4 8891.8 8893.9 6967.1 7476.7 8115.2 8139.4 8206.7 5650.2 5956.4 6015.3 6043.0 6114.4 5645.4 5738.3 5743.8 5766.2 5831.8 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4405.96 Median:4832.93 stddev:1261.44 (26.1%) stddev-sans-first:1227.92 11:37:40 INFO - PROCESS | 1642 | Values: 362.2 392.0 394.2 400.6 401.3 4396.0 4825.0 4871.6 4988.0 5116.2 3927.6 4388.9 4640.3 4952.1 4983.8 3363.9 3598.9 3646.9 3663.6 4002.6 3886.2 3995.7 3999.3 3999.3 4024.2 3630.7 3696.4 3978.3 3986.5 4015.7 3505.8 3773.1 3911.7 3921.4 3970.6 3557.4 3566.2 3569.7 3589.2 3597.3 4194.6 4639.2 4691.8 4901.8 4949.8 3781.0 3800.7 4324.2 4583.6 4661.0 5410.4 5426.3 5431.0 5474.9 5502.6 3985.2 4017.5 4182.6 4284.0 4396.9 4943.0 5284.3 5314.4 5322.6 5574.8 3777.9 3972.9 4009.6 4276.9 4500.6 4583.3 4585.3 4595.1 4604.5 4620.0 4312.0 4332.8 4771.9 4877.3 4923.4 4374.1 4390.9 4890.8 5309.1 5423.6 1443.0 1470.3 1550.7 1551.4 1553.6 1084.6 1161.7 1162.9 1172.9 1185.5 4870.4 5079.3 5088.8 5106.4 5108.7 4851.6 4949.0 5642.0 5647.9 5657.2 3958.2 4498.6 4590.0 4868.0 5093.7 2337.6 2350.2 2602.6 2652.8 2763.8 5232.7 5362.9 5574.9 5763.5 5829.7 5118.8 5466.8 5733.7 5757.9 5764.2 4833.4 4969.2 5719.1 5781.9 5797.7 4925.6 5340.9 5537.3 5593.0 5627.3 4788.3 5118.0 5374.3 5525.3 5576.7 5006.5 5097.3 5174.7 5513.0 5611.4 3432.3 3946.3 4419.4 4459.9 4466.0 4198.7 4832.5 5130.3 5146.9 5470.9 4928.8 4962.9 5475.3 5477.4 5508.7 4362.7 5048.9 5059.5 5414.9 5452.8 5061.9 5106.4 5267.2 5299.8 5302.3 5186.5 5252.0 5459.2 5472.5 5501.5 4476.0 5280.5 5285.7 5321.2 5334.6 11:37:40 INFO - PROCESS | 1642 | 11:37:40 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20571.77 Median:17636.43 stddev:28403.14 (161.0%) stddev-sans-first:28443.91 11:37:40 INFO - PROCESS | 1642 | Values: 773.2 784.7 803.0 848.3 912.8 15244.7 16454.6 17608.3 17664.6 17687.4 15444.9 15683.1 15716.8 15851.6 15858.0 973.2 1003.8 1030.5 1035.0 1035.4 897.7 921.6 991.8 1033.0 1033.3 1086.6 1086.9 1087.3 1089.5 1091.7 1082.2 1083.1 1083.4 1083.6 1085.8 808.8 809.2 809.7 810.0 810.2 16903.0 16932.9 16976.2 17455.8 17702.2 14177.3 14240.9 14831.5 14835.5 14869.5 12192.5 12201.0 12247.2 12279.9 12638.8 3826.9 3864.1 3869.7 3902.0 4019.2 96792.5 99066.5 107852.0 111304.0 118551.0 11957.9 11988.2 12035.9 12243.2 12300.1 26579.5 27132.2 27152.6 27185.5 27191.5 8289.9 8327.8 8602.3 8653.3 8831.4 4337.0 4500.2 4537.3 4573.2 4704.8 3463.7 3736.7 3740.9 3745.6 3751.1 656.9 670.7 693.7 703.7 704.7 670.9 675.7 687.0 706.6 733.3 8818.4 10182.6 10636.8 11560.4 11624.5 579.4 580.4 631.7 671.0 742.4 4720.4 4872.8 4877.9 4886.7 4888.2 96171.0 96462.0 97323.0 99928.5 102835.5 47576.0 69974.0 83873.6 87268.1 93945.6 71019.6 71354.3 80708.2 82894.8 84365.6 11286.5 11289.8 11409.9 11491.2 11600.9 47897.5 48465.0 52136.5 54463.0 54825.0 55862.7 65063.7 67045.7 69629.7 70027.9 12388.0 12681.4 13028.7 13220.4 13321.7 14263.9 14594.6 14869.5 15468.6 15515.8 13447.3 14388.5 14393.5 14446.8 14543.3 12951.9 14126.9 14207.1 14315.3 14492.0 13660.9 13762.9 14062.1 14384.8 14571.6 10214.3 10512.3 10653.1 11016.9 11066.8 11266.3 11469.8 11637.6 11642.4 11667.6 11:37:40 INFO - PROCESS | 1642 | -------- Summary: end -------- 11:37:40 INFO - PROCESS | 1642 | 11:37:41 INFO - TEST-INFO | 1642: exit 0 11:37:41 INFO - TEST-OK | dromaeo_css | took 1118492ms 11:37:41 INFO - TEST-START | kraken 11:37:41 INFO - operating with platform_type : mac_ 11:37:41 INFO - Initialising browser for kraken test... 11:37:41 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpnK7tY8/profile http://localhost:49223/getInfo.html) 11:37:43 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 11:37:43 INFO - PROCESS | 1652 | colorDepth:24 11:37:43 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 11:37:43 INFO - PROCESS | 1652 | __metrics 11:37:43 INFO - PROCESS | 1652 | 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" 11:37:43 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:37:43 INFO - TEST-INFO | 1652: exit 0 11:37:43 INFO - Browser initialized. 11:37:43 INFO - Running cycle 1/1 for kraken test... 11:37:43 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/tmpnK7tY8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:37:55 INFO - PROCESS | 1654 | RSS: Main: 165081088 11:37:55 INFO - PROCESS | 1654 | 11:37:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49223/tests/kraken/driver.html?testName=audio-beat-detection) 11:37:59 INFO - PROCESS | 1654 | RSS: Main: 216399872 11:37:59 INFO - PROCESS | 1654 | 11:38:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49223/tests/kraken/driver.html?testName=audio-dft) 11:38:02 INFO - PROCESS | 1654 | RSS: Main: 231694336 11:38:02 INFO - PROCESS | 1654 | 11:38:05 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49223/tests/kraken/driver.html?testName=audio-fft) 11:38:06 INFO - PROCESS | 1654 | RSS: Main: 327753728 11:38:06 INFO - PROCESS | 1654 | 11:38:08 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49223/tests/kraken/driver.html?testName=audio-oscillator) 11:38:09 INFO - PROCESS | 1654 | RSS: Main: 229416960 11:38:09 INFO - PROCESS | 1654 | 11:38:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:11 INFO - PROCESS | 1654 | RSS: Main: 232177664 11:38:11 INFO - PROCESS | 1654 | 11:38:14 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49223/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:15 INFO - PROCESS | 1654 | RSS: Main: 273387520 11:38:15 INFO - PROCESS | 1654 | 11:38:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49223/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:19 INFO - PROCESS | 1654 | RSS: Main: 272654336 11:38:19 INFO - PROCESS | 1654 | 11:38:21 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49223/tests/kraken/driver.html?testName=json-parse-financial) 11:38:22 INFO - PROCESS | 1654 | RSS: Main: 271654912 11:38:22 INFO - PROCESS | 1654 | 11:38:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:24 INFO - PROCESS | 1654 | RSS: Main: 246714368 11:38:24 INFO - PROCESS | 1654 | 11:38:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:27 INFO - PROCESS | 1654 | RSS: Main: 253640704 11:38:27 INFO - PROCESS | 1654 | 11:38:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:29 INFO - PROCESS | 1654 | RSS: Main: 261001216 11:38:29 INFO - PROCESS | 1654 | 11:38:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:33 INFO - PROCESS | 1654 | RSS: Main: 274255872 11:38:33 INFO - PROCESS | 1654 | 11:38:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:38:37 INFO - PROCESS | 1654 | RSS: Main: 267907072 11:38:37 INFO - PROCESS | 1654 | 11:38:38 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49223/tests/kraken/driver.html?testName=ai-astar) 11:38:39 INFO - PROCESS | 1654 | RSS: Main: 312397824 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | __start_tp_report 11:38:39 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 11:38:39 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 11:38:39 INFO - PROCESS | 1654 | |i|pagename|runs| 11:38:39 INFO - PROCESS | 1654 | |0;ai-astar;103;113;120;117;116;115;116;115;112;117 11:38:39 INFO - PROCESS | 1654 | |1;audio-beat-detection;157;135;93;125;130;136;137;118;126;106 11:38:39 INFO - PROCESS | 1654 | |2;audio-dft;184;184;183;183;184;183;182;183;184;179 11:38:39 INFO - PROCESS | 1654 | |3;audio-fft;83;59;60;90;60;62;58;61;75;58 11:38:39 INFO - PROCESS | 1654 | |4;audio-oscillator;89;69;85;68;69;68;81;68;68;83 11:38:39 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;89;88;87;88;102;109;88;87;87 11:38:39 INFO - PROCESS | 1654 | |6;imaging-darkroom;117;150;100;94;94;94;95;94;106;149 11:38:39 INFO - PROCESS | 1654 | |7;imaging-desaturate;84;83;83;86;84;85;85;84;83;86 11:38:39 INFO - PROCESS | 1654 | |8;json-parse-financial;59;59;59;60;63;63;62;62;63;64 11:38:39 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;54;70;64;60;60;57;56;57;58;57 11:38:39 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;85;83;84;82;79;80;80;83;82;87 11:38:39 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;134;135;133;133;133;145;134;135;192;168 11:38:39 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;160;162;161;171;166;160;161;160;210;204 11:38:39 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;64;63;64;63;63;65;73;80;78;79 11:38:39 INFO - PROCESS | 1654 | __end_tp_report 11:38:39 INFO - PROCESS | 1654 | __start_cc_report 11:38:39 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2097 11:38:39 INFO - PROCESS | 1654 | __end_cc_report 11:38:39 INFO - PROCESS | 1654 | __startTimestamp1495651119133__endTimestamp 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | ------- Summary: start ------- 11:38:39 INFO - PROCESS | 1654 | Number of tests: 14 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:114.40 Median:116.00 stddev:4.58 (3.9%) stddev-sans-first:2.35 11:38:39 INFO - PROCESS | 1654 | Values: 103.0 113.0 120.0 117.0 116.0 115.0 116.0 115.0 112.0 117.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:126.30 Median:135.50 stddev:17.74 (13.1%) stddev-sans-first:14.94 11:38:39 INFO - PROCESS | 1654 | Values: 157.0 135.0 93.0 125.0 130.0 136.0 137.0 118.0 126.0 106.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:182.90 Median:183.50 stddev:1.52 (0.8%) stddev-sans-first:1.56 11:38:39 INFO - PROCESS | 1654 | Values: 184.0 184.0 183.0 183.0 184.0 183.0 182.0 183.0 184.0 179.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.60 Median:61.50 stddev:11.70 (19.0%) stddev-sans-first:10.80 11:38:39 INFO - PROCESS | 1654 | Values: 83.0 59.0 60.0 90.0 60.0 62.0 58.0 61.0 75.0 58.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:74.80 Median:75.00 stddev:8.59 (11.4%) stddev-sans-first:7.41 11:38:39 INFO - PROCESS | 1654 | Values: 89.0 69.0 85.0 68.0 69.0 68.0 81.0 68.0 68.0 83.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:88.00 stddev:7.69 (8.7%) stddev-sans-first:8.06 11:38:39 INFO - PROCESS | 1654 | Values: 88.0 89.0 88.0 87.0 88.0 102.0 109.0 88.0 87.0 87.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:109.30 Median:94.00 stddev:22.44 (23.9%) stddev-sans-first:23.62 11:38:39 INFO - PROCESS | 1654 | Values: 117.0 150.0 100.0 94.0 94.0 94.0 95.0 94.0 106.0 149.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:1.16 (1.4%) stddev-sans-first:1.22 11:38:39 INFO - PROCESS | 1654 | Values: 84.0 83.0 83.0 86.0 84.0 85.0 85.0 84.0 83.0 86.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:62.50 stddev:1.96 (3.1%) stddev-sans-first:1.87 11:38:39 INFO - PROCESS | 1654 | Values: 59.0 59.0 59.0 60.0 63.0 63.0 62.0 62.0 63.0 64.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:4.64 (7.9%) stddev-sans-first:4.51 11:38:39 INFO - PROCESS | 1654 | Values: 54.0 70.0 64.0 60.0 60.0 57.0 56.0 57.0 58.0 57.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:2.46 (3.0%) stddev-sans-first:2.44 11:38:39 INFO - PROCESS | 1654 | Values: 85.0 83.0 84.0 82.0 79.0 80.0 80.0 83.0 82.0 87.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:135.00 stddev:20.02 (14.8%) stddev-sans-first:20.89 11:38:39 INFO - PROCESS | 1654 | Values: 134.0 135.0 133.0 133.0 133.0 145.0 134.0 135.0 192.0 168.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:164.00 stddev:19.08 (11.6%) stddev-sans-first:19.78 11:38:39 INFO - PROCESS | 1654 | Values: 160.0 162.0 161.0 171.0 166.0 160.0 161.0 160.0 210.0 204.0 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:7.39 (10.7%) stddev-sans-first:7.60 11:38:39 INFO - PROCESS | 1654 | Values: 64.0 63.0 64.0 63.0 63.0 65.0 73.0 80.0 78.0 79.0 11:38:39 INFO - PROCESS | 1654 | -------- Summary: end -------- 11:38:39 INFO - PROCESS | 1654 | 11:38:39 INFO - TEST-INFO | 1654: exit 0 11:38:39 INFO - TEST-OK | kraken | took 58858ms 11:38:39 INFO - SUITE-END | took 1177s 11:38:40 INFO - Completed test suite (00:19:37) 11:38:40 INFO - javascript benchmark 11:38:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7820.445616400579, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2878.8848446062157, 3049.2224482756897, 3564.7682900611444, 3570.428731402976, 3587.623299553547, 6107.297660769007, 6108.808782287456, 6133.723982420791, 6171.845703857406, 6177.135201071842, 6144.0, 6187.783427580036, 6200.255969283681, 6203.379662033794, 6220.03589443637, 5502.449755024496, 5514.6139770216105, 5551.1118221084635, 5567.55459563236, 5675.460831221028, 5362.088444964346, 5371.838844834661, 5384.057789886754, 5655.123455864347, 5674.517665998395, 5472.2338872557875, 5473.17902314654, 5482.013237617227, 5482.780688772445, 5504.146857237115, 5544.889102217953, 5589.608727389084, 5615.803446879339, 5628.605997580171, 5643.520300774439, 5472.972635136839, 5565.526930210937, 5576.442355764391, 5578.497935185812, 5588.580856435743, 5561.916571251434, 5828.41715828418, 5874.1776151338845, 6247.0, 6279.748810047593, 6333.8416539586415, 6344.460720838734, 6348.968255158695, 6371.0, 6384.297727249998, 6489.610623362566, 6540.93459065408, 6556.344365563453, 6563.212414510289, 6565.409113179789, 6218.844528886769, 6290.402411770874, 6292.33930437302, 6302.054691796176, 6308.842278943017, 6315.210598675166, 6365.745370185141, 6525.184351956005, 6591.703373348211, 6681.665916704145, 6360.0777887206095, 6383.106365108889, 6391.872162556723, 6400.295967443578, 6403.839904002437, 6465.935340646533, 6482.740690372332, 6522.804315870531, 6530.706118224692, 6534.313897040837, 6285.151504546828, 6305.3379395163765, 6316.115743795872, 6421.5825971311715, 6432.807015789534, 6268.310485846553, 6423.0686550450855, 6424.743010279536, 6428.0357946307495, 6438.25960014595, 5034.748262586856, 5106.795728170906, 5112.437631860493, 5225.895482090337, 5230.947690523046, 4664.39362882823, 4693.882652933704, 4715.4577223619035, 4719.38647975761, 4778.522147785194, 5125.461826508237, 5881.088431293157, 5911.290645122613, 6195.070739389038, 6205.379462053758, 6321.336259692758, 6358.395952384516, 6419.454346380517, 6498.090267362573, 6535.150430444012, 6181.721822517908, 6210.534209934182, 6214.689265536705, 6214.782482613087, 6232.439080482778, 5684.175794509855, 5710.057840456361, 5717.199592057115, 5723.255976723, 5761.48146666802, 6337.524685648595, 6400.679966001681, 6572.80281591553, 6677.69950352245, 6737.966310168418, 6397.424231819158, 6493.123428337303, 6498.707558159988, 6509.316521765147, 6522.28254891971, 6233.2208473940755, 6737.966310168418, 6741.426978706865, 6745.3591908768585, 6745.898811517929, 5968.432998865101, 6273.96863015682, 6305.779297724557, 6312.14786003902, 6352.205974253218, 6472.385123413268, 6521.7065232065615, 6525.967370163119, 6527.706253218712, 6537.640429776408, 6312.210973628296, 6346.587471814318, 6357.841053973688, 6361.968190159019, 6364.427201551883, 6199.411055949678, 6244.0321750128805, 6283.214598175228, 6297.086922396135, 6343.270523889812, 5537.390887002346, 6256.311805701278, 6296.811095667137, 6306.243250809932, 6308.022256550242, 6382.585131966407, 6388.744450221939, 6391.552591318563, 6395.296517383177, 6409.903851442139, 6121.0, 6121.8493044937295, 6144.600600960924, 6265.185525881606, 6313.305536391085], "value": 5970.659881198701, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.7249962513117, 819.1235378145385, 840.3865178419752, 908.5048648486578, 922.7600823785814, 29508.704912950863, 41146.38280425796, 41351.37972930405, 43591.12817743643, 43810.56189438105, 43140.56859431405, 43325.91685207871, 43382.0, 43437.78281108598, 43494.78252608733, 7920.128785833554, 9727.805443891119, 9888.950555247213, 9914.553845076953, 9925.205983521337, 7953.681852725884, 11767.823482647767, 11918.880811191864, 11927.821082683766, 11930.522779088826, 12065.758684826298, 12114.575989840358, 12130.575429859957, 12148.088893332992, 12160.817587736146, 12031.278123312586, 12037.879621203763, 12047.879521204763, 12066.396680165957, 12068.879311206863, 11755.471003804763, 11827.822582661267, 11838.704032399173, 11843.111766617452, 11865.5847045353, 41005.79497102495, 41253.381199282034, 41283.1743365134, 41331.76004719863, 41369.79315103405, 4027.8791636250958, 4071.2671719090554, 4091.631753142202, 4102.856400026015, 4122.814473348676, 28825.71174288251, 29072.69172887204, 30098.097057088322, 30973.690263097305, 31100.688993110005, 3137.748980081588, 3294.769366144347, 3296.324253528021, 3332.216929021678, 3361.3277344531193, 351415.0, 356978.0, 357177.0, 358516.0, 358583.0, 54323.45676543263, 54476.182857257176, 54609.72695136578, 54645.45354546483, 54741.452585474435, 56404.0, 56547.43452565504, 56570.15144772832, 56639.71680141573, 56695.0, 15607.765883511756, 15982.920085399499, 15988.120653364176, 15989.200539972955, 16022.439214627431, 12092.87907120935, 12134.089943254292, 13752.449902004008, 13755.724885502234, 13757.0, 10684.51919663617, 11845.940770296093, 11957.581484647995, 12057.276563406223, 12192.0, 4712.929306060412, 5492.176173573996, 5536.169574563848, 5536.446355364512, 5557.72211389437, 1055.472263868066, 1076.445630500293, 1076.4563895232857, 1076.8653918260218, 1118.2395970739974, 28390.43219135647, 28457.857710711727, 28578.571321430194, 28848.423031539252, 28849.56725649117, 887.0, 1177.8704342522315, 1181.1141643767176, 1248.7477807202786, 1257.4530079415483, 14144.36350364236, 14284.928575357057, 14585.708285834224, 14615.634609134644, 14617.634559135893, 484144.0, 554239.0, 561665.0, 562838.0, 563096.0, 51634.0, 52102.47897521052, 52230.47769522332, 52443.0, 52580.21129683058, 1450.840407555168, 1508.6907184027248, 1508.9773653395428, 1510.124128005754, 1518.2864053894652, 27333.809578522752, 27450.313742156606, 27935.441291173654, 28284.71715282903, 28498.57252141261, 30667.539986899767, 41720.37419438772, 41748.956276092125, 41847.1630567393, 41956.58043419649, 450780.0, 451534.0, 452150.0, 452472.0, 453820.0, 28775.85612071926, 29361.706382935896, 29472.11583652494, 30047.549286760277, 30145.976356292053, 39964.40053399259, 40029.0, 40047.0, 40254.0, 40431.59568404278, 22242.77757222407, 28024.43951121007, 28347.433051338445, 28469.857650711612, 29269.0, 27232.183034508995, 28413.147605571867, 29451.41097178087, 29498.852505737334, 29522.55716164302, 33478.66521334756, 33955.66044339525, 34207.0, 34216.657833422345, 34229.973100807016, 28656.0, 28715.569266461436, 28992.710072899, 29200.560174011873, 29377.971770988766, 23156.88421557949, 23333.41666458352, 23552.17567385202, 23553.0, 23574.410639734146], "value": 19182.82380816049, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.36735998082844, 431.7387980271935, 437.07994671217097, 444.2580889913844, 448.1708838648499, 20313.1874725011, 22409.55180896381, 22792.430189245235, 22883.19908803192, 22891.427714307152, 21447.892760536215, 22543.872806359697, 23295.534089318204, 24002.87998560009, 24281.514369712597, 6739.292374300701, 6819.045333653293, 6911.827204319907, 7093.0, 7102.112235970504, 6734.225564060122, 6813.182418109809, 6842.623655698934, 6860.485463590251, 6864.931350686479, 6559.508036897228, 6816.659167041628, 6855.622940738257, 6888.311168883097, 6901.482388820833, 6586.670666466705, 6820.761273355433, 6892.965535172342, 6908.689108990083, 6954.965225173842, 6850.588964662136, 6863.588184708883, 6869.347411995853, 6875.449964002868, 6878.0, 26455.47089058208, 26703.332416689544, 28417.57373639397, 28586.285342866595, 28638.19524544254, 3062.800917940349, 3103.379324135182, 3124.8437578121, 3128.7340576051065, 3263.086335825949, 16012.439564615182, 16953.152342382833, 16958.576035599086, 17367.826321736746, 17381.391651292142, 2011.6680747676617, 2051.887146206958, 2094.068139677844, 2104.8737075775502, 2114.947126321839, 133166.0, 142848.0, 162892.0, 165972.17013914854, 168652.99999999878, 19038.238470461027, 20155.496112597302, 20230.0, 20387.694184587242, 20573.0, 26483.0, 33197.50203746946, 33233.33533329368, 33235.335293293996, 33273.0, 10446.843297350546, 10532.65121877822, 10886.346819190874, 10895.727606809893, 11070.889291107147, 9057.365984381162, 9082.775614656834, 9100.0, 9253.398529095588, 9268.25853931684, 9313.720588382359, 9450.763730906783, 9451.243900487945, 9512.429254244767, 9533.380330278509, 3212.9839350803095, 3740.7007439404783, 3810.8094595270127, 3815.5802861685193, 3821.7324787264624, 1053.6680945502142, 1055.8574592430077, 1063.3194755356578, 1073.1682945716975, 1103.7626910214342, 22233.55481893672, 22426.88786556057, 22748.31755047351, 22771.886140569524, 22836.42908927257, 935.9657578375933, 1030.253066526762, 1081.648464249122, 1082.983755243672, 1127.8984891359653, 9871.703848884545, 11591.710207244887, 11595.652130436101, 11632.0, 11632.825507617392, 788898.0, 790356.0482197552, 801395.0, 811073.0, 831718.0, 73260.0, 113336.0, 114158.0, 115113.0, 144516.0, 1147.71880889181, 1217.9330136842382, 1263.7788387032233, 1265.1586694847824, 1271.3516106785605, 20300.695489567963, 20383.388498345073, 20443.38669839907, 20478.897605511876, 20701.0, 60439.69780151071, 60936.69531652491, 61450.99999999821, 61729.382706172364, 61844.0, 87822.0, 88771.55614221888, 89325.0, 90640.51663233718, 90843.0, 7873.763787086396, 9437.669681561112, 9580.28147888925, 11770.469838920886, 11891.643250702493, 13116.08187426871, 13190.934045329712, 13339.266340351374, 13621.931890340486, 13656.0, 10344.793104138025, 10952.671419857099, 11482.82775758381, 11491.195616306779, 11867.228630139014, 10494.0, 10501.474926253504, 10609.20430967665, 10729.570817167227, 10793.352398856094, 11527.538898443969, 11591.411195233957, 11878.346690932081, 11981.161318707607, 12030.578929737418, 11515.654530364103, 11616.709582260173, 11635.301881887113, 11880.0, 11896.643100706993, 11285.492152853305, 11651.88348116508, 11661.6501504955, 11691.415429228675, 11770.058395328524], "value": 11747.32667661748, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1619.5384315470087, 1638.2382192280588, 1647.1105602974387, 1661.2690416216867, 1662.2519866060272, 10742.194335424845, 11274.985251327378, 11597.652070437889, 11605.709857253572, 11628.302301861884, 11343.716407089807, 11560.306381617109, 11576.53693852245, 11580.59467918621, 11584.304941703482, 2034.888081155536, 2547.465032343201, 2547.7707006369424, 2549.7067837198774, 2551.0306083688174, 2469.826832254683, 2475.195561442529, 2506.0477018732854, 2515.107136966378, 2515.1825656661567, 2118.237434523578, 2470.938226544342, 2505.1232068775876, 2540.0347867810297, 2543.656606358146, 2451.901923923041, 2465.778079972811, 2485.092941076512, 2492.190038237562, 2500.6999160100813, 2439.780419762212, 2464.581021226396, 2467.7038755349295, 2469.987650061756, 2472.184179220853, 11294.943525282402, 11562.306261624246, 11563.42182890852, 11577.94211028948, 11578.594749183821, 5969.283685957669, 6149.13912052313, 6174.5060395168275, 6177.505799536027, 6197.101420294032, 3691.9077023074638, 3766.39737641976, 3819.9427008594894, 3837.2325534893134, 3915.353966595508, 1231.347385885482, 1270.8602053774077, 1283.1980012492193, 1290.8394907860845, 1318.1827267094463, 13733.969952253521, 14008.36962336687, 14380.137191768423, 15957.12235827029, 16118.274677639534, 4144.647704945053, 4414.139242847678, 4807.519248075165, 4953.430355509163, 4962.15643340633, 10782.730431739112, 11695.064394848392, 12200.938995304967, 12206.267623942593, 12219.877801222052, 5192.948070519322, 5346.705931173745, 5898.675572843449, 6015.6691381974415, 6152.907706384408, 5482.0, 5676.035074037423, 5678.290213723285, 5698.0, 5733.025385684444, 4012.0972781124597, 4039.2931237033404, 4121.196366708523, 4143.129942712004, 4152.667786577066, 1067.386252904583, 1084.4469320646526, 1088.6065835730278, 1103.150574057987, 1104.2987702808614, 958.6453012385323, 963.349738926222, 975.858500517421, 984.6455276100598, 998.4175082494328, 6491.123698300669, 6549.0, 6581.3747693969, 6627.1716035495565, 6679.899801502981, 905.158202871336, 935.3919952031098, 941.3598752847992, 990.5641517732175, 1053.7312985188728, 3289.276359200972, 4056.0, 4186.434831297796, 4238.406623072772, 4239.109786944776, 13843.30783460823, 14506.492272770402, 14514.0, 14523.273836308354, 14525.201113938834, 13734.381952812148, 14028.018038737395, 14258.643533911527, 14261.500847470288, 14282.285885705673, 9249.583768730423, 10253.7436564085, 10377.11794497461, 10395.94802026, 10506.894931050592, 6439.291677915519, 6512.6092434454085, 6579.572327798678, 6605.900911486236, 6613.636250006103, 12181.390930453264, 12452.81320780171, 12608.621741347773, 12610.684732881751, 12649.557265495663, 12631.684207894508, 12675.049371297006, 12816.55142070023, 12867.806982895077, 12972.481100755864, 8678.522681252593, 9164.358494905293, 9441.055894410778, 9678.85481717789, 9709.6601618943, 10737.14102871784, 10752.784944301227, 10759.193060520649, 10876.238663293494, 10936.835947460953, 8775.91224087751, 9042.321825863219, 9110.134537218953, 9173.40372875761, 9183.908160918305, 7529.8117547061765, 8740.825183496167, 8884.422512536665, 8891.822163556822, 8893.911060889308, 6967.1291088613925, 7476.691578973767, 8115.229053239933, 8139.389545784208, 8206.712765053195, 5650.152477128299, 5956.374580668968, 6015.338312785502, 6043.0, 6114.449699527064, 5645.4072322405555, 5738.282714660668, 5743.770249189985, 5766.163906233489, 5831.7667293307795], "value": 5258.32989295712, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.15075647606363, 391.9764814111152, 394.2469882524379, 400.6074047433517, 401.29172011399885, 4396.010528050661, 4825.0, 4871.585915197208, 4987.959752600387, 5116.232565115234, 3927.6465118139363, 4388.912221755563, 4640.303954406832, 4952.097423550686, 4983.825566105187, 3363.882264120756, 3598.8689839839376, 3646.8723594674193, 3663.6153203913605, 4002.559718430985, 3886.173498455721, 3995.6603688686496, 3999.280129576675, 3999.320115580358, 4024.2353952748886, 3630.6929505378043, 3696.445533170019, 3978.3236849735613, 3986.4817573715377, 4015.678745700337, 3505.8422370993367, 3773.0568757090123, 3911.7261791674596, 3921.3529767588598, 3970.563238043813, 3557.3596752584785, 3566.2154326048226, 3569.714422846166, 3589.2412717768366, 3597.2660777809056, 4194.622483976426, 4639.164950308943, 4691.812327506896, 4901.779419926112, 4949.826756063557, 3780.9621903780885, 3800.6769424598942, 4324.248679284895, 4583.633309335279, 4661.0, 5410.3507579090365, 5426.321709786277, 5431.0, 5474.945250547484, 5502.5597952164135, 3985.20295940813, 4017.4978127734034, 4182.623563879235, 4283.993261583525, 4396.934045989313, 4943.011397720435, 5284.2866213061125, 5314.441983591706, 5322.574194064466, 5574.777008919638, 3777.9244415111543, 3972.880813575597, 4009.599040095967, 4276.893077673021, 4500.572445617661, 4583.289590113471, 4585.266357382803, 4595.071214111953, 4604.516525764813, 4620.020087043905, 4312.029793296483, 4332.848350307724, 4771.928421073687, 4877.268409738567, 4923.433805112386, 4374.103308821747, 4390.8902277442685, 4890.804367825318, 5309.097453432925, 5423.616977670668, 1442.9826971984726, 1470.3456961651962, 1550.6976139652886, 1551.4027099566747, 1553.6115971007248, 1084.6366467233408, 1161.7269941563725, 1162.8662703789003, 1172.9120315976336, 1185.4606154199992, 4870.391201099792, 5079.31429257053, 5088.796448142107, 5106.361704786902, 5108.66793658411, 4851.587615052689, 4949.045127174746, 5642.0, 5647.943520564741, 5657.20799088128, 3958.247932892741, 4498.550144985541, 4589.990202155521, 4868.0, 5093.694378337237, 2337.64935259709, 2350.200931683236, 2602.5705758550007, 2652.774514166279, 2763.7927155463017, 5232.712200828991, 5362.91955620666, 5574.916376254359, 5763.538916886639, 5829.708514574254, 5118.795248190105, 5466.835994920159, 5733.713314334266, 5757.8560535986935, 5764.184281951172, 4833.3958255218095, 4969.211084009754, 5719.056355701346, 5781.88436231273, 5797.652140871562, 4925.601848847778, 5340.866478338073, 5537.280153580009, 5593.049181639212, 5627.324721033502, 4788.307458690572, 5118.00198961199, 5374.3013408256675, 5525.254090697865, 5576.693281869374, 5006.549410553068, 5097.278986339918, 5174.663646862942, 5512.972435137799, 5611.438856114356, 3432.3306955143507, 3946.329124048976, 4419.447569053868, 4459.910801784011, 4466.012624382119, 4198.690720103869, 4832.468428472936, 5130.333056702605, 5146.904564481062, 5470.945290547203, 4928.778204980713, 4962.851114466572, 5475.260839786578, 5477.370102438271, 5508.724563771715, 4362.672799540111, 5048.925829541287, 5059.468755780737, 5414.891702166014, 5452.781888724407, 5061.924071138862, 5106.387233532, 5267.155735902723, 5299.8410047698635, 5302.250257414967, 5186.481351864783, 5252.032601580095, 5459.208414779914, 5472.50747432733, 5501.504864562208, 4476.0, 5280.524752772269, 5285.709285989307, 5321.206366657536, 5334.599905007218], "value": 4050.6314145091646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.176566956192, 784.7371130671224, 802.9859180062156, 848.2620120495169, 912.7672443526902, 15244.695106097872, 16454.588635284123, 17608.29566817329, 17664.55838604034, 17687.380941667045, 15444.922775386136, 15683.137427441487, 15716.764248536281, 15851.603709907258, 15858.0, 973.1728031173517, 1003.7691330993857, 1030.5259580592935, 1034.974125646861, 1035.3942943378133, 897.6768363389175, 921.5668635741191, 991.8115558043985, 1032.989670103297, 1033.3076838518211, 1086.5708045322092, 1086.945652717365, 1087.3475914451305, 1089.4661615808236, 1091.6561283195767, 1082.161324973148, 1083.1389045708681, 1083.377058191543, 1083.5990683447096, 1085.7502774361863, 808.7573727881671, 809.2029351089172, 809.6761295481796, 809.9996504317163, 810.1898101898101, 16903.0, 16932.915335423244, 16976.151192440328, 17455.825441745546, 17702.203400846865, 14177.291135443187, 14240.857591424057, 14831.480898168513, 14835.480758173411, 14869.479568215169, 12192.451339689647, 12201.0, 12247.203931744409, 12279.877201227962, 12638.810417843648, 3826.8660596879254, 3864.0533069397898, 3869.690424766012, 3901.955929685566, 4019.1760689058674, 96792.51603741937, 99066.50466747693, 107852.0, 111304.0, 118551.0, 11957.940210298893, 11988.220765650205, 12035.879641203475, 12243.20419172751, 12300.077494187972, 26579.468410631678, 27132.186034419, 27152.592711109348, 27185.45629087407, 27191.45617087647, 8289.917100828914, 8327.849237212133, 8602.31181505478, 8653.307735381155, 8831.381803273838, 4336.9783151084675, 4500.212462818994, 4537.296719008559, 4573.245414506569, 4704.764761761899, 3463.688268055887, 3736.7384283099923, 3740.8877733668032, 3745.6254374562327, 3751.0997360633796, 656.8981807819796, 670.6814263225027, 693.6577027805971, 703.6516924122592, 704.7145905908116, 670.8825955457776, 675.7060678604724, 687.0, 706.593708617547, 733.3216774483582, 8818.382713210141, 10182.643607473703, 10636.787264254672, 11560.434077585132, 11624.476898539586, 579.3858509979435, 580.3963877567367, 631.7125707802938, 670.9664516774142, 742.4459858088267, 4720.409948756405, 4872.82945096927, 4877.878053048631, 4886.682365646222, 4888.242322440027, 96171.0, 96462.0, 97323.0, 99928.50035749775, 102835.48582257041, 47576.04847903023, 69974.0, 83873.58063209645, 87268.12731872727, 93945.59081613782, 71019.64490177722, 71354.28645713581, 80708.19291807125, 82894.75657865137, 84365.57817210874, 11286.49210785533, 11289.830652540055, 11409.885901140882, 11491.195616307112, 11600.883991160317, 47897.521024789305, 48465.03069938652, 52136.47863521468, 54463.0, 54825.0, 55862.72068639631, 65063.67468162629, 67045.66477167583, 69629.65185174042, 70027.94958075735, 12388.0, 12681.365931703562, 13028.674283142997, 13220.405081771536, 13321.733565328834, 14263.857361426253, 14594.635134121732, 14869.546524823283, 15468.613284667523, 15515.76726349083, 13447.327633618084, 14388.496402625859, 14393.496227631982, 14446.783298250744, 14543.272836357928, 12951.935240323737, 14126.858731412554, 14207.147571145764, 14315.284235788376, 14492.0, 13660.86339136596, 13762.931185344009, 14062.085964412281, 14384.784228236376, 14571.635709107357, 10214.336068155844, 10512.316699414514, 10653.147748179972, 11016.944915275693, 11066.833997489883, 11266.267692599955, 11469.770604588028, 11637.592684256011, 11642.359670218219, 11667.59163429276], "value": 7981.806117720815, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1438.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 120.0, 117.0, 116.0, 115.0, 116.0, 115.0, 112.0, 117.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 135.0, 93.0, 125.0, 130.0, 136.0, 137.0, 118.0, 126.0, 106.0], "value": 126.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 183.0, 183.0, 184.0, 183.0, 182.0, 183.0, 184.0, 179.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 60.0, 90.0, 60.0, 62.0, 58.0, 61.0, 75.0, 58.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 85.0, 68.0, 69.0, 68.0, 81.0, 68.0, 68.0, 83.0], "value": 74.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 87.0, 88.0, 102.0, 109.0, 88.0, 87.0, 87.0], "value": 91.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 150.0, 100.0, 94.0, 94.0, 94.0, 95.0, 94.0, 106.0, 149.0], "value": 109.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 86.0, 84.0, 85.0, 85.0, 84.0, 83.0, 86.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 63.0, 63.0, 62.0, 62.0, 63.0, 64.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 70.0, 64.0, 60.0, 60.0, 57.0, 56.0, 57.0, 58.0, 57.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 82.0, 79.0, 80.0, 80.0, 83.0, 82.0, 87.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 133.0, 133.0, 133.0, 145.0, 134.0, 135.0, 192.0, 168.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 171.0, 166.0, 160.0, 161.0, 160.0, 210.0, 204.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 63.0, 65.0, 73.0, 80.0, 78.0, 79.0], "value": 69.2, "unit": "score"}]}]} 11:38:40 INFO - Return code: 0 11:38:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:38:40 INFO - # TBPL SUCCESS # 11:38:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:40 INFO - 2017-05-24 11:38:40.447 screenresolution[1658:9997] starting screenresolution argv=screenresolution get 11:38:40 INFO - 2017-05-24 11:38:40.449 screenresolution[1658:9997] Display 0: 1600x1200x32@60 11:38:40 INFO - 2017-05-24 11:38:40.455 screenresolution[1659:10000] starting screenresolution argv=screenresolution list 11:38:40 INFO - Available Modes on Display 0 11:38:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:38:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:38:40 INFO - Intel Iris: 11:38:40 INFO - Chipset Model: Intel Iris 11:38:40 INFO - Type: GPU 11:38:40 INFO - Bus: Built-In 11:38:40 INFO - VRAM (Dynamic, Max): 1536 MB 11:38:40 INFO - Vendor: Intel (0x8086) 11:38:40 INFO - Device ID: 0x0a2e 11:38:40 INFO - Revision ID: 0x0009 11:38:40 INFO - Displays: 11:38:40 INFO - Display: 11:38:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:38:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:38:40 INFO - Display Serial Number: 1600x1200 60 11:38:40 INFO - Main Display: Yes 11:38:40 INFO - Mirror: Off 11:38:40 INFO - Online: Yes 11:38:40 INFO - Rotation: Supported 11:38:40 INFO - Return code: 0 11:38:40 INFO - Running post-action listener: _resource_record_post_action 11:38:40 INFO - [mozharness: 2017-05-24 18:38:40.689101Z] Finished run-tests step (success) 11:38:40 INFO - Running post-run listener: _resource_record_post_run 11:38:40 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 38581248; Write bytes: 424480768; Read time: 243; Write time: 1382 11:38:40 INFO - TinderboxPrint: CPU usage
53.7% 11:38:40 INFO - TinderboxPrint: I/O read bytes / time
38,581,248 / 243 11:38:40 INFO - TinderboxPrint: I/O write bytes / time
424,480,768 / 1,382 11:38:40 INFO - TinderboxPrint: CPU idle
2,207.9 (46.3%) 11:38:40 INFO - TinderboxPrint: CPU system
953.4 (20.0%) 11:38:40 INFO - TinderboxPrint: CPU user
1,612.4 (33.8%) 11:38:40 INFO - TinderboxPrint: Swap in / out
160,530,432 / 0 11:38:40 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 119804416; Write bytes: 116598784; Read time: 11208; Write time: 259 11:38:40 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 36463616; Write bytes: 296810496; Read time: 222; Write time: 1086 11:38:41 INFO - Running post-run listener: _upload_blobber_files 11:38:41 INFO - Blob upload gear active. 11:38:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:38:41 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 11:38:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:38:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:38:41 INFO - (blobuploader) - INFO - Open directory for files ... 11:38:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:38:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:38:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:43 INFO - (blobuploader) - INFO - Done attempting. 11:38:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:38:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:38:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:44 INFO - (blobuploader) - INFO - Done attempting. 11:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:45 INFO - (blobuploader) - INFO - Done attempting. 11:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:38:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:38:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:38:47 INFO - (blobuploader) - INFO - Done attempting. 11:38:47 INFO - (blobuploader) - INFO - Iteration through files over. 11:38:47 INFO - Return code: 0 11:38:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:38:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:38:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8111e16ac4fe04395ed865c792e88ec49604fe938c46698eb8b3c257ad39627c97db2a1aa7e4698bd6d8538b6eea48e3b101357f0535141b4ed9197c54afb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21c65d3d520fda28c83ff6db369557e6519d8e087a1c04292fd685c83c6e3444c6e2de1709fb0ee99b93415f7a0906a582b5f47597f7cf488fcf36260792563e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a316020fd1b3bf81b263961cd841fb8c769e319209a12fcf7c56ef8327f3264f7ef18fa496074b316b45947cd436e661953374431d00c977f923bd7a043d0ac0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae968190e820b9fe63933502444559fe75609af6775891719dfdb027ef4058668e3a990a2c7804c60ecababc2e762088ab65d1f350e13df6c5c155d42eb6c0fd"} 11:38:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:38:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:38:47 INFO - Contents: 11:38:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8111e16ac4fe04395ed865c792e88ec49604fe938c46698eb8b3c257ad39627c97db2a1aa7e4698bd6d8538b6eea48e3b101357f0535141b4ed9197c54afb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21c65d3d520fda28c83ff6db369557e6519d8e087a1c04292fd685c83c6e3444c6e2de1709fb0ee99b93415f7a0906a582b5f47597f7cf488fcf36260792563e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a316020fd1b3bf81b263961cd841fb8c769e319209a12fcf7c56ef8327f3264f7ef18fa496074b316b45947cd436e661953374431d00c977f923bd7a043d0ac0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae968190e820b9fe63933502444559fe75609af6775891719dfdb027ef4058668e3a990a2c7804c60ecababc2e762088ab65d1f350e13df6c5c155d42eb6c0fd"} 11:38:47 INFO - Running post-run listener: copy_logs_to_upload_dir 11:38:47 INFO - Copying logs to upload dir... 11:38:47 INFO - mkdir: /builds/slave/test/build/upload/logs 11:38:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.333756 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-24 11:38:47.881277) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 11:38:47.884423) ========= 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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8111e16ac4fe04395ed865c792e88ec49604fe938c46698eb8b3c257ad39627c97db2a1aa7e4698bd6d8538b6eea48e3b101357f0535141b4ed9197c54afb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21c65d3d520fda28c83ff6db369557e6519d8e087a1c04292fd685c83c6e3444c6e2de1709fb0ee99b93415f7a0906a582b5f47597f7cf488fcf36260792563e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a316020fd1b3bf81b263961cd841fb8c769e319209a12fcf7c56ef8327f3264f7ef18fa496074b316b45947cd436e661953374431d00c977f923bd7a043d0ac0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae968190e820b9fe63933502444559fe75609af6775891719dfdb027ef4058668e3a990a2c7804c60ecababc2e762088ab65d1f350e13df6c5c155d42eb6c0fd"} build_url:https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/Y0-sMlvgQEysXxRD8xTQ5A/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b8111e16ac4fe04395ed865c792e88ec49604fe938c46698eb8b3c257ad39627c97db2a1aa7e4698bd6d8538b6eea48e3b101357f0535141b4ed9197c54afb55", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/21c65d3d520fda28c83ff6db369557e6519d8e087a1c04292fd685c83c6e3444c6e2de1709fb0ee99b93415f7a0906a582b5f47597f7cf488fcf36260792563e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a316020fd1b3bf81b263961cd841fb8c769e319209a12fcf7c56ef8327f3264f7ef18fa496074b316b45947cd436e661953374431d00c977f923bd7a043d0ac0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ae968190e820b9fe63933502444559fe75609af6775891719dfdb027ef4058668e3a990a2c7804c60ecababc2e762088ab65d1f350e13df6c5c155d42eb6c0fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 11:38:47.919512) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 11:38:47.920185) ========= 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.zWYYyIVtQk/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.WPYjcXPpBg/Listeners TMPDIR=/var/folders/ng/csmfm9x9681blsv1wkb387f800000w/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.004981 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 11:38:47.969104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 11:38:47.969413) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 11:38:47.969765) ========= ========= Total master_lag: 0.17 =========