builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0390 starttime: 1486106611.67 results: success (0) buildid: 20170202220408 builduid: cf2789a52e6a4a3a9a9bc4ec542121a4 revision: 2aede0a97bc685e163196cc451b947a04ae6a598 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.669364) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.669779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.670057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.694830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.695094) ========= 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.9kli2WbffQ/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.JuEXsS1C13/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-02 23:23:31-- 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% 23.4M=0s 2017-02-02 23:23:31 (23.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093228 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.811936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.815270) ========= 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.9kli2WbffQ/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.JuEXsS1C13/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.024811 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:31.863699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-02-02 23:23:31.864018) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2aede0a97bc685e163196cc451b947a04ae6a598 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 2aede0a97bc685e163196cc451b947a04ae6a598 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9kli2WbffQ/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.JuEXsS1C13/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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-02 23:23:31,974 truncating revision to first 12 chars 2017-02-02 23:23:31,974 Setting DEBUG logging. 2017-02-02 23:23:31,974 attempt 1/10 2017-02-02 23:23:31,974 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2aede0a97bc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 23:23:32,849 unpacking tar archive at: mozilla-central-2aede0a97bc6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.145695 ========= master_lag: 3.54 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-02-02 23:23:36.550516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:36.550876) ========= script_repo_revision: 2aede0a97bc685e163196cc451b947a04ae6a598 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:36.555328) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:36.555631) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 23:23:36.588678) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-02 23:23:36.589089) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9kli2WbffQ/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.JuEXsS1C13/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:23:36 INFO - MultiFileLogger online at 20170202 23:23:36 in /builds/slave/test 23:23:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 23:23:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:23:36 INFO - {'append_to_log': False, 23:23:36 INFO - 'base_work_dir': '/builds/slave/test', 23:23:36 INFO - 'blob_upload_branch': 'Firefox', 23:23:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:23:36 INFO - 'branch': 'Firefox', 23:23:36 INFO - 'buildbot_json_path': 'buildprops.json', 23:23:36 INFO - 'config_files': ('talos/mac_config.py',), 23:23:36 INFO - 'default_actions': ('clobber', 23:23:36 INFO - 'read-buildbot-config', 23:23:36 INFO - 'download-and-extract', 23:23:36 INFO - 'populate-webroot', 23:23:36 INFO - 'create-virtualenv', 23:23:36 INFO - 'install', 23:23:36 INFO - 'run-tests'), 23:23:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:23:36 INFO - 'download_minidump_stackwalk': True, 23:23:36 INFO - 'download_symbols': 'ondemand', 23:23:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:23:36 INFO - 'tooltool.py': '/tools/tooltool.py', 23:23:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:23:36 INFO - '/tools/misc-python/virtualenv.py')}, 23:23:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:23:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:23:36 INFO - 'installer_path': 'installer.exe', 23:23:36 INFO - 'log_level': 'info', 23:23:36 INFO - 'log_name': 'talos', 23:23:36 INFO - 'log_to_console': True, 23:23:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:23:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:23:36 INFO - 'opt_config_files': (), 23:23:36 INFO - 'pip_index': False, 23:23:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:23:36 INFO - 'cmd': ('bash', 23:23:36 INFO - '-c', 23:23:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:23:36 INFO - 'enabled': True, 23:23:36 INFO - 'halt_on_failure': False, 23:23:36 INFO - 'name': 'check_screen_resolution'},), 23:23:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:23:36 INFO - 'cmd': ('bash', 23:23:36 INFO - '-c', 23:23:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:23:36 INFO - 'enabled': True, 23:23:36 INFO - 'halt_on_failure': False, 23:23:36 INFO - 'name': 'check_screen_resolution'},), 23:23:36 INFO - 'run_cmd_checks_enabled': True, 23:23:36 INFO - 'sps_profile': False, 23:23:36 INFO - 'sps_profile_interval': 0, 23:23:36 INFO - 'suite': 'dromaeojs-e10s', 23:23:36 INFO - 'system_bits': '32', 23:23:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:23:36 INFO - 'title': 't-yosemite-r7-0390', 23:23:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:23:36 INFO - 'use_talos_json': True, 23:23:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:23:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:23:36 INFO - 'work_dir': 'build'} 23:23:36 INFO - [mozharness: 2017-02-03 07:23:36.801166Z] Running clobber step. 23:23:36 INFO - Running pre-action listener: _resource_record_pre_action 23:23:36 INFO - Running main action method: clobber 23:23:36 INFO - rmtree: /builds/slave/test/build 23:23:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:23:39 INFO - Running post-action listener: _resource_record_post_action 23:23:39 INFO - [mozharness: 2017-02-03 07:23:39.068116Z] Finished clobber step (success) 23:23:39 INFO - [mozharness: 2017-02-03 07:23:39.068251Z] Running read-buildbot-config step. 23:23:39 INFO - Running pre-action listener: _resource_record_pre_action 23:23:39 INFO - Running main action method: read_buildbot_config 23:23:39 INFO - Using buildbot properties: 23:23:39 INFO - { 23:23:39 INFO - "project": "", 23:23:39 INFO - "product": "firefox", 23:23:39 INFO - "script_repo_revision": "production", 23:23:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 23:23:39 INFO - "repository": "", 23:23:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 23:23:39 INFO - "buildid": "20170202220408", 23:23:39 INFO - "pgo_build": "False", 23:23:39 INFO - "basedir": "/builds/slave/test", 23:23:39 INFO - "buildnumber": 42, 23:23:39 INFO - "slavename": "t-yosemite-r7-0390", 23:23:39 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 23:23:39 INFO - "platform": "yosemite_r7", 23:23:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:23:39 INFO - "branch": "mozilla-central", 23:23:39 INFO - "repo_path": "mozilla-central", 23:23:39 INFO - "revision": "2aede0a97bc685e163196cc451b947a04ae6a598", 23:23:39 INFO - "stage_platform": "macosx64", 23:23:39 INFO - "builduid": "cf2789a52e6a4a3a9a9bc4ec542121a4", 23:23:39 INFO - "slavebuilddir": "test" 23:23:39 INFO - } 23:23:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 23:23:39 INFO - Running post-action listener: _resource_record_post_action 23:23:39 INFO - [mozharness: 2017-02-03 07:23:39.071586Z] Finished read-buildbot-config step (success) 23:23:39 INFO - [mozharness: 2017-02-03 07:23:39.071710Z] Running download-and-extract step. 23:23:39 INFO - Running pre-action listener: _resource_record_pre_action 23:23:39 INFO - Running main action method: download_and_extract 23:23:39 INFO - mkdir: /builds/slave/test/build/tests 23:23:39 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')]} 23:23:39 INFO - trying https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 23:23:39 INFO - Downloading https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 23:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 23:23:40 INFO - Downloaded 1199 bytes. 23:23:40 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 23:23:40 INFO - Using the following test package requirements: 23:23:40 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 23:23:40 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 23:23:40 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 23:23:40 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'jsshell-mac.zip'], 23:23:40 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 23:23:40 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 23:23:40 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 23:23:40 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 23:23:40 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 23:23:40 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 23:23:40 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 23:23:40 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:23:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 23:23:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:23:40 INFO - Fetch https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 23:23:41 INFO - Expected file size: 34849080 23:23:41 INFO - Obtained file size: 34849080 23:23:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:23:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 23:23:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:23:48 INFO - Fetch https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 23:23:49 INFO - Expected file size: 34849080 23:23:49 INFO - Obtained file size: 34849080 23:23:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 23:23:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:23:56 INFO - Fetch https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 23:23:57 INFO - Expected file size: 14403454 23:23:57 INFO - Obtained file size: 14403454 23:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:23:57 INFO - trying https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 23:23:57 INFO - Downloading https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 23:23:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 23:23:59 INFO - Downloaded 70183927 bytes. 23:23:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 23:23:59 INFO - mkdir: /builds/slave/test/properties 23:23:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:23:59 INFO - Writing to file /builds/slave/test/properties/build_url 23:23:59 INFO - Contents: 23:23:59 INFO - build_url:https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 23:24:00 INFO - Running post-action listener: _resource_record_post_action 23:24:00 INFO - Running post-action listener: set_extra_try_arguments 23:24:00 INFO - [mozharness: 2017-02-03 07:24:00.384569Z] Finished download-and-extract step (success) 23:24:00 INFO - [mozharness: 2017-02-03 07:24:00.384695Z] Running populate-webroot step. 23:24:00 INFO - Running pre-action listener: _resource_record_pre_action 23:24:00 INFO - Running main action method: populate_webroot 23:24:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:24:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:24:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:24:00 INFO - '--tppagecycles', 23:24:00 INFO - '7'], 23:24:00 INFO - 'tests': ['tsvgm']}}, 23:24:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:24:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:24:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:24:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:24:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:24:00 INFO - 'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:24:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:24:00 INFO - 'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['damp', 'tps']}, 23:24:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:24:00 INFO - 'tests': ['damp', 'tps']}, 23:24:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['dromaeo_dom']}, 23:24:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:24:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['basic_compositor_video']}, 23:24:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:24:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['a11yr', 23:24:00 INFO - 'ts_paint', 23:24:00 INFO - 'tpaint', 23:24:00 INFO - 'sessionrestore', 23:24:00 INFO - 'sessionrestore_no_auto_restore', 23:24:00 INFO - 'tabpaint']}, 23:24:00 INFO - 'other-e10s': {'tests': ['a11yr', 23:24:00 INFO - 'ts_paint', 23:24:00 INFO - 'tpaint', 23:24:00 INFO - 'sessionrestore', 23:24:00 INFO - 'sessionrestore_no_auto_restore', 23:24:00 INFO - 'tabpaint']}, 23:24:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:24:00 INFO - 'ts_paint', 23:24:00 INFO - 'tpaint', 23:24:00 INFO - 'sessionrestore', 23:24:00 INFO - 'sessionrestore_no_auto_restore', 23:24:00 INFO - 'tabpaint']}, 23:24:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:24:00 INFO - 'ts_paint', 23:24:00 INFO - 'tpaint', 23:24:00 INFO - 'sessionrestore', 23:24:00 INFO - 'sessionrestore_no_auto_restore', 23:24:00 INFO - 'tabpaint']}, 23:24:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['a11yr', 23:24:00 INFO - 'ts_paint', 23:24:00 INFO - 'tpaint', 23:24:00 INFO - 'sessionrestore', 23:24:00 INFO - 'sessionrestore_no_auto_restore', 23:24:00 INFO - 'tabpaint']}, 23:24:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['a11yr', 23:24:00 INFO - 'ts_paint', 23:24:00 INFO - 'tpaint', 23:24:00 INFO - 'sessionrestore', 23:24:00 INFO - 'sessionrestore_no_auto_restore', 23:24:00 INFO - 'tabpaint']}, 23:24:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['tsvgx', 23:24:00 INFO - 'tsvgr_opacity', 23:24:00 INFO - 'tart', 23:24:00 INFO - 'tscrollx', 23:24:00 INFO - 'cart', 23:24:00 INFO - 'tsvg_static']}, 23:24:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:24:00 INFO - 'tsvgr_opacity', 23:24:00 INFO - 'tart', 23:24:00 INFO - 'tscrollx', 23:24:00 INFO - 'cart', 23:24:00 INFO - 'tsvg_static']}, 23:24:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:24:00 INFO - 'talos_options': ['--disable-e10s'], 23:24:00 INFO - 'tests': ['tp5o']}, 23:24:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:24:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:24:00 INFO - 'talos_options': ['--disable-e10s', 23:24:00 INFO - '--xperf_path', 23:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:00 INFO - 'tests': ['tp5n']}, 23:24:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:24:00 INFO - 'talos_options': ['--xperf_path', 23:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:24:00 INFO - 'tests': ['tp5n']}}, 23:24:00 INFO - 'talos.zip': {'path': '', 23:24:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:24:00 INFO - Running post-action listener: _resource_record_post_action 23:24:00 INFO - [mozharness: 2017-02-03 07:24:00.403283Z] Finished populate-webroot step (success) 23:24:00 INFO - [mozharness: 2017-02-03 07:24:00.403400Z] Running create-virtualenv step. 23:24:00 INFO - Running pre-action listener: _resource_record_pre_action 23:24:00 INFO - Running main action method: create_virtualenv 23:24:00 INFO - Creating virtualenv /builds/slave/test/build/venv 23:24:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:24:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:24:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:24:00 INFO - Using real prefix '/tools/python27' 23:24:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:24:01 INFO - Installing distribute.............................................................................................................................................................................................done. 23:24:04 INFO - Installing pip.................done. 23:24:04 INFO - Return code: 0 23:24:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:24:04 INFO - Reading from file tmpfile_stdout 23:24:04 INFO - Output received: 23:24:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 23:24:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:04 INFO - 'HOME': '/Users/cltbld', 23:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:04 INFO - 'LOGNAME': 'cltbld', 23:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:04 INFO - 'MOZ_NO_REMOTE': '1', 23:24:04 INFO - 'NO_EM_RESTART': '1', 23:24:04 INFO - 'PAGER': '/bin/cat', 23:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:04 INFO - 'PWD': '/builds/slave/test', 23:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:04 INFO - 'SHELL': '/bin/bash', 23:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:04 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:04 INFO - 'USER': 'cltbld', 23:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:04 INFO - 'XPC_FLAGS': '0x0', 23:24:04 INFO - 'XPC_SERVICE_NAME': '0', 23:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:24:04 INFO - Cleaning up... 23:24:04 INFO - Return code: 0 23:24:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:04 INFO - 'HOME': '/Users/cltbld', 23:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:04 INFO - 'LOGNAME': 'cltbld', 23:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:04 INFO - 'MOZ_NO_REMOTE': '1', 23:24:04 INFO - 'NO_EM_RESTART': '1', 23:24:04 INFO - 'PAGER': '/bin/cat', 23:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:04 INFO - 'PWD': '/builds/slave/test', 23:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:04 INFO - 'SHELL': '/bin/bash', 23:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:04 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:04 INFO - 'USER': 'cltbld', 23:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:04 INFO - 'XPC_FLAGS': '0x0', 23:24:04 INFO - 'XPC_SERVICE_NAME': '0', 23:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:04 INFO - Downloading/unpacking psutil>=3.1.1 23:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:24:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:08 INFO - Installing collected packages: psutil 23:24:08 INFO - Running setup.py install for psutil 23:24:08 INFO - building 'psutil._psutil_osx' extension 23:24:08 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 23:24:08 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 23:24:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 23:24:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 23:24:09 INFO - building 'psutil._psutil_posix' extension 23:24:09 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 23:24:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:24:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:24:09 INFO - ^ 23:24:09 INFO - 1 warning generated. 23:24:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 23:24:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:24:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:24:09 INFO - Successfully installed psutil 23:24:09 INFO - Cleaning up... 23:24:09 INFO - Return code: 0 23:24:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:24: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')]} 23:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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')]} 23:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:24: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 mozsystemmonitor==0.3 23:24:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:09 INFO - 'HOME': '/Users/cltbld', 23:24:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:09 INFO - 'LOGNAME': 'cltbld', 23:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:09 INFO - 'MOZ_NO_REMOTE': '1', 23:24:09 INFO - 'NO_EM_RESTART': '1', 23:24:09 INFO - 'PAGER': '/bin/cat', 23:24:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:09 INFO - 'PWD': '/builds/slave/test', 23:24:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:09 INFO - 'SHELL': '/bin/bash', 23:24:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:09 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:09 INFO - 'USER': 'cltbld', 23:24:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:09 INFO - 'XPC_FLAGS': '0x0', 23:24:09 INFO - 'XPC_SERVICE_NAME': '0', 23:24:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:24:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:24:12 INFO - Installing collected packages: mozsystemmonitor 23:24:12 INFO - Running setup.py install for mozsystemmonitor 23:24:12 INFO - Successfully installed mozsystemmonitor 23:24:12 INFO - Cleaning up... 23:24:12 INFO - Return code: 0 23:24:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:24:12 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')]} 23:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:12 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')]} 23:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:12 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 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:12 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 23:24:12 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 23:24:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:12 INFO - 'HOME': '/Users/cltbld', 23:24:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:12 INFO - 'LOGNAME': 'cltbld', 23:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:12 INFO - 'MOZ_NO_REMOTE': '1', 23:24:12 INFO - 'NO_EM_RESTART': '1', 23:24:12 INFO - 'PAGER': '/bin/cat', 23:24:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:12 INFO - 'PWD': '/builds/slave/test', 23:24:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:12 INFO - 'SHELL': '/bin/bash', 23:24:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:12 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:12 INFO - 'USER': 'cltbld', 23:24:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:12 INFO - 'XPC_FLAGS': '0x0', 23:24:12 INFO - 'XPC_SERVICE_NAME': '0', 23:24:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:13 INFO - Downloading/unpacking jsonschema==2.5.1 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:24:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:24:15 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 23:24:15 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 23:24:15 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 23:24:15 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 23:24:15 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 23:24:15 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 23:24:16 INFO - Downloading functools32-3.2.3-2.tar.gz 23:24:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:24:16 INFO - warning: no files found matching '*.txt' 23:24:16 INFO - no previously-included directories found matching 'build' 23:24:16 INFO - no previously-included directories found matching 'dist' 23:24:16 INFO - no previously-included directories found matching '.git*' 23:24:16 INFO - Installing collected packages: jsonschema, functools32 23:24:16 INFO - Running setup.py install for functools32 23:24:16 INFO - warning: no files found matching '*.txt' 23:24:16 INFO - no previously-included directories found matching 'build' 23:24:16 INFO - no previously-included directories found matching 'dist' 23:24:16 INFO - no previously-included directories found matching '.git*' 23:24:16 INFO - Successfully installed jsonschema functools32 23:24:16 INFO - Cleaning up... 23:24:16 INFO - Return code: 0 23:24:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:24:16 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')]} 23:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:16 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')]} 23:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:16 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 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:16 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 23:24:16 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 23:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:16 INFO - 'HOME': '/Users/cltbld', 23:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:16 INFO - 'LOGNAME': 'cltbld', 23:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:16 INFO - 'MOZ_NO_REMOTE': '1', 23:24:16 INFO - 'NO_EM_RESTART': '1', 23:24:16 INFO - 'PAGER': '/bin/cat', 23:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:16 INFO - 'PWD': '/builds/slave/test', 23:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:16 INFO - 'SHELL': '/bin/bash', 23:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:16 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:16 INFO - 'USER': 'cltbld', 23:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:16 INFO - 'XPC_FLAGS': '0x0', 23:24:16 INFO - 'XPC_SERVICE_NAME': '0', 23:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:24:16 INFO - Cleaning up... 23:24:16 INFO - Return code: 0 23:24:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:24:16 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')]} 23:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:16 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')]} 23:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:16 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 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:16 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 23:24:16 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 23:24:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:16 INFO - 'HOME': '/Users/cltbld', 23:24:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:16 INFO - 'LOGNAME': 'cltbld', 23:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:16 INFO - 'MOZ_NO_REMOTE': '1', 23:24:16 INFO - 'NO_EM_RESTART': '1', 23:24:16 INFO - 'PAGER': '/bin/cat', 23:24:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:16 INFO - 'PWD': '/builds/slave/test', 23:24:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:16 INFO - 'SHELL': '/bin/bash', 23:24:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:16 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:16 INFO - 'USER': 'cltbld', 23:24:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:16 INFO - 'XPC_FLAGS': '0x0', 23:24:16 INFO - 'XPC_SERVICE_NAME': '0', 23:24:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:16 INFO - Downloading/unpacking blobuploader==1.2.4 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24: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 23:24:19 INFO - Downloading blobuploader-1.2.4.tar.gz 23:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:24:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:24:19 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 23:24:19 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 23:24:19 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 23:24:19 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 23:24:19 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 23:24:19 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 23:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:24:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:20 INFO - Downloading docopt-0.6.1.tar.gz 23:24:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:24:20 INFO - Installing collected packages: blobuploader, requests, docopt 23:24:20 INFO - Running setup.py install for blobuploader 23:24:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:24:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:24:21 INFO - Running setup.py install for requests 23:24:21 INFO - Running setup.py install for docopt 23:24:21 INFO - Successfully installed blobuploader requests docopt 23:24:21 INFO - Cleaning up... 23:24:21 INFO - Return code: 0 23:24:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:21 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')]} 23:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:21 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')]} 23:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:21 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 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:21 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 23:24:21 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 23:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:21 INFO - 'HOME': '/Users/cltbld', 23:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:21 INFO - 'LOGNAME': 'cltbld', 23:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:21 INFO - 'MOZ_NO_REMOTE': '1', 23:24:21 INFO - 'NO_EM_RESTART': '1', 23:24:21 INFO - 'PAGER': '/bin/cat', 23:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:21 INFO - 'PWD': '/builds/slave/test', 23:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:21 INFO - 'SHELL': '/bin/bash', 23:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:21 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:21 INFO - 'USER': 'cltbld', 23:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:21 INFO - 'XPC_FLAGS': '0x0', 23:24:21 INFO - 'XPC_SERVICE_NAME': '0', 23:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-QuSLon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-QbTAlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Emy7h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_NvXiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-LkFmbJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-bue_Pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-ml14JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-USp_zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:22 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-DGJeEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-xL6whi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-mo_VvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-qayQVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-jaY_dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_vAoka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-3FZi0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-_n3lsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:23 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-HI7KWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:24:23 INFO - Running setup.py install for manifestparser 23:24:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:24:24 INFO - Running setup.py install for mozcrash 23:24:24 INFO - Running setup.py install for mozdebug 23:24:24 INFO - Running setup.py install for mozdevice 23:24:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:24:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:24:24 INFO - Running setup.py install for mozfile 23:24:24 INFO - Running setup.py install for mozhttpd 23:24:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:24:24 INFO - Running setup.py install for mozinfo 23:24:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:24:24 INFO - Running setup.py install for mozInstall 23:24:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozleak 23:24:25 INFO - Running setup.py install for mozlog 23:24:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for moznetwork 23:24:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozprocess 23:24:25 INFO - Running setup.py install for mozprofile 23:24:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:24:25 INFO - Running setup.py install for mozrunner 23:24:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Running setup.py install for mozscreenshot 23:24:26 INFO - Running setup.py install for moztest 23:24:26 INFO - Running setup.py install for mozversion 23:24:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:24:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:24:26 INFO - Cleaning up... 23:24:26 INFO - Return code: 0 23:24:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:27 INFO - 'HOME': '/Users/cltbld', 23:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:27 INFO - 'LOGNAME': 'cltbld', 23:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:27 INFO - 'MOZ_NO_REMOTE': '1', 23:24:27 INFO - 'NO_EM_RESTART': '1', 23:24:27 INFO - 'PAGER': '/bin/cat', 23:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:27 INFO - 'PWD': '/builds/slave/test', 23:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:27 INFO - 'SHELL': '/bin/bash', 23:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:27 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:27 INFO - 'USER': 'cltbld', 23:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:27 INFO - 'XPC_FLAGS': '0x0', 23:24:27 INFO - 'XPC_SERVICE_NAME': '0', 23:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:24:27 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-H14y4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:24:28 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)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-hJLR4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:24:28 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)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-Hd7zvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-hAlGW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-mnmsn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-oZea7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-wqEjCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-ghxuM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-iG9Kp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:24:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:24:28 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-O1utUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:24:29 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)) 23:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:24:29 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-l0V7zU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:24:29 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)) 23:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:24:29 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-gH8SrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:24:29 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-hRUQFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:24:29 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-1292Us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:29 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-40hP2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:24:29 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-ZxlMeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:24:29 INFO - Running setup.py (path:/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/pip-HQx9bD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:24:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:24:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:24:32 INFO - Downloading blessings-1.6.tar.gz 23:24:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:24:32 INFO - Installing collected packages: blessings 23:24:32 INFO - Running setup.py install for blessings 23:24:33 INFO - Successfully installed blessings 23:24:33 INFO - Cleaning up... 23:24:33 INFO - Return code: 0 23:24:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:24:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:33 INFO - Reading from file tmpfile_stdout 23:24:33 INFO - Current package versions: 23:24:33 INFO - blessings == 1.6 23:24:33 INFO - blobuploader == 1.2.4 23:24:33 INFO - docopt == 0.6.1 23:24:33 INFO - functools32 == 3.2.3-2 23:24:33 INFO - jsonschema == 2.5.1 23:24:33 INFO - manifestparser == 1.1 23:24:33 INFO - mozInstall == 1.12 23:24:33 INFO - mozcrash == 1.0 23:24:33 INFO - mozdebug == 0.1 23:24:33 INFO - mozdevice == 0.49 23:24:33 INFO - mozfile == 1.2 23:24:33 INFO - mozhttpd == 0.7 23:24:33 INFO - mozinfo == 0.9 23:24:33 INFO - mozleak == 0.1 23:24:33 INFO - mozlog == 3.4 23:24:33 INFO - moznetwork == 0.27 23:24:33 INFO - mozprocess == 0.24 23:24:33 INFO - mozprofile == 0.28 23:24:33 INFO - mozrunner == 6.13 23:24:33 INFO - mozscreenshot == 0.1 23:24:33 INFO - mozsystemmonitor == 0.3 23:24:33 INFO - moztest == 0.8 23:24:33 INFO - mozversion == 1.4 23:24:33 INFO - psutil == 3.1.1 23:24:33 INFO - requests == 1.2.3 23:24:33 INFO - wsgiref == 0.1.2 23:24:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:33 INFO - 'HOME': '/Users/cltbld', 23:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:33 INFO - 'LOGNAME': 'cltbld', 23:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:33 INFO - 'MOZ_NO_REMOTE': '1', 23:24:33 INFO - 'NO_EM_RESTART': '1', 23:24:33 INFO - 'PAGER': '/bin/cat', 23:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:33 INFO - 'PWD': '/builds/slave/test', 23:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:33 INFO - 'SHELL': '/bin/bash', 23:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:33 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:33 INFO - 'USER': 'cltbld', 23:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:33 INFO - 'XPC_FLAGS': '0x0', 23:24:33 INFO - 'XPC_SERVICE_NAME': '0', 23:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:24:33 INFO - Cleaning up... 23:24:33 INFO - Return code: 0 23:24:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:24:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:24:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105520b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105523768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2715a3440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, '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.9kli2WbffQ/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.JuEXsS1C13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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 23:24:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:24:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:24:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:33 INFO - 'HOME': '/Users/cltbld', 23:24:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:33 INFO - 'LOGNAME': 'cltbld', 23:24:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:33 INFO - 'MOZ_NO_REMOTE': '1', 23:24:33 INFO - 'NO_EM_RESTART': '1', 23:24:33 INFO - 'PAGER': '/bin/cat', 23:24:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:33 INFO - 'PWD': '/builds/slave/test', 23:24:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:33 INFO - 'SHELL': '/bin/bash', 23:24:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:33 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:33 INFO - 'USER': 'cltbld', 23:24:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:33 INFO - 'XPC_FLAGS': '0x0', 23:24:33 INFO - 'XPC_SERVICE_NAME': '0', 23:24:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:24:33 INFO - Cleaning up... 23:24:34 INFO - Return code: 0 23:24:34 INFO - Running post-action listener: _resource_record_post_action 23:24:34 INFO - Running post-action listener: _start_resource_monitoring 23:24:34 INFO - Starting resource monitoring. 23:24:34 INFO - [mozharness: 2017-02-03 07:24:34.047614Z] Finished create-virtualenv step (success) 23:24:34 INFO - [mozharness: 2017-02-03 07:24:34.048507Z] Running install step. 23:24:34 INFO - Running pre-action listener: _resource_record_pre_action 23:24:34 INFO - Running main action method: install 23:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:24:34 INFO - Reading from file tmpfile_stdout 23:24:34 INFO - Detecting whether we're running mozinstall >=1.0... 23:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:24:34 INFO - Reading from file tmpfile_stdout 23:24:34 INFO - Output received: 23:24:34 INFO - Usage: mozinstall [options] installer 23:24:34 INFO - Options: 23:24:34 INFO - -h, --help show this help message and exit 23:24:34 INFO - -d DEST, --destination=DEST 23:24:34 INFO - Directory to install application into. [default: 23:24:34 INFO - "/builds/slave/test"] 23:24:34 INFO - --app=APP Application being installed. [default: firefox] 23:24:34 INFO - mkdir: /builds/slave/test/build/application 23:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:24:56 INFO - Reading from file tmpfile_stdout 23:24:56 INFO - Output received: 23:24:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:24:56 INFO - Running post-action listener: _resource_record_post_action 23:24:56 INFO - [mozharness: 2017-02-03 07:24:56.431145Z] Finished install step (success) 23:24:56 INFO - [mozharness: 2017-02-03 07:24:56.431323Z] Running run-tests step. 23:24:56 INFO - Running pre-action listener: _resource_record_pre_action 23:24:56 INFO - Running main action method: run_tests 23:24:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:24:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:24:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:24:56 INFO - 2017-02-02 23:24:56.445 screenresolution[1642:7559] starting screenresolution argv=screenresolution get 23:24:56 INFO - 2017-02-02 23:24:56.448 screenresolution[1642:7559] Display 0: 1600x1200x32@60 23:24:56 INFO - 2017-02-02 23:24:56.454 screenresolution[1643:7562] starting screenresolution argv=screenresolution list 23:24:56 INFO - Available Modes on Display 0 23:24:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:24:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:24:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:24:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:24:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:24:56 INFO - Intel Iris: 23:24:56 INFO - Chipset Model: Intel Iris 23:24:56 INFO - Type: GPU 23:24:56 INFO - Bus: Built-In 23:24:56 INFO - VRAM (Dynamic, Max): 1536 MB 23:24:56 INFO - Vendor: Intel (0x8086) 23:24:56 INFO - Device ID: 0x0a2e 23:24:56 INFO - Revision ID: 0x0009 23:24:56 INFO - Displays: 23:24:56 INFO - Display: 23:24:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:24:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:24:56 INFO - Display Serial Number: 1600x1200 60 23:24:56 INFO - Main Display: Yes 23:24:56 INFO - Mirror: Off 23:24:56 INFO - Online: Yes 23:24:56 INFO - Rotation: Supported 23:24:56 INFO - Return code: 0 23:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:24:56 INFO - Python 2.7.3 23:24:56 INFO - Return code: 0 23:24:56 INFO - grabbing minidump binary from tooltool 23:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:24:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1052fed30>, '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 0x105225db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1052f3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:24:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:24:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 23:24:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:24:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:24:56 INFO - Return code: 0 23:24:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:24:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:24:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:24:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:24:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 23:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0390 --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 23:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9kli2WbffQ/Render', 23:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:24:56 INFO - 'HOME': '/Users/cltbld', 23:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:24:56 INFO - 'LOGNAME': 'cltbld', 23:24:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:24:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:24:56 INFO - 'MOZ_NO_REMOTE': '1', 23:24:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:24:56 INFO - 'NO_EM_RESTART': '1', 23:24:56 INFO - 'PAGER': '/bin/cat', 23:24:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:24:56 INFO - 'PWD': '/builds/slave/test', 23:24:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:24:56 INFO - 'SHELL': '/bin/bash', 23:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JuEXsS1C13/Listeners', 23:24:56 INFO - 'TMPDIR': '/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/', 23:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:24:56 INFO - 'USER': 'cltbld', 23:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:24:56 INFO - 'XPC_FLAGS': '0x0', 23:24:56 INFO - 'XPC_SERVICE_NAME': '0', 23:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:24:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0390', '--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 23:24:57 INFO - mozversion application_buildid: 20170202220408 23:24:57 INFO - mozversion application_changeset: 2aede0a97bc685e163196cc451b947a04ae6a598 23:24:57 INFO - mozversion application_display_name: Nightly 23:24:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:24:57 INFO - mozversion application_name: Firefox 23:24:57 INFO - mozversion application_remotingname: firefox 23:24:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:24:57 INFO - mozversion application_vendor: Mozilla 23:24:57 INFO - mozversion application_version: 54.0a1 23:24:57 INFO - mozversion platform_buildid: 20170202220408 23:24:57 INFO - mozversion platform_changeset: 2aede0a97bc685e163196cc451b947a04ae6a598 23:24:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:24:57 INFO - mozversion platform_version: 54.0a1 23:24:57 INFO - using testdate: 1486106697 23:24:57 INFO - actual date: 1486106697 23:24:57 INFO - starting webserver on 'localhost:49246' 23:24:57 INFO - SUITE-START | Running 2 tests 23:24:57 INFO - TEST-START | dromaeo_css 23:24:57 INFO - operating with platform_type : mac_ 23:24:57 INFO - Initialising browser for dromaeo_css test... 23:24:57 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp8i3jHy/profile http://localhost:49246/getInfo.html) 23:24:59 INFO - PROCESS | 1653 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 23:24:59 INFO - PROCESS | 1653 | 2017-02-02 23:24:59.776 plugin-container[1655:7738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903b, name = 'com.apple.tsm.portname' 23:24:59 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:24:59 INFO - PROCESS | 1653 | 2017-02-02 23:24:59.779 plugin-container[1655:7738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e4b, name = 'com.apple.CFPasteboardClient' 23:24:59 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:24:59 INFO - PROCESS | 1653 | 2017-02-02 23:24:59.779 plugin-container[1655:7738] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:24:59 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 23:24:59 INFO - PROCESS | 1653 | colorDepth:24 23:24:59 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 23:24:59 INFO - PROCESS | 1653 | __metrics 23:24:59 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 23:24:59 INFO - PROCESS | 1653 | 1486106699931 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp8i3jHy/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp8i3jHy/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp8i3jHy/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp8i3jHy/profile/extensions/talos-powers@TalosPowersService.js:55:9 23:25:00 INFO - TEST-INFO | 1653: exit 0 23:25:00 INFO - Browser initialized. 23:25:00 INFO - Running cycle 1/1 for dromaeo_css test... 23:25:00 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmp8i3jHy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:03 INFO - PROCESS | 1656 | 2017-02-02 23:25:03.077 plugin-container[1657:7855] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 23:25:03 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:25:03 INFO - PROCESS | 1656 | 2017-02-02 23:25:03.078 plugin-container[1657:7855] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 23:25:03 INFO - PROCESS | 1656 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:25:03 INFO - PROCESS | 1656 | 2017-02-02 23:25:03.078 plugin-container[1657:7855] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:25:12 INFO - PROCESS | 1656 | RSS: Main: 233553920 23:25:12 INFO - PROCESS | 1656 | 23:28:15 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 23:28:17 INFO - PROCESS | 1656 | RSS: Main: 256176128 23:28:17 INFO - PROCESS | 1656 | 23:30:00 INFO - PROCESS | 1656 | ************************* 23:30:00 INFO - PROCESS | 1656 | A coding exception was thrown and uncaught in a Task. 23:30:00 INFO - PROCESS | 1656 | 23:30:00 ERROR - PROCESS | 1656 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:30:00 INFO - PROCESS | 1656 | Full stack: 23:30:00 INFO - PROCESS | 1656 | ************************* 23:31:19 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 23:31:20 INFO - PROCESS | 1656 | RSS: Main: 263073792 23:31:20 INFO - PROCESS | 1656 | 23:34:22 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 23:34:23 INFO - PROCESS | 1656 | RSS: Main: 274460672 23:34:23 INFO - PROCESS | 1656 | 23:37:25 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 23:37:25 INFO - PROCESS | 1656 | RSS: Main: 268460032 23:37:25 INFO - PROCESS | 1656 | 23:40:28 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 23:40:29 INFO - PROCESS | 1656 | RSS: Main: 273584128 23:40:29 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 23:43:31 INFO - PROCESS | 1656 | RSS: Main: 275292160 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | __start_tp_report 23:43:31 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 23:43:31 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 23:43:31 INFO - PROCESS | 1656 | |i|pagename|runs| 23:43:31 INFO - PROCESS | 1656 | |0;dojo.html;2903.593496910433;3357.5299458075874;3360.0423879194436;3388.2207092368753;3407.148212946763;5561.555075593953;5644.604877658566;5651.491365777079;5710.714464276785;5736.483716465517;5592.5246354059955;5599.496045355917;5687.459691329317;5691.231683722696;5754.827355179351;4865.635077369194;5102.387713474388;5148.639595228336;5199.324087868572;5254.81608143715;5195.766190521416;5294.258803767476;5303.893922121555;5314.4951229633125;5346.893062138755;5115.718635475047;5141.948580514184;5233.345831771028;5247.842564723064;5273.920891186635;5055.494450554952;5112.616553758483;5174.197999310113;5223;5247.2129180623215;4305.418768466279;5157.045946499872;5190.06578815813;5196.350456192976;5212.6611770235195;5520.834374968757;5644.266245388073;5694.288213973254;5710.486056254957;5728.742206600671;4979.402471703383;6118.755249790003;6160.630362178284;6223.564350495467;6275.780347687809;6292;6292.5595208335435;6311.274203466568;6314.336994615591;6319.526035547352;4798.520147985243;5626.156076588462;5782.710864456761;5836.124581312794;5867.471927526543;6163.137160797492;6180.6291622502795;6205.6586887720705;6219.502439804895;6269.435750782452;6088.628912517097;6117.174181485442;6148.508119350441;6162.7226774795245;6189.566730328924;5203.9219411708855;6190.41191086846;6216.533759968021;6220.564560480723;6226.283977342573;6104.095385180791;6106.419890110433;6124.228368151265;6164.630122192682;6189.81430557084;6178.567500274938;6181.443670069715;6189.412005859436;6200.503959683215;6213.96893015532;4983.626228032912;4986.177280748636;4986.32684587576;4986.601071914238;5013.523715247045;4359.193549193346;4379.824807007748;4384.101259241847;4436.511983681792;4477.261251893401;5826.970865145732;5883.205767221456;5889.911651325234;5920.940790592125;5935.109733540004;6198.2252218472695;6198.752049917953;6230;6274.058891166362;6278.780242691575;4366.995591014021;5706.9429305707245;5750.654960702372;5817.88364232713;5934.1692163097205;4617.515160908123;5404.648697834628;5459.972700136474;5514.696691681916;5518.944810551923;5326.227696983993;5496.780128794963;6236.781712640036;6330.4619107375465;6373.681315934185;6139.723712432862;6154.630722156685;6247.31279559239;6272.780452684134;6289.182406287154;6201.81394558164;6212.81361559154;6234.470070043915;6286.9371306288185;6307.495400368051;6168.938310616836;6191.040388739752;6214.005759078525;6218.502519798496;6241.78153764616;6139.754409823557;6307.463865571478;6316.431521162934;6336.778212762715;6341.175647165839;5018.824341148043;5970.671613061323;6133.141360209485;6133.487685122301;6134.681512609229;6114.938850611437;6135.845176233341;6140.078988151813;6141.087130295657;6156.384361563808;5372.979133964534;5771.826845194651;5819.534437244925;5928.3775203603;5962.55280853929;6124.777645458507;6139.570230083851;6142.754289828356;6159.076138579249;6168.691565421801;5908.940910590839;5949.791757288647;5961.493273071837;5974.2830860297045;5982.427556150723 23:43:31 INFO - PROCESS | 1656 | |1;ext.html;448.16417381583335;452.3305507848384;481.021122016696;493.9753012349382;544.2570890734149;38315.80842095789;40622.79688601557;40662.18675626489;40844.59155408445;40919.795401023024;42079.948001299985;43113;43148.137037259316;43160;43185.70442886718;9154.992950775426;9447.90552094477;11037.3377597344;11385.316880987126;11424.771504569904;11092.1126309895;11205.271657342246;11231.382273974928;11252.15608829337;11252.38111903845;11209.271397359145;11231.32612043276;11271.549138034468;11283.605073822418;11295.887041129567;11180.105591552656;11233.887661123448;11246.268992515501;11281.210315277935;11284.097272218203;9667;11142.554297828077;11168.832467512993;11194.832077518844;11204.943975280154;37726.62273377259;37794.43308350377;37849.62150378488;37942;38059.429108563396;3893.279743247508;3923.470331505239;3948.170884114311;3951.9802400988096;3959.8812035638975;28811.56782648262;29002.564961525593;29326.70673293261;29835.552466713016;30148.24629384261;3126.1559378967777;3198.0885447647543;3287.4904389819617;3289.2434740009694;3291.243014106769;473412;478560.60719696176;478794;482678;482888.9999999965;49410.505894940594;49666.255006174935;56430.7178464105;56893;58171;56982.7150864243;61216.387836121066;61255.46861328413;61344.38655613387;61357.69321153365;15200.391984320724;15290.847091528942;15486.922565387102;15508.689826203412;15513.45702900393;11791.35147566892;11846.585369512199;11870.287782733063;11925.582604608797;11941.343226122473;14994.625134371729;18144.818551814315;18212.544686382946;18302;18315.54211144732;8002.759917202493;8081.151479094728;8107.959460202661;8108.432409731262;8173.18268173178;848.4739461533889;855.781775647206;866.540733411293;870.8563087090686;892.3664198419195;23907.880460597935;29645;29958;30557.388852223277;30646.84676576603;1006.411249419098;1027.712240572626;1034.177828626244;1035.5184839049878;1045;15653.373865045498;15663.765043524356;15670.686586268212;15691.293891774898;16012.839871601367;555972;556716;559019;559383;560346;62077.37922620716;62557;62599;62684.686576566826;62786.744265114445;1411.4213172599184;1433.426629348269;1448.3192899337294;1452.7457694903349;1456.1627064437992;27839.721602783713;28330;28717.856410717814;29821.85089074541;29862.25344366408;50995.745021274655;52562.47437525729;52676.36192752106;52686.20970685366;52854.73572632112;530271;535599;540042;540324;540433;23776.40558986039;24317.027318907047;26492.602610960465;27070.323241919108;27276.454470910074;45932.54067459283;46633.3005004932;46867.76566117148;46925.06149877052;47397.28904066373;34248.82875585606;37883.431748523246;37991.240175196894;38603.80698096492;38672.41991370188;37395.2520949574;37607.2478550422;37672.62327376691;38230;38706.225875482894;36202.4569631461;36913.89258322254;37083.07292317713;37213;37246.62753372431;29754.553681695226;31780.04659860208;34060.82969585136;34257.14357141092;34326.656733433345;22623.09507619677;24160;24283;24401.64036286815;24976.875115624305 23:43:31 INFO - PROCESS | 1656 | |2;jquery.html;364.25509832392754;382.10206015862724;387.9756999523623;398.34472293077886;424.5330136849466;15664.765028524582;17645.911770441147;20102;20376.592468150666;21348.35954921353;20160;20546.48633784156;20604.587908241825;20660.48348791281;20754.169833206655;5736.196932429453;5942.940570594304;6024.156618073452;6054.909176362358;6071.544634152434;5729.197912292282;5883.970580147115;5969;5970.582059255854;5994.820155395345;6063.818085457443;6067.575269731121;6075.878482430371;6076.665783381913;6079.4528492435675;5987.520998320146;6060.1212824140475;6599.307072757363;6665.766698165541;6716.294789047129;5700;5889.587728858982;5958.40415958405;5959.880802383928;5973.342932277446;12579.308138052404;13830.446782128703;13839.031267811257;13863.722725545533;13892.722145557133;2544.52926208652;2601.596752503365;2614.6078088286718;2628.829126106797;2648;10052.44711540865;10282.89717102827;10591.099756520705;13897.444102235899;13985.930070349685;1592.5779668387886;1823.6626224148442;1858.4238885945401;1862.590230149365;1877.6432477829305;113707;124990.75009249883;126629;134337;135091.32454337765;9340.20608248293;10577.735556610993;11106.333619982826;12131;12199.719029501952;12826.80759788604;12882;13309.068365214536;15552.844471555365;15584.142872141914;7249.456290778213;8167.877481837777;8424.410291279673;8543.316534677211;8612.052674205832;7108.827043537862;8227.506349619041;8319.001719793663;8339.166083391734;8480.703175388831;4719.10337035962;4830.951690483121;4832.516748325139;4860.104559221906;4877.926831097537;1724.8533874620546;2043.4176259765895;2064.0505367531105;2070.451330397446;2071.2647010311425;899.8526878230178;963.1861077389594;1001.7645853224486;1007.1317705655903;1042.9843552346722;21379.685604604696;21529.892350538146;21697.891510542348;21756.891215544136;21850;879.9824003519893;1023.672424824064;1025.1388833379847;1052.4685034057752;1077.2836064017497;9472;9499.38254013487;12112.805829523093;12513.186642868184;12597.811032834516;706465;731949.6805031988;750153;767819;776830;156673;158406;160402;162408.18795905946;163605;974.3325821812082;1049.3808652894982;1096.5394534295615;1121.2039451989017;1122.2649164797072;18805.341813036477;19603.70594441113;19636.90181549083;19643.901780491007;19648.80351196527;44665.77667111644;48784.75607621939;59781.40218597758;59981.10028349666;60084.69957650359;84702.57648711717;86616.70074949008;87423.56288218773;88487;88492.1150788484;5813.302403711582;6568.638724870178;7945.006874140732;8254.54599997006;8535.786605334917;10667.466626668791;12899.968507400567;13350.933245333712;13434.328283585586;13488.595342139752;10548.46836759157;10617.734556636145;11150.442477876237;11240.213185076966;11358.886411135783;10652.627158049741;11089.889101108885;11173.162012849232;11347.943260283975;11437.02785263262;10976.286541374786;11233.71915702114;11496.207037114393;11764.411779411166;11858.288502689866;5520.613557050968;7271.745488907863;8280.296174824967;8458.40791144614;8538.44500107491;9100.362974591715;9457.527123643928;11383.43082845871;11422.600208992646;11678.532858685558 23:43:31 INFO - PROCESS | 1656 | |3;mootools.html;1353.7292541491702;1409.4573589168167;1418.8723014928655;1425.2232533269373;1440.5246268731319;7916.802079947997;8130.983627046619;8383.538905360203;8385.58072096395;8408.369372297087;8307.626156822942;8437.578121093951;8443.366747493947;8444.57777111145;8466.068732439428;2288.9771102288973;2319.0955527344263;2323.860568365895;2330.7086614173227;2330.93007209784;1959.2065213588448;2306.792388685018;2342.976570234293;2344.402177444758;2346.3430239532872;2282.2468585366873;2284.737255215655;2308.1690591387087;2309.2494939144763;2312.0058374898786;1971.5169783403157;2151.8816465094415;2260.2993072147606;2284.8689898500265;2296.0356650206954;2025.3518873960338;2104.9159682763234;2259.5932732108213;2328.301509547146;2333.230034088747;8101.230383113595;8307.8338433231;8317;8430.199131082538;8468.153184681543;5101.4133374662015;5236.031334203185;5237.738113094369;5266.078436273675;5287.312649355559;3461.6019157796673;3484.5992710838323;3485.163560745428;3548.3258180945795;3551.4672799080085;1207.8369420128347;1214.8117041858527;1255.8179064035755;1256.3290823205116;1267.8415198100238;10582.894171058268;10610.840837387368;10720.892791072067;10732.409717465536;10768.78462430755;4188.329867221291;4434.689571729948;4529.705569137996;4541.704789188692;4546.227141385973;8533.701320453754;8600.311975041981;8608.698695545625;8621.52581608005;8652.221300082896;5117.078925793318;5117.437081920985;5118.10433174193;5131.846044618667;5150.793968241303;4613.123506533748;4659.254519276899;4660.324252983299;4722.150012997625;4791.784369703371;3633.091727068233;3638.8544458221904;3702.8889133326043;3728.4034554471154;3736.6637002669345;1155.8266260061057;1160.9187356884936;1162.604714397109;1169.7368092179192;1173.524722487394;717.1107826295356;719.1226703421817;750.1111183247868;752.7779305105007;768.2509553185711;4965.428975667773;4967.602591792648;5395.21769343443;5395.406505284415;5602.971985140048;555.1783360626215;556.1907424697056;561.147056474157;561.719140429785;571.5598988778701;2575.961360579593;2989.970100298969;3157.447446696819;3227.580414546141;3386.3227354529195;9010.27917766577;9050.547472626342;9542.570584323583;9731.659391921248;9836.311458197857;8793.472391656522;9336.299777516713;9795.118439340493;9811.26415518839;9832.557534910946;7677.500962437423;7765.961170194113;7769.339606133542;7771.378289736807;7783.793512005648;5205.323307969939;5351.892962140813;5368.946310536845;5395.622306438511;5410.83767486976;8917.643294268157;8937.329700272636;9050.592723327598;9123.817523649357;9221.769455763659;9052.321075919464;9256.305777066613;9270.53647317645;9359.298052646214;9375.34372593912;6629.2376376715365;6703.597784132968;6704.4301234395625;6721.227058888095;6726.159230096238;7596.240375962359;7715.498492597963;7722.806929826799;7786.182450842806;7788.299053085249;6121.80624778164;7019.859602807813;7104.751333703295;7139.107611548557;7253.492255542062;6801.625910574966;6898.724051037902;7012.5792452453015;7014.298570143149;7081.663051192991;6197.132401463708;6237.5009999200865;6289.591176573508;6300.464460520907;6320.787724296643;4689.437267527918;4817.156997525489;4875.293082503088;4931.630127740362;5015.5987520997505;4875.098106850244;4878.170710979071;4956.405231372259;5015.974920125376;5033.370828646419 23:43:31 INFO - PROCESS | 1656 | |4;prototype.html;314.2818659363355;333.37159454428394;364.21148214116437;371.8772804974358;372.281496711347;4569.702969306997;5165.612579056572;5270;5421.701806400646;5598.804041858531;4919.385076865392;5286.65636733613;5310.309659744228;5424.647397919132;5515.503604675579;3875.534935807707;4203.159368126379;4285.185814695214;4285.228658841407;4302.827886884521;3299.9010029699148;4106.835726570934;4138.2758017347;4255.63827074699;4323.243432399333;3768.6082525726792;3870.5161854768153;4158.147579746144;4210.894727631803;4225.408442818008;3531.4173161428334;3712.201876596545;4181.310083836163;4239.872803815875;4295.591918767712;3796.316663000659;3796.886093417202;3797.468354430382;3798.720767539482;3809.847606095753;4521.299198624219;4559.8372415033955;5238.266642670029;5264.842054738364;5303.124984377573;4887.902241955177;4937.456879743226;4944.950550494485;4957.008598280322;4957.652964292501;5549.972250138764;5756.388211300842;5779;5783.537317014629;5798.797042103506;2905.5060639691305;3224.9032529024166;3901.7073719471155;3929.8624548140965;3942.4874766280486;5725.7935556088305;5742.598018138732;5952.035828176691;5977.46202841742;6020.969895150496;3927.9607203927594;3936.488256526633;3939.783311917815;3941.4481972523868;3944.861929832442;4002.979985100114;4007.479027726435;4009.558948515661;4009.8195581198916;4012.7792971386853;4215.810288537024;4305.870823875289;4670.416197975253;4712.717236965725;4763.571278584944;5508.14623733322;5796.536277097822;5802.361740208574;5819.88360232793;5858.5898987070495;1122.7193201699574;1144.7824913266452;1291.1536502801084;1304.8629893861007;1305.106002388367;774.0363247756467;825.5624519004937;892.8928528576612;898.955052247385;899.9190072893471;4528.592426681548;4808.58146846681;4850.296706977469;5187.896242075138;5197.506236907488;4764.499727528629;5551.639143455663;5727.656340619576;5735.447725761996;5762.366139724627;4249.386627224235;4876.829310974099;5153.793848246103;5155.819546315861;5210.348706411699;2643.6695413073367;2655.9203223903314;2813.268550176969;2855.6430446194227;2975.9553606695918;5122.795088196505;5904.704764761831;5918.852028699231;5953.910691339634;5954.910676339859;5021.899562008739;5032.622553308516;5177.611679124081;5780.913286300709;5845.766169353178;5791.420857914259;5855.657736905272;5883.294004719461;5942.998785613324;5943.898709890162;4669.735178438386;5305.708186049805;5378.569714422915;5732.684702341411;5740.167675687086;4881.414230292387;5259.7370131494035;5284.392294886137;5550.389457159628;5622.5783066271015;5075.441701412916;5255.894882102413;5899.823005309848;5954.880902382015;5961.493273071664;3180.8389937673046;3374.6287908329573;3501.509788629645;3658.835352409095;3957.179697339141;5144.871378215575;5650.039493286234;5976.372480889444;6006.1470801369;6015.729292181775;5268.947310526999;5316.441773613869;5425.077736784677;5745.597808153389;5932.063628503918;5412.7293635318865;5523.751431185526;5533.446655334596;5769.480746732815;5867.735951882261;4852.490488498657;5459.372172200247;5470.81161099312;5675.631083979528;5715.542756579547;4697.5302469754115;4774.899044420444;5796.275465566804;5810.854728631818;5817.447342502455;4606.355110284496;5651.2935883014625;5678.630888992202;5702.258706368146;5717.313922329347 23:43:31 INFO - PROCESS | 1656 | |5;yui.html;688.390774164864;702.4380495603516;739.9630018499075;772.4322622872188;818.4557269415836;15000.549983500485;15627.92186039071;15720.528384148465;15721.292541835617;15742.449014284517;14257.71484570308;14416.135031898093;14442;14448.711025779477;14491.130532168077;840.684743221292;852.8848605438249;857.9828403431927;859.2610355094614;873.1443185678039;866.384866744609;866.4844417571535;866.7183165471215;867.0808942520916;867.995660021699;782.5695867272977;883.5979629268668;886.9512176830272;911.3483859040784;913.0777914306565;900.7928176519438;906.9773255668595;913.4062859141545;914.4421902639351;915.199200699388;671.2515545167153;673.3132205150768;681.8499930015389;682.0655701688718;685.9588424694534;15146.772798408032;15310.004849684736;15497.380104795795;15578.22108894562;15847.366105355772;14043.719125617532;14276.643083922881;14301.928490357586;14361.784573231409;14398.280085995659;9906.851397229048;11872.821907671392;11876;11926.821097683542;12042.09684273683;3223.3069889973535;3669.26614677063;3679.208970071421;3692.9630703692887;3861.517310336208;109512;112085;113711;114239;115008.42495787551;8753.562321883881;10619.415932123808;10701.678949631523;10861.40262285582;10876;21092.261770838253;21688.34934951954;21889.890550547145;21901.561968760536;21944.231951881608;6261.655608941552;7351.264873512606;7447.478676492594;7568.735094271674;7597.544147351176;4143.875683729493;4165.562615925284;4219.915601688011;4242.8727138185905;4328.7402755834755;2921.9123426297247;3384.6953774160443;3421.0763093964492;3474.1314671332166;3479.530263414407;542.7530473634487;554.0746952589186;615.5844804756861;631.5421319543386;644.1561554363799;637.6620391192675;641.8106658535743;659.475716805141;666.4302021771413;670.2158474584747;8623.31013518917;9440.86709594853;9845.163161131384;9895.356801807859;10127.392356458637;616.2174038970483;661.8378497268104;662.2847324889108;675.1998881325645;686.1114856261154;4638.466576343763;4779.354787103696;4804.807807687724;4807.086653535817;4831.9275210871165;103499;103862;104600.47699761452;105108;106943.93056069495;93905.59141612881;94047.64880878033;94826.52586737022;95000;95575;67597.64804703879;74392.24622610475;76047.61976190083;76631.61684191655;76722.23277767263;8271.255586997198;9258;9269.212116970133;9279.953600232226;9285.210757085724;46591.767041164574;53079.93840123253;53622.46377536331;53925.46074539205;54302.728486357315;68402.97395538971;69970.65014675098;71017.28982710106;71703.92444113447;72098;10659.573617055232;10924.399158046066;10945.781084378108;11092.833607496055;11300;10524.315919465516;11836.993855522376;12004.319395284492;12126.333051682243;12421.441035153259;11512.149327367937;11559.884401155881;11605.593804216813;11676.70808229801;11969.64091077269;11364.43177841088;11462.94268528652;11583.6524904253;11742.58900938463;11892.167548271884;11211.495482703134;11263.26788758728;11483.36841473727;11529.192956492965;11844.526218951145;9227.35408521424;9391.85912211331;9442.622295108118;9479.146876781122;9787.706368808947;6547.901781473186;6769.9661501694145;8988.235999940078;9003.14470125337;9277.536123193948 23:43:31 INFO - PROCESS | 1656 | __end_tp_report 23:43:31 INFO - PROCESS | 1656 | __start_cc_report 23:43:31 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,386 23:43:31 INFO - PROCESS | 1656 | __end_cc_report 23:43:31 INFO - PROCESS | 1656 | __startTimestamp1486107811825__endTimestamp 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | ------- Summary: start ------- 23:43:31 INFO - PROCESS | 1656 | Number of tests: 6 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5688.90 Median:5928.38 stddev:673.69 (11.4%) stddev-sans-first:639.34 23:43:31 INFO - PROCESS | 1656 | Values: 2903.6 3357.5 3360.0 3388.2 3407.1 5561.6 5644.6 5651.5 5710.7 5736.5 5592.5 5599.5 5687.5 5691.2 5754.8 4865.6 5102.4 5148.6 5199.3 5254.8 5195.8 5294.3 5303.9 5314.5 5346.9 5115.7 5141.9 5233.3 5247.8 5273.9 5055.5 5112.6 5174.2 5223.0 5247.2 4305.4 5157.0 5190.1 5196.4 5212.7 5520.8 5644.3 5694.3 5710.5 5728.7 4979.4 6118.8 6160.6 6223.6 6275.8 6292.0 6292.6 6311.3 6314.3 6319.5 4798.5 5626.2 5782.7 5836.1 5867.5 6163.1 6180.6 6205.7 6219.5 6269.4 6088.6 6117.2 6148.5 6162.7 6189.6 5203.9 6190.4 6216.5 6220.6 6226.3 6104.1 6106.4 6124.2 6164.6 6189.8 6178.6 6181.4 6189.4 6200.5 6214.0 4983.6 4986.2 4986.3 4986.6 5013.5 4359.2 4379.8 4384.1 4436.5 4477.3 5827.0 5883.2 5889.9 5920.9 5935.1 6198.2 6198.8 6230.0 6274.1 6278.8 4367.0 5706.9 5750.7 5817.9 5934.2 4617.5 5404.6 5460.0 5514.7 5518.9 5326.2 5496.8 6236.8 6330.5 6373.7 6139.7 6154.6 6247.3 6272.8 6289.2 6201.8 6212.8 6234.5 6286.9 6307.5 6168.9 6191.0 6214.0 6218.5 6241.8 6139.8 6307.5 6316.4 6336.8 6341.2 5018.8 5970.7 6133.1 6133.5 6134.7 6114.9 6135.8 6140.1 6141.1 6156.4 5373.0 5771.8 5819.5 5928.4 5962.6 6124.8 6139.6 6142.8 6159.1 6168.7 5908.9 5949.8 5961.5 5974.3 5982.4 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:66368.49 Median:37148.04 stddev:140094.98 (377.1%) stddev-sans-first:140400.56 23:43:31 INFO - PROCESS | 1656 | Values: 448.2 452.3 481.0 494.0 544.3 38315.8 40622.8 40662.2 40844.6 40919.8 42079.9 43113.0 43148.1 43160.0 43185.7 9155.0 9447.9 11037.3 11385.3 11424.8 11092.1 11205.3 11231.4 11252.2 11252.4 11209.3 11231.3 11271.5 11283.6 11295.9 11180.1 11233.9 11246.3 11281.2 11284.1 9667.0 11142.6 11168.8 11194.8 11204.9 37726.6 37794.4 37849.6 37942.0 38059.4 3893.3 3923.5 3948.2 3952.0 3959.9 28811.6 29002.6 29326.7 29835.6 30148.2 3126.2 3198.1 3287.5 3289.2 3291.2 473412.0 478560.6 478794.0 482678.0 482889.0 49410.5 49666.3 56430.7 56893.0 58171.0 56982.7 61216.4 61255.5 61344.4 61357.7 15200.4 15290.8 15486.9 15508.7 15513.5 11791.4 11846.6 11870.3 11925.6 11941.3 14994.6 18144.8 18212.5 18302.0 18315.5 8002.8 8081.2 8108.0 8108.4 8173.2 848.5 855.8 866.5 870.9 892.4 23907.9 29645.0 29958.0 30557.4 30646.8 1006.4 1027.7 1034.2 1035.5 1045.0 15653.4 15663.8 15670.7 15691.3 16012.8 555972.0 556716.0 559019.0 559383.0 560346.0 62077.4 62557.0 62599.0 62684.7 62786.7 1411.4 1433.4 1448.3 1452.7 1456.2 27839.7 28330.0 28717.9 29821.9 29862.3 50995.7 52562.5 52676.4 52686.2 52854.7 530271.0 535599.0 540042.0 540324.0 540433.0 23776.4 24317.0 26492.6 27070.3 27276.5 45932.5 46633.3 46867.8 46925.1 47397.3 34248.8 37883.4 37991.2 38603.8 38672.4 37395.3 37607.2 37672.6 38230.0 38706.2 36202.5 36913.9 37083.1 37213.0 37246.6 29754.6 31780.0 34060.8 34257.1 34326.7 22623.1 24160.0 24283.0 24401.6 24976.9 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:40314.46 Median:21364.02 stddev:124583.58 (583.1%) stddev-sans-first:124896.95 23:43:31 INFO - PROCESS | 1656 | Values: 364.3 382.1 388.0 398.3 424.5 15664.8 17645.9 20102.0 20376.6 21348.4 20160.0 20546.5 20604.6 20660.5 20754.2 5736.2 5942.9 6024.2 6054.9 6071.5 5729.2 5884.0 5969.0 5970.6 5994.8 6063.8 6067.6 6075.9 6076.7 6079.5 5987.5 6060.1 6599.3 6665.8 6716.3 5700.0 5889.6 5958.4 5959.9 5973.3 12579.3 13830.4 13839.0 13863.7 13892.7 2544.5 2601.6 2614.6 2628.8 2648.0 10052.4 10282.9 10591.1 13897.4 13985.9 1592.6 1823.7 1858.4 1862.6 1877.6 113707.0 124990.8 126629.0 134337.0 135091.3 9340.2 10577.7 11106.3 12131.0 12199.7 12826.8 12882.0 13309.1 15552.8 15584.1 7249.5 8167.9 8424.4 8543.3 8612.1 7108.8 8227.5 8319.0 8339.2 8480.7 4719.1 4831.0 4832.5 4860.1 4877.9 1724.9 2043.4 2064.1 2070.5 2071.3 899.9 963.2 1001.8 1007.1 1043.0 21379.7 21529.9 21697.9 21756.9 21850.0 880.0 1023.7 1025.1 1052.5 1077.3 9472.0 9499.4 12112.8 12513.2 12597.8 706465.0 731949.7 750153.0 767819.0 776830.0 156673.0 158406.0 160402.0 162408.2 163605.0 974.3 1049.4 1096.5 1121.2 1122.3 18805.3 19603.7 19636.9 19643.9 19648.8 44665.8 48784.8 59781.4 59981.1 60084.7 84702.6 86616.7 87423.6 88487.0 88492.1 5813.3 6568.6 7945.0 8254.5 8535.8 10667.5 12900.0 13350.9 13434.3 13488.6 10548.5 10617.7 11150.4 11240.2 11358.9 10652.6 11089.9 11173.2 11347.9 11437.0 10976.3 11233.7 11496.2 11764.4 11858.3 5520.6 7271.7 8280.3 8458.4 8538.4 9100.4 9457.5 11383.4 11422.6 11678.5 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5290.22 Median:5251.91 stddev:2912.08 (55.4%) stddev-sans-first:2905.22 23:43:31 INFO - PROCESS | 1656 | Values: 1353.7 1409.5 1418.9 1425.2 1440.5 7916.8 8131.0 8383.5 8385.6 8408.4 8307.6 8437.6 8443.4 8444.6 8466.1 2289.0 2319.1 2323.9 2330.7 2330.9 1959.2 2306.8 2343.0 2344.4 2346.3 2282.2 2284.7 2308.2 2309.2 2312.0 1971.5 2151.9 2260.3 2284.9 2296.0 2025.4 2104.9 2259.6 2328.3 2333.2 8101.2 8307.8 8317.0 8430.2 8468.2 5101.4 5236.0 5237.7 5266.1 5287.3 3461.6 3484.6 3485.2 3548.3 3551.5 1207.8 1214.8 1255.8 1256.3 1267.8 10582.9 10610.8 10720.9 10732.4 10768.8 4188.3 4434.7 4529.7 4541.7 4546.2 8533.7 8600.3 8608.7 8621.5 8652.2 5117.1 5117.4 5118.1 5131.8 5150.8 4613.1 4659.3 4660.3 4722.2 4791.8 3633.1 3638.9 3702.9 3728.4 3736.7 1155.8 1160.9 1162.6 1169.7 1173.5 717.1 719.1 750.1 752.8 768.3 4965.4 4967.6 5395.2 5395.4 5603.0 555.2 556.2 561.1 561.7 571.6 2576.0 2990.0 3157.4 3227.6 3386.3 9010.3 9050.5 9542.6 9731.7 9836.3 8793.5 9336.3 9795.1 9811.3 9832.6 7677.5 7766.0 7769.3 7771.4 7783.8 5205.3 5351.9 5368.9 5395.6 5410.8 8917.6 8937.3 9050.6 9123.8 9221.8 9052.3 9256.3 9270.5 9359.3 9375.3 6629.2 6703.6 6704.4 6721.2 6726.2 7596.2 7715.5 7722.8 7786.2 7788.3 6121.8 7019.9 7104.8 7139.1 7253.5 6801.6 6898.7 7012.6 7014.3 7081.7 6197.1 6237.5 6289.6 6300.5 6320.8 4689.4 4817.2 4875.3 4931.6 5015.6 4875.1 4878.2 4956.4 5016.0 5033.4 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:4571.20 Median:5149.33 stddev:1414.23 (27.5%) stddev-sans-first:1381.63 23:43:31 INFO - PROCESS | 1656 | Values: 314.3 333.4 364.2 371.9 372.3 4569.7 5165.6 5270.0 5421.7 5598.8 4919.4 5286.7 5310.3 5424.6 5515.5 3875.5 4203.2 4285.2 4285.2 4302.8 3299.9 4106.8 4138.3 4255.6 4323.2 3768.6 3870.5 4158.1 4210.9 4225.4 3531.4 3712.2 4181.3 4239.9 4295.6 3796.3 3796.9 3797.5 3798.7 3809.8 4521.3 4559.8 5238.3 5264.8 5303.1 4887.9 4937.5 4945.0 4957.0 4957.7 5550.0 5756.4 5779.0 5783.5 5798.8 2905.5 3224.9 3901.7 3929.9 3942.5 5725.8 5742.6 5952.0 5977.5 6021.0 3928.0 3936.5 3939.8 3941.4 3944.9 4003.0 4007.5 4009.6 4009.8 4012.8 4215.8 4305.9 4670.4 4712.7 4763.6 5508.1 5796.5 5802.4 5819.9 5858.6 1122.7 1144.8 1291.2 1304.9 1305.1 774.0 825.6 892.9 899.0 899.9 4528.6 4808.6 4850.3 5187.9 5197.5 4764.5 5551.6 5727.7 5735.4 5762.4 4249.4 4876.8 5153.8 5155.8 5210.3 2643.7 2655.9 2813.3 2855.6 2976.0 5122.8 5904.7 5918.9 5953.9 5954.9 5021.9 5032.6 5177.6 5780.9 5845.8 5791.4 5855.7 5883.3 5943.0 5943.9 4669.7 5305.7 5378.6 5732.7 5740.2 4881.4 5259.7 5284.4 5550.4 5622.6 5075.4 5255.9 5899.8 5954.9 5961.5 3180.8 3374.6 3501.5 3658.8 3957.2 5144.9 5650.0 5976.4 6006.1 6015.7 5268.9 5316.4 5425.1 5745.6 5932.1 5412.7 5523.8 5533.4 5769.5 5867.7 4852.5 5459.4 5470.8 5675.6 5715.5 4697.5 4774.9 5796.3 5810.9 5817.4 4606.4 5651.3 5678.6 5702.3 5717.3 23:43:31 INFO - PROCESS | 1656 | 23:43:31 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:20464.38 Median:53351.20 stddev:30641.24 (57.4%) stddev-sans-first:30691.22 23:43:31 INFO - PROCESS | 1656 | Values: 688.4 702.4 740.0 772.4 818.5 15000.5 15627.9 15720.5 15721.3 15742.4 14257.7 14416.1 14442.0 14448.7 14491.1 840.7 852.9 858.0 859.3 873.1 866.4 866.5 866.7 867.1 868.0 782.6 883.6 887.0 911.3 913.1 900.8 907.0 913.4 914.4 915.2 671.3 673.3 681.8 682.1 686.0 15146.8 15310.0 15497.4 15578.2 15847.4 14043.7 14276.6 14301.9 14361.8 14398.3 9906.9 11872.8 11876.0 11926.8 12042.1 3223.3 3669.3 3679.2 3693.0 3861.5 109512.0 112085.0 113711.0 114239.0 115008.4 8753.6 10619.4 10701.7 10861.4 10876.0 21092.3 21688.3 21889.9 21901.6 21944.2 6261.7 7351.3 7447.5 7568.7 7597.5 4143.9 4165.6 4219.9 4242.9 4328.7 2921.9 3384.7 3421.1 3474.1 3479.5 542.8 554.1 615.6 631.5 644.2 637.7 641.8 659.5 666.4 670.2 8623.3 9440.9 9845.2 9895.4 10127.4 616.2 661.8 662.3 675.2 686.1 4638.5 4779.4 4804.8 4807.1 4831.9 103499.0 103862.0 104600.5 105108.0 106943.9 93905.6 94047.6 94826.5 95000.0 95575.0 67597.6 74392.2 76047.6 76631.6 76722.2 8271.3 9258.0 9269.2 9280.0 9285.2 46591.8 53079.9 53622.5 53925.5 54302.7 68403.0 69970.7 71017.3 71703.9 72098.0 10659.6 10924.4 10945.8 11092.8 11300.0 10524.3 11837.0 12004.3 12126.3 12421.4 11512.1 11559.9 11605.6 11676.7 11969.6 11364.4 11462.9 11583.7 11742.6 11892.2 11211.5 11263.3 11483.4 11529.2 11844.5 9227.4 9391.9 9442.6 9479.1 9787.7 6547.9 6770.0 8988.2 9003.1 9277.5 23:43:31 INFO - PROCESS | 1656 | -------- Summary: end -------- 23:43:31 INFO - PROCESS | 1656 | 23:43:32 INFO - TEST-INFO | 1656: exit 0 23:43:32 INFO - TEST-OK | dromaeo_css | took 1115423ms 23:43:32 INFO - TEST-START | kraken 23:43:32 INFO - operating with platform_type : mac_ 23:43:32 INFO - Initialising browser for kraken test... 23:43:32 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpmOhOxr/profile http://localhost:49246/getInfo.html) 23:43:35 INFO - PROCESS | 1668 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 23:43:35 INFO - PROCESS | 1668 | 2017-02-02 23:43:35.139 plugin-container[1669:10086] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 23:43:35 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:43:35 INFO - PROCESS | 1668 | 2017-02-02 23:43:35.142 plugin-container[1669:10086] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 23:43:35 INFO - PROCESS | 1668 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:43:35 INFO - PROCESS | 1668 | 2017-02-02 23:43:35.142 plugin-container[1669:10086] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:43:35 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 23:43:35 INFO - PROCESS | 1668 | colorDepth:24 23:43:35 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 23:43:35 INFO - PROCESS | 1668 | __metrics 23:43:35 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 23:43:35 INFO - PROCESS | 1668 | 1486107815282 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < forceQuit@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpmOhOxr/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpmOhOxr/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpmOhOxr/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpmOhOxr/profile/extensions/talos-powers@TalosPowersService.js:55:9 23:43:35 INFO - TEST-INFO | 1668: exit 0 23:43:35 INFO - Browser initialized. 23:43:35 INFO - Running cycle 1/1 for kraken test... 23:43:35 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/T/tmpmOhOxr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:38 INFO - PROCESS | 1670 | 2017-02-02 23:43:38.440 plugin-container[1671:10205] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 23:43:38 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:43:38 INFO - PROCESS | 1670 | 2017-02-02 23:43:38.442 plugin-container[1671:10205] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 23:43:38 INFO - PROCESS | 1670 | See /usr/include/servers/bootstrap_defs.h for the error codes. 23:43:38 INFO - PROCESS | 1670 | 2017-02-02 23:43:38.443 plugin-container[1671:10205] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 23:43:48 INFO - PROCESS | 1670 | RSS: Main: 233918464 23:43:48 INFO - PROCESS | 1670 | 23:43:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 23:43:52 INFO - PROCESS | 1670 | RSS: Main: 247439360 23:43:52 INFO - PROCESS | 1670 | 23:43:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 23:43:55 INFO - PROCESS | 1670 | RSS: Main: 255324160 23:43:55 INFO - PROCESS | 1670 | 23:43:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 23:43:59 INFO - PROCESS | 1670 | RSS: Main: 257994752 23:43:59 INFO - PROCESS | 1670 | 23:44:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 23:44:01 INFO - PROCESS | 1670 | RSS: Main: 260231168 23:44:01 INFO - PROCESS | 1670 | 23:44:03 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:44:04 INFO - PROCESS | 1670 | RSS: Main: 260616192 23:44:04 INFO - PROCESS | 1670 | 23:44:07 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 23:44:08 INFO - PROCESS | 1670 | RSS: Main: 266125312 23:44:08 INFO - PROCESS | 1670 | 23:44:11 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 23:44:12 INFO - PROCESS | 1670 | RSS: Main: 265547776 23:44:12 INFO - PROCESS | 1670 | 23:44:15 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 23:44:16 INFO - PROCESS | 1670 | RSS: Main: 265142272 23:44:16 INFO - PROCESS | 1670 | 23:44:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:44:18 INFO - PROCESS | 1670 | RSS: Main: 265113600 23:44:18 INFO - PROCESS | 1670 | 23:44:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:44:20 INFO - PROCESS | 1670 | RSS: Main: 265150464 23:44:20 INFO - PROCESS | 1670 | 23:44:23 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:44:23 INFO - PROCESS | 1670 | RSS: Main: 265916416 23:44:23 INFO - PROCESS | 1670 | 23:44:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:44:27 INFO - PROCESS | 1670 | RSS: Main: 265580544 23:44:27 INFO - PROCESS | 1670 | 23:44:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:44:31 INFO - PROCESS | 1670 | RSS: Main: 262893568 23:44:31 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 23:44:33 INFO - PROCESS | 1670 | RSS: Main: 264925184 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | __start_tp_report 23:44:33 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 23:44:33 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 23:44:33 INFO - PROCESS | 1670 | |i|pagename|runs| 23:44:33 INFO - PROCESS | 1670 | |0;ai-astar;112;173;165;119;117;123;151;172;119;120 23:44:33 INFO - PROCESS | 1670 | |1;audio-beat-detection;141;111;110;151;113;114;120;142;157;114 23:44:33 INFO - PROCESS | 1670 | |2;audio-dft;199;237;273;239;196;195;195;198;193;196 23:44:33 INFO - PROCESS | 1670 | |3;audio-fft;80;59;61;86;60;59;61;61;72;61 23:44:33 INFO - PROCESS | 1670 | |4;audio-oscillator;92;72;83;73;71;70;82;71;73;84 23:44:33 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;91;82;137;119;90;121;137;133;99;90 23:44:33 INFO - PROCESS | 1670 | |6;imaging-darkroom;123;141;154;93;155;153;104;109;155;104 23:44:33 INFO - PROCESS | 1670 | |7;imaging-desaturate;91;93;125;93;145;77;149;147;119;92 23:44:33 INFO - PROCESS | 1670 | |8;json-parse-financial;65;65;64;63;66;63;64;67;66;67 23:44:33 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;69;77;75;79;74;70;71;106;101;73 23:44:33 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;79;84;83;108;112;110;91;91;87;87 23:44:33 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;135;141;137;137;144;144;128;153;198;167 23:44:33 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;241;201;195;200;203;217;175;203;236;175 23:44:33 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;67;68;67;68;69;67;67;67;71;87 23:44:33 INFO - PROCESS | 1670 | __end_tp_report 23:44:33 INFO - PROCESS | 1670 | __start_cc_report 23:44:33 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,924 23:44:33 INFO - PROCESS | 1670 | __end_cc_report 23:44:33 INFO - PROCESS | 1670 | __startTimestamp1486107873391__endTimestamp 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | ------- Summary: start ------- 23:44:33 INFO - PROCESS | 1670 | Number of tests: 14 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:137.10 Median:137.00 stddev:25.08 (18.3%) stddev-sans-first:24.90 23:44:33 INFO - PROCESS | 1670 | Values: 112.0 173.0 165.0 119.0 117.0 123.0 151.0 172.0 119.0 120.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:130.50 stddev:18.33 (14.0%) stddev-sans-first:18.76 23:44:33 INFO - PROCESS | 1670 | Values: 141.0 111.0 110.0 151.0 113.0 114.0 120.0 142.0 157.0 114.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:212.10 Median:198.50 stddev:27.67 (13.9%) stddev-sans-first:28.94 23:44:33 INFO - PROCESS | 1670 | Values: 199.0 237.0 273.0 239.0 196.0 195.0 195.0 198.0 193.0 196.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:66.00 Median:61.00 stddev:9.81 (16.1%) stddev-sans-first:9.00 23:44:33 INFO - PROCESS | 1670 | Values: 80.0 59.0 61.0 86.0 60.0 59.0 61.0 61.0 72.0 61.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.50 stddev:7.55 (9.7%) stddev-sans-first:5.77 23:44:33 INFO - PROCESS | 1670 | Values: 92.0 72.0 83.0 73.0 71.0 70.0 82.0 71.0 73.0 84.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:86.00 stddev:21.74 (25.3%) stddev-sans-first:21.96 23:44:33 INFO - PROCESS | 1670 | Values: 91.0 82.0 137.0 119.0 90.0 121.0 137.0 133.0 99.0 90.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:129.10 Median:153.50 stddev:25.12 (16.4%) stddev-sans-first:26.55 23:44:33 INFO - PROCESS | 1670 | Values: 123.0 141.0 154.0 93.0 155.0 153.0 104.0 109.0 155.0 104.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:113.10 Median:84.00 stddev:27.24 (32.4%) stddev-sans-first:27.69 23:44:33 INFO - PROCESS | 1670 | Values: 91.0 93.0 125.0 93.0 145.0 77.0 149.0 147.0 119.0 92.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.50 stddev:1.49 (2.3%) stddev-sans-first:1.58 23:44:33 INFO - PROCESS | 1670 | Values: 65.0 65.0 64.0 63.0 66.0 63.0 64.0 67.0 66.0 67.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:79.50 Median:73.50 stddev:13.07 (17.8%) stddev-sans-first:13.29 23:44:33 INFO - PROCESS | 1670 | Values: 69.0 77.0 75.0 79.0 74.0 70.0 71.0 106.0 101.0 73.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:93.20 Median:85.50 stddev:12.16 (14.2%) stddev-sans-first:11.77 23:44:33 INFO - PROCESS | 1670 | Values: 79.0 84.0 83.0 108.0 112.0 110.0 91.0 91.0 87.0 87.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:144.00 stddev:20.48 (14.2%) stddev-sans-first:21.15 23:44:33 INFO - PROCESS | 1670 | Values: 135.0 141.0 137.0 137.0 144.0 144.0 128.0 153.0 198.0 167.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.60 Median:203.00 stddev:21.98 (10.8%) stddev-sans-first:18.96 23:44:33 INFO - PROCESS | 1670 | Values: 241.0 201.0 195.0 200.0 203.0 217.0 175.0 203.0 236.0 175.0 23:44:33 INFO - PROCESS | 1670 | 23:44:33 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:68.00 stddev:6.18 (9.1%) stddev-sans-first:6.47 23:44:33 INFO - PROCESS | 1670 | Values: 67.0 68.0 67.0 68.0 69.0 67.0 67.0 67.0 71.0 87.0 23:44:33 INFO - PROCESS | 1670 | -------- Summary: end -------- 23:44:33 INFO - PROCESS | 1670 | 23:44:34 INFO - TEST-INFO | 1670: exit 0 23:44:34 INFO - TEST-OK | kraken | took 61826ms 23:44:34 INFO - SUITE-END | took 1177s 23:44:34 INFO - Completed test suite (00:19:37) 23:44:34 INFO - javascript benchmark 23:44:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7187.906038327761, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2903.593496910433, 3357.5299458075874, 3360.0423879194436, 3388.2207092368753, 3407.148212946763, 5561.555075593953, 5644.604877658566, 5651.491365777079, 5710.714464276785, 5736.483716465517, 5592.5246354059955, 5599.496045355917, 5687.459691329317, 5691.231683722696, 5754.827355179351, 4865.635077369194, 5102.387713474388, 5148.639595228336, 5199.324087868572, 5254.81608143715, 5195.766190521416, 5294.258803767476, 5303.893922121555, 5314.4951229633125, 5346.893062138755, 5115.718635475047, 5141.948580514184, 5233.345831771028, 5247.842564723064, 5273.920891186635, 5055.494450554952, 5112.616553758483, 5174.197999310113, 5223.0, 5247.2129180623215, 4305.418768466279, 5157.045946499872, 5190.06578815813, 5196.350456192976, 5212.6611770235195, 5520.834374968757, 5644.266245388073, 5694.288213973254, 5710.486056254957, 5728.742206600671, 4979.402471703383, 6118.755249790003, 6160.630362178284, 6223.564350495467, 6275.780347687809, 6292.0, 6292.5595208335435, 6311.274203466568, 6314.336994615591, 6319.526035547352, 4798.520147985243, 5626.156076588462, 5782.710864456761, 5836.124581312794, 5867.471927526543, 6163.137160797492, 6180.6291622502795, 6205.6586887720705, 6219.502439804895, 6269.435750782452, 6088.628912517097, 6117.174181485442, 6148.508119350441, 6162.7226774795245, 6189.566730328924, 5203.9219411708855, 6190.41191086846, 6216.533759968021, 6220.564560480723, 6226.283977342573, 6104.095385180791, 6106.419890110433, 6124.228368151265, 6164.630122192682, 6189.81430557084, 6178.567500274938, 6181.443670069715, 6189.412005859436, 6200.503959683215, 6213.96893015532, 4983.626228032912, 4986.177280748636, 4986.32684587576, 4986.601071914238, 5013.523715247045, 4359.193549193346, 4379.824807007748, 4384.101259241847, 4436.511983681792, 4477.261251893401, 5826.970865145732, 5883.205767221456, 5889.911651325234, 5920.940790592125, 5935.109733540004, 6198.2252218472695, 6198.752049917953, 6230.0, 6274.058891166362, 6278.780242691575, 4366.995591014021, 5706.9429305707245, 5750.654960702372, 5817.88364232713, 5934.1692163097205, 4617.515160908123, 5404.648697834628, 5459.972700136474, 5514.696691681916, 5518.944810551923, 5326.227696983993, 5496.780128794963, 6236.781712640036, 6330.4619107375465, 6373.681315934185, 6139.723712432862, 6154.630722156685, 6247.31279559239, 6272.780452684134, 6289.182406287154, 6201.81394558164, 6212.81361559154, 6234.470070043915, 6286.9371306288185, 6307.495400368051, 6168.938310616836, 6191.040388739752, 6214.005759078525, 6218.502519798496, 6241.78153764616, 6139.754409823557, 6307.463865571478, 6316.431521162934, 6336.778212762715, 6341.175647165839, 5018.824341148043, 5970.671613061323, 6133.141360209485, 6133.487685122301, 6134.681512609229, 6114.938850611437, 6135.845176233341, 6140.078988151813, 6141.087130295657, 6156.384361563808, 5372.979133964534, 5771.826845194651, 5819.534437244925, 5928.3775203603, 5962.55280853929, 6124.777645458507, 6139.570230083851, 6142.754289828356, 6159.076138579249, 6168.691565421801, 5908.940910590839, 5949.791757288647, 5961.493273071837, 5974.2830860297045, 5982.427556150723], "value": 5646.754232328739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.16417381583335, 452.3305507848384, 481.021122016696, 493.9753012349382, 544.2570890734149, 38315.80842095789, 40622.79688601557, 40662.18675626489, 40844.59155408445, 40919.795401023024, 42079.948001299985, 43113.0, 43148.137037259316, 43160.0, 43185.70442886718, 9154.992950775426, 9447.90552094477, 11037.3377597344, 11385.316880987126, 11424.771504569904, 11092.1126309895, 11205.271657342246, 11231.382273974928, 11252.15608829337, 11252.38111903845, 11209.271397359145, 11231.32612043276, 11271.549138034468, 11283.605073822418, 11295.887041129567, 11180.105591552656, 11233.887661123448, 11246.268992515501, 11281.210315277935, 11284.097272218203, 9667.0, 11142.554297828077, 11168.832467512993, 11194.832077518844, 11204.943975280154, 37726.62273377259, 37794.43308350377, 37849.62150378488, 37942.0, 38059.429108563396, 3893.279743247508, 3923.470331505239, 3948.170884114311, 3951.9802400988096, 3959.8812035638975, 28811.56782648262, 29002.564961525593, 29326.70673293261, 29835.552466713016, 30148.24629384261, 3126.1559378967777, 3198.0885447647543, 3287.4904389819617, 3289.2434740009694, 3291.243014106769, 473412.0, 478560.60719696176, 478794.0, 482678.0, 482888.9999999965, 49410.505894940594, 49666.255006174935, 56430.7178464105, 56893.0, 58171.0, 56982.7150864243, 61216.387836121066, 61255.46861328413, 61344.38655613387, 61357.69321153365, 15200.391984320724, 15290.847091528942, 15486.922565387102, 15508.689826203412, 15513.45702900393, 11791.35147566892, 11846.585369512199, 11870.287782733063, 11925.582604608797, 11941.343226122473, 14994.625134371729, 18144.818551814315, 18212.544686382946, 18302.0, 18315.54211144732, 8002.759917202493, 8081.151479094728, 8107.959460202661, 8108.432409731262, 8173.18268173178, 848.4739461533889, 855.781775647206, 866.540733411293, 870.8563087090686, 892.3664198419195, 23907.880460597935, 29645.0, 29958.0, 30557.388852223277, 30646.84676576603, 1006.411249419098, 1027.712240572626, 1034.177828626244, 1035.5184839049878, 1045.0, 15653.373865045498, 15663.765043524356, 15670.686586268212, 15691.293891774898, 16012.839871601367, 555972.0, 556716.0, 559019.0, 559383.0, 560346.0, 62077.37922620716, 62557.0, 62599.0, 62684.686576566826, 62786.744265114445, 1411.4213172599184, 1433.426629348269, 1448.3192899337294, 1452.7457694903349, 1456.1627064437992, 27839.721602783713, 28330.0, 28717.856410717814, 29821.85089074541, 29862.25344366408, 50995.745021274655, 52562.47437525729, 52676.36192752106, 52686.20970685366, 52854.73572632112, 530271.0, 535599.0, 540042.0, 540324.0, 540433.0, 23776.40558986039, 24317.027318907047, 26492.602610960465, 27070.323241919108, 27276.454470910074, 45932.54067459283, 46633.3005004932, 46867.76566117148, 46925.06149877052, 47397.28904066373, 34248.82875585606, 37883.431748523246, 37991.240175196894, 38603.80698096492, 38672.41991370188, 37395.2520949574, 37607.2478550422, 37672.62327376691, 38230.0, 38706.225875482894, 36202.4569631461, 36913.89258322254, 37083.07292317713, 37213.0, 37246.62753372431, 29754.553681695226, 31780.04659860208, 34060.82969585136, 34257.14357141092, 34326.656733433345, 22623.09507619677, 24160.0, 24283.0, 24401.64036286815, 24976.875115624305], "value": 19975.14361106268, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.25509832392754, 382.10206015862724, 387.9756999523623, 398.34472293077886, 424.5330136849466, 15664.765028524582, 17645.911770441147, 20102.0, 20376.592468150666, 21348.35954921353, 20160.0, 20546.48633784156, 20604.587908241825, 20660.48348791281, 20754.169833206655, 5736.196932429453, 5942.940570594304, 6024.156618073452, 6054.909176362358, 6071.544634152434, 5729.197912292282, 5883.970580147115, 5969.0, 5970.582059255854, 5994.820155395345, 6063.818085457443, 6067.575269731121, 6075.878482430371, 6076.665783381913, 6079.4528492435675, 5987.520998320146, 6060.1212824140475, 6599.307072757363, 6665.766698165541, 6716.294789047129, 5700.0, 5889.587728858982, 5958.40415958405, 5959.880802383928, 5973.342932277446, 12579.308138052404, 13830.446782128703, 13839.031267811257, 13863.722725545533, 13892.722145557133, 2544.52926208652, 2601.596752503365, 2614.6078088286718, 2628.829126106797, 2648.0, 10052.44711540865, 10282.89717102827, 10591.099756520705, 13897.444102235899, 13985.930070349685, 1592.5779668387886, 1823.6626224148442, 1858.4238885945401, 1862.590230149365, 1877.6432477829305, 113707.0, 124990.75009249883, 126629.0, 134337.0, 135091.32454337765, 9340.20608248293, 10577.735556610993, 11106.333619982826, 12131.0, 12199.719029501952, 12826.80759788604, 12882.0, 13309.068365214536, 15552.844471555365, 15584.142872141914, 7249.456290778213, 8167.877481837777, 8424.410291279673, 8543.316534677211, 8612.052674205832, 7108.827043537862, 8227.506349619041, 8319.001719793663, 8339.166083391734, 8480.703175388831, 4719.10337035962, 4830.951690483121, 4832.516748325139, 4860.104559221906, 4877.926831097537, 1724.8533874620546, 2043.4176259765895, 2064.0505367531105, 2070.451330397446, 2071.2647010311425, 899.8526878230178, 963.1861077389594, 1001.7645853224486, 1007.1317705655903, 1042.9843552346722, 21379.685604604696, 21529.892350538146, 21697.891510542348, 21756.891215544136, 21850.0, 879.9824003519893, 1023.672424824064, 1025.1388833379847, 1052.4685034057752, 1077.2836064017497, 9472.0, 9499.38254013487, 12112.805829523093, 12513.186642868184, 12597.811032834516, 706465.0, 731949.6805031988, 750153.0, 767819.0, 776830.0, 156673.0, 158406.0, 160402.0, 162408.18795905946, 163605.0, 974.3325821812082, 1049.3808652894982, 1096.5394534295615, 1121.2039451989017, 1122.2649164797072, 18805.341813036477, 19603.70594441113, 19636.90181549083, 19643.901780491007, 19648.80351196527, 44665.77667111644, 48784.75607621939, 59781.40218597758, 59981.10028349666, 60084.69957650359, 84702.57648711717, 86616.70074949008, 87423.56288218773, 88487.0, 88492.1150788484, 5813.302403711582, 6568.638724870178, 7945.006874140732, 8254.54599997006, 8535.786605334917, 10667.466626668791, 12899.968507400567, 13350.933245333712, 13434.328283585586, 13488.595342139752, 10548.46836759157, 10617.734556636145, 11150.442477876237, 11240.213185076966, 11358.886411135783, 10652.627158049741, 11089.889101108885, 11173.162012849232, 11347.943260283975, 11437.02785263262, 10976.286541374786, 11233.71915702114, 11496.207037114393, 11764.411779411166, 11858.288502689866, 5520.613557050968, 7271.745488907863, 8280.296174824967, 8458.40791144614, 8538.44500107491, 9100.362974591715, 9457.527123643928, 11383.43082845871, 11422.600208992646, 11678.532858685558], "value": 9723.736391785938, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.7292541491702, 1409.4573589168167, 1418.8723014928655, 1425.2232533269373, 1440.5246268731319, 7916.802079947997, 8130.983627046619, 8383.538905360203, 8385.58072096395, 8408.369372297087, 8307.626156822942, 8437.578121093951, 8443.366747493947, 8444.57777111145, 8466.068732439428, 2288.9771102288973, 2319.0955527344263, 2323.860568365895, 2330.7086614173227, 2330.93007209784, 1959.2065213588448, 2306.792388685018, 2342.976570234293, 2344.402177444758, 2346.3430239532872, 2282.2468585366873, 2284.737255215655, 2308.1690591387087, 2309.2494939144763, 2312.0058374898786, 1971.5169783403157, 2151.8816465094415, 2260.2993072147606, 2284.8689898500265, 2296.0356650206954, 2025.3518873960338, 2104.9159682763234, 2259.5932732108213, 2328.301509547146, 2333.230034088747, 8101.230383113595, 8307.8338433231, 8317.0, 8430.199131082538, 8468.153184681543, 5101.4133374662015, 5236.031334203185, 5237.738113094369, 5266.078436273675, 5287.312649355559, 3461.6019157796673, 3484.5992710838323, 3485.163560745428, 3548.3258180945795, 3551.4672799080085, 1207.8369420128347, 1214.8117041858527, 1255.8179064035755, 1256.3290823205116, 1267.8415198100238, 10582.894171058268, 10610.840837387368, 10720.892791072067, 10732.409717465536, 10768.78462430755, 4188.329867221291, 4434.689571729948, 4529.705569137996, 4541.704789188692, 4546.227141385973, 8533.701320453754, 8600.311975041981, 8608.698695545625, 8621.52581608005, 8652.221300082896, 5117.078925793318, 5117.437081920985, 5118.10433174193, 5131.846044618667, 5150.793968241303, 4613.123506533748, 4659.254519276899, 4660.324252983299, 4722.150012997625, 4791.784369703371, 3633.091727068233, 3638.8544458221904, 3702.8889133326043, 3728.4034554471154, 3736.6637002669345, 1155.8266260061057, 1160.9187356884936, 1162.604714397109, 1169.7368092179192, 1173.524722487394, 717.1107826295356, 719.1226703421817, 750.1111183247868, 752.7779305105007, 768.2509553185711, 4965.428975667773, 4967.602591792648, 5395.21769343443, 5395.406505284415, 5602.971985140048, 555.1783360626215, 556.1907424697056, 561.147056474157, 561.719140429785, 571.5598988778701, 2575.961360579593, 2989.970100298969, 3157.447446696819, 3227.580414546141, 3386.3227354529195, 9010.27917766577, 9050.547472626342, 9542.570584323583, 9731.659391921248, 9836.311458197857, 8793.472391656522, 9336.299777516713, 9795.118439340493, 9811.26415518839, 9832.557534910946, 7677.500962437423, 7765.961170194113, 7769.339606133542, 7771.378289736807, 7783.793512005648, 5205.323307969939, 5351.892962140813, 5368.946310536845, 5395.622306438511, 5410.83767486976, 8917.643294268157, 8937.329700272636, 9050.592723327598, 9123.817523649357, 9221.769455763659, 9052.321075919464, 9256.305777066613, 9270.53647317645, 9359.298052646214, 9375.34372593912, 6629.2376376715365, 6703.597784132968, 6704.4301234395625, 6721.227058888095, 6726.159230096238, 7596.240375962359, 7715.498492597963, 7722.806929826799, 7786.182450842806, 7788.299053085249, 6121.80624778164, 7019.859602807813, 7104.751333703295, 7139.107611548557, 7253.492255542062, 6801.625910574966, 6898.724051037902, 7012.5792452453015, 7014.298570143149, 7081.663051192991, 6197.132401463708, 6237.5009999200865, 6289.591176573508, 6300.464460520907, 6320.787724296643, 4689.437267527918, 4817.156997525489, 4875.293082503088, 4931.630127740362, 5015.5987520997505, 4875.098106850244, 4878.170710979071, 4956.405231372259, 5015.974920125376, 5033.370828646419], "value": 4232.7509715781425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.2818659363355, 333.37159454428394, 364.21148214116437, 371.8772804974358, 372.281496711347, 4569.702969306997, 5165.612579056572, 5270.0, 5421.701806400646, 5598.804041858531, 4919.385076865392, 5286.65636733613, 5310.309659744228, 5424.647397919132, 5515.503604675579, 3875.534935807707, 4203.159368126379, 4285.185814695214, 4285.228658841407, 4302.827886884521, 3299.9010029699148, 4106.835726570934, 4138.2758017347, 4255.63827074699, 4323.243432399333, 3768.6082525726792, 3870.5161854768153, 4158.147579746144, 4210.894727631803, 4225.408442818008, 3531.4173161428334, 3712.201876596545, 4181.310083836163, 4239.872803815875, 4295.591918767712, 3796.316663000659, 3796.886093417202, 3797.468354430382, 3798.720767539482, 3809.847606095753, 4521.299198624219, 4559.8372415033955, 5238.266642670029, 5264.842054738364, 5303.124984377573, 4887.902241955177, 4937.456879743226, 4944.950550494485, 4957.008598280322, 4957.652964292501, 5549.972250138764, 5756.388211300842, 5779.0, 5783.537317014629, 5798.797042103506, 2905.5060639691305, 3224.9032529024166, 3901.7073719471155, 3929.8624548140965, 3942.4874766280486, 5725.7935556088305, 5742.598018138732, 5952.035828176691, 5977.46202841742, 6020.969895150496, 3927.9607203927594, 3936.488256526633, 3939.783311917815, 3941.4481972523868, 3944.861929832442, 4002.979985100114, 4007.479027726435, 4009.558948515661, 4009.8195581198916, 4012.7792971386853, 4215.810288537024, 4305.870823875289, 4670.416197975253, 4712.717236965725, 4763.571278584944, 5508.14623733322, 5796.536277097822, 5802.361740208574, 5819.88360232793, 5858.5898987070495, 1122.7193201699574, 1144.7824913266452, 1291.1536502801084, 1304.8629893861007, 1305.106002388367, 774.0363247756467, 825.5624519004937, 892.8928528576612, 898.955052247385, 899.9190072893471, 4528.592426681548, 4808.58146846681, 4850.296706977469, 5187.896242075138, 5197.506236907488, 4764.499727528629, 5551.639143455663, 5727.656340619576, 5735.447725761996, 5762.366139724627, 4249.386627224235, 4876.829310974099, 5153.793848246103, 5155.819546315861, 5210.348706411699, 2643.6695413073367, 2655.9203223903314, 2813.268550176969, 2855.6430446194227, 2975.9553606695918, 5122.795088196505, 5904.704764761831, 5918.852028699231, 5953.910691339634, 5954.910676339859, 5021.899562008739, 5032.622553308516, 5177.611679124081, 5780.913286300709, 5845.766169353178, 5791.420857914259, 5855.657736905272, 5883.294004719461, 5942.998785613324, 5943.898709890162, 4669.735178438386, 5305.708186049805, 5378.569714422915, 5732.684702341411, 5740.167675687086, 4881.414230292387, 5259.7370131494035, 5284.392294886137, 5550.389457159628, 5622.5783066271015, 5075.441701412916, 5255.894882102413, 5899.823005309848, 5954.880902382015, 5961.493273071664, 3180.8389937673046, 3374.6287908329573, 3501.509788629645, 3658.835352409095, 3957.179697339141, 5144.871378215575, 5650.039493286234, 5976.372480889444, 6006.1470801369, 6015.729292181775, 5268.947310526999, 5316.441773613869, 5425.077736784677, 5745.597808153389, 5932.063628503918, 5412.7293635318865, 5523.751431185526, 5533.446655334596, 5769.480746732815, 5867.735951882261, 4852.490488498657, 5459.372172200247, 5470.81161099312, 5675.631083979528, 5715.542756579547, 4697.5302469754115, 4774.899044420444, 5796.275465566804, 5810.854728631818, 5817.447342502455, 4606.355110284496, 5651.2935883014625, 5678.630888992202, 5702.258706368146, 5717.313922329347], "value": 4125.658106261841, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.390774164864, 702.4380495603516, 739.9630018499075, 772.4322622872188, 818.4557269415836, 15000.549983500485, 15627.92186039071, 15720.528384148465, 15721.292541835617, 15742.449014284517, 14257.71484570308, 14416.135031898093, 14442.0, 14448.711025779477, 14491.130532168077, 840.684743221292, 852.8848605438249, 857.9828403431927, 859.2610355094614, 873.1443185678039, 866.384866744609, 866.4844417571535, 866.7183165471215, 867.0808942520916, 867.995660021699, 782.5695867272977, 883.5979629268668, 886.9512176830272, 911.3483859040784, 913.0777914306565, 900.7928176519438, 906.9773255668595, 913.4062859141545, 914.4421902639351, 915.199200699388, 671.2515545167153, 673.3132205150768, 681.8499930015389, 682.0655701688718, 685.9588424694534, 15146.772798408032, 15310.004849684736, 15497.380104795795, 15578.22108894562, 15847.366105355772, 14043.719125617532, 14276.643083922881, 14301.928490357586, 14361.784573231409, 14398.280085995659, 9906.851397229048, 11872.821907671392, 11876.0, 11926.821097683542, 12042.09684273683, 3223.3069889973535, 3669.26614677063, 3679.208970071421, 3692.9630703692887, 3861.517310336208, 109512.0, 112085.0, 113711.0, 114239.0, 115008.42495787551, 8753.562321883881, 10619.415932123808, 10701.678949631523, 10861.40262285582, 10876.0, 21092.261770838253, 21688.34934951954, 21889.890550547145, 21901.561968760536, 21944.231951881608, 6261.655608941552, 7351.264873512606, 7447.478676492594, 7568.735094271674, 7597.544147351176, 4143.875683729493, 4165.562615925284, 4219.915601688011, 4242.8727138185905, 4328.7402755834755, 2921.9123426297247, 3384.6953774160443, 3421.0763093964492, 3474.1314671332166, 3479.530263414407, 542.7530473634487, 554.0746952589186, 615.5844804756861, 631.5421319543386, 644.1561554363799, 637.6620391192675, 641.8106658535743, 659.475716805141, 666.4302021771413, 670.2158474584747, 8623.31013518917, 9440.86709594853, 9845.163161131384, 9895.356801807859, 10127.392356458637, 616.2174038970483, 661.8378497268104, 662.2847324889108, 675.1998881325645, 686.1114856261154, 4638.466576343763, 4779.354787103696, 4804.807807687724, 4807.086653535817, 4831.9275210871165, 103499.0, 103862.0, 104600.47699761452, 105108.0, 106943.93056069495, 93905.59141612881, 94047.64880878033, 94826.52586737022, 95000.0, 95575.0, 67597.64804703879, 74392.24622610475, 76047.61976190083, 76631.61684191655, 76722.23277767263, 8271.255586997198, 9258.0, 9269.212116970133, 9279.953600232226, 9285.210757085724, 46591.767041164574, 53079.93840123253, 53622.46377536331, 53925.46074539205, 54302.728486357315, 68402.97395538971, 69970.65014675098, 71017.28982710106, 71703.92444113447, 72098.0, 10659.573617055232, 10924.399158046066, 10945.781084378108, 11092.833607496055, 11300.0, 10524.315919465516, 11836.993855522376, 12004.319395284492, 12126.333051682243, 12421.441035153259, 11512.149327367937, 11559.884401155881, 11605.593804216813, 11676.70808229801, 11969.64091077269, 11364.43177841088, 11462.94268528652, 11583.6524904253, 11742.58900938463, 11892.167548271884, 11211.495482703134, 11263.26788758728, 11483.36841473727, 11529.192956492965, 11844.526218951145, 9227.35408521424, 9391.85912211331, 9442.622295108118, 9479.146876781122, 9787.706368808947, 6547.901781473186, 6769.9661501694145, 8988.235999940078, 9003.14470125337, 9277.536123193948], "value": 7199.916354066075, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1632.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 173.0, 165.0, 119.0, 117.0, 123.0, 151.0, 172.0, 119.0, 120.0], "value": 137.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 111.0, 110.0, 151.0, 113.0, 114.0, 120.0, 142.0, 157.0, 114.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 237.0, 273.0, 239.0, 196.0, 195.0, 195.0, 198.0, 193.0, 196.0], "value": 212.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 61.0, 86.0, 60.0, 59.0, 61.0, 61.0, 72.0, 61.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 72.0, 83.0, 73.0, 71.0, 70.0, 82.0, 71.0, 73.0, 84.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 82.0, 137.0, 119.0, 90.0, 121.0, 137.0, 133.0, 99.0, 90.0], "value": 109.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 141.0, 154.0, 93.0, 155.0, 153.0, 104.0, 109.0, 155.0, 104.0], "value": 129.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 125.0, 93.0, 145.0, 77.0, 149.0, 147.0, 119.0, 92.0], "value": 113.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 63.0, 66.0, 63.0, 64.0, 67.0, 66.0, 67.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 75.0, 79.0, 74.0, 70.0, 71.0, 106.0, 101.0, 73.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 84.0, 83.0, 108.0, 112.0, 110.0, 91.0, 91.0, 87.0, 87.0], "value": 93.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 141.0, 137.0, 137.0, 144.0, 144.0, 128.0, 153.0, 198.0, 167.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [241.0, 201.0, 195.0, 200.0, 203.0, 217.0, 175.0, 203.0, 236.0, 175.0], "value": 204.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 69.0, 67.0, 67.0, 67.0, 71.0, 87.0], "value": 69.8, "unit": "score"}]}]} 23:44:34 INFO - Return code: 0 23:44:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:44:34 ERROR - # TBPL SUCCESS # 23:44:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:44:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:44:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:44:34 INFO - 2017-02-02 23:44:34.665 screenresolution[1675:10591] starting screenresolution argv=screenresolution get 23:44:34 INFO - 2017-02-02 23:44:34.668 screenresolution[1675:10591] Display 0: 1600x1200x32@60 23:44:34 INFO - 2017-02-02 23:44:34.674 screenresolution[1676:10594] starting screenresolution argv=screenresolution list 23:44:34 INFO - Available Modes on Display 0 23:44:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:44:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:44:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:44:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:44:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:44:34 INFO - Intel Iris: 23:44:34 INFO - Chipset Model: Intel Iris 23:44:34 INFO - Type: GPU 23:44:34 INFO - Bus: Built-In 23:44:34 INFO - VRAM (Dynamic, Max): 1536 MB 23:44:34 INFO - Vendor: Intel (0x8086) 23:44:34 INFO - Device ID: 0x0a2e 23:44:34 INFO - Revision ID: 0x0009 23:44:34 INFO - Displays: 23:44:34 INFO - Display: 23:44:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:44:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:44:34 INFO - Display Serial Number: 1600x1200 60 23:44:34 INFO - Main Display: Yes 23:44:34 INFO - Mirror: Off 23:44:34 INFO - Online: Yes 23:44:34 INFO - Rotation: Supported 23:44:34 INFO - Return code: 0 23:44:34 INFO - Running post-action listener: _resource_record_post_action 23:44:34 INFO - [mozharness: 2017-02-03 07:44:34.915016Z] Finished run-tests step (success) 23:44:34 INFO - Running post-run listener: _resource_record_post_run 23:44:34 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 38517248; Write bytes: 559552512; Read time: 257; Write time: 1698 23:44:34 INFO - TinderboxPrint: CPU usage
54.7% 23:44:34 INFO - TinderboxPrint: I/O read bytes / time
38,517,248 / 257 23:44:34 INFO - TinderboxPrint: I/O write bytes / time
559,552,512 / 1,698 23:44:34 INFO - TinderboxPrint: CPU idle
2,174.9 (45.3%) 23:44:34 INFO - TinderboxPrint: CPU system
975.1 (20.3%) 23:44:34 INFO - TinderboxPrint: CPU user
1,651.6 (34.4%) 23:44:34 INFO - TinderboxPrint: Swap in / out
290,594,816 / 0 23:44:34 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 246698496; Write bytes: 238948352; Read time: 17969; Write time: 494 23:44:34 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 36428288; Write bytes: 301273088; Read time: 228; Write time: 1147 23:44:35 INFO - Running post-run listener: _upload_blobber_files 23:44:35 INFO - Blob upload gear active. 23:44:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:44:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:44:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:44:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:44:35 INFO - (blobuploader) - INFO - Open directory for files ... 23:44:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:44:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:44:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:37 INFO - (blobuploader) - INFO - Done attempting. 23:44:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:44:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:44:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:38 INFO - (blobuploader) - INFO - Done attempting. 23:44:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:44:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:44:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:39 INFO - (blobuploader) - INFO - Done attempting. 23:44:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:44:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:44:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:44:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:44:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:44:41 INFO - (blobuploader) - INFO - Done attempting. 23:44:41 INFO - (blobuploader) - INFO - Iteration through files over. 23:44:41 INFO - Return code: 0 23:44:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:44:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:44:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1aee90ffc4c95bb19cb7fc7dc74e9ab712430f8408238b26e3e477eb653007a6924af2a67c8a0abeb209f9e5a26c9dd39373e6eda0113ece3715d7468430296d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6776a0bc7b1ef8eb73c3839a06d3061b162abadff3addcef6a016dfd4c388b8f149961500ee1b062e832f2ea2682faf6a2807cc64e168ef91ccf9ef505826727", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e6af9d9200a54c94cebaca2df3907376b7d479a1af8ec39f413a3061956b12db52edfe3348be0e547a2d67a2890a7887f2bcf26123fca8554ad246f7664f615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a270a2ddf1fc30e7ca6bff99b04aec51de84c502b1f483c1b84386b5fdf700fde47819fa5088959cab1ffb4092c3159a4bd3e82465e865eb63a5d502c56c0cb"} 23:44:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:44:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:44:41 INFO - Contents: 23:44:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1aee90ffc4c95bb19cb7fc7dc74e9ab712430f8408238b26e3e477eb653007a6924af2a67c8a0abeb209f9e5a26c9dd39373e6eda0113ece3715d7468430296d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6776a0bc7b1ef8eb73c3839a06d3061b162abadff3addcef6a016dfd4c388b8f149961500ee1b062e832f2ea2682faf6a2807cc64e168ef91ccf9ef505826727", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e6af9d9200a54c94cebaca2df3907376b7d479a1af8ec39f413a3061956b12db52edfe3348be0e547a2d67a2890a7887f2bcf26123fca8554ad246f7664f615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a270a2ddf1fc30e7ca6bff99b04aec51de84c502b1f483c1b84386b5fdf700fde47819fa5088959cab1ffb4092c3159a4bd3e82465e865eb63a5d502c56c0cb"} 23:44:41 INFO - Running post-run listener: copy_logs_to_upload_dir 23:44:41 INFO - Copying logs to upload dir... 23:44:41 INFO - mkdir: /builds/slave/test/build/upload/logs 23:44:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.059841 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-02-02 23:44:41.697924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 23:44:41.705548) ========= 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.9kli2WbffQ/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.JuEXsS1C13/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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/Firefox/sha512/1aee90ffc4c95bb19cb7fc7dc74e9ab712430f8408238b26e3e477eb653007a6924af2a67c8a0abeb209f9e5a26c9dd39373e6eda0113ece3715d7468430296d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6776a0bc7b1ef8eb73c3839a06d3061b162abadff3addcef6a016dfd4c388b8f149961500ee1b062e832f2ea2682faf6a2807cc64e168ef91ccf9ef505826727", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e6af9d9200a54c94cebaca2df3907376b7d479a1af8ec39f413a3061956b12db52edfe3348be0e547a2d67a2890a7887f2bcf26123fca8554ad246f7664f615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a270a2ddf1fc30e7ca6bff99b04aec51de84c502b1f483c1b84386b5fdf700fde47819fa5088959cab1ffb4092c3159a4bd3e82465e865eb63a5d502c56c0cb"} build_url:https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/dcFSHP-wTd-Ei-nMbkhw8Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1aee90ffc4c95bb19cb7fc7dc74e9ab712430f8408238b26e3e477eb653007a6924af2a67c8a0abeb209f9e5a26c9dd39373e6eda0113ece3715d7468430296d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6776a0bc7b1ef8eb73c3839a06d3061b162abadff3addcef6a016dfd4c388b8f149961500ee1b062e832f2ea2682faf6a2807cc64e168ef91ccf9ef505826727", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e6af9d9200a54c94cebaca2df3907376b7d479a1af8ec39f413a3061956b12db52edfe3348be0e547a2d67a2890a7887f2bcf26123fca8554ad246f7664f615", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a270a2ddf1fc30e7ca6bff99b04aec51de84c502b1f483c1b84386b5fdf700fde47819fa5088959cab1ffb4092c3159a4bd3e82465e865eb63a5d502c56c0cb"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 23:44:41.742246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 23:44:41.742529) ========= 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.9kli2WbffQ/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.JuEXsS1C13/Listeners TMPDIR=/var/folders/vc/_7zfnphs2611zn3vnbmsqk3c00000w/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.005067 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 23:44:41.790654) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 23:44:41.790931) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 23:44:41.791231) ========= ========= Total master_lag: 3.71 =========