builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0268 starttime: 1487909010.48 results: success (0) buildid: 20170223184858 builduid: 93548a5ea54241cc8b7460eaedc8ef69 revision: 883dd404cfa2bab84de402e87484e1b2b268f466 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.477890) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.478636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.479046) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.505420) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.505827) ========= 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.vnh47lwEWe/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.61AR75wxSP/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-02-23 20:03:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 48.2M=0s 2017-02-23 20:03:30 (48.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.627588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.627905) ========= 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.vnh47lwEWe/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.61AR75wxSP/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.025321 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:30.676488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 20:03:30.676861) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 883dd404cfa2bab84de402e87484e1b2b268f466 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 883dd404cfa2bab84de402e87484e1b2b268f466 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vnh47lwEWe/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.61AR75wxSP/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-02-23 20:03:30,783 truncating revision to first 12 chars 2017-02-23 20:03:30,783 Setting DEBUG logging. 2017-02-23 20:03:30,783 attempt 1/10 2017-02-23 20:03:30,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/883dd404cfa2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 20:03:32,076 unpacking tar archive at: mozilla-aurora-883dd404cfa2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.569507 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 20:03:32.269163) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:32.269504) ========= script_repo_revision: 883dd404cfa2bab84de402e87484e1b2b268f466 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:32.269943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:32.270390) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 20:03:32.290398) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-23 20:03:32.290939) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vnh47lwEWe/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.61AR75wxSP/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:03:32 INFO - MultiFileLogger online at 20170223 20:03:32 in /builds/slave/test 20:03:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 20:03:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:03:32 INFO - {'append_to_log': False, 20:03:32 INFO - 'base_work_dir': '/builds/slave/test', 20:03:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 20:03:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:03:32 INFO - 'branch': 'Mozilla-Aurora', 20:03:32 INFO - 'buildbot_json_path': 'buildprops.json', 20:03:32 INFO - 'config_files': ('talos/mac_config.py',), 20:03:32 INFO - 'default_actions': ('clobber', 20:03:32 INFO - 'read-buildbot-config', 20:03:32 INFO - 'download-and-extract', 20:03:32 INFO - 'populate-webroot', 20:03:32 INFO - 'create-virtualenv', 20:03:32 INFO - 'install', 20:03:32 INFO - 'run-tests'), 20:03:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:03:32 INFO - 'download_minidump_stackwalk': True, 20:03:32 INFO - 'download_symbols': 'ondemand', 20:03:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:03:32 INFO - 'tooltool.py': '/tools/tooltool.py', 20:03:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:03:32 INFO - '/tools/misc-python/virtualenv.py')}, 20:03:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:03:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:03:32 INFO - 'installer_path': 'installer.exe', 20:03:32 INFO - 'log_level': 'info', 20:03:32 INFO - 'log_name': 'talos', 20:03:32 INFO - 'log_to_console': True, 20:03:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:03:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:03:32 INFO - 'opt_config_files': (), 20:03:32 INFO - 'pip_index': False, 20:03:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:03:32 INFO - 'cmd': ('bash', 20:03:32 INFO - '-c', 20:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:03:32 INFO - 'enabled': True, 20:03:32 INFO - 'halt_on_failure': False, 20:03:32 INFO - 'name': 'check_screen_resolution'},), 20:03:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:03:32 INFO - 'cmd': ('bash', 20:03:32 INFO - '-c', 20:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:03:32 INFO - 'enabled': True, 20:03:32 INFO - 'halt_on_failure': False, 20:03:32 INFO - 'name': 'check_screen_resolution'},), 20:03:32 INFO - 'run_cmd_checks_enabled': True, 20:03:32 INFO - 'sps_profile': False, 20:03:32 INFO - 'sps_profile_interval': 0, 20:03:32 INFO - 'suite': 'dromaeojs-e10s', 20:03:32 INFO - 'system_bits': '32', 20:03:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:03:32 INFO - 'title': 't-yosemite-r7-0268', 20:03:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:03:32 INFO - 'use_talos_json': True, 20:03:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:03:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:03:32 INFO - 'work_dir': 'build'} 20:03:32 INFO - [mozharness: 2017-02-24 04:03:32.500533Z] Running clobber step. 20:03:32 INFO - Running pre-action listener: _resource_record_pre_action 20:03:32 INFO - Running main action method: clobber 20:03:32 INFO - rmtree: /builds/slave/test/build 20:03:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:03:36 INFO - Running post-action listener: _resource_record_post_action 20:03:36 INFO - [mozharness: 2017-02-24 04:03:36.796406Z] Finished clobber step (success) 20:03:36 INFO - [mozharness: 2017-02-24 04:03:36.796529Z] Running read-buildbot-config step. 20:03:36 INFO - Running pre-action listener: _resource_record_pre_action 20:03:36 INFO - Running main action method: read_buildbot_config 20:03:36 INFO - Using buildbot properties: 20:03:36 INFO - { 20:03:36 INFO - "project": "", 20:03:36 INFO - "product": "firefox", 20:03:36 INFO - "script_repo_revision": "production", 20:03:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 20:03:36 INFO - "repository": "", 20:03:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 20:03:36 INFO - "buildid": "20170223184858", 20:03:36 INFO - "pgo_build": "False", 20:03:36 INFO - "basedir": "/builds/slave/test", 20:03:36 INFO - "buildnumber": 8, 20:03:36 INFO - "slavename": "t-yosemite-r7-0268", 20:03:36 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 20:03:36 INFO - "platform": "yosemite_r7", 20:03:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 20:03:36 INFO - "branch": "mozilla-aurora", 20:03:36 INFO - "repo_path": "releases/mozilla-aurora", 20:03:36 INFO - "revision": "883dd404cfa2bab84de402e87484e1b2b268f466", 20:03:36 INFO - "stage_platform": "macosx64", 20:03:36 INFO - "builduid": "93548a5ea54241cc8b7460eaedc8ef69", 20:03:36 INFO - "slavebuilddir": "test" 20:03:36 INFO - } 20:03:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 20:03:36 INFO - Running post-action listener: _resource_record_post_action 20:03:36 INFO - [mozharness: 2017-02-24 04:03:36.799845Z] Finished read-buildbot-config step (success) 20:03:36 INFO - [mozharness: 2017-02-24 04:03:36.799957Z] Running download-and-extract step. 20:03:36 INFO - Running pre-action listener: _resource_record_pre_action 20:03:36 INFO - Running main action method: download_and_extract 20:03:36 INFO - mkdir: /builds/slave/test/build/tests 20:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:36 INFO - trying https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 20:03:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 20:03:37 INFO - Downloaded 1199 bytes. 20:03:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 20:03:37 INFO - Using the following test package requirements: 20:03:37 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:03:37 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 20:03:37 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 20:03:37 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'jsshell-mac.zip'], 20:03:37 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 20:03:37 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 20:03:37 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 20:03:37 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 20:03:37 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 20:03:37 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 20:03:37 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 20:03:37 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 20:03:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:03:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:03:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:03:38 INFO - Expected file size: 16357721 20:03:38 INFO - Obtained file size: 16357721 20:03:45 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 20:03:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 20:03:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 20:03:45 INFO - Fetch https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 20:03:46 INFO - Expected file size: 16357721 20:03:46 INFO - Obtained file size: 16357721 20:03:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 20:03:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 20:03:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 20:03:53 INFO - Expected file size: 14403472 20:03:53 INFO - Obtained file size: 14403472 20:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:54 INFO - trying https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:03:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 20:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 20:03:56 INFO - Downloaded 73930795 bytes. 20:03:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:03:56 INFO - mkdir: /builds/slave/test/properties 20:03:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:56 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:56 INFO - Contents: 20:03:56 INFO - build_url:https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 20:03:57 INFO - Running post-action listener: _resource_record_post_action 20:03:57 INFO - Running post-action listener: set_extra_try_arguments 20:03:57 INFO - [mozharness: 2017-02-24 04:03:57.054493Z] Finished download-and-extract step (success) 20:03:57 INFO - [mozharness: 2017-02-24 04:03:57.054612Z] Running populate-webroot step. 20:03:57 INFO - Running pre-action listener: _resource_record_pre_action 20:03:57 INFO - Running main action method: populate_webroot 20:03:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:57 INFO - '--tppagecycles', 20:03:57 INFO - '7'], 20:03:57 INFO - 'tests': ['tsvgm']}}, 20:03:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:03:57 INFO - 'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:03:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:03:57 INFO - 'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['damp', 'tps']}, 20:03:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:03:57 INFO - 'tests': ['damp', 'tps']}, 20:03:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['dromaeo_dom']}, 20:03:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['basic_compositor_video']}, 20:03:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:03:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['a11yr', 20:03:57 INFO - 'ts_paint', 20:03:57 INFO - 'tpaint', 20:03:57 INFO - 'sessionrestore', 20:03:57 INFO - 'sessionrestore_no_auto_restore', 20:03:57 INFO - 'tabpaint']}, 20:03:57 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:57 INFO - 'ts_paint', 20:03:57 INFO - 'tpaint', 20:03:57 INFO - 'sessionrestore', 20:03:57 INFO - 'sessionrestore_no_auto_restore', 20:03:57 INFO - 'tabpaint']}, 20:03:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:57 INFO - 'ts_paint', 20:03:57 INFO - 'tpaint', 20:03:57 INFO - 'sessionrestore', 20:03:57 INFO - 'sessionrestore_no_auto_restore', 20:03:57 INFO - 'tabpaint']}, 20:03:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:57 INFO - 'ts_paint', 20:03:57 INFO - 'tpaint', 20:03:57 INFO - 'sessionrestore', 20:03:57 INFO - 'sessionrestore_no_auto_restore', 20:03:57 INFO - 'tabpaint']}, 20:03:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['a11yr', 20:03:57 INFO - 'ts_paint', 20:03:57 INFO - 'tpaint', 20:03:57 INFO - 'sessionrestore', 20:03:57 INFO - 'sessionrestore_no_auto_restore', 20:03:57 INFO - 'tabpaint']}, 20:03:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['a11yr', 20:03:57 INFO - 'ts_paint', 20:03:57 INFO - 'tpaint', 20:03:57 INFO - 'sessionrestore', 20:03:57 INFO - 'sessionrestore_no_auto_restore', 20:03:57 INFO - 'tabpaint']}, 20:03:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['tsvgx', 20:03:57 INFO - 'tsvgr_opacity', 20:03:57 INFO - 'tart', 20:03:57 INFO - 'tscrollx', 20:03:57 INFO - 'cart', 20:03:57 INFO - 'tsvg_static']}, 20:03:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:57 INFO - 'tsvgr_opacity', 20:03:57 INFO - 'tart', 20:03:57 INFO - 'tscrollx', 20:03:57 INFO - 'cart', 20:03:57 INFO - 'tsvg_static']}, 20:03:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:03:57 INFO - 'talos_options': ['--disable-e10s'], 20:03:57 INFO - 'tests': ['tp5o']}, 20:03:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:03:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:03:57 INFO - 'talos_options': ['--disable-e10s', 20:03:57 INFO - '--xperf_path', 20:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:57 INFO - 'tests': ['tp5n']}, 20:03:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:03:57 INFO - 'talos_options': ['--xperf_path', 20:03:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:57 INFO - 'tests': ['tp5n']}}, 20:03:57 INFO - 'talos.zip': {'path': '', 20:03:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:57 INFO - Running post-action listener: _resource_record_post_action 20:03:57 INFO - [mozharness: 2017-02-24 04:03:57.073274Z] Finished populate-webroot step (success) 20:03:57 INFO - [mozharness: 2017-02-24 04:03:57.073420Z] Running create-virtualenv step. 20:03:57 INFO - Running pre-action listener: _resource_record_pre_action 20:03:57 INFO - Running main action method: create_virtualenv 20:03:57 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:57 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 20:03:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:57 INFO - Using real prefix '/tools/python27' 20:03:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:57 INFO - Installing distribute.............................................................................................................................................................................................done. 20:04:00 INFO - Installing pip.................done. 20:04:00 INFO - Return code: 0 20:04:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:04:01 INFO - Reading from file tmpfile_stdout 20:04:01 INFO - Output received: 20:04:01 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) 20:04:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:04:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:01 INFO - 'HOME': '/Users/cltbld', 20:04:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:01 INFO - 'LOGNAME': 'cltbld', 20:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:01 INFO - 'MOZ_NO_REMOTE': '1', 20:04:01 INFO - 'NO_EM_RESTART': '1', 20:04:01 INFO - 'PAGER': '/bin/cat', 20:04:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:01 INFO - 'PWD': '/builds/slave/test', 20:04:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:01 INFO - 'SHELL': '/bin/bash', 20:04:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:01 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:01 INFO - 'USER': 'cltbld', 20:04:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:01 INFO - 'XPC_FLAGS': '0x0', 20:04:01 INFO - 'XPC_SERVICE_NAME': '0', 20:04:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:01 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 20:04:01 INFO - Cleaning up... 20:04:01 INFO - Return code: 0 20:04:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:04:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:04:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:01 INFO - 'HOME': '/Users/cltbld', 20:04:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:01 INFO - 'LOGNAME': 'cltbld', 20:04:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:01 INFO - 'MOZ_NO_REMOTE': '1', 20:04:01 INFO - 'NO_EM_RESTART': '1', 20:04:01 INFO - 'PAGER': '/bin/cat', 20:04:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:01 INFO - 'PWD': '/builds/slave/test', 20:04:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:01 INFO - 'SHELL': '/bin/bash', 20:04:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:01 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:01 INFO - 'USER': 'cltbld', 20:04:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:01 INFO - 'XPC_FLAGS': '0x0', 20:04:01 INFO - 'XPC_SERVICE_NAME': '0', 20:04:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:01 INFO - Downloading/unpacking psutil>=3.1.1 20:04:01 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 20:04:01 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 20:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 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 20:04:01 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 20:04:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:04:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:05 INFO - Installing collected packages: psutil 20:04:05 INFO - Running setup.py install for psutil 20:04:05 INFO - building 'psutil._psutil_osx' extension 20:04:05 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 20:04:05 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 20:04:05 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 20:04:06 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 20:04:06 INFO - building 'psutil._psutil_posix' extension 20:04:06 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 20:04:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:04:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:04:06 INFO - ^ 20:04:06 INFO - 1 warning generated. 20:04:06 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 20:04:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:04:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:04:06 INFO - Successfully installed psutil 20:04:06 INFO - Cleaning up... 20:04:06 INFO - Return code: 0 20:04:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:04:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:06 INFO - 'HOME': '/Users/cltbld', 20:04:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:06 INFO - 'LOGNAME': 'cltbld', 20:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:06 INFO - 'MOZ_NO_REMOTE': '1', 20:04:06 INFO - 'NO_EM_RESTART': '1', 20:04:06 INFO - 'PAGER': '/bin/cat', 20:04:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:06 INFO - 'PWD': '/builds/slave/test', 20:04:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:06 INFO - 'SHELL': '/bin/bash', 20:04:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:06 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:06 INFO - 'USER': 'cltbld', 20:04:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:06 INFO - 'XPC_FLAGS': '0x0', 20:04:06 INFO - 'XPC_SERVICE_NAME': '0', 20:04:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:04:06 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 20:04:06 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 20:04:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:06 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 20:04:06 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 20:04:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:04:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:04:09 INFO - Installing collected packages: mozsystemmonitor 20:04:09 INFO - Running setup.py install for mozsystemmonitor 20:04:09 INFO - Successfully installed mozsystemmonitor 20:04:09 INFO - Cleaning up... 20:04:09 INFO - Return code: 0 20:04:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:04:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:04:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:09 INFO - 'HOME': '/Users/cltbld', 20:04:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:09 INFO - 'LOGNAME': 'cltbld', 20:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:09 INFO - 'MOZ_NO_REMOTE': '1', 20:04:09 INFO - 'NO_EM_RESTART': '1', 20:04:09 INFO - 'PAGER': '/bin/cat', 20:04:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:09 INFO - 'PWD': '/builds/slave/test', 20:04:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:09 INFO - 'SHELL': '/bin/bash', 20:04:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:09 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:09 INFO - 'USER': 'cltbld', 20:04:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:09 INFO - 'XPC_FLAGS': '0x0', 20:04:09 INFO - 'XPC_SERVICE_NAME': '0', 20:04:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:09 INFO - Downloading/unpacking jsonschema==2.5.1 20:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:04:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:04:12 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 20:04:12 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 20:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:12 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 20:04:12 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 20:04:13 INFO - Downloading functools32-3.2.3-2.tar.gz 20:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:04:13 INFO - warning: no files found matching '*.txt' 20:04:13 INFO - no previously-included directories found matching 'build' 20:04:13 INFO - no previously-included directories found matching 'dist' 20:04:13 INFO - no previously-included directories found matching '.git*' 20:04:13 INFO - Installing collected packages: jsonschema, functools32 20:04:13 INFO - Running setup.py install for functools32 20:04:13 INFO - warning: no files found matching '*.txt' 20:04:13 INFO - no previously-included directories found matching 'build' 20:04:13 INFO - no previously-included directories found matching 'dist' 20:04:13 INFO - no previously-included directories found matching '.git*' 20:04:13 INFO - Successfully installed jsonschema functools32 20:04:13 INFO - Cleaning up... 20:04:13 INFO - Return code: 0 20:04:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:13 INFO - 'HOME': '/Users/cltbld', 20:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:13 INFO - 'LOGNAME': 'cltbld', 20:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:13 INFO - 'MOZ_NO_REMOTE': '1', 20:04:13 INFO - 'NO_EM_RESTART': '1', 20:04:13 INFO - 'PAGER': '/bin/cat', 20:04:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:13 INFO - 'PWD': '/builds/slave/test', 20:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:13 INFO - 'SHELL': '/bin/bash', 20:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:13 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:13 INFO - 'USER': 'cltbld', 20:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:13 INFO - 'XPC_FLAGS': '0x0', 20:04:13 INFO - 'XPC_SERVICE_NAME': '0', 20:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:04:13 INFO - Cleaning up... 20:04:13 INFO - Return code: 0 20:04:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:13 INFO - 'HOME': '/Users/cltbld', 20:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:13 INFO - 'LOGNAME': 'cltbld', 20:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:13 INFO - 'MOZ_NO_REMOTE': '1', 20:04:13 INFO - 'NO_EM_RESTART': '1', 20:04:13 INFO - 'PAGER': '/bin/cat', 20:04:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:13 INFO - 'PWD': '/builds/slave/test', 20:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:13 INFO - 'SHELL': '/bin/bash', 20:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:13 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:13 INFO - 'USER': 'cltbld', 20:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:13 INFO - 'XPC_FLAGS': '0x0', 20:04:13 INFO - 'XPC_SERVICE_NAME': '0', 20:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:13 INFO - Downloading/unpacking blobuploader==1.2.4 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:16 INFO - Downloading blobuploader-1.2.4.tar.gz 20:04:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:04:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:04:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:17 INFO - Downloading docopt-0.6.1.tar.gz 20:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:04:17 INFO - Installing collected packages: blobuploader, requests, docopt 20:04:17 INFO - Running setup.py install for blobuploader 20:04:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:04:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:04:18 INFO - Running setup.py install for requests 20:04:18 INFO - Running setup.py install for docopt 20:04:18 INFO - Successfully installed blobuploader requests docopt 20:04:18 INFO - Cleaning up... 20:04:18 INFO - Return code: 0 20:04:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:04:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:04:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:18 INFO - 'HOME': '/Users/cltbld', 20:04:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:18 INFO - 'LOGNAME': 'cltbld', 20:04:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:18 INFO - 'MOZ_NO_REMOTE': '1', 20:04:18 INFO - 'NO_EM_RESTART': '1', 20:04:18 INFO - 'PAGER': '/bin/cat', 20:04:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:18 INFO - 'PWD': '/builds/slave/test', 20:04:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:18 INFO - 'SHELL': '/bin/bash', 20:04:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:18 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:18 INFO - 'USER': 'cltbld', 20:04:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:18 INFO - 'XPC_FLAGS': '0x0', 20:04:18 INFO - 'XPC_SERVICE_NAME': '0', 20:04:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-u8t5g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-1vuzSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-3uZ0t3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-RuymrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Bz9ulF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-YeQ0V7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-uUPUjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-7jmYQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-86bWxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:19 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-M8yPZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:20 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-UlTpuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:20 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-0MCiSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:20 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-swlJlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:20 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-483Oav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:20 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Vx1tnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:20 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-XF71QK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:20 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-GFvPdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:04:20 INFO - Running setup.py install for manifestparser 20:04:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:04:20 INFO - Running setup.py install for mozcrash 20:04:21 INFO - Running setup.py install for mozdebug 20:04:21 INFO - Running setup.py install for mozdevice 20:04:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Running setup.py install for mozfile 20:04:21 INFO - Running setup.py install for mozhttpd 20:04:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Running setup.py install for mozinfo 20:04:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Running setup.py install for mozInstall 20:04:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:04:21 INFO - Running setup.py install for mozleak 20:04:22 INFO - Running setup.py install for mozlog 20:04:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:04:22 INFO - Running setup.py install for moznetwork 20:04:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:04:22 INFO - Running setup.py install for mozprocess 20:04:22 INFO - Running setup.py install for mozprofile 20:04:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:04:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:04:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:04:22 INFO - Running setup.py install for mozrunner 20:04:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:04:22 INFO - Running setup.py install for mozscreenshot 20:04:23 INFO - Running setup.py install for moztest 20:04:23 INFO - Running setup.py install for mozversion 20:04:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:04:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:23 INFO - Cleaning up... 20:04:23 INFO - Return code: 0 20:04:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:04:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:04:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:23 INFO - 'HOME': '/Users/cltbld', 20:04:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:23 INFO - 'LOGNAME': 'cltbld', 20:04:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:23 INFO - 'MOZ_NO_REMOTE': '1', 20:04:23 INFO - 'NO_EM_RESTART': '1', 20:04:23 INFO - 'PAGER': '/bin/cat', 20:04:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:23 INFO - 'PWD': '/builds/slave/test', 20:04:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:23 INFO - 'SHELL': '/bin/bash', 20:04:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:23 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:23 INFO - 'USER': 'cltbld', 20:04:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:23 INFO - 'XPC_FLAGS': '0x0', 20:04:23 INFO - 'XPC_SERVICE_NAME': '0', 20:04:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:23 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-SQr4eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:23 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)) 20:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:23 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-hc1N3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:23 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)) 20:04:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:23 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-FV9GiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-bKSGuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Trl0kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-P2v7kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-KV6kbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-kbmHQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-Uox3IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-ISE4JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-poMRzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:24 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)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:24 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-L8ww4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:25 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-4qp0DI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:25 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)) 20:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:25 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-X43Wpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:25 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)) 20:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:25 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-YlCZUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:25 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)) 20:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:25 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-8k0xZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:25 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)) 20:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:25 INFO - Running setup.py (path:/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/pip-lE03Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:25 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)) 20:04:25 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)) 20:04:25 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)) 20:04:25 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)) 20:04:25 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)) 20:04:25 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)) 20:04:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:04:25 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 20:04:25 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 20:04:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:25 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 20:04:25 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 20:04:28 INFO - Downloading blessings-1.6.tar.gz 20:04:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:28 INFO - Installing collected packages: blessings 20:04:28 INFO - Running setup.py install for blessings 20:04:28 INFO - Successfully installed blessings 20:04:28 INFO - Cleaning up... 20:04:28 INFO - Return code: 0 20:04:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:04:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:28 INFO - Reading from file tmpfile_stdout 20:04:28 INFO - Current package versions: 20:04:28 INFO - blessings == 1.6 20:04:28 INFO - blobuploader == 1.2.4 20:04:28 INFO - docopt == 0.6.1 20:04:28 INFO - functools32 == 3.2.3-2 20:04:28 INFO - jsonschema == 2.5.1 20:04:28 INFO - manifestparser == 1.1 20:04:28 INFO - mozInstall == 1.12 20:04:28 INFO - mozcrash == 1.0 20:04:28 INFO - mozdebug == 0.1 20:04:28 INFO - mozdevice == 0.49 20:04:28 INFO - mozfile == 1.2 20:04:28 INFO - mozhttpd == 0.7 20:04:28 INFO - mozinfo == 0.9 20:04:28 INFO - mozleak == 0.1 20:04:28 INFO - mozlog == 3.4 20:04:28 INFO - moznetwork == 0.27 20:04:28 INFO - mozprocess == 0.24 20:04:28 INFO - mozprofile == 0.28 20:04:28 INFO - mozrunner == 6.13 20:04:28 INFO - mozscreenshot == 0.1 20:04:28 INFO - mozsystemmonitor == 0.3 20:04:28 INFO - moztest == 0.8 20:04:28 INFO - mozversion == 1.4 20:04:28 INFO - psutil == 3.1.1 20:04:28 INFO - requests == 1.2.3 20:04:28 INFO - wsgiref == 0.1.2 20:04:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:04:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:04:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:29 INFO - 'HOME': '/Users/cltbld', 20:04:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:29 INFO - 'LOGNAME': 'cltbld', 20:04:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:29 INFO - 'MOZ_NO_REMOTE': '1', 20:04:29 INFO - 'NO_EM_RESTART': '1', 20:04:29 INFO - 'PAGER': '/bin/cat', 20:04:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:29 INFO - 'PWD': '/builds/slave/test', 20:04:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:29 INFO - 'SHELL': '/bin/bash', 20:04:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:29 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:29 INFO - 'USER': 'cltbld', 20:04:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:29 INFO - 'XPC_FLAGS': '0x0', 20:04:29 INFO - 'XPC_SERVICE_NAME': '0', 20:04:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 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)) 20:04:29 INFO - Cleaning up... 20:04:29 INFO - Return code: 0 20:04:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1054e1b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054e4768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe0259eb80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, '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.vnh47lwEWe/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.61AR75wxSP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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 20:04:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:04:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:30 INFO - 'HOME': '/Users/cltbld', 20:04:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:30 INFO - 'LOGNAME': 'cltbld', 20:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:30 INFO - 'MOZ_NO_REMOTE': '1', 20:04:30 INFO - 'NO_EM_RESTART': '1', 20:04:30 INFO - 'PAGER': '/bin/cat', 20:04:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:30 INFO - 'PWD': '/builds/slave/test', 20:04:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:30 INFO - 'SHELL': '/bin/bash', 20:04:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:30 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:30 INFO - 'USER': 'cltbld', 20:04:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:30 INFO - 'XPC_FLAGS': '0x0', 20:04:30 INFO - 'XPC_SERVICE_NAME': '0', 20:04:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:04:30 INFO - Cleaning up... 20:04:30 INFO - Return code: 0 20:04:30 INFO - Running post-action listener: _resource_record_post_action 20:04:30 INFO - Running post-action listener: _start_resource_monitoring 20:04:30 INFO - Starting resource monitoring. 20:04:30 INFO - [mozharness: 2017-02-24 04:04:30.533713Z] Finished create-virtualenv step (success) 20:04:30 INFO - [mozharness: 2017-02-24 04:04:30.534680Z] Running install step. 20:04:30 INFO - Running pre-action listener: _resource_record_pre_action 20:04:30 INFO - Running main action method: install 20:04:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:30 INFO - Reading from file tmpfile_stdout 20:04:30 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:04:30 INFO - Reading from file tmpfile_stdout 20:04:30 INFO - Output received: 20:04:30 INFO - Usage: mozinstall [options] installer 20:04:30 INFO - Options: 20:04:30 INFO - -h, --help show this help message and exit 20:04:30 INFO - -d DEST, --destination=DEST 20:04:30 INFO - Directory to install application into. [default: 20:04:30 INFO - "/builds/slave/test"] 20:04:30 INFO - --app=APP Application being installed. [default: firefox] 20:04:30 INFO - mkdir: /builds/slave/test/build/application 20:04:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:04:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 20:04:51 INFO - Reading from file tmpfile_stdout 20:04:51 INFO - Output received: 20:04:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 20:04:51 INFO - Running post-action listener: _resource_record_post_action 20:04:51 INFO - [mozharness: 2017-02-24 04:04:51.065981Z] Finished install step (success) 20:04:51 INFO - [mozharness: 2017-02-24 04:04:51.066136Z] Running run-tests step. 20:04:51 INFO - Running pre-action listener: _resource_record_pre_action 20:04:51 INFO - Running main action method: run_tests 20:04:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:04:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:04:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:04:51 INFO - 2017-02-23 20:04:51.080 screenresolution[1625:7512] starting screenresolution argv=screenresolution get 20:04:51 INFO - 2017-02-23 20:04:51.083 screenresolution[1625:7512] Display 0: 1600x1200x32@60 20:04:51 INFO - 2017-02-23 20:04:51.089 screenresolution[1626:7514] starting screenresolution argv=screenresolution list 20:04:51 INFO - Available Modes on Display 0 20:04:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:04:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:04:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:04:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:04:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:04:51 INFO - Intel Iris: 20:04:51 INFO - Chipset Model: Intel Iris 20:04:51 INFO - Type: GPU 20:04:51 INFO - Bus: Built-In 20:04:51 INFO - VRAM (Dynamic, Max): 1536 MB 20:04:51 INFO - Vendor: Intel (0x8086) 20:04:51 INFO - Device ID: 0x0a2e 20:04:51 INFO - Revision ID: 0x0009 20:04:51 INFO - Displays: 20:04:51 INFO - Display: 20:04:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:04:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:04:51 INFO - Display Serial Number: 1600x1200 60 20:04:51 INFO - Main Display: Yes 20:04:51 INFO - Mirror: Off 20:04:51 INFO - Online: Yes 20:04:51 INFO - Rotation: Supported 20:04:51 INFO - Return code: 0 20:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:04:51 INFO - Python 2.7.3 20:04:51 INFO - Return code: 0 20:04:51 INFO - grabbing minidump binary from tooltool 20:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:51 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 0x1052bfd30>, '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 0x1051e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052b4be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:04:51 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 20:04:51 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 20:04:51 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 20:04:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:51 INFO - Return code: 0 20:04:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:04:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:04:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:04:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:04:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:04:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:04:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0268 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:04:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vnh47lwEWe/Render', 20:04:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:51 INFO - 'HOME': '/Users/cltbld', 20:04:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:51 INFO - 'LOGNAME': 'cltbld', 20:04:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:04:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:04:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:51 INFO - 'MOZ_NO_REMOTE': '1', 20:04:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:04:51 INFO - 'NO_EM_RESTART': '1', 20:04:51 INFO - 'PAGER': '/bin/cat', 20:04:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:51 INFO - 'PWD': '/builds/slave/test', 20:04:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:04:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:51 INFO - 'SHELL': '/bin/bash', 20:04:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.61AR75wxSP/Listeners', 20:04:51 INFO - 'TMPDIR': '/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/', 20:04:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:51 INFO - 'USER': 'cltbld', 20:04:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:51 INFO - 'XPC_FLAGS': '0x0', 20:04:51 INFO - 'XPC_SERVICE_NAME': '0', 20:04:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0268', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:04:51 INFO - mozversion application_buildid: 20170223184858 20:04:51 INFO - mozversion application_changeset: 883dd404cfa2bab84de402e87484e1b2b268f466 20:04:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 20:04:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:51 INFO - mozversion application_name: Firefox 20:04:51 INFO - mozversion application_remotingname: firefox-dev 20:04:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:04:51 INFO - mozversion application_vendor: Mozilla 20:04:51 INFO - mozversion application_version: 53.0a2 20:04:51 INFO - mozversion platform_buildid: 20170223184858 20:04:51 INFO - mozversion platform_changeset: 883dd404cfa2bab84de402e87484e1b2b268f466 20:04:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 20:04:51 INFO - mozversion platform_version: 53.0a2 20:04:51 INFO - using testdate: 1487909091 20:04:51 INFO - actual date: 1487909091 20:04:51 INFO - starting webserver on 'localhost:49250' 20:04:51 INFO - SUITE-START | Running 2 tests 20:04:51 INFO - TEST-START | dromaeo_css 20:04:51 INFO - operating with platform_type : mac_ 20:04:51 INFO - Initialising browser for dromaeo_css test... 20:04:51 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmp6tQma8/profile http://localhost:49250/getInfo.html) 20:04:52 INFO - PROCESS | 1636 | 1487909092216 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 20:04:52 INFO - PROCESS | 1636 | 1487909092216 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 20:04:52 INFO - PROCESS | 1636 | 1487909092252 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 20:04:54 INFO - PROCESS | 1636 | 2017-02-23 20:04:54.477 plugin-container[1638:7691] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9147, name = 'com.apple.tsm.portname' 20:04:54 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:54 INFO - PROCESS | 1636 | 2017-02-23 20:04:54.481 plugin-container[1638:7691] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9703, name = 'com.apple.CFPasteboardClient' 20:04:54 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:54 INFO - PROCESS | 1636 | 2017-02-23 20:04:54.481 plugin-container[1638:7691] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:04:54 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 20:04:54 INFO - PROCESS | 1636 | colorDepth:24 20:04:54 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 20:04:54 INFO - PROCESS | 1636 | __metrics 20:04:54 ERROR - PROCESS | 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 20:04:54 INFO - PROCESS | 1636 | 1487909094650 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 20:04:55 INFO - TEST-INFO | 1636: exit 0 20:04:55 INFO - Browser initialized. 20:04:55 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:55 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmp6tQma8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:55 INFO - PROCESS | 1639 | 1487909095603 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 20:04:55 INFO - PROCESS | 1639 | 1487909095604 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 20:04:57 INFO - PROCESS | 1639 | 2017-02-23 20:04:57.819 plugin-container[1640:7819] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 20:04:57 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:57 INFO - PROCESS | 1639 | 2017-02-23 20:04:57.820 plugin-container[1640:7819] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1b, name = 'com.apple.CFPasteboardClient' 20:04:57 INFO - PROCESS | 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:57 INFO - PROCESS | 1639 | 2017-02-23 20:04:57.820 plugin-container[1640:7819] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:05:07 INFO - PROCESS | 1639 | RSS: Main: 218730496 20:05:07 INFO - PROCESS | 1639 | 20:08:10 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 20:08:12 INFO - PROCESS | 1639 | RSS: Main: 235798528 20:08:12 INFO - PROCESS | 1639 | 20:09:55 INFO - PROCESS | 1639 | ************************* 20:09:55 INFO - PROCESS | 1639 | A coding exception was thrown and uncaught in a Task. 20:09:55 INFO - PROCESS | 1639 | 20:09:55 ERROR - PROCESS | 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:09:55 INFO - PROCESS | 1639 | Full stack: 20:09:55 INFO - PROCESS | 1639 | ************************* 20:11:14 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 20:11:15 INFO - PROCESS | 1639 | RSS: Main: 246755328 20:11:15 INFO - PROCESS | 1639 | 20:14:17 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 20:14:17 INFO - PROCESS | 1639 | RSS: Main: 253898752 20:14:17 INFO - PROCESS | 1639 | 20:17:19 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 20:17:20 INFO - PROCESS | 1639 | RSS: Main: 250687488 20:17:20 INFO - PROCESS | 1639 | 20:20:23 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 20:20:23 INFO - PROCESS | 1639 | RSS: Main: 255262720 20:20:23 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 20:23:26 INFO - PROCESS | 1639 | RSS: Main: 256925696 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | __start_tp_report 20:23:26 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 20:23:26 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 20:23:26 INFO - PROCESS | 1639 | |i|pagename|runs| 20:23:26 INFO - PROCESS | 1639 | |0;dojo.html;3385.847636856341;3394.355072536218;3395.8471868765905;3396.0660818274973;3411.3347897160065;5648.717564121798;5655.745491452884;5662.06575914974;5705.743241554135;5706.543476521879;4574.748388838612;4639.466461356945;5739.426057394258;5753.453421924921;5806.825795226139;4757.215059515176;5209.296744939432;5243.239730239113;5257.658252213594;5309.946900530984;4863.270509423597;5276.9736151319385;5291.841244762663;5309.62832601718;5309.707966061865;5162.638615296931;5179.482051794809;5306.814261500848;5313.22958171065;5380.112281473572;4159.542450330461;5247.737613119348;5274.657147285453;5296.9735151324385;5344.144936810092;5159.432462429129;5210;5222.086134926372;5224.63427560071;5225.059489291926;4626.699264547794;4893.926591101136;5687.573431992617;5798.681072541009;5806.796762113348;6147.831911936718;6177.104319873638;6203.534734894901;6234.345393733638;6299.118123462673;6289.276733175652;6297.96851015742;6300.369963003709;6305.684715764193;6310.400511951358;5701.458361455655;5942.7920022799;5944.108383742387;5944.256967879015;5951.166836642873;4864.975675121602;5560.360558535739;6258.530610204253;6292.2134733158355;6305.684715764193;6127.479164271087;6237.96881015592;6242.937570624326;6243.469305109026;6248.343923887926;6243.469305109116;6263.123162757218;6268.937310626927;6287.811365659038;6295.779647712399;6117.522930757332;6127.861529871541;6133.028644417026;6142.232220972379;6198.442140207403;6226.750929962751;6252.437280644764;6259.906101408483;6265.71804268809;6272.874542509125;4995.375578052744;4996.90006199874;5017.7491125443585;5020.849374518771;5025.723585202776;3548.8935331940083;3621.3843646580144;4353.717008394444;4474.731516109044;4493.0115374617535;5774.419859686937;5826.8928903508195;5882.735276912549;5897;5922.407759224043;6146.6004709693725;6280.497560195174;6288.9056664150075;6291.1192433059405;6316.431521163117;5659.943400566024;5744.281964754406;5750.827475175752;5814.360420353758;5848.61983971049;5406.8918621627345;5463.043967305785;5467.125259958467;5468.398476167618;5475.6440831345835;6317.178766760292;6361.427471527585;6365.936340636719;6390.105385245976;6390.201224846895;6167.876642467036;6196.10156527292;6206;6247.5001999840815;6279.874402511833;6382.6170429774365;6386.393292637192;6386.68066596659;6387.616742995435;6401.815664102156;6213.968930155501;6255.218097737783;6262.780802671885;6274.592151510137;6299.086632438362;6187.133801267916;6234.37656234391;6242.406971337716;6272.6236425814595;6322.557420980487;6138.81758342749;6210.72051757681;6212.689365531795;6215.65813880241;6220.222472190976;6037.939620603738;6118.785842495491;6161.691915404302;6193.163922870535;6224.408681175281;5819.6508209507565;5871.588988770916;5965.802845275099;6087.36082711309;6094.512439004958;6117.675163990694;6127.264728232641;6170.074488826712;6202.906956395748;6237.594556353823;6007.429294217042;6066.605670631395;6093.29927058394;6123.418275263843;6133.84665383369 20:23:26 INFO - PROCESS | 1639 | |1;ext.html;449.5392222971454;460.095911533836;472.9196036673765;500.9305133539891;514.9279100925874;31495.37009259816;40273.79863100684;40403.393949090714;40452.19095618093;40611;34093.48859767106;41444;41942.580574194246;41958.790206049;41976.37035444463;8156.429049966505;8410.453320534176;9038.59326330315;9244.214241789456;9263.536823158849;10122.88648248692;10968.670939871778;11080.445977701123;11374.943125284362;11437.771244575104;10569.471526423686;11240.718982025433;11270.661880143609;11305.208635395526;11325.150613703963;11117.27737697051;11157.944210278978;11193.328400295926;11200.607978720705;11213.327200368005;11271.267367621078;11340.319580825177;11350.375729334883;11354.943225283821;11369.943150284278;33445.49831752526;40239.19521609581;40317;40506.594934050576;40754.38868416976;3870.1679138985255;3906.2968665640174;3935.232629637222;3977.7414468059774;4003.8598649047144;29235.97674081418;29728.702712973027;29908;30112.397752045057;30138;2968.9406211875857;2993.027266138514;3010.1270631517054;3025.410045041218;3029.469842777505;462720;462884.68557657;463717;464834;465287.6735616334;55567.722161388934;55827;55936.16095758567;56155;60206.591736330054;62984;63210.68394657997;63402.68298658569;63518;63690;16010;16380.754288685679;16599.66800664004;16613.91693041527;16658.58353541171;11572.594959176557;11853.5851245206;12680.556180533822;12874.613761587167;13048.934755326163;15961.920190398974;16032.839671603368;16041.358345666276;16084.75872861908;16147.192640367935;6724.327567243335;6838.623875686785;6839.658017099126;6860.759873404407;6883.105196324445;742.7103429662436;747.4767662636176;829.4194064155115;859.7248880358351;861.8233262181237;24178;26885.327866803487;28353.432931341256;30043.83789895479;30339.848300758797;826.4669288309127;988.7330420786348;1044.874615046184;1081.1242893256488;1170.0054953289805;15115.622109447131;15418.845811541742;15465;15472.5358239253;15677.216139192995;216397;217854;218625;219246;219541;60037.699811500665;60122.098168527504;60160.69919650374;60393.396066038775;60399.698001509714;1223.2843786385065;1389.4095009620871;1407.56365526685;1423.1034448297507;1425.137791636066;28605.14184574466;29172.562411564268;29490.557641634965;29848.701512984593;29919.401611968075;49343.506564933894;49487.50512494829;49780.75109624429;49815.50184498109;49849;545202;546469;547576.2621186868;548565;549453;24193;24823.379415514755;39521.60478395294;39851.605193818075;39900;42139;42308.57691423169;42667;43039.56960430481;43096.78451607722;26709.06518271851;34601.653983459844;35641.64358356383;35917.92246232617;36734.89795306145;27980.44039119247;32688.83655581707;35204.823975879954;35875.10312242215;36238.8188059058;33607.15982100467;34330.313393731485;34752.957411277705;34913.9525814226;35016.82491587526;29719.257018573844;30942.22644433907;31587.36825263528;31617.5257371135;31729.365412691157;23540;23601.763982360644;23671.05315787418;24018.15936442216;24033.879830600734 20:23:26 INFO - PROCESS | 1639 | |2;jquery.html;371.90516418313325;388.15963439154234;388.2293647110486;397.8080774930134;417.2572820379725;15438.61403464914;19677.803221967777;20415.897920510415;21000.36998890032;21051.157953681854;20792.16831326745;20794.376168714924;21111.6833247501;21224;21352.039158237876;5312.9203061954;5689.175069614904;5723.284589426322;5750.367459579443;5750.712464376765;5155.896882062357;5466.098093814516;5620.91568626471;5706.315242170946;5724.484796368326;5603.663780173182;5652.208690783294;5652.773889044433;5665.433456654322;5676.318841738997;5401.189821526763;5580.999999999959;5634.239377684001;5638.40796716345;5659.518940890009;4984.202527595604;5002.7248501332415;5002.89994200114;5004.774785134678;5017.724025178613;19848.80151198484;24892.875535622206;24969.250922472173;25199.748002519922;25358.873205634038;2722.101706436871;2802.467531169071;2815.197668664441;2818.816776909515;2826.901058462944;15087;15682.215889205494;15769.763453548207;15865.286062127232;16404.425845095484;1823.5896923192308;1833.4316361927845;1855.044652004219;1871.6350311689225;1875.9025969807678;129910;131142;132415;133726.33136834254;134725.3263733675;11477.253978491372;11935.403229838474;11939.88060119405;11957.641270761891;12021.519139234508;11401.315921044597;13450.798238026437;14629.56111316641;14645.267736613127;14647.853521464862;8534.27458666008;8821.558922053871;8886.155815197546;8912.910870891337;9056.320775941831;8702.738917832476;8876.911230887737;8880.8667869982;8911.50986695725;9038.502882341534;5823.330317013598;7306.2693730626515;7423.591702456417;7429.777106686808;7462.02993610838;1716.9742453863203;1766.9028203448677;1972.7768783354413;2027.4829918370722;2036.185525789696;1044.8380501022355;1054.9678035769336;1082.1342925659442;1089.3082892363248;1112.6550769261394;21623.59446635995;22259.666105008437;22325.330240092822;22713.205037823598;22830.543389132123;1081.799867024603;1081.9513121909533;1082.3722241100143;1119.692084676704;1142.731458107344;11592.942035289938;11670.474828632732;11695.298282103102;11922.582709605296;11945.104117191071;398023;403569;525021;751738;779925;123970;126852;137516;139480;145984.27007864893;950.1401231885155;974.152487336008;1006.5369929832212;1006.9295149339476;1008.621766837436;19224.846509209492;20034.298799541946;20059.699104513737;20061.79938200658;20095.497612559804;47652.285215722484;49619.25571116508;56863.431365685814;57684.71157644185;58299.4170058294;78705.21294787207;86043.13956860351;86906;87034;87508.5624571873;6978.441724661913;8332.750017499242;8356.582170891552;8523.232909038215;8759.956200218958;12449;13278.601641950758;13301.733965320833;13645.795313070113;13691.726165476834;10976.23166378346;11238.213325067167;11342.60300889465;11342.716432089264;11392.829107563559;10585.576576937145;10625.25623206368;11083.944580277048;11211.88788112141;11583.76832463363;11423.543058277908;11439.656810295704;11566.65300041;11594.231874640944;11633.95294423506;7897.1707970662255;8384.119667434832;8523.531205783742;8540.615672294638;8541.572921354033;9808.215342772704;10226.130778883879;10791.010988900922;11133.109351252042;11341.943290283496 20:23:26 INFO - PROCESS | 1639 | |3;mootools.html;1385.445821671332;1395.9092658977172;1405.3254437869823;1416.9574912752616;1422.1680317014545;7483.588402637853;7757.961210193956;7938.563379014159;8374.91625083749;8385.496870187793;7864.646090925908;8036.91963080369;8140.348772098233;8204.95897520513;8269.586520673973;2271.954560908781;2326.232343326698;2329.2546385156757;2330.33585428153;2331.0326214620995;2071.6167509010806;2139.1978008246906;2304.308707387777;2348.7181538215436;2352.2707960532202;2242.697235873161;2311.237291693737;2312.09828167015;2316.3745788637057;2323.523677646087;2308.1690591387087;2309.168699268262;2324.976750232493;2331.300609817048;2336.8247381446376;2288.302067869299;2290.7823756743082;2343.109618345018;2349.107339211106;2361.740208577055;8307.584620768997;8329.791755206108;8330.291925186366;8343.207395297497;8364.623591938378;5006.173981293082;5157.638965272433;5161.225816127611;5162.97418512905;5165.173572228463;3194.9201269968203;3247.772655914087;3272.2146684795716;3275.2303208746166;3452.879149229765;1112.076976109835;1142.1034487926938;1198.7662405830868;1205.891469767725;1206.1255589697487;10562;10644.627438039708;10667.573297068107;10684.130277201459;10724.678259652223;4332.371806088099;4630.53694630541;4650.302454631832;4669.789859456333;4693.296005599187;9343.95328023369;9418.481983490974;9464.337496375325;9475.763105922408;9489.667861624948;5127.487251274917;5138.07514647367;5163.561097306771;5187.974060129751;5205.167173252262;4501.527339629357;4695.107929493385;4716.716996980193;4739.3601863748645;4740.549647783455;3896.8636097736444;3929.8231579578987;3932.803359831997;3982.38273067675;4062.5531191568903;1171.5782318365382;1211.6849619099098;1245.4395522014947;1285.9871401286055;1289.7098152915707;856.4732689395977;863.7883718489011;880.3089574683843;899.8020435504178;906.723449347942;5525.889482210333;5558.082916318762;5583.916241256385;5810.1865738796605;5826.65040097587;936.166811537732;982.3958265666564;982.6953644370125;987.9901200988041;999.3454287441738;2582.431864989699;3477.2355976998347;3681.171736359298;3716;3775.452559378875;9476.668316608886;9802.117809397188;9851.556679949419;9885.505724713736;9982.900170998197;7893.644785984645;8585.699500517452;9863.654772082942;9977.650782222587;9989.450580218012;7369.8526029478035;7426.7400640978385;7832.138464768871;7834.764957051298;7835;4513.977430112828;5225.190095535198;5240.816571419982;5578.693171875586;5652.406497317723;8654.4807311559;9015.594298256463;9076.727698169065;9154.496502692416;9185.127412895765;8819.823603527766;9076.818463630558;9356.4386136832;9376.578053987723;9402.95298523503;7646.617669116633;7718.459707820399;7805.219478052377;7807.570583617956;7814.062312522534;6408.487321014214;7715.112762032438;7794.610269486617;7794.72718454874;7799.37604991588;6911.320162748161;6951.7914462566205;6986.755463558751;7116.110486189226;7140.821479463055;6831.043653888559;6871.793846184622;6892.862142757217;6897.379235868796;6923.134608173978;6268.655223962726;6307;6334.809955701337;6386.393292637192;6389.52078594098;4728.479867214535;4788.928166077442;4840.419149702058;4940.629452790983;5020.824271150638;4159.604837540429;4881.682690625098;4901.485344038824;4916.631252655993;4967.155583550877 20:23:26 INFO - PROCESS | 1639 | |4;prototype.html;351.8698081709768;353.9505366588066;360.18238598381674;366.8789299531155;370.86648806429696;4405.00887300358;5251.737413129347;5418.349798024237;5543.417941116185;5569.52659023983;4673.813047478106;5161.793528258874;5367.409584945653;5375;5386.8383948481605;3896.7661940283533;4082.9588454943946;4196.139791342775;4258.574142585732;4265.165978629188;3367.0740546349825;4075.9388609170887;4245.617894389505;4269.462993322401;4280.57194280571;3306.6442758469034;3636.8545258189774;4107.960109518949;4155.480564929384;4217.219814334343;3468.4450487921813;3878.4764056852246;4061.614146656063;4100.7334523256195;4197.958020419803;3075.400296942097;3092.1496588438135;3712.1090938174643;3738.532683414573;3751.981240093782;4320.546342634009;4493.988852508192;4983.451820299764;5174.249733788617;5268.471133855733;3644.908877278063;4025.5169379674335;4872.244802055687;4885.485499495132;4888.951110488921;4429.645628349725;4807.519248075199;5708.885822283531;5709.887341683562;5722.885542289173;3569.785812851237;3613.49411082446;3777.5089238399105;3821.9680686214842;4140.101928649957;5129.871428285771;5609.635373700738;5780.8843823123725;5995.7901473448655;6021.2473440819895;3154.542591324245;3646.6717995380545;3953.2488827122756;3959.9010024749614;3967.9603203968168;3352.8155951422905;3683.613220611851;3999.6201310547813;4008.5390180129075;4037.818298176589;3667.7065834733157;3912.882613521599;4107.774072425986;4334.349847522897;4641.8375356863025;5279.973600132052;5742.425757424307;5753.971230143822;5775.711214439261;5804.187413762077;972.4457059476031;1109.6449136276476;1253.7179134694802;1257.5852166312898;1284.9935750321188;849.2569002123142;873.0745409865563;878.3587980774071;881.1584936385736;889.5685592487638;4205.642520385741;4668.323093151542;4826.562585894101;4883.145449546315;5087.728067983005;5131.435542090367;5399.433059528771;5456.0903683710385;5576.749046292926;5622.839099066661;4318.676099292566;4684.664870511888;4730.9763451182525;4760;5075.974620126875;2816.380396312808;2853.5149024665857;2888.050565868031;2913.2710131032313;2932.8240305581735;5172.818951336685;5213.6350455467755;5375.919361209585;5747.712614369265;5782.335031471351;4347.804348804311;4534.79593418297;5247.320857325619;5764.221830052973;5809.8547536311935;5201.42784293735;5444.5916556258435;5743.712814359265;5769.394213607595;5773.711314434177;5230.895382092261;5266.0257852297445;5422.620416570802;5462.289902312833;5634.464725851038;4923.113839508923;5318.920216196838;5372.489613486712;5798.33319168301;5863.530917526673;5434.619576629756;5984.940150598438;6029.849253768515;6033.5173186145885;6056.788012419544;3938.2714197873483;3948.756141815319;3962.821673024663;3968.682505399619;4025.6376926076796;4307.483102027777;4911.852644420673;5851;5866.706664666664;5958.731857066356;5471.6169868108855;5589.469000444951;5633.492985631313;5775.509081727932;5805.390434004369;5739.684317362418;5739.827805165852;5764.538836893123;5789.2763404574425;5835.153902684002;4390.758508282075;5618.876224755147;5626.099824028136;5650.68921209321;5655.981923253854;5241.89516209666;5614.69119198448;5657.519110875622;5706.857328566819;5780.682062486436;4830.222621992439;5151.419763264645;5598.272224610774;5647.407022262768;5667.489925906688 20:23:26 INFO - PROCESS | 1639 | |5;yui.html;695.2630211975303;720.5424555407318;750.7034721285092;813.5078277642026;820.3068407195917;14450.349734261958;14737.336819843105;15070.020448670843;15329.080255184697;15359;13245.337733113354;13348;13391.330433478335;13453.596392108228;13467.46130154795;619.5724949784634;834.6619619054293;849.0617867256685;849.668629234599;852.8251708399794;648.8053583924827;665.3612531969316;822.3092602214139;841.3395484544634;848.516345682961;887.3832686283004;890.4123278636101;893.2764460786751;893.4326702543866;894.2845723421269;882.3999680217449;885.3713863157166;885.9557022148866;886.3529623374908;887.1350433327518;647.6405594894832;652.9738810447576;655.9737610495574;658.8978708300222;659.4394764450227;14661.560153195422;14792.852071479363;14803.259837008107;14888.702225955529;15475.767863482057;13947.930260348734;14338.64153396163;14443.98892077555;14447.277636118151;14504;11462.49764401282;11728.296302221894;11755.823662645067;11760.294382337002;11818.290902545788;3638.7998660073686;3657.140571965586;3668.724845636588;3782.489363935861;3875.263699897039;102884.48557757238;109963;112975.87024129818;113091.43454282758;113158.43420782844;8786.384953053353;10647.307924985005;10823.242373033812;10847.240693151403;11090.722731931604;19825.206991720457;22311.442213944458;22324.55350892973;22383.9927203273;22574.435639108826;7447.255274472509;7570.280823321776;7637.236276372319;7865.685372585147;7910.762677119696;4004.839806407769;4104.220198162339;4163.916721665611;4218.6625069994325;4254.404383386328;3311.453610154346;3424.811635360079;3428.3486137633768;3430.073880052372;3435.4503279475166;511.6086194061546;631.1637080867869;633.6483251795298;634.4828964394004;654.7086546486768;620.4725982914576;639.4756299834185;641.6695401868042;646.3794757033301;656.3207080671482;9376.765580860532;9537.52312384392;9616.615335386647;9622.951885240529;9636.807263854684;612.5252928980076;652.8216569092738;656.9507286953498;677.0487465111527;678.5691086160225;4323.958115391869;4392.538783427694;4676.415448068991;4740.075685241413;4762.666613337033;86898;88617;89998.10001899897;90675.63986540207;91689;68810.65594671994;77467.61266193746;85366.57316713377;86475;88393.11606883978;72183.63908180426;74788.62605687046;78828.60585697035;79391;79531.60234198792;9199.494027828534;9982.450965196984;10802.081823044815;11075.224734268524;11080.556777729123;46077.76961115173;48157;51008;51050.74474627603;52126.91492340264;68141.3185868135;69419.6529017372;69573.3042669587;70694.2326441843;70954.64522677353;12784.74430511403;12833.165844220095;12891.226526408445;12969.54606588765;13014.349282535646;14154.929225354219;14355.497557585435;14522.636934076732;14596.854031459974;15131.924340378668;13055;13226.801597976231;13232.735345293233;13432.932835335761;13443.798343025059;11227.012480537931;12771.680707982003;12971.41628626733;13224.603261902159;13636.386362613508;12829.93585032069;13032.283224422748;13035;13121.73756524845;13407.597772066854;9870.309078364446;10483.423411712123;10646;10936.50785714629;11275.887241127484;8899.955500222717;10394.18674099168;10609.151267898395;10620.415877126832;10675.786484270116 20:23:26 INFO - PROCESS | 1639 | __end_tp_report 20:23:26 INFO - PROCESS | 1639 | __start_cc_report 20:23:26 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,386 20:23:26 INFO - PROCESS | 1639 | __end_cc_report 20:23:26 INFO - PROCESS | 1639 | __startTimestamp1487910206888__endTimestamp 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | ------- Summary: start ------- 20:23:26 INFO - PROCESS | 1639 | Number of tests: 6 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5736.80 Median:6066.61 stddev:703.92 (11.6%) stddev-sans-first:681.49 20:23:26 INFO - PROCESS | 1639 | Values: 3385.8 3394.4 3395.8 3396.1 3411.3 5648.7 5655.7 5662.1 5705.7 5706.5 4574.7 4639.5 5739.4 5753.5 5806.8 4757.2 5209.3 5243.2 5257.7 5309.9 4863.3 5277.0 5291.8 5309.6 5309.7 5162.6 5179.5 5306.8 5313.2 5380.1 4159.5 5247.7 5274.7 5297.0 5344.1 5159.4 5210.0 5222.1 5224.6 5225.1 4626.7 4893.9 5687.6 5798.7 5806.8 6147.8 6177.1 6203.5 6234.3 6299.1 6289.3 6298.0 6300.4 6305.7 6310.4 5701.5 5942.8 5944.1 5944.3 5951.2 4865.0 5560.4 6258.5 6292.2 6305.7 6127.5 6238.0 6242.9 6243.5 6248.3 6243.5 6263.1 6268.9 6287.8 6295.8 6117.5 6127.9 6133.0 6142.2 6198.4 6226.8 6252.4 6259.9 6265.7 6272.9 4995.4 4996.9 5017.7 5020.8 5025.7 3548.9 3621.4 4353.7 4474.7 4493.0 5774.4 5826.9 5882.7 5897.0 5922.4 6146.6 6280.5 6288.9 6291.1 6316.4 5659.9 5744.3 5750.8 5814.4 5848.6 5406.9 5463.0 5467.1 5468.4 5475.6 6317.2 6361.4 6365.9 6390.1 6390.2 6167.9 6196.1 6206.0 6247.5 6279.9 6382.6 6386.4 6386.7 6387.6 6401.8 6214.0 6255.2 6262.8 6274.6 6299.1 6187.1 6234.4 6242.4 6272.6 6322.6 6138.8 6210.7 6212.7 6215.7 6220.2 6037.9 6118.8 6161.7 6193.2 6224.4 5819.7 5871.6 5965.8 6087.4 6094.5 6117.7 6127.3 6170.1 6202.9 6237.6 6007.4 6066.6 6093.3 6123.4 6133.8 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:56370.69 Median:33850.32 stddev:115590.27 (341.5%) stddev-sans-first:115838.28 20:23:26 INFO - PROCESS | 1639 | Values: 449.5 460.1 472.9 500.9 514.9 31495.4 40273.8 40403.4 40452.2 40611.0 34093.5 41444.0 41942.6 41958.8 41976.4 8156.4 8410.5 9038.6 9244.2 9263.5 10122.9 10968.7 11080.4 11374.9 11437.8 10569.5 11240.7 11270.7 11305.2 11325.2 11117.3 11157.9 11193.3 11200.6 11213.3 11271.3 11340.3 11350.4 11354.9 11369.9 33445.5 40239.2 40317.0 40506.6 40754.4 3870.2 3906.3 3935.2 3977.7 4003.9 29236.0 29728.7 29908.0 30112.4 30138.0 2968.9 2993.0 3010.1 3025.4 3029.5 462720.0 462884.7 463717.0 464834.0 465287.7 55567.7 55827.0 55936.2 56155.0 60206.6 62984.0 63210.7 63402.7 63518.0 63690.0 16010.0 16380.8 16599.7 16613.9 16658.6 11572.6 11853.6 12680.6 12874.6 13048.9 15961.9 16032.8 16041.4 16084.8 16147.2 6724.3 6838.6 6839.7 6860.8 6883.1 742.7 747.5 829.4 859.7 861.8 24178.0 26885.3 28353.4 30043.8 30339.8 826.5 988.7 1044.9 1081.1 1170.0 15115.6 15418.8 15465.0 15472.5 15677.2 216397.0 217854.0 218625.0 219246.0 219541.0 60037.7 60122.1 60160.7 60393.4 60399.7 1223.3 1389.4 1407.6 1423.1 1425.1 28605.1 29172.6 29490.6 29848.7 29919.4 49343.5 49487.5 49780.8 49815.5 49849.0 545202.0 546469.0 547576.3 548565.0 549453.0 24193.0 24823.4 39521.6 39851.6 39900.0 42139.0 42308.6 42667.0 43039.6 43096.8 26709.1 34601.7 35641.6 35917.9 36734.9 27980.4 32688.8 35204.8 35875.1 36238.8 33607.2 34330.3 34753.0 34914.0 35016.8 29719.3 30942.2 31587.4 31617.5 31729.4 23540.0 23601.8 23671.1 24018.2 24033.9 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35409.27 Median:21167.84 stddev:100155.18 (473.1%) stddev-sans-first:100401.59 20:23:26 INFO - PROCESS | 1639 | Values: 371.9 388.2 388.2 397.8 417.3 15438.6 19677.8 20415.9 21000.4 21051.2 20792.2 20794.4 21111.7 21224.0 21352.0 5312.9 5689.2 5723.3 5750.4 5750.7 5155.9 5466.1 5620.9 5706.3 5724.5 5603.7 5652.2 5652.8 5665.4 5676.3 5401.2 5581.0 5634.2 5638.4 5659.5 4984.2 5002.7 5002.9 5004.8 5017.7 19848.8 24892.9 24969.3 25199.7 25358.9 2722.1 2802.5 2815.2 2818.8 2826.9 15087.0 15682.2 15769.8 15865.3 16404.4 1823.6 1833.4 1855.0 1871.6 1875.9 129910.0 131142.0 132415.0 133726.3 134725.3 11477.3 11935.4 11939.9 11957.6 12021.5 11401.3 13450.8 14629.6 14645.3 14647.9 8534.3 8821.6 8886.2 8912.9 9056.3 8702.7 8876.9 8880.9 8911.5 9038.5 5823.3 7306.3 7423.6 7429.8 7462.0 1717.0 1766.9 1972.8 2027.5 2036.2 1044.8 1055.0 1082.1 1089.3 1112.7 21623.6 22259.7 22325.3 22713.2 22830.5 1081.8 1082.0 1082.4 1119.7 1142.7 11592.9 11670.5 11695.3 11922.6 11945.1 398023.0 403569.0 525021.0 751738.0 779925.0 123970.0 126852.0 137516.0 139480.0 145984.3 950.1 974.2 1006.5 1006.9 1008.6 19224.8 20034.3 20059.7 20061.8 20095.5 47652.3 49619.3 56863.4 57684.7 58299.4 78705.2 86043.1 86906.0 87034.0 87508.6 6978.4 8332.8 8356.6 8523.2 8760.0 12449.0 13278.6 13301.7 13645.8 13691.7 10976.2 11238.2 11342.6 11342.7 11392.8 10585.6 10625.3 11083.9 11211.9 11583.8 11423.5 11439.7 11566.7 11594.2 11634.0 7897.2 8384.1 8523.5 8540.6 8541.6 9808.2 10226.1 10791.0 11133.1 11341.9 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5359.89 Median:5215.18 stddev:2907.20 (55.7%) stddev-sans-first:2900.01 20:23:26 INFO - PROCESS | 1639 | Values: 1385.4 1395.9 1405.3 1417.0 1422.2 7483.6 7758.0 7938.6 8374.9 8385.5 7864.6 8036.9 8140.3 8205.0 8269.6 2272.0 2326.2 2329.3 2330.3 2331.0 2071.6 2139.2 2304.3 2348.7 2352.3 2242.7 2311.2 2312.1 2316.4 2323.5 2308.2 2309.2 2325.0 2331.3 2336.8 2288.3 2290.8 2343.1 2349.1 2361.7 8307.6 8329.8 8330.3 8343.2 8364.6 5006.2 5157.6 5161.2 5163.0 5165.2 3194.9 3247.8 3272.2 3275.2 3452.9 1112.1 1142.1 1198.8 1205.9 1206.1 10562.0 10644.6 10667.6 10684.1 10724.7 4332.4 4630.5 4650.3 4669.8 4693.3 9344.0 9418.5 9464.3 9475.8 9489.7 5127.5 5138.1 5163.6 5188.0 5205.2 4501.5 4695.1 4716.7 4739.4 4740.5 3896.9 3929.8 3932.8 3982.4 4062.6 1171.6 1211.7 1245.4 1286.0 1289.7 856.5 863.8 880.3 899.8 906.7 5525.9 5558.1 5583.9 5810.2 5826.7 936.2 982.4 982.7 988.0 999.3 2582.4 3477.2 3681.2 3716.0 3775.5 9476.7 9802.1 9851.6 9885.5 9982.9 7893.6 8585.7 9863.7 9977.7 9989.5 7369.9 7426.7 7832.1 7834.8 7835.0 4514.0 5225.2 5240.8 5578.7 5652.4 8654.5 9015.6 9076.7 9154.5 9185.1 8819.8 9076.8 9356.4 9376.6 9403.0 7646.6 7718.5 7805.2 7807.6 7814.1 6408.5 7715.1 7794.6 7794.7 7799.4 6911.3 6951.8 6986.8 7116.1 7140.8 6831.0 6871.8 6892.9 6897.4 6923.1 6268.7 6307.0 6334.8 6386.4 6389.5 4728.5 4788.9 4840.4 4940.6 5020.8 4159.6 4881.7 4901.5 4916.6 4967.2 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4489.70 Median:5029.71 stddev:1397.24 (27.8%) stddev-sans-first:1366.20 20:23:26 INFO - PROCESS | 1639 | Values: 351.9 354.0 360.2 366.9 370.9 4405.0 5251.7 5418.3 5543.4 5569.5 4673.8 5161.8 5367.4 5375.0 5386.8 3896.8 4083.0 4196.1 4258.6 4265.2 3367.1 4075.9 4245.6 4269.5 4280.6 3306.6 3636.9 4108.0 4155.5 4217.2 3468.4 3878.5 4061.6 4100.7 4198.0 3075.4 3092.1 3712.1 3738.5 3752.0 4320.5 4494.0 4983.5 5174.2 5268.5 3644.9 4025.5 4872.2 4885.5 4889.0 4429.6 4807.5 5708.9 5709.9 5722.9 3569.8 3613.5 3777.5 3822.0 4140.1 5129.9 5609.6 5780.9 5995.8 6021.2 3154.5 3646.7 3953.2 3959.9 3968.0 3352.8 3683.6 3999.6 4008.5 4037.8 3667.7 3912.9 4107.8 4334.3 4641.8 5280.0 5742.4 5754.0 5775.7 5804.2 972.4 1109.6 1253.7 1257.6 1285.0 849.3 873.1 878.4 881.2 889.6 4205.6 4668.3 4826.6 4883.1 5087.7 5131.4 5399.4 5456.1 5576.7 5622.8 4318.7 4684.7 4731.0 4760.0 5076.0 2816.4 2853.5 2888.1 2913.3 2932.8 5172.8 5213.6 5375.9 5747.7 5782.3 4347.8 4534.8 5247.3 5764.2 5809.9 5201.4 5444.6 5743.7 5769.4 5773.7 5230.9 5266.0 5422.6 5462.3 5634.5 4923.1 5318.9 5372.5 5798.3 5863.5 5434.6 5984.9 6029.8 6033.5 6056.8 3938.3 3948.8 3962.8 3968.7 4025.6 4307.5 4911.9 5851.0 5866.7 5958.7 5471.6 5589.5 5633.5 5775.5 5805.4 5739.7 5739.8 5764.5 5789.3 5835.2 4390.8 5618.9 5626.1 5650.7 5656.0 5241.9 5614.7 5657.5 5706.9 5780.7 4830.2 5151.4 5598.3 5647.4 5667.5 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19916.66 Median:4358.25 stddev:28403.40 (651.7%) stddev-sans-first:28446.41 20:23:26 INFO - PROCESS | 1639 | Values: 695.3 720.5 750.7 813.5 820.3 14450.3 14737.3 15070.0 15329.1 15359.0 13245.3 13348.0 13391.3 13453.6 13467.5 619.6 834.7 849.1 849.7 852.8 648.8 665.4 822.3 841.3 848.5 887.4 890.4 893.3 893.4 894.3 882.4 885.4 886.0 886.4 887.1 647.6 653.0 656.0 658.9 659.4 14661.6 14792.9 14803.3 14888.7 15475.8 13947.9 14338.6 14444.0 14447.3 14504.0 11462.5 11728.3 11755.8 11760.3 11818.3 3638.8 3657.1 3668.7 3782.5 3875.3 102884.5 109963.0 112975.9 113091.4 113158.4 8786.4 10647.3 10823.2 10847.2 11090.7 19825.2 22311.4 22324.6 22384.0 22574.4 7447.3 7570.3 7637.2 7865.7 7910.8 4004.8 4104.2 4163.9 4218.7 4254.4 3311.5 3424.8 3428.3 3430.1 3435.5 511.6 631.2 633.6 634.5 654.7 620.5 639.5 641.7 646.4 656.3 9376.8 9537.5 9616.6 9623.0 9636.8 612.5 652.8 657.0 677.0 678.6 4324.0 4392.5 4676.4 4740.1 4762.7 86898.0 88617.0 89998.1 90675.6 91689.0 68810.7 77467.6 85366.6 86475.0 88393.1 72183.6 74788.6 78828.6 79391.0 79531.6 9199.5 9982.5 10802.1 11075.2 11080.6 46077.8 48157.0 51008.0 51050.7 52126.9 68141.3 69419.7 69573.3 70694.2 70954.6 12784.7 12833.2 12891.2 12969.5 13014.3 14154.9 14355.5 14522.6 14596.9 15131.9 13055.0 13226.8 13232.7 13432.9 13443.8 11227.0 12771.7 12971.4 13224.6 13636.4 12829.9 13032.3 13035.0 13121.7 13407.6 9870.3 10483.4 10646.0 10936.5 11275.9 8900.0 10394.2 10609.2 10620.4 10675.8 20:23:26 INFO - PROCESS | 1639 | -------- Summary: end -------- 20:23:26 INFO - PROCESS | 1639 | 20:23:26 INFO - PROCESS | 1639 | 1487910206914 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 20:23:27 INFO - TEST-INFO | 1639: exit 0 20:23:27 INFO - TEST-OK | dromaeo_css | took 1115880ms 20:23:27 INFO - TEST-START | kraken 20:23:27 INFO - operating with platform_type : mac_ 20:23:27 INFO - Initialising browser for kraken test... 20:23:27 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpCzLknF/profile http://localhost:49250/getInfo.html) 20:23:28 INFO - PROCESS | 1651 | 1487910208045 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 20:23:28 INFO - PROCESS | 1651 | 1487910208046 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 20:23:28 INFO - PROCESS | 1651 | 1487910208081 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 20:23:30 INFO - PROCESS | 1651 | 2017-02-23 20:23:30.360 plugin-container[1652:10111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b47, name = 'com.apple.tsm.portname' 20:23:30 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:30 INFO - PROCESS | 1651 | 2017-02-23 20:23:30.363 plugin-container[1652:10111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8833, name = 'com.apple.CFPasteboardClient' 20:23:30 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:30 INFO - PROCESS | 1651 | 2017-02-23 20:23:30.363 plugin-container[1652:10111] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:23:30 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 20:23:30 INFO - PROCESS | 1651 | colorDepth:24 20:23:30 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 20:23:30 INFO - PROCESS | 1651 | __metrics 20:23:30 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 20:23:30 INFO - PROCESS | 1651 | 1487910210516 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 20:23:31 INFO - TEST-INFO | 1651: exit 0 20:23:31 INFO - Browser initialized. 20:23:31 INFO - Running cycle 1/1 for kraken test... 20:23:31 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/T/tmpCzLknF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:31 INFO - PROCESS | 1653 | 1487910211645 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 20:23:31 INFO - PROCESS | 1653 | 1487910211646 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 20:23:33 INFO - PROCESS | 1653 | 2017-02-23 20:23:33.720 plugin-container[1654:10235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c47, name = 'com.apple.tsm.portname' 20:23:33 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:33 INFO - PROCESS | 1653 | 2017-02-23 20:23:33.720 plugin-container[1654:10235] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 20:23:33 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:33 INFO - PROCESS | 1653 | 2017-02-23 20:23:33.720 plugin-container[1654:10235] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:23:43 INFO - PROCESS | 1653 | RSS: Main: 218628096 20:23:43 INFO - PROCESS | 1653 | 20:23:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:47 INFO - PROCESS | 1653 | RSS: Main: 232964096 20:23:47 INFO - PROCESS | 1653 | 20:23:50 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 20:23:50 INFO - PROCESS | 1653 | RSS: Main: 241856512 20:23:50 INFO - PROCESS | 1653 | 20:23:54 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 20:23:54 INFO - PROCESS | 1653 | RSS: Main: 244895744 20:23:54 INFO - PROCESS | 1653 | 20:23:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 20:23:57 INFO - PROCESS | 1653 | RSS: Main: 246439936 20:23:57 INFO - PROCESS | 1653 | 20:23:59 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:59 INFO - PROCESS | 1653 | RSS: Main: 246456320 20:23:59 INFO - PROCESS | 1653 | 20:24:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 20:24:03 INFO - PROCESS | 1653 | RSS: Main: 249925632 20:24:03 INFO - PROCESS | 1653 | 20:24:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 20:24:07 INFO - PROCESS | 1653 | RSS: Main: 249376768 20:24:07 INFO - PROCESS | 1653 | 20:24:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 20:24:11 INFO - PROCESS | 1653 | RSS: Main: 249655296 20:24:11 INFO - PROCESS | 1653 | 20:24:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:24:13 INFO - PROCESS | 1653 | RSS: Main: 249163776 20:24:13 INFO - PROCESS | 1653 | 20:24:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:24:16 INFO - PROCESS | 1653 | RSS: Main: 249176064 20:24:16 INFO - PROCESS | 1653 | 20:24:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:24:19 INFO - PROCESS | 1653 | RSS: Main: 249143296 20:24:19 INFO - PROCESS | 1653 | 20:24:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:24:23 INFO - PROCESS | 1653 | RSS: Main: 249499648 20:24:23 INFO - PROCESS | 1653 | 20:24:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:24:26 INFO - PROCESS | 1653 | RSS: Main: 249475072 20:24:26 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 20:24:28 INFO - PROCESS | 1653 | RSS: Main: 251408384 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | __start_tp_report 20:24:28 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:24:28 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:24:28 INFO - PROCESS | 1653 | |i|pagename|runs| 20:24:28 INFO - PROCESS | 1653 | |0;ai-astar;106;133;178;156;118;125;169;163;119;126 20:24:28 INFO - PROCESS | 1653 | |1;audio-beat-detection;140;113;112;147;113;114;113;119;131;115 20:24:28 INFO - PROCESS | 1653 | |2;audio-dft;196;195;201;206;201;199;197;198;200;196 20:24:28 INFO - PROCESS | 1653 | |3;audio-fft;83;62;58;85;60;67;55;58;71;59 20:24:28 INFO - PROCESS | 1653 | |4;audio-oscillator;88;72;84;74;69;72;82;70;69;87 20:24:28 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;92;90;91;95;91;90;77;132;132;89 20:24:28 INFO - PROCESS | 1653 | |6;imaging-darkroom;102;99;103;169;145;152;130;177;174;105 20:24:28 INFO - PROCESS | 1653 | |7;imaging-desaturate;76;97;78;97;147;149;93;133;148;91 20:24:28 INFO - PROCESS | 1653 | |8;json-parse-financial;61;66;86;94;58;86;101;101;100;98 20:24:28 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;67;77;70;89;72;70;69;70;71;71 20:24:28 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;83;89;86;87;87;86;87;85;86 20:24:28 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;151;158;176;159;154;158;165;160;252;155 20:24:28 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;171;229;235;172;173;167;175;154;200;219 20:24:28 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;70;70;65;67;66;69;65;69;64;66 20:24:28 INFO - PROCESS | 1653 | __end_tp_report 20:24:28 INFO - PROCESS | 1653 | __start_cc_report 20:24:28 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,983 20:24:28 INFO - PROCESS | 1653 | __end_cc_report 20:24:28 INFO - PROCESS | 1653 | __startTimestamp1487910268694__endTimestamp 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:24:28 INFO - PROCESS | 1653 | Number of tests: 14 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:139.30 Median:144.50 stddev:24.98 (17.3%) stddev-sans-first:23.41 20:24:28 INFO - PROCESS | 1653 | Values: 106.0 133.0 178.0 156.0 118.0 125.0 169.0 163.0 119.0 126.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:121.70 Median:117.00 stddev:12.88 (11.0%) stddev-sans-first:11.84 20:24:28 INFO - PROCESS | 1653 | Values: 140.0 113.0 112.0 147.0 113.0 114.0 113.0 119.0 131.0 115.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:198.90 Median:199.50 stddev:3.28 (1.6%) stddev-sans-first:3.31 20:24:28 INFO - PROCESS | 1653 | Values: 196.0 195.0 201.0 206.0 201.0 199.0 197.0 198.0 200.0 196.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:65.80 Median:64.50 stddev:10.67 (16.6%) stddev-sans-first:9.33 20:24:28 INFO - PROCESS | 1653 | Values: 83.0 62.0 58.0 85.0 60.0 67.0 55.0 58.0 71.0 59.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:78.00 stddev:7.67 (9.8%) stddev-sans-first:6.97 20:24:28 INFO - PROCESS | 1653 | Values: 88.0 72.0 84.0 74.0 69.0 72.0 82.0 70.0 69.0 87.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:90.50 stddev:18.57 (20.5%) stddev-sans-first:19.58 20:24:28 INFO - PROCESS | 1653 | Values: 92.0 90.0 91.0 95.0 91.0 90.0 77.0 132.0 132.0 89.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:135.60 Median:160.50 stddev:31.90 (19.9%) stddev-sans-first:31.44 20:24:28 INFO - PROCESS | 1653 | Values: 102.0 99.0 103.0 169.0 145.0 152.0 130.0 177.0 174.0 105.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:110.90 Median:84.50 stddev:29.86 (35.3%) stddev-sans-first:28.87 20:24:28 INFO - PROCESS | 1653 | Values: 76.0 97.0 78.0 97.0 147.0 149.0 93.0 133.0 148.0 91.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:85.10 Median:76.00 stddev:17.18 (22.6%) stddev-sans-first:15.85 20:24:28 INFO - PROCESS | 1653 | Values: 61.0 66.0 86.0 94.0 58.0 86.0 101.0 101.0 100.0 98.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:71.00 stddev:6.31 (8.9%) stddev-sans-first:6.36 20:24:28 INFO - PROCESS | 1653 | Values: 67.0 77.0 70.0 89.0 72.0 70.0 69.0 70.0 71.0 71.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.50 stddev:1.60 (1.8%) stddev-sans-first:1.64 20:24:28 INFO - PROCESS | 1653 | Values: 85.0 83.0 89.0 86.0 87.0 87.0 86.0 87.0 85.0 86.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:168.80 Median:159.50 stddev:30.04 (18.8%) stddev-sans-first:31.16 20:24:28 INFO - PROCESS | 1653 | Values: 151.0 158.0 176.0 159.0 154.0 158.0 165.0 160.0 252.0 155.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.50 Median:187.50 stddev:28.88 (15.4%) stddev-sans-first:29.85 20:24:28 INFO - PROCESS | 1653 | Values: 171.0 229.0 235.0 172.0 173.0 167.0 175.0 154.0 200.0 219.0 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:2.23 (3.3%) stddev-sans-first:2.11 20:24:28 INFO - PROCESS | 1653 | Values: 70.0 70.0 65.0 67.0 66.0 69.0 65.0 69.0 64.0 66.0 20:24:28 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:24:28 INFO - PROCESS | 1653 | 20:24:28 INFO - PROCESS | 1653 | 1487910268716 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 20:24:29 INFO - TEST-INFO | 1653: exit 0 20:24:29 INFO - TEST-OK | kraken | took 62079ms 20:24:29 INFO - SUITE-END | took 1177s 20:24:29 INFO - Completed test suite (00:19:38) 20:24:29 INFO - javascript benchmark 20:24:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7212.46021390792, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3385.847636856341, 3394.355072536218, 3395.8471868765905, 3396.0660818274973, 3411.3347897160065, 5648.717564121798, 5655.745491452884, 5662.06575914974, 5705.743241554135, 5706.543476521879, 4574.748388838612, 4639.466461356945, 5739.426057394258, 5753.453421924921, 5806.825795226139, 4757.215059515176, 5209.296744939432, 5243.239730239113, 5257.658252213594, 5309.946900530984, 4863.270509423597, 5276.9736151319385, 5291.841244762663, 5309.62832601718, 5309.707966061865, 5162.638615296931, 5179.482051794809, 5306.814261500848, 5313.22958171065, 5380.112281473572, 4159.542450330461, 5247.737613119348, 5274.657147285453, 5296.9735151324385, 5344.144936810092, 5159.432462429129, 5210.0, 5222.086134926372, 5224.63427560071, 5225.059489291926, 4626.699264547794, 4893.926591101136, 5687.573431992617, 5798.681072541009, 5806.796762113348, 6147.831911936718, 6177.104319873638, 6203.534734894901, 6234.345393733638, 6299.118123462673, 6289.276733175652, 6297.96851015742, 6300.369963003709, 6305.684715764193, 6310.400511951358, 5701.458361455655, 5942.7920022799, 5944.108383742387, 5944.256967879015, 5951.166836642873, 4864.975675121602, 5560.360558535739, 6258.530610204253, 6292.2134733158355, 6305.684715764193, 6127.479164271087, 6237.96881015592, 6242.937570624326, 6243.469305109026, 6248.343923887926, 6243.469305109116, 6263.123162757218, 6268.937310626927, 6287.811365659038, 6295.779647712399, 6117.522930757332, 6127.861529871541, 6133.028644417026, 6142.232220972379, 6198.442140207403, 6226.750929962751, 6252.437280644764, 6259.906101408483, 6265.71804268809, 6272.874542509125, 4995.375578052744, 4996.90006199874, 5017.7491125443585, 5020.849374518771, 5025.723585202776, 3548.8935331940083, 3621.3843646580144, 4353.717008394444, 4474.731516109044, 4493.0115374617535, 5774.419859686937, 5826.8928903508195, 5882.735276912549, 5897.0, 5922.407759224043, 6146.6004709693725, 6280.497560195174, 6288.9056664150075, 6291.1192433059405, 6316.431521163117, 5659.943400566024, 5744.281964754406, 5750.827475175752, 5814.360420353758, 5848.61983971049, 5406.8918621627345, 5463.043967305785, 5467.125259958467, 5468.398476167618, 5475.6440831345835, 6317.178766760292, 6361.427471527585, 6365.936340636719, 6390.105385245976, 6390.201224846895, 6167.876642467036, 6196.10156527292, 6206.0, 6247.5001999840815, 6279.874402511833, 6382.6170429774365, 6386.393292637192, 6386.68066596659, 6387.616742995435, 6401.815664102156, 6213.968930155501, 6255.218097737783, 6262.780802671885, 6274.592151510137, 6299.086632438362, 6187.133801267916, 6234.37656234391, 6242.406971337716, 6272.6236425814595, 6322.557420980487, 6138.81758342749, 6210.72051757681, 6212.689365531795, 6215.65813880241, 6220.222472190976, 6037.939620603738, 6118.785842495491, 6161.691915404302, 6193.163922870535, 6224.408681175281, 5819.6508209507565, 5871.588988770916, 5965.802845275099, 6087.36082711309, 6094.512439004958, 6117.675163990694, 6127.264728232641, 6170.074488826712, 6202.906956395748, 6237.594556353823, 6007.429294217042, 6066.605670631395, 6093.29927058394, 6123.418275263843, 6133.84665383369], "value": 5690.490315291794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.5392222971454, 460.095911533836, 472.9196036673765, 500.9305133539891, 514.9279100925874, 31495.37009259816, 40273.79863100684, 40403.393949090714, 40452.19095618093, 40611.0, 34093.48859767106, 41444.0, 41942.580574194246, 41958.790206049, 41976.37035444463, 8156.429049966505, 8410.453320534176, 9038.59326330315, 9244.214241789456, 9263.536823158849, 10122.88648248692, 10968.670939871778, 11080.445977701123, 11374.943125284362, 11437.771244575104, 10569.471526423686, 11240.718982025433, 11270.661880143609, 11305.208635395526, 11325.150613703963, 11117.27737697051, 11157.944210278978, 11193.328400295926, 11200.607978720705, 11213.327200368005, 11271.267367621078, 11340.319580825177, 11350.375729334883, 11354.943225283821, 11369.943150284278, 33445.49831752526, 40239.19521609581, 40317.0, 40506.594934050576, 40754.38868416976, 3870.1679138985255, 3906.2968665640174, 3935.232629637222, 3977.7414468059774, 4003.8598649047144, 29235.97674081418, 29728.702712973027, 29908.0, 30112.397752045057, 30138.0, 2968.9406211875857, 2993.027266138514, 3010.1270631517054, 3025.410045041218, 3029.469842777505, 462720.0, 462884.68557657, 463717.0, 464834.0, 465287.6735616334, 55567.722161388934, 55827.0, 55936.16095758567, 56155.0, 60206.591736330054, 62984.0, 63210.68394657997, 63402.68298658569, 63518.0, 63690.0, 16010.0, 16380.754288685679, 16599.66800664004, 16613.91693041527, 16658.58353541171, 11572.594959176557, 11853.5851245206, 12680.556180533822, 12874.613761587167, 13048.934755326163, 15961.920190398974, 16032.839671603368, 16041.358345666276, 16084.75872861908, 16147.192640367935, 6724.327567243335, 6838.623875686785, 6839.658017099126, 6860.759873404407, 6883.105196324445, 742.7103429662436, 747.4767662636176, 829.4194064155115, 859.7248880358351, 861.8233262181237, 24178.0, 26885.327866803487, 28353.432931341256, 30043.83789895479, 30339.848300758797, 826.4669288309127, 988.7330420786348, 1044.874615046184, 1081.1242893256488, 1170.0054953289805, 15115.622109447131, 15418.845811541742, 15465.0, 15472.5358239253, 15677.216139192995, 216397.0, 217854.0, 218625.0, 219246.0, 219541.0, 60037.699811500665, 60122.098168527504, 60160.69919650374, 60393.396066038775, 60399.698001509714, 1223.2843786385065, 1389.4095009620871, 1407.56365526685, 1423.1034448297507, 1425.137791636066, 28605.14184574466, 29172.562411564268, 29490.557641634965, 29848.701512984593, 29919.401611968075, 49343.506564933894, 49487.50512494829, 49780.75109624429, 49815.50184498109, 49849.0, 545202.0, 546469.0, 547576.2621186868, 548565.0, 549453.0, 24193.0, 24823.379415514755, 39521.60478395294, 39851.605193818075, 39900.0, 42139.0, 42308.57691423169, 42667.0, 43039.56960430481, 43096.78451607722, 26709.06518271851, 34601.653983459844, 35641.64358356383, 35917.92246232617, 36734.89795306145, 27980.44039119247, 32688.83655581707, 35204.823975879954, 35875.10312242215, 36238.8188059058, 33607.15982100467, 34330.313393731485, 34752.957411277705, 34913.9525814226, 35016.82491587526, 29719.257018573844, 30942.22644433907, 31587.36825263528, 31617.5257371135, 31729.365412691157, 23540.0, 23601.763982360644, 23671.05315787418, 24018.15936442216, 24033.879830600734], "value": 19025.395863999547, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.90516418313325, 388.15963439154234, 388.2293647110486, 397.8080774930134, 417.2572820379725, 15438.61403464914, 19677.803221967777, 20415.897920510415, 21000.36998890032, 21051.157953681854, 20792.16831326745, 20794.376168714924, 21111.6833247501, 21224.0, 21352.039158237876, 5312.9203061954, 5689.175069614904, 5723.284589426322, 5750.367459579443, 5750.712464376765, 5155.896882062357, 5466.098093814516, 5620.91568626471, 5706.315242170946, 5724.484796368326, 5603.663780173182, 5652.208690783294, 5652.773889044433, 5665.433456654322, 5676.318841738997, 5401.189821526763, 5580.999999999959, 5634.239377684001, 5638.40796716345, 5659.518940890009, 4984.202527595604, 5002.7248501332415, 5002.89994200114, 5004.774785134678, 5017.724025178613, 19848.80151198484, 24892.875535622206, 24969.250922472173, 25199.748002519922, 25358.873205634038, 2722.101706436871, 2802.467531169071, 2815.197668664441, 2818.816776909515, 2826.901058462944, 15087.0, 15682.215889205494, 15769.763453548207, 15865.286062127232, 16404.425845095484, 1823.5896923192308, 1833.4316361927845, 1855.044652004219, 1871.6350311689225, 1875.9025969807678, 129910.0, 131142.0, 132415.0, 133726.33136834254, 134725.3263733675, 11477.253978491372, 11935.403229838474, 11939.88060119405, 11957.641270761891, 12021.519139234508, 11401.315921044597, 13450.798238026437, 14629.56111316641, 14645.267736613127, 14647.853521464862, 8534.27458666008, 8821.558922053871, 8886.155815197546, 8912.910870891337, 9056.320775941831, 8702.738917832476, 8876.911230887737, 8880.8667869982, 8911.50986695725, 9038.502882341534, 5823.330317013598, 7306.2693730626515, 7423.591702456417, 7429.777106686808, 7462.02993610838, 1716.9742453863203, 1766.9028203448677, 1972.7768783354413, 2027.4829918370722, 2036.185525789696, 1044.8380501022355, 1054.9678035769336, 1082.1342925659442, 1089.3082892363248, 1112.6550769261394, 21623.59446635995, 22259.666105008437, 22325.330240092822, 22713.205037823598, 22830.543389132123, 1081.799867024603, 1081.9513121909533, 1082.3722241100143, 1119.692084676704, 1142.731458107344, 11592.942035289938, 11670.474828632732, 11695.298282103102, 11922.582709605296, 11945.104117191071, 398023.0, 403569.0, 525021.0, 751738.0, 779925.0, 123970.0, 126852.0, 137516.0, 139480.0, 145984.27007864893, 950.1401231885155, 974.152487336008, 1006.5369929832212, 1006.9295149339476, 1008.621766837436, 19224.846509209492, 20034.298799541946, 20059.699104513737, 20061.79938200658, 20095.497612559804, 47652.285215722484, 49619.25571116508, 56863.431365685814, 57684.71157644185, 58299.4170058294, 78705.21294787207, 86043.13956860351, 86906.0, 87034.0, 87508.5624571873, 6978.441724661913, 8332.750017499242, 8356.582170891552, 8523.232909038215, 8759.956200218958, 12449.0, 13278.601641950758, 13301.733965320833, 13645.795313070113, 13691.726165476834, 10976.23166378346, 11238.213325067167, 11342.60300889465, 11342.716432089264, 11392.829107563559, 10585.576576937145, 10625.25623206368, 11083.944580277048, 11211.88788112141, 11583.76832463363, 11423.543058277908, 11439.656810295704, 11566.65300041, 11594.231874640944, 11633.95294423506, 7897.1707970662255, 8384.119667434832, 8523.531205783742, 8540.615672294638, 8541.572921354033, 9808.215342772704, 10226.130778883879, 10791.010988900922, 11133.109351252042, 11341.943290283496], "value": 10023.657452675627, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.445821671332, 1395.9092658977172, 1405.3254437869823, 1416.9574912752616, 1422.1680317014545, 7483.588402637853, 7757.961210193956, 7938.563379014159, 8374.91625083749, 8385.496870187793, 7864.646090925908, 8036.91963080369, 8140.348772098233, 8204.95897520513, 8269.586520673973, 2271.954560908781, 2326.232343326698, 2329.2546385156757, 2330.33585428153, 2331.0326214620995, 2071.6167509010806, 2139.1978008246906, 2304.308707387777, 2348.7181538215436, 2352.2707960532202, 2242.697235873161, 2311.237291693737, 2312.09828167015, 2316.3745788637057, 2323.523677646087, 2308.1690591387087, 2309.168699268262, 2324.976750232493, 2331.300609817048, 2336.8247381446376, 2288.302067869299, 2290.7823756743082, 2343.109618345018, 2349.107339211106, 2361.740208577055, 8307.584620768997, 8329.791755206108, 8330.291925186366, 8343.207395297497, 8364.623591938378, 5006.173981293082, 5157.638965272433, 5161.225816127611, 5162.97418512905, 5165.173572228463, 3194.9201269968203, 3247.772655914087, 3272.2146684795716, 3275.2303208746166, 3452.879149229765, 1112.076976109835, 1142.1034487926938, 1198.7662405830868, 1205.891469767725, 1206.1255589697487, 10562.0, 10644.627438039708, 10667.573297068107, 10684.130277201459, 10724.678259652223, 4332.371806088099, 4630.53694630541, 4650.302454631832, 4669.789859456333, 4693.296005599187, 9343.95328023369, 9418.481983490974, 9464.337496375325, 9475.763105922408, 9489.667861624948, 5127.487251274917, 5138.07514647367, 5163.561097306771, 5187.974060129751, 5205.167173252262, 4501.527339629357, 4695.107929493385, 4716.716996980193, 4739.3601863748645, 4740.549647783455, 3896.8636097736444, 3929.8231579578987, 3932.803359831997, 3982.38273067675, 4062.5531191568903, 1171.5782318365382, 1211.6849619099098, 1245.4395522014947, 1285.9871401286055, 1289.7098152915707, 856.4732689395977, 863.7883718489011, 880.3089574683843, 899.8020435504178, 906.723449347942, 5525.889482210333, 5558.082916318762, 5583.916241256385, 5810.1865738796605, 5826.65040097587, 936.166811537732, 982.3958265666564, 982.6953644370125, 987.9901200988041, 999.3454287441738, 2582.431864989699, 3477.2355976998347, 3681.171736359298, 3716.0, 3775.452559378875, 9476.668316608886, 9802.117809397188, 9851.556679949419, 9885.505724713736, 9982.900170998197, 7893.644785984645, 8585.699500517452, 9863.654772082942, 9977.650782222587, 9989.450580218012, 7369.8526029478035, 7426.7400640978385, 7832.138464768871, 7834.764957051298, 7835.0, 4513.977430112828, 5225.190095535198, 5240.816571419982, 5578.693171875586, 5652.406497317723, 8654.4807311559, 9015.594298256463, 9076.727698169065, 9154.496502692416, 9185.127412895765, 8819.823603527766, 9076.818463630558, 9356.4386136832, 9376.578053987723, 9402.95298523503, 7646.617669116633, 7718.459707820399, 7805.219478052377, 7807.570583617956, 7814.062312522534, 6408.487321014214, 7715.112762032438, 7794.610269486617, 7794.72718454874, 7799.37604991588, 6911.320162748161, 6951.7914462566205, 6986.755463558751, 7116.110486189226, 7140.821479463055, 6831.043653888559, 6871.793846184622, 6892.862142757217, 6897.379235868796, 6923.134608173978, 6268.655223962726, 6307.0, 6334.809955701337, 6386.393292637192, 6389.52078594098, 4728.479867214535, 4788.928166077442, 4840.419149702058, 4940.629452790983, 5020.824271150638, 4159.604837540429, 4881.682690625098, 4901.485344038824, 4916.631252655993, 4967.155583550877], "value": 4367.963327924308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8698081709768, 353.9505366588066, 360.18238598381674, 366.8789299531155, 370.86648806429696, 4405.00887300358, 5251.737413129347, 5418.349798024237, 5543.417941116185, 5569.52659023983, 4673.813047478106, 5161.793528258874, 5367.409584945653, 5375.0, 5386.8383948481605, 3896.7661940283533, 4082.9588454943946, 4196.139791342775, 4258.574142585732, 4265.165978629188, 3367.0740546349825, 4075.9388609170887, 4245.617894389505, 4269.462993322401, 4280.57194280571, 3306.6442758469034, 3636.8545258189774, 4107.960109518949, 4155.480564929384, 4217.219814334343, 3468.4450487921813, 3878.4764056852246, 4061.614146656063, 4100.7334523256195, 4197.958020419803, 3075.400296942097, 3092.1496588438135, 3712.1090938174643, 3738.532683414573, 3751.981240093782, 4320.546342634009, 4493.988852508192, 4983.451820299764, 5174.249733788617, 5268.471133855733, 3644.908877278063, 4025.5169379674335, 4872.244802055687, 4885.485499495132, 4888.951110488921, 4429.645628349725, 4807.519248075199, 5708.885822283531, 5709.887341683562, 5722.885542289173, 3569.785812851237, 3613.49411082446, 3777.5089238399105, 3821.9680686214842, 4140.101928649957, 5129.871428285771, 5609.635373700738, 5780.8843823123725, 5995.7901473448655, 6021.2473440819895, 3154.542591324245, 3646.6717995380545, 3953.2488827122756, 3959.9010024749614, 3967.9603203968168, 3352.8155951422905, 3683.613220611851, 3999.6201310547813, 4008.5390180129075, 4037.818298176589, 3667.7065834733157, 3912.882613521599, 4107.774072425986, 4334.349847522897, 4641.8375356863025, 5279.973600132052, 5742.425757424307, 5753.971230143822, 5775.711214439261, 5804.187413762077, 972.4457059476031, 1109.6449136276476, 1253.7179134694802, 1257.5852166312898, 1284.9935750321188, 849.2569002123142, 873.0745409865563, 878.3587980774071, 881.1584936385736, 889.5685592487638, 4205.642520385741, 4668.323093151542, 4826.562585894101, 4883.145449546315, 5087.728067983005, 5131.435542090367, 5399.433059528771, 5456.0903683710385, 5576.749046292926, 5622.839099066661, 4318.676099292566, 4684.664870511888, 4730.9763451182525, 4760.0, 5075.974620126875, 2816.380396312808, 2853.5149024665857, 2888.050565868031, 2913.2710131032313, 2932.8240305581735, 5172.818951336685, 5213.6350455467755, 5375.919361209585, 5747.712614369265, 5782.335031471351, 4347.804348804311, 4534.79593418297, 5247.320857325619, 5764.221830052973, 5809.8547536311935, 5201.42784293735, 5444.5916556258435, 5743.712814359265, 5769.394213607595, 5773.711314434177, 5230.895382092261, 5266.0257852297445, 5422.620416570802, 5462.289902312833, 5634.464725851038, 4923.113839508923, 5318.920216196838, 5372.489613486712, 5798.33319168301, 5863.530917526673, 5434.619576629756, 5984.940150598438, 6029.849253768515, 6033.5173186145885, 6056.788012419544, 3938.2714197873483, 3948.756141815319, 3962.821673024663, 3968.682505399619, 4025.6376926076796, 4307.483102027777, 4911.852644420673, 5851.0, 5866.706664666664, 5958.731857066356, 5471.6169868108855, 5589.469000444951, 5633.492985631313, 5775.509081727932, 5805.390434004369, 5739.684317362418, 5739.827805165852, 5764.538836893123, 5789.2763404574425, 5835.153902684002, 4390.758508282075, 5618.876224755147, 5626.099824028136, 5650.68921209321, 5655.981923253854, 5241.89516209666, 5614.69119198448, 5657.519110875622, 5706.857328566819, 5780.682062486436, 4830.222621992439, 5151.419763264645, 5598.272224610774, 5647.407022262768, 5667.489925906688], "value": 4059.3537763148593, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.2630211975303, 720.5424555407318, 750.7034721285092, 813.5078277642026, 820.3068407195917, 14450.349734261958, 14737.336819843105, 15070.020448670843, 15329.080255184697, 15359.0, 13245.337733113354, 13348.0, 13391.330433478335, 13453.596392108228, 13467.46130154795, 619.5724949784634, 834.6619619054293, 849.0617867256685, 849.668629234599, 852.8251708399794, 648.8053583924827, 665.3612531969316, 822.3092602214139, 841.3395484544634, 848.516345682961, 887.3832686283004, 890.4123278636101, 893.2764460786751, 893.4326702543866, 894.2845723421269, 882.3999680217449, 885.3713863157166, 885.9557022148866, 886.3529623374908, 887.1350433327518, 647.6405594894832, 652.9738810447576, 655.9737610495574, 658.8978708300222, 659.4394764450227, 14661.560153195422, 14792.852071479363, 14803.259837008107, 14888.702225955529, 15475.767863482057, 13947.930260348734, 14338.64153396163, 14443.98892077555, 14447.277636118151, 14504.0, 11462.49764401282, 11728.296302221894, 11755.823662645067, 11760.294382337002, 11818.290902545788, 3638.7998660073686, 3657.140571965586, 3668.724845636588, 3782.489363935861, 3875.263699897039, 102884.48557757238, 109963.0, 112975.87024129818, 113091.43454282758, 113158.43420782844, 8786.384953053353, 10647.307924985005, 10823.242373033812, 10847.240693151403, 11090.722731931604, 19825.206991720457, 22311.442213944458, 22324.55350892973, 22383.9927203273, 22574.435639108826, 7447.255274472509, 7570.280823321776, 7637.236276372319, 7865.685372585147, 7910.762677119696, 4004.839806407769, 4104.220198162339, 4163.916721665611, 4218.6625069994325, 4254.404383386328, 3311.453610154346, 3424.811635360079, 3428.3486137633768, 3430.073880052372, 3435.4503279475166, 511.6086194061546, 631.1637080867869, 633.6483251795298, 634.4828964394004, 654.7086546486768, 620.4725982914576, 639.4756299834185, 641.6695401868042, 646.3794757033301, 656.3207080671482, 9376.765580860532, 9537.52312384392, 9616.615335386647, 9622.951885240529, 9636.807263854684, 612.5252928980076, 652.8216569092738, 656.9507286953498, 677.0487465111527, 678.5691086160225, 4323.958115391869, 4392.538783427694, 4676.415448068991, 4740.075685241413, 4762.666613337033, 86898.0, 88617.0, 89998.10001899897, 90675.63986540207, 91689.0, 68810.65594671994, 77467.61266193746, 85366.57316713377, 86475.0, 88393.11606883978, 72183.63908180426, 74788.62605687046, 78828.60585697035, 79391.0, 79531.60234198792, 9199.494027828534, 9982.450965196984, 10802.081823044815, 11075.224734268524, 11080.556777729123, 46077.76961115173, 48157.0, 51008.0, 51050.74474627603, 52126.91492340264, 68141.3185868135, 69419.6529017372, 69573.3042669587, 70694.2326441843, 70954.64522677353, 12784.74430511403, 12833.165844220095, 12891.226526408445, 12969.54606588765, 13014.349282535646, 14154.929225354219, 14355.497557585435, 14522.636934076732, 14596.854031459974, 15131.924340378668, 13055.0, 13226.801597976231, 13232.735345293233, 13432.932835335761, 13443.798343025059, 11227.012480537931, 12771.680707982003, 12971.41628626733, 13224.603261902159, 13636.386362613508, 12829.93585032069, 13032.283224422748, 13035.0, 13121.73756524845, 13407.597772066854, 9870.309078364446, 10483.423411712123, 10646.0, 10936.50785714629, 11275.887241127484, 8899.955500222717, 10394.18674099168, 10609.151267898395, 10620.415877126832, 10675.786484270116], "value": 7314.8955954607, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1615.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 133.0, 178.0, 156.0, 118.0, 125.0, 169.0, 163.0, 119.0, 126.0], "value": 139.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 113.0, 112.0, 147.0, 113.0, 114.0, 113.0, 119.0, 131.0, 115.0], "value": 121.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 195.0, 201.0, 206.0, 201.0, 199.0, 197.0, 198.0, 200.0, 196.0], "value": 198.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 58.0, 85.0, 60.0, 67.0, 55.0, 58.0, 71.0, 59.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 84.0, 74.0, 69.0, 72.0, 82.0, 70.0, 69.0, 87.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 91.0, 95.0, 91.0, 90.0, 77.0, 132.0, 132.0, 89.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 99.0, 103.0, 169.0, 145.0, 152.0, 130.0, 177.0, 174.0, 105.0], "value": 135.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 97.0, 78.0, 97.0, 147.0, 149.0, 93.0, 133.0, 148.0, 91.0], "value": 110.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 66.0, 86.0, 94.0, 58.0, 86.0, 101.0, 101.0, 100.0, 98.0], "value": 85.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 70.0, 89.0, 72.0, 70.0, 69.0, 70.0, 71.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 89.0, 86.0, 87.0, 87.0, 86.0, 87.0, 85.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 158.0, 176.0, 159.0, 154.0, 158.0, 165.0, 160.0, 252.0, 155.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 229.0, 235.0, 172.0, 173.0, 167.0, 175.0, 154.0, 200.0, 219.0], "value": 189.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 65.0, 67.0, 66.0, 69.0, 65.0, 69.0, 64.0, 66.0], "value": 67.1, "unit": "score"}]}]} 20:24:29 INFO - Return code: 0 20:24:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:24:30 ERROR - # TBPL SUCCESS # 20:24:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:24:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:24:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:24:30 INFO - 2017-02-23 20:24:30.024 screenresolution[1658:10630] starting screenresolution argv=screenresolution get 20:24:30 INFO - 2017-02-23 20:24:30.026 screenresolution[1658:10630] Display 0: 1600x1200x32@60 20:24:30 INFO - 2017-02-23 20:24:30.033 screenresolution[1659:10633] starting screenresolution argv=screenresolution list 20:24:30 INFO - Available Modes on Display 0 20:24:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:24:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:24:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:24:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:24:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:24:30 INFO - Intel Iris: 20:24:30 INFO - Chipset Model: Intel Iris 20:24:30 INFO - Type: GPU 20:24:30 INFO - Bus: Built-In 20:24:30 INFO - VRAM (Dynamic, Max): 1536 MB 20:24:30 INFO - Vendor: Intel (0x8086) 20:24:30 INFO - Device ID: 0x0a2e 20:24:30 INFO - Revision ID: 0x0009 20:24:30 INFO - Displays: 20:24:30 INFO - Display: 20:24:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:24:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:24:30 INFO - Display Serial Number: 1600x1200 60 20:24:30 INFO - Main Display: Yes 20:24:30 INFO - Mirror: Off 20:24:30 INFO - Online: Yes 20:24:30 INFO - Rotation: Supported 20:24:30 INFO - Return code: 0 20:24:30 INFO - Running post-action listener: _resource_record_post_action 20:24:30 INFO - [mozharness: 2017-02-24 04:24:30.269720Z] Finished run-tests step (success) 20:24:30 INFO - Running post-run listener: _resource_record_post_run 20:24:30 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 38976000; Write bytes: 511768576; Read time: 250; Write time: 1644 20:24:30 INFO - TinderboxPrint: CPU usage
54.2% 20:24:30 INFO - TinderboxPrint: I/O read bytes / time
38,976,000 / 250 20:24:30 INFO - TinderboxPrint: I/O write bytes / time
511,768,576 / 1,644 20:24:30 INFO - TinderboxPrint: CPU idle
2,198.4 (45.8%) 20:24:30 INFO - TinderboxPrint: CPU system
964.8 (20.1%) 20:24:30 INFO - TinderboxPrint: CPU user
1,634.4 (34.1%) 20:24:30 INFO - TinderboxPrint: Swap in / out
246,890,496 / 0 20:24:30 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201421312; Write bytes: 200758784; Read time: 15743; Write time: 447 20:24:30 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37001728; Write bytes: 300270080; Read time: 232; Write time: 1165 20:24:30 INFO - Running post-run listener: _upload_blobber_files 20:24:30 INFO - Blob upload gear active. 20:24:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:24:30 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 20:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:24:31 INFO - (blobuploader) - INFO - Open directory for files ... 20:24:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:24:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:24:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:32 INFO - (blobuploader) - INFO - Done attempting. 20:24:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:24:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:24:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:33 INFO - (blobuploader) - INFO - Done attempting. 20:24:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:24:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:24:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:34 INFO - (blobuploader) - INFO - Done attempting. 20:24:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:24:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:24:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:36 INFO - (blobuploader) - INFO - Done attempting. 20:24:36 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:36 INFO - Return code: 0 20:24:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:24:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18cc03b2688cf9d70492ab8f838489449610fa9a803a9d1445d4cc5b343c440174382077190e2357cac21dc28c5ec186d2d2fd6f6026c09ebaf88142e251056a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bad5040c0fc19588bffafed1ebe611a06401a0e7a69b99fdffbdd61b0c947547b7a66ff4a5848578444d871365e7ccb255c092eb98a4a26f18f9119e04e9c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e86a8e75983a3a2e34d82537ced25193c718b3225404eb71f1a7a957e56d6432f92e8ceb7a9dce34ed48983be47547076e207633db570878e4f5bdbcf6577c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b3e6983f9cd540105a6b2d39f02d67769656b64e02b76a00e8dba4c3bc14b990d94406311eb1d6b109fda469b0eebf2207a408026249ac4ba1bd13645acc06"} 20:24:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:24:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:24:36 INFO - Contents: 20:24:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18cc03b2688cf9d70492ab8f838489449610fa9a803a9d1445d4cc5b343c440174382077190e2357cac21dc28c5ec186d2d2fd6f6026c09ebaf88142e251056a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bad5040c0fc19588bffafed1ebe611a06401a0e7a69b99fdffbdd61b0c947547b7a66ff4a5848578444d871365e7ccb255c092eb98a4a26f18f9119e04e9c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e86a8e75983a3a2e34d82537ced25193c718b3225404eb71f1a7a957e56d6432f92e8ceb7a9dce34ed48983be47547076e207633db570878e4f5bdbcf6577c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b3e6983f9cd540105a6b2d39f02d67769656b64e02b76a00e8dba4c3bc14b990d94406311eb1d6b109fda469b0eebf2207a408026249ac4ba1bd13645acc06"} 20:24:36 INFO - Running post-run listener: copy_logs_to_upload_dir 20:24:36 INFO - Copying logs to upload dir... 20:24:36 INFO - mkdir: /builds/slave/test/build/upload/logs 20:24:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.030473 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-23 20:24:36.361234) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 20:24:36.364985) ========= 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.vnh47lwEWe/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.61AR75wxSP/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18cc03b2688cf9d70492ab8f838489449610fa9a803a9d1445d4cc5b343c440174382077190e2357cac21dc28c5ec186d2d2fd6f6026c09ebaf88142e251056a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bad5040c0fc19588bffafed1ebe611a06401a0e7a69b99fdffbdd61b0c947547b7a66ff4a5848578444d871365e7ccb255c092eb98a4a26f18f9119e04e9c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e86a8e75983a3a2e34d82537ced25193c718b3225404eb71f1a7a957e56d6432f92e8ceb7a9dce34ed48983be47547076e207633db570878e4f5bdbcf6577c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b3e6983f9cd540105a6b2d39f02d67769656b64e02b76a00e8dba4c3bc14b990d94406311eb1d6b109fda469b0eebf2207a408026249ac4ba1bd13645acc06"} build_url:https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011099 build_url: 'https://queue.taskcluster.net/v1/task/Oh1z_8m9SPeFFTCWq0pQcQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/18cc03b2688cf9d70492ab8f838489449610fa9a803a9d1445d4cc5b343c440174382077190e2357cac21dc28c5ec186d2d2fd6f6026c09ebaf88142e251056a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2bad5040c0fc19588bffafed1ebe611a06401a0e7a69b99fdffbdd61b0c947547b7a66ff4a5848578444d871365e7ccb255c092eb98a4a26f18f9119e04e9c94", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c1e86a8e75983a3a2e34d82537ced25193c718b3225404eb71f1a7a957e56d6432f92e8ceb7a9dce34ed48983be47547076e207633db570878e4f5bdbcf6577c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b3e6983f9cd540105a6b2d39f02d67769656b64e02b76a00e8dba4c3bc14b990d94406311eb1d6b109fda469b0eebf2207a408026249ac4ba1bd13645acc06"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 20:24:36.398270) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:24:36.398618) ========= 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.vnh47lwEWe/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.61AR75wxSP/Listeners TMPDIR=/var/folders/lh/qp12vhwd15354byzrjs4wrjw00000w/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.005147 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 20:24:36.447350) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 20:24:36.447703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 20:24:36.448011) ========= ========= Total master_lag: 0.17 =========