builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0337 starttime: 1486402543.14 results: success (0) buildid: 20170206081455 builduid: 87e4d5280cec4f97a54e54cc4680eeac revision: 7f1b358fb17dfd982c5e18c34d5735cd481c7f7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.136250) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.136737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.137082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.161676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.162011) ========= 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.kfkhJPysaH/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.ix2TDN3PDr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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-06 09:35:43-- 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% 91.5M=0s 2017-02-06 09:35:43 (91.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176474 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.362003) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.362333) ========= 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.kfkhJPysaH/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.ix2TDN3PDr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.019493 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:43.411201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 09:35:43.411614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7f1b358fb17dfd982c5e18c34d5735cd481c7f7c --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 7f1b358fb17dfd982c5e18c34d5735cd481c7f7c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kfkhJPysaH/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.ix2TDN3PDr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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-06 09:35:43,502 truncating revision to first 12 chars 2017-02-06 09:35:43,502 Setting DEBUG logging. 2017-02-06 09:35:43,502 attempt 1/10 2017-02-06 09:35:43,502 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7f1b358fb17d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 09:35:44,958 unpacking tar archive at: mozilla-central-7f1b358fb17d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.709199 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 09:35:45.144687) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:45.145009) ========= script_repo_revision: 7f1b358fb17dfd982c5e18c34d5735cd481c7f7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:45.145416) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:45.145696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 09:35:45.165245) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-06 09:35:45.165621) ========= /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.kfkhJPysaH/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.ix2TDN3PDr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:35:45 INFO - MultiFileLogger online at 20170206 09:35:45 in /builds/slave/test 09:35:45 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 09:35:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:45 INFO - {'append_to_log': False, 09:35:45 INFO - 'base_work_dir': '/builds/slave/test', 09:35:45 INFO - 'blob_upload_branch': 'Firefox', 09:35:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:45 INFO - 'branch': 'Firefox', 09:35:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:45 INFO - 'config_files': ('talos/mac_config.py',), 09:35:45 INFO - 'default_actions': ('clobber', 09:35:45 INFO - 'read-buildbot-config', 09:35:45 INFO - 'download-and-extract', 09:35:45 INFO - 'populate-webroot', 09:35:45 INFO - 'create-virtualenv', 09:35:45 INFO - 'install', 09:35:45 INFO - 'run-tests'), 09:35:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:45 INFO - 'download_minidump_stackwalk': True, 09:35:45 INFO - 'download_symbols': 'ondemand', 09:35:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:45 INFO - 'installer_path': 'installer.exe', 09:35:45 INFO - 'log_level': 'info', 09:35:45 INFO - 'log_name': 'talos', 09:35:45 INFO - 'log_to_console': True, 09:35:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:35:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:35:45 INFO - 'opt_config_files': (), 09:35:45 INFO - 'pip_index': False, 09:35:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:35:45 INFO - 'cmd': ('bash', 09:35:45 INFO - '-c', 09:35:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:35:45 INFO - 'enabled': True, 09:35:45 INFO - 'halt_on_failure': False, 09:35:45 INFO - 'name': 'check_screen_resolution'},), 09:35:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:35:45 INFO - 'cmd': ('bash', 09:35:45 INFO - '-c', 09:35:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:35:45 INFO - 'enabled': True, 09:35:45 INFO - 'halt_on_failure': False, 09:35:45 INFO - 'name': 'check_screen_resolution'},), 09:35:45 INFO - 'run_cmd_checks_enabled': True, 09:35:45 INFO - 'sps_profile': False, 09:35:45 INFO - 'sps_profile_interval': 0, 09:35:45 INFO - 'suite': 'dromaeojs-e10s', 09:35:45 INFO - 'system_bits': '32', 09:35:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:45 INFO - 'title': 't-yosemite-r7-0337', 09:35:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:45 INFO - 'use_talos_json': True, 09:35:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:45 INFO - 'work_dir': 'build'} 09:35:45 INFO - [mozharness: 2017-02-06 17:35:45.378066Z] Running clobber step. 09:35:45 INFO - Running pre-action listener: _resource_record_pre_action 09:35:45 INFO - Running main action method: clobber 09:35:45 INFO - rmtree: /builds/slave/test/build 09:35:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:47 INFO - Running post-action listener: _resource_record_post_action 09:35:47 INFO - [mozharness: 2017-02-06 17:35:47.009769Z] Finished clobber step (success) 09:35:47 INFO - [mozharness: 2017-02-06 17:35:47.009903Z] Running read-buildbot-config step. 09:35:47 INFO - Running pre-action listener: _resource_record_pre_action 09:35:47 INFO - Running main action method: read_buildbot_config 09:35:47 INFO - Using buildbot properties: 09:35:47 INFO - { 09:35:47 INFO - "project": "", 09:35:47 INFO - "product": "firefox", 09:35:47 INFO - "script_repo_revision": "production", 09:35:47 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:35:47 INFO - "repository": "", 09:35:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:35:47 INFO - "buildid": "20170206081455", 09:35:47 INFO - "pgo_build": "False", 09:35:47 INFO - "basedir": "/builds/slave/test", 09:35:47 INFO - "buildnumber": 134, 09:35:47 INFO - "slavename": "t-yosemite-r7-0337", 09:35:47 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:35:47 INFO - "platform": "yosemite_r7", 09:35:47 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:35:47 INFO - "branch": "mozilla-central", 09:35:47 INFO - "repo_path": "mozilla-central", 09:35:47 INFO - "revision": "7f1b358fb17dfd982c5e18c34d5735cd481c7f7c", 09:35:47 INFO - "stage_platform": "macosx64", 09:35:47 INFO - "builduid": "87e4d5280cec4f97a54e54cc4680eeac", 09:35:47 INFO - "slavebuilddir": "test" 09:35:47 INFO - } 09:35:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 09:35:47 INFO - Running post-action listener: _resource_record_post_action 09:35:47 INFO - [mozharness: 2017-02-06 17:35:47.013324Z] Finished read-buildbot-config step (success) 09:35:47 INFO - [mozharness: 2017-02-06 17:35:47.013456Z] Running download-and-extract step. 09:35:47 INFO - Running pre-action listener: _resource_record_pre_action 09:35:47 INFO - Running main action method: download_and_extract 09:35:47 INFO - mkdir: /builds/slave/test/build/tests 09:35:47 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')]} 09:35:47 INFO - trying https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 09:35:47 INFO - Downloading https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/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 09:35:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/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 09:35:47 INFO - Downloaded 1199 bytes. 09:35:47 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 09:35:47 INFO - Using the following test package requirements: 09:35:47 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:35:47 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 09:35:47 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 09:35:47 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'jsshell-mac.zip'], 09:35:47 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 09:35:47 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 09:35:47 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 09:35:47 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 09:35:47 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 09:35:47 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 09:35:47 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 09:35:47 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:35:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:35:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:35:47 INFO - Fetch https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:35:49 INFO - Expected file size: 34851045 09:35:49 INFO - Obtained file size: 34851045 09:35:56 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 09:35:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 09:35:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:35:56 INFO - Fetch https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 09:35:57 INFO - Expected file size: 34851045 09:35:57 INFO - Obtained file size: 34851045 09:36:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 09:36:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:36:04 INFO - Fetch https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 09:36:06 INFO - Expected file size: 14403454 09:36:06 INFO - Obtained file size: 14403454 09:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:06 INFO - trying https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:36:06 INFO - Downloading https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 09:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/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 09:36:09 INFO - Downloaded 70256619 bytes. 09:36:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:36:09 INFO - mkdir: /builds/slave/test/properties 09:36:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:36:09 INFO - Writing to file /builds/slave/test/properties/build_url 09:36:09 INFO - Contents: 09:36:09 INFO - build_url:https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 09:36:10 INFO - Running post-action listener: _resource_record_post_action 09:36:10 INFO - Running post-action listener: set_extra_try_arguments 09:36:10 INFO - [mozharness: 2017-02-06 17:36:10.372395Z] Finished download-and-extract step (success) 09:36:10 INFO - [mozharness: 2017-02-06 17:36:10.372528Z] Running populate-webroot step. 09:36:10 INFO - Running pre-action listener: _resource_record_pre_action 09:36:10 INFO - Running main action method: populate_webroot 09:36:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:36:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:36:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:36:10 INFO - '--tppagecycles', 09:36:10 INFO - '7'], 09:36:10 INFO - 'tests': ['tsvgm']}}, 09:36:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:36:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:36:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:36:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:36:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:36:10 INFO - 'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:36:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:36:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:36:10 INFO - 'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['damp', 'tps']}, 09:36:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:36:10 INFO - 'tests': ['damp', 'tps']}, 09:36:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['dromaeo_dom']}, 09:36:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:36:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['basic_compositor_video']}, 09:36:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:36:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['a11yr', 09:36:10 INFO - 'ts_paint', 09:36:10 INFO - 'tpaint', 09:36:10 INFO - 'sessionrestore', 09:36:10 INFO - 'sessionrestore_no_auto_restore', 09:36:10 INFO - 'tabpaint']}, 09:36:10 INFO - 'other-e10s': {'tests': ['a11yr', 09:36:10 INFO - 'ts_paint', 09:36:10 INFO - 'tpaint', 09:36:10 INFO - 'sessionrestore', 09:36:10 INFO - 'sessionrestore_no_auto_restore', 09:36:10 INFO - 'tabpaint']}, 09:36:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:36:10 INFO - 'ts_paint', 09:36:10 INFO - 'tpaint', 09:36:10 INFO - 'sessionrestore', 09:36:10 INFO - 'sessionrestore_no_auto_restore', 09:36:10 INFO - 'tabpaint']}, 09:36:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:36:10 INFO - 'ts_paint', 09:36:10 INFO - 'tpaint', 09:36:10 INFO - 'sessionrestore', 09:36:10 INFO - 'sessionrestore_no_auto_restore', 09:36:10 INFO - 'tabpaint']}, 09:36:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['a11yr', 09:36:10 INFO - 'ts_paint', 09:36:10 INFO - 'tpaint', 09:36:10 INFO - 'sessionrestore', 09:36:10 INFO - 'sessionrestore_no_auto_restore', 09:36:10 INFO - 'tabpaint']}, 09:36:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['a11yr', 09:36:10 INFO - 'ts_paint', 09:36:10 INFO - 'tpaint', 09:36:10 INFO - 'sessionrestore', 09:36:10 INFO - 'sessionrestore_no_auto_restore', 09:36:10 INFO - 'tabpaint']}, 09:36:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['tsvgx', 09:36:10 INFO - 'tsvgr_opacity', 09:36:10 INFO - 'tart', 09:36:10 INFO - 'tscrollx', 09:36:10 INFO - 'cart', 09:36:10 INFO - 'tsvg_static']}, 09:36:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:36:10 INFO - 'tsvgr_opacity', 09:36:10 INFO - 'tart', 09:36:10 INFO - 'tscrollx', 09:36:10 INFO - 'cart', 09:36:10 INFO - 'tsvg_static']}, 09:36:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:36:10 INFO - 'talos_options': ['--disable-e10s'], 09:36:10 INFO - 'tests': ['tp5o']}, 09:36:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:36:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:36:10 INFO - 'talos_options': ['--disable-e10s', 09:36:10 INFO - '--xperf_path', 09:36:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:10 INFO - 'tests': ['tp5n']}, 09:36:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:36:10 INFO - 'talos_options': ['--xperf_path', 09:36:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:36:10 INFO - 'tests': ['tp5n']}}, 09:36:10 INFO - 'talos.zip': {'path': '', 09:36:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:36:10 INFO - Running post-action listener: _resource_record_post_action 09:36:10 INFO - [mozharness: 2017-02-06 17:36:10.391222Z] Finished populate-webroot step (success) 09:36:10 INFO - [mozharness: 2017-02-06 17:36:10.391360Z] Running create-virtualenv step. 09:36:10 INFO - Running pre-action listener: _resource_record_pre_action 09:36:10 INFO - Running main action method: create_virtualenv 09:36:10 INFO - Creating virtualenv /builds/slave/test/build/venv 09:36:10 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 09:36:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:36:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:36:10 INFO - Using real prefix '/tools/python27' 09:36:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:36:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:36:14 INFO - Installing pip.................done. 09:36:14 INFO - Return code: 0 09:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:36:14 INFO - Reading from file tmpfile_stdout 09:36:14 INFO - Output received: 09:36:14 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) 09:36:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:14 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 09:36:14 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 09:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:14 INFO - 'HOME': '/Users/cltbld', 09:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:14 INFO - 'LOGNAME': 'cltbld', 09:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:14 INFO - 'MOZ_NO_REMOTE': '1', 09:36:14 INFO - 'NO_EM_RESTART': '1', 09:36:14 INFO - 'PAGER': '/bin/cat', 09:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:14 INFO - 'PWD': '/builds/slave/test', 09:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:14 INFO - 'SHELL': '/bin/bash', 09:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:14 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:14 INFO - 'USER': 'cltbld', 09:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:14 INFO - 'XPC_FLAGS': '0x0', 09:36:14 INFO - 'XPC_SERVICE_NAME': '0', 09:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:14 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 09:36:14 INFO - Cleaning up... 09:36:14 INFO - Return code: 0 09:36:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:14 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 09:36:14 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 09:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:14 INFO - 'HOME': '/Users/cltbld', 09:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:14 INFO - 'LOGNAME': 'cltbld', 09:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:14 INFO - 'MOZ_NO_REMOTE': '1', 09:36:14 INFO - 'NO_EM_RESTART': '1', 09:36:14 INFO - 'PAGER': '/bin/cat', 09:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:14 INFO - 'PWD': '/builds/slave/test', 09:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:14 INFO - 'SHELL': '/bin/bash', 09:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:14 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:14 INFO - 'USER': 'cltbld', 09:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:14 INFO - 'XPC_FLAGS': '0x0', 09:36:14 INFO - 'XPC_SERVICE_NAME': '0', 09:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:14 INFO - Downloading/unpacking psutil>=3.1.1 09:36:14 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 09:36:14 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 09:36:14 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 09:36:14 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 09:36:14 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 09:36:14 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 09:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:36:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:18 INFO - Installing collected packages: psutil 09:36:18 INFO - Running setup.py install for psutil 09:36:18 INFO - building 'psutil._psutil_osx' extension 09:36:18 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 09:36:18 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 09:36:18 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 09:36:18 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 09:36:18 INFO - building 'psutil._psutil_posix' extension 09:36:18 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 09:36:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:36:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:36:19 INFO - ^ 09:36:19 INFO - 1 warning generated. 09:36:19 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 09:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:36:19 INFO - Successfully installed psutil 09:36:19 INFO - Cleaning up... 09:36:19 INFO - Return code: 0 09:36:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:36:19 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')]} 09:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:19 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')]} 09:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:20 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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:20 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 09:36:20 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 09:36:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:20 INFO - 'HOME': '/Users/cltbld', 09:36:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:20 INFO - 'LOGNAME': 'cltbld', 09:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:20 INFO - 'MOZ_NO_REMOTE': '1', 09:36:20 INFO - 'NO_EM_RESTART': '1', 09:36:20 INFO - 'PAGER': '/bin/cat', 09:36:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:20 INFO - 'PWD': '/builds/slave/test', 09:36:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:20 INFO - 'SHELL': '/bin/bash', 09:36:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:20 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:20 INFO - 'USER': 'cltbld', 09:36:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:20 INFO - 'XPC_FLAGS': '0x0', 09:36:20 INFO - 'XPC_SERVICE_NAME': '0', 09:36:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36: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 09:36:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:36:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:36:23 INFO - Installing collected packages: mozsystemmonitor 09:36:23 INFO - Running setup.py install for mozsystemmonitor 09:36:23 INFO - Successfully installed mozsystemmonitor 09:36:23 INFO - Cleaning up... 09:36:23 INFO - Return code: 0 09:36:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:36:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:23 INFO - 'HOME': '/Users/cltbld', 09:36:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:23 INFO - 'LOGNAME': 'cltbld', 09:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:23 INFO - 'MOZ_NO_REMOTE': '1', 09:36:23 INFO - 'NO_EM_RESTART': '1', 09:36:23 INFO - 'PAGER': '/bin/cat', 09:36:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:23 INFO - 'PWD': '/builds/slave/test', 09:36:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:23 INFO - 'SHELL': '/bin/bash', 09:36:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:23 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:23 INFO - 'USER': 'cltbld', 09:36:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:23 INFO - 'XPC_FLAGS': '0x0', 09:36:23 INFO - 'XPC_SERVICE_NAME': '0', 09:36:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:23 INFO - Downloading/unpacking jsonschema==2.5.1 09:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:36:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:36:26 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 09:36:26 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 09:36:26 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 09:36:26 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 09:36:26 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 09:36:26 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 09:36:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:36:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:36:27 INFO - warning: no files found matching '*.txt' 09:36:27 INFO - no previously-included directories found matching 'build' 09:36:27 INFO - no previously-included directories found matching 'dist' 09:36:27 INFO - no previously-included directories found matching '.git*' 09:36:27 INFO - Installing collected packages: jsonschema, functools32 09:36:27 INFO - Running setup.py install for functools32 09:36:27 INFO - warning: no files found matching '*.txt' 09:36:27 INFO - no previously-included directories found matching 'build' 09:36:27 INFO - no previously-included directories found matching 'dist' 09:36:27 INFO - no previously-included directories found matching '.git*' 09:36:27 INFO - Successfully installed jsonschema functools32 09:36:27 INFO - Cleaning up... 09:36:27 INFO - Return code: 0 09:36:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:27 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 09:36:27 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 09:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:27 INFO - 'HOME': '/Users/cltbld', 09:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:27 INFO - 'LOGNAME': 'cltbld', 09:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:27 INFO - 'MOZ_NO_REMOTE': '1', 09:36:27 INFO - 'NO_EM_RESTART': '1', 09:36:27 INFO - 'PAGER': '/bin/cat', 09:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:27 INFO - 'PWD': '/builds/slave/test', 09:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:27 INFO - 'SHELL': '/bin/bash', 09:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:27 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:27 INFO - 'USER': 'cltbld', 09:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:27 INFO - 'XPC_FLAGS': '0x0', 09:36:27 INFO - 'XPC_SERVICE_NAME': '0', 09:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:36:27 INFO - Cleaning up... 09:36:27 INFO - Return code: 0 09:36:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:36: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')]} 09:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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')]} 09:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:27 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 09:36:27 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 09:36:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:27 INFO - 'HOME': '/Users/cltbld', 09:36:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:27 INFO - 'LOGNAME': 'cltbld', 09:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:27 INFO - 'MOZ_NO_REMOTE': '1', 09:36:27 INFO - 'NO_EM_RESTART': '1', 09:36:27 INFO - 'PAGER': '/bin/cat', 09:36:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:27 INFO - 'PWD': '/builds/slave/test', 09:36:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:27 INFO - 'SHELL': '/bin/bash', 09:36:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:27 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:27 INFO - 'USER': 'cltbld', 09:36:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:27 INFO - 'XPC_FLAGS': '0x0', 09:36:27 INFO - 'XPC_SERVICE_NAME': '0', 09:36:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:36:27 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 09:36:27 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 09:36:27 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 09:36:27 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 09:36:27 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 09:36:27 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 09:36:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:30 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 09:36:30 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 09:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:31 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 09:36:31 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 09:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:31 INFO - Downloading docopt-0.6.1.tar.gz 09:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:31 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:31 INFO - Running setup.py install for blobuploader 09:36:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:31 INFO - Running setup.py install for requests 09:36:32 INFO - Running setup.py install for docopt 09:36:32 INFO - Successfully installed blobuploader requests docopt 09:36:32 INFO - Cleaning up... 09:36:32 INFO - Return code: 0 09:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:32 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')]} 09:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:32 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')]} 09:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:32 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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:32 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 09:36:32 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 09:36:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:32 INFO - 'HOME': '/Users/cltbld', 09:36:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:32 INFO - 'LOGNAME': 'cltbld', 09:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:32 INFO - 'MOZ_NO_REMOTE': '1', 09:36:32 INFO - 'NO_EM_RESTART': '1', 09:36:32 INFO - 'PAGER': '/bin/cat', 09:36:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:32 INFO - 'PWD': '/builds/slave/test', 09:36:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:32 INFO - 'SHELL': '/bin/bash', 09:36:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:32 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:32 INFO - 'USER': 'cltbld', 09:36:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:32 INFO - 'XPC_FLAGS': '0x0', 09:36:32 INFO - 'XPC_SERVICE_NAME': '0', 09:36:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:32 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-QJRyTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:32 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-p4u3z7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Cntczn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-_nSLis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-iDqQ76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4mxN1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-CbN3Wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-JE_YdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4H8iNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-kigxKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:33 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4puqpx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:34 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-RmiwpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:34 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-00NKhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:34 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-GSYlIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:34 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-AT0YhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:34 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-tV9n79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:34 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-u7NIpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:34 INFO - Running setup.py install for manifestparser 09:36:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:34 INFO - Running setup.py install for mozcrash 09:36:34 INFO - Running setup.py install for mozdebug 09:36:35 INFO - Running setup.py install for mozdevice 09:36:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Running setup.py install for mozfile 09:36:35 INFO - Running setup.py install for mozhttpd 09:36:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Running setup.py install for mozinfo 09:36:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Running setup.py install for mozInstall 09:36:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:35 INFO - Running setup.py install for mozleak 09:36:35 INFO - Running setup.py install for mozlog 09:36:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:36 INFO - Running setup.py install for moznetwork 09:36:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:36 INFO - Running setup.py install for mozprocess 09:36:36 INFO - Running setup.py install for mozprofile 09:36:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:36 INFO - Running setup.py install for mozrunner 09:36:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:36 INFO - Running setup.py install for mozscreenshot 09:36:36 INFO - Running setup.py install for moztest 09:36:37 INFO - Running setup.py install for mozversion 09:36:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:37 INFO - Cleaning up... 09:36:37 INFO - Return code: 0 09:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:37 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')]} 09:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:37 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')]} 09:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:37 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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:37 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 09:36:37 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 09:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:37 INFO - 'HOME': '/Users/cltbld', 09:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:37 INFO - 'LOGNAME': 'cltbld', 09:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:37 INFO - 'MOZ_NO_REMOTE': '1', 09:36:37 INFO - 'NO_EM_RESTART': '1', 09:36:37 INFO - 'PAGER': '/bin/cat', 09:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:37 INFO - 'PWD': '/builds/slave/test', 09:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:37 INFO - 'SHELL': '/bin/bash', 09:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:37 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:37 INFO - 'USER': 'cltbld', 09:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:37 INFO - 'XPC_FLAGS': '0x0', 09:36:37 INFO - 'XPC_SERVICE_NAME': '0', 09:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:37 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-Hv115X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:37 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)) 09:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:37 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-nUbINt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:37 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)) 09:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:37 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-5FufN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:37 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)) 09:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:37 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-rwJ8l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:37 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)) 09:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:37 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ADIcLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-6ZMfA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-UGQJ14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-odmuvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-V835V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-9pItbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-kKCxBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-vAJFhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-ZlMu9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:38 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)) 09:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:38 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-0c4hYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:39 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)) 09:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:39 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-dOXvJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:39 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)) 09:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:39 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-U7XJXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:39 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)) 09:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:39 INFO - Running setup.py (path:/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/pip-4xNK3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:39 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)) 09:36:39 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)) 09:36:39 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)) 09:36:39 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)) 09:36:39 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)) 09:36:39 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)) 09:36:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:41 INFO - Downloading blessings-1.6.tar.gz 09:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:42 INFO - Installing collected packages: blessings 09:36:42 INFO - Running setup.py install for blessings 09:36:42 INFO - Successfully installed blessings 09:36:42 INFO - Cleaning up... 09:36:42 INFO - Return code: 0 09:36:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:42 INFO - Reading from file tmpfile_stdout 09:36:42 INFO - Current package versions: 09:36:42 INFO - blessings == 1.6 09:36:42 INFO - blobuploader == 1.2.4 09:36:42 INFO - docopt == 0.6.1 09:36:42 INFO - functools32 == 3.2.3-2 09:36:42 INFO - jsonschema == 2.5.1 09:36:42 INFO - manifestparser == 1.1 09:36:42 INFO - mozInstall == 1.12 09:36:42 INFO - mozcrash == 1.0 09:36:42 INFO - mozdebug == 0.1 09:36:42 INFO - mozdevice == 0.49 09:36:42 INFO - mozfile == 1.2 09:36:42 INFO - mozhttpd == 0.7 09:36:42 INFO - mozinfo == 0.9 09:36:42 INFO - mozleak == 0.1 09:36:42 INFO - mozlog == 3.4 09:36:42 INFO - moznetwork == 0.27 09:36:42 INFO - mozprocess == 0.24 09:36:42 INFO - mozprofile == 0.28 09:36:42 INFO - mozrunner == 6.13 09:36:42 INFO - mozscreenshot == 0.1 09:36:42 INFO - mozsystemmonitor == 0.3 09:36:42 INFO - moztest == 0.8 09:36:42 INFO - mozversion == 1.4 09:36:42 INFO - psutil == 3.1.1 09:36:42 INFO - requests == 1.2.3 09:36:42 INFO - wsgiref == 0.1.2 09:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:42 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')]} 09:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:42 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')]} 09:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:42 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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:42 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 09:36:42 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 09:36:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:42 INFO - 'HOME': '/Users/cltbld', 09:36:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:42 INFO - 'LOGNAME': 'cltbld', 09:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:42 INFO - 'MOZ_NO_REMOTE': '1', 09:36:42 INFO - 'NO_EM_RESTART': '1', 09:36:42 INFO - 'PAGER': '/bin/cat', 09:36:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:42 INFO - 'PWD': '/builds/slave/test', 09:36:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:42 INFO - 'SHELL': '/bin/bash', 09:36:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:42 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:42 INFO - 'USER': 'cltbld', 09:36:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:42 INFO - 'XPC_FLAGS': '0x0', 09:36:42 INFO - 'XPC_SERVICE_NAME': '0', 09:36:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 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)) 09:36:42 INFO - Cleaning up... 09:36:42 INFO - Return code: 0 09:36:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36:42 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')]} 09:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:42 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')]} 09:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:42 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 0x102683b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102686768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb0b1cf0a80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, '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.kfkhJPysaH/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.ix2TDN3PDr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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 09:36:42 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 09:36:42 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 09:36:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:36:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:42 INFO - 'HOME': '/Users/cltbld', 09:36:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:42 INFO - 'LOGNAME': 'cltbld', 09:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:42 INFO - 'MOZ_NO_REMOTE': '1', 09:36:42 INFO - 'NO_EM_RESTART': '1', 09:36:42 INFO - 'PAGER': '/bin/cat', 09:36:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:42 INFO - 'PWD': '/builds/slave/test', 09:36:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:42 INFO - 'SHELL': '/bin/bash', 09:36:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:36:42 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:36:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:42 INFO - 'USER': 'cltbld', 09:36:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:42 INFO - 'XPC_FLAGS': '0x0', 09:36:42 INFO - 'XPC_SERVICE_NAME': '0', 09:36:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:36:43 INFO - Cleaning up... 09:36:43 INFO - Return code: 0 09:36:43 INFO - Running post-action listener: _resource_record_post_action 09:36:43 INFO - Running post-action listener: _start_resource_monitoring 09:36:43 INFO - Starting resource monitoring. 09:36:43 INFO - [mozharness: 2017-02-06 17:36:43.183210Z] Finished create-virtualenv step (success) 09:36:43 INFO - [mozharness: 2017-02-06 17:36:43.184212Z] Running install step. 09:36:43 INFO - Running pre-action listener: _resource_record_pre_action 09:36:43 INFO - Running main action method: install 09:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:43 INFO - Reading from file tmpfile_stdout 09:36:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:43 INFO - Reading from file tmpfile_stdout 09:36:43 INFO - Output received: 09:36:43 INFO - Usage: mozinstall [options] installer 09:36:43 INFO - Options: 09:36:43 INFO - -h, --help show this help message and exit 09:36:43 INFO - -d DEST, --destination=DEST 09:36:43 INFO - Directory to install application into. [default: 09:36:43 INFO - "/builds/slave/test"] 09:36:43 INFO - --app=APP Application being installed. [default: firefox] 09:36:43 INFO - mkdir: /builds/slave/test/build/application 09:36:43 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'] 09:36:43 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 09:37:05 INFO - Reading from file tmpfile_stdout 09:37:05 INFO - Output received: 09:37:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:37:05 INFO - Running post-action listener: _resource_record_post_action 09:37:05 INFO - [mozharness: 2017-02-06 17:37:05.270627Z] Finished install step (success) 09:37:05 INFO - [mozharness: 2017-02-06 17:37:05.270759Z] Running run-tests step. 09:37:05 INFO - Running pre-action listener: _resource_record_pre_action 09:37:05 INFO - Running main action method: run_tests 09:37:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:37:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:37:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:37:05 INFO - 2017-02-06 09:37:05.285 screenresolution[2519:291607] starting screenresolution argv=screenresolution get 09:37:05 INFO - 2017-02-06 09:37:05.288 screenresolution[2519:291607] Display 0: 1600x1200x32@60 09:37:05 INFO - 2017-02-06 09:37:05.293 screenresolution[2520:291610] starting screenresolution argv=screenresolution list 09:37:05 INFO - Available Modes on Display 0 09:37:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:37:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:37:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:37:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:37:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:37:05 INFO - Intel Iris: 09:37:05 INFO - Chipset Model: Intel Iris 09:37:05 INFO - Type: GPU 09:37:05 INFO - Bus: Built-In 09:37:05 INFO - VRAM (Dynamic, Max): 1536 MB 09:37:05 INFO - Vendor: Intel (0x8086) 09:37:05 INFO - Device ID: 0x0a2e 09:37:05 INFO - Revision ID: 0x0009 09:37:05 INFO - Displays: 09:37:05 INFO - Display: 09:37:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:37:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:37:05 INFO - Display Serial Number: 1600x1200 60 09:37:05 INFO - Main Display: Yes 09:37:05 INFO - Mirror: Off 09:37:05 INFO - Online: Yes 09:37:05 INFO - Rotation: Supported 09:37:05 INFO - Return code: 0 09:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:37:05 INFO - Python 2.7.3 09:37:05 INFO - Return code: 0 09:37:05 INFO - grabbing minidump binary from tooltool 09:37:05 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')]} 09:37:05 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 0x102461d30>, '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 0x102388db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102456be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:37:05 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 09:37:05 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 09:37:05 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 09:37:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:37:05 INFO - Return code: 0 09:37:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:37:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:37:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:37:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:37:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:37:05 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/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 09:37:05 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/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0337 --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 09:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kfkhJPysaH/Render', 09:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:37:05 INFO - 'HOME': '/Users/cltbld', 09:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:37:05 INFO - 'LOGNAME': 'cltbld', 09:37:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:37:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:37:05 INFO - 'MOZ_NO_REMOTE': '1', 09:37:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:37:05 INFO - 'NO_EM_RESTART': '1', 09:37:05 INFO - 'PAGER': '/bin/cat', 09:37:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:37:05 INFO - 'PWD': '/builds/slave/test', 09:37:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:37:05 INFO - 'SHELL': '/bin/bash', 09:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ix2TDN3PDr/Listeners', 09:37:05 INFO - 'TMPDIR': '/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/', 09:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:37:05 INFO - 'USER': 'cltbld', 09:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:37:05 INFO - 'XPC_FLAGS': '0x0', 09:37:05 INFO - 'XPC_SERVICE_NAME': '0', 09:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:37:05 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/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0337', '--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 09:37:05 INFO - mozversion application_buildid: 20170206081455 09:37:05 INFO - mozversion application_changeset: 7f1b358fb17dfd982c5e18c34d5735cd481c7f7c 09:37:05 INFO - mozversion application_display_name: Nightly 09:37:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:37:05 INFO - mozversion application_name: Firefox 09:37:05 INFO - mozversion application_remotingname: firefox 09:37:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:37:05 INFO - mozversion application_vendor: Mozilla 09:37:05 INFO - mozversion application_version: 54.0a1 09:37:05 INFO - mozversion platform_buildid: 20170206081455 09:37:05 INFO - mozversion platform_changeset: 7f1b358fb17dfd982c5e18c34d5735cd481c7f7c 09:37:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:37:05 INFO - mozversion platform_version: 54.0a1 09:37:05 INFO - using testdate: 1486402625 09:37:05 INFO - actual date: 1486402625 09:37:05 INFO - starting webserver on 'localhost:53689' 09:37:05 INFO - SUITE-START | Running 2 tests 09:37:05 INFO - TEST-START | dromaeo_css 09:37:05 INFO - operating with platform_type : mac_ 09:37:05 INFO - Initialising browser for dromaeo_css test... 09:37:05 INFO - TEST-INFO | started process 2530 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpeZZJSO/profile http://localhost:53689/getInfo.html) 09:37:08 INFO - PROCESS | 2530 | 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] 09:37:08 INFO - PROCESS | 2530 | 2017-02-06 09:37:08.982 plugin-container[2532:291767] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 09:37:08 INFO - PROCESS | 2530 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:37:08 INFO - PROCESS | 2530 | 2017-02-06 09:37:08.985 plugin-container[2532:291767] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 09:37:08 INFO - PROCESS | 2530 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:37:08 INFO - PROCESS | 2530 | 2017-02-06 09:37:08.986 plugin-container[2532:291767] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:37:09 INFO - PROCESS | 2530 | __metrics Screen width/height:1600/1200 09:37:09 INFO - PROCESS | 2530 | colorDepth:24 09:37:09 INFO - PROCESS | 2530 | Browser inner width/height: 1024/689 09:37:09 INFO - PROCESS | 2530 | __metrics 09:37:09 ERROR - PROCESS | 2530 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 09:37:09 INFO - PROCESS | 2530 | 1486402629164 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/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpeZZJSO/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpeZZJSO/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpeZZJSO/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpeZZJSO/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:37:09 INFO - TEST-INFO | 2530: exit 0 09:37:09 INFO - Browser initialized. 09:37:09 INFO - Running cycle 1/1 for dromaeo_css test... 09:37:09 INFO - TEST-INFO | started process 2533 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpeZZJSO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:37:12 INFO - PROCESS | 2533 | 2017-02-06 09:37:12.480 plugin-container[2534:291884] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 09:37:12 INFO - PROCESS | 2533 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:37:12 INFO - PROCESS | 2533 | 2017-02-06 09:37:12.481 plugin-container[2534:291884] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 09:37:12 INFO - PROCESS | 2533 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:37:12 INFO - PROCESS | 2533 | 2017-02-06 09:37:12.481 plugin-container[2534:291884] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:37:22 INFO - PROCESS | 2533 | RSS: Main: 233377792 09:37:22 INFO - PROCESS | 2533 | 09:40:24 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53689/tests/dromaeo/cssquery-ext.html) 09:40:25 INFO - PROCESS | 2533 | RSS: Main: 255885312 09:40:25 INFO - PROCESS | 2533 | 09:42:10 INFO - PROCESS | 2533 | ************************* 09:42:10 INFO - PROCESS | 2533 | A coding exception was thrown and uncaught in a Task. 09:42:10 INFO - PROCESS | 2533 | 09:42:10 ERROR - PROCESS | 2533 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:42:10 INFO - PROCESS | 2533 | Full stack: 09:42:10 INFO - PROCESS | 2533 | ************************* 09:43:28 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-ext.html (next: http://localhost:53689/tests/dromaeo/cssquery-jquery.html) 09:43:29 INFO - PROCESS | 2533 | RSS: Main: 266194944 09:43:29 INFO - PROCESS | 2533 | 09:46:30 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53689/tests/dromaeo/cssquery-mootools.html) 09:46:31 INFO - PROCESS | 2533 | RSS: Main: 276545536 09:46:31 INFO - PROCESS | 2533 | 09:49:33 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53689/tests/dromaeo/cssquery-prototype.html) 09:49:34 INFO - PROCESS | 2533 | RSS: Main: 269778944 09:49:34 INFO - PROCESS | 2533 | 09:52:37 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53689/tests/dromaeo/cssquery-yui.html) 09:52:37 INFO - PROCESS | 2533 | RSS: Main: 274735104 09:52:37 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-yui.html (next: http://localhost:53689/tests/dromaeo/cssquery-dojo.html) 09:55:40 INFO - PROCESS | 2533 | RSS: Main: 279506944 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | __start_tp_report 09:55:40 INFO - PROCESS | 2533 | _x_x_mozilla_page_load 09:55:40 INFO - PROCESS | 2533 | _x_x_mozilla_page_load_details 09:55:40 INFO - PROCESS | 2533 | |i|pagename|runs| 09:55:40 INFO - PROCESS | 2533 | |0;dojo.html;3028.606281183446;3267.673232676733;3323.833808309584;3325.833708314584;3332.6833950774685;4807.711537307764;5484.067708489556;5525.668459892409;5561.47166019228;5565.916511252334;5332.200169974506;5415.566754659628;5536.916946245809;5572.832815015556;5630;4988.925166122502;4997.475265097149;5069.315642388267;5080.720560369178;5082.186850103984;4341.6092551670345;4994.375703037121;5089.389273287192;5092.210707340369;5136.743162841862;4925.4335751388335;5108.106081435771;5122.436531981479;5129.281900533928;5136.666116702402;4958.380202474691;5009.824656137054;5018.222175562793;5025.748712564394;5026.447090820006;4926.704397736112;4983.07813054586;5001.24981252815;5001.3998320201445;5005.57452616528;5370.489803468664;5508.20131080995;5523.530499907512;5565.359983601857;5596.524295434893;6066;6069.089636554508;6070.180525629028;6070.787522436738;6086.360932102154;5099.818149117725;5902.380250073724;6051.334353221142;6172.135900973867;6192.628442293477;5573.498385145356;5686.971565142189;5715.799947001835;5723.771049158028;5796.594238403271;6106.694665266719;6124.142620033199;6155.35368786271;6174.25908890927;6176.474999625082;5986.9401305986385;6052.303985041688;6068.120122582201;6072.39276072398;6079;5913.615614985012;6039.033754599243;6085.2393450818645;6104.26748790148;6140.263168419819;5155.793768249303;5820.592558520948;5910.379410161957;6040.697965101727;6060.33336333003;6119.318721178302;6120.081987701791;6141.455323060903;6144.279601711528;6167.599106058092;4860.36815214027;4918.163912134945;4927.408710954708;4928.457869634337;4968.627352948543;4274.829006839754;4276.529581746067;4293.677974151951;4321.573880619388;4329.610335069859;5705.657660540381;5711.685857277889;5718.571107166979;5727.4845263926445;5741.88516229673;6131.356207598227;6153.815385538441;6171.444569988633;6172.845678858064;6196.287426945959;5523.8895222096135;5567.944320556823;5623.831285061455;5640.238567793295;5678.602497825113;5347.625666203328;5356.464353564613;5358.142697168434;5369.6509726867625;5376.973115134399;6182;6191.690415479208;6203.255609326729;6218.06728990655;6227.09707092469;5687.77248910039;5759.136129580596;6098.695065246809;6146.723397447215;6175.536834737323;6071.635701857903;6186.443220110212;6192.752289908353;6199.535034872493;6230.314665386713;5865.501432378295;6014.248218972629;6055.666938318259;6080.422359875804;6094.847628809315;5781.306243250837;5929.495992840657;6121.1430399743185;6133.693315334126;6138.416850399205;5978.192943952685;5978.9402105980125;6007.459328660441;6027.427394397525;6089.147519347383;5984.251968503937;5984.790532331347;6059.818205453844;6060.757569697339;6065.090236464565;4530.546945305443;5566.471185237396;5757.050086735641;5766.740496677576;5943.138244954544;5974.761009559569;5989.610675306091;6003.129546215687;6006.459418652343;6032.33644299118;5791.9131213031;5818.359980402068;5824.825255242349;5835.387284335084;5836.095405212199 09:55:40 INFO - PROCESS | 2533 | |1;ext.html;448.7733694484283;449.4606472233321;459.75862672097156;478.23243693871314;495.1631742355418;27880.721192788067;40926.38610420846;40931;43765.56234437654;44425;42248.78875605625;42720;42896;42919;43009.139817203715;9090.772730681736;9300.581473833694;9312.30157738169;9321.953390233039;10749.301295415811;10737.852429514089;11041.779164416706;11043.72390690231;11052.281601695904;11058.778824423507;10111.140553052963;10373.599564058868;11051.447427628627;11090.057345125633;11090.500927458243;11013.28413653114;11075.833862492069;11081.667549973514;11089.944550277278;11099.500522476508;11022.779544409148;11082.944585277102;11086.002259796656;11096.944515277453;11097.056750176245;36163.4575481368;36339.091522712144;36502.26995460076;36504.087397815005;36534;3857.961420385788;3889.1638297765835;3894.6300101490315;3896.7467114637457;3910.2179564087296;27226.86386568074;27935.161945141677;28033;28191.436171276666;28230.72961716707;3115.12776422602;3232.69289417505;3246.821424821634;3296.571445712042;3297.241634424072;462272;469131;473231;473641;479476.6026169882;44700.55299446964;46017.07965840664;47359.76320118377;55165;55559.88880222373;56857.715711422;57620;57661.711691441276;61635;61815.38184618186;14505.492307769178;14647;14720.263986800832;14724.33740481681;14732.189729564763;11077.335359878432;11178.329300242012;11214.831777523344;11221.943890280496;11260.38067906273;17541.649167016843;17670.381536646157;17675.20461579232;17699.29202831898;17700;7927.009123859518;7988.520688758693;8055.516668999879;8063.475874068166;8122.553259570662;730.087390761548;845.2899564365962;847.8304339132075;858.9613467393982;869.5391442535466;27104.32239194036;28506.144815655563;29345.7065429343;29346.559801602994;29879.850600746857;876.2595606712318;892.9464232146092;1008.863803386548;1013.5236438873718;1190.1787766441128;14755;15225.390984360502;15438.305276262596;15515.689686206439;15543.844561554466;609792;627605;637673;639229;640481;59107.40892591105;59137.70431147903;59212;59295.81408371808;59365.70317148473;1354.1401210231575;1392.6587985943509;1398.6643205630576;1404.9719005619831;1409.8872090232962;21699.891500542395;26955.595666064633;28219.858900706186;28453.861845526775;29483.41033179367;47928.76035619799;48947.02105957932;49049;49116;49155.50844491652;421174;543650;544789;545686;548146;23764.88117559401;24511.63232551549;24545;25327.860246288594;25981.350466237738;40825;41029.38455923223;41062.1787564253;41593.37609935914;41757;34543.82728086444;34717.47923781196;34763.957081287605;35528.82235588909;35853.64146358607;26022.60966085548;33711.4943275856;33760;35067.473987889694;35116.82441587776;33498.497522536694;34291.485627715105;34346.313073738886;35351.11622209465;35354.82322588371;26791.464170716867;29350;31068.434295716805;32737.508937366434;32937.84717534971;23884.522309553366;24014;24052.51894962126;24056.037758490165;24550.508989819748 09:55:40 INFO - PROCESS | 2533 | |2;jquery.html;356.9089882080069;389.3439554350917;396.1843218709131;404.69243375034966;425.8913976935881;14282.4287028519;19982.900085499572;20148.294809681665;20677.379678609628;20831.687524687124;20801.959902004877;20882.791172088273;20901.790982090173;21111.366659000254;21169.259075932347;5221.843344699665;5601.131824567178;5650.858728531799;5660.518855897254;5677.205191273225;4959.280904268879;5411.702356370398;5533.418991005947;5570.275864137657;5619.381867994517;5488.643238189525;5534.944650553503;5546.722663866811;5549.38956714761;5572.944270557304;5382.4886635769535;5467.289252397183;5469.945300547023;5521.558275337963;5554.166874968767;4854.878628034292;4900.460949295574;4900.877478063041;4909.165441874889;4909.8772530686665;23760.7623923762;24329.39176520601;24438.511229775482;24548.018079276986;24665.63001554978;2611.125273033536;2651.469706058777;2689.2066840282164;2689.6329843839053;2709.2684975056823;14489;14984;15068.849311506854;15074.170920599363;15567.299471523695;1773.6630040292303;1780.97328540072;1797.2810875649714;1798.4245041586698;1827.2964908510319;104738;108465.99999999921;130221.69778302191;133460;134354.3282283592;11392.487338069806;11889.940550297193;12068.948278792626;12241.387930603434;12247.32639704807;13771.449142034407;14275.357608907623;15531.06813591188;15538;15540.30068646891;10159.339642923187;10450.738731531772;10656.78686426267;10715.892841071645;10841.241113122005;8433.40966132377;8528;8566.61450234741;8570.271526920282;8927.285817134743;10515.84226236607;10562.31344962575;10610.575576976835;10698.73253168677;10715.83926241107;3490.7207423406066;4038.2529232092156;4140.192662430797;4156.625903668684;4177.185448837508;984.778424854402;990.1929927109383;991.4002028772488;1010.2826992835022;1038.0968557354997;20732.274370397266;21561.784382156293;21569.78430215709;21738.34784956454;21935.451613709785;755.5919803306153;760.8097975506123;983.5475681186591;1003.5634498992962;1011.7875246198233;8635.784105397415;10361.378317300987;10626.574937002433;10737.463126843782;10753.193510486744;730695;731499;733518;736687;752002.2399887965;122455.38772306082;136709;147207;148076.67309942158;149978;852.3351785607236;986.9259805514615;1050.364529459681;1057.6139709006156;1061.501094485575;18726;18787.624247515247;19091.331803386816;19131.521711957314;19323.03384830725;41611.95970100772;51570.710732230495;57688.71155644195;59129.40870591239;60053;79800;82286.58856705678;87575;90309;90846.09153908376;11321.660350189508;11587.8261826071;11598.652040438801;11708.121890858049;12719.682007949876;12649.039398893186;13640.970607523934;13690.589282321545;13716.382762775898;13885.514007009706;11333.829992549954;11472.426378681199;11744.119191060534;11985.940070299594;11986.820197696867;10547.419891906018;10773.461326933779;10882.836757448804;11429.771404572028;11503.76992460163;11486.425678715863;11489.253198542068;11780.410979450822;11945.641630751092;11985.760284794429;11568.958793708607;12393.963478947715;12451.501939922302;12460.563880264148;12651.240925544496;9631.181349585084;10925.562977480811;11428.657140285804;11743.706407339885;11886.34625095628 09:55:40 INFO - PROCESS | 2533 | |3;mootools.html;1413.8303403591572;1416.8158139441864;1428.692831041326;1436.2531483628513;1437.7987081808549;8199.385046121535;8341.874871876911;8601.612927418266;8640.697575584847;8663.956680216597;8501.277391421736;8606.096359882216;8650.307975361971;8657.913420865789;8701.260392866598;2279.327598358488;2303.527776805751;2311.5839148953182;2313.3060081975423;2314.5023819878807;1890.395073576456;2264.7055882735303;2304.665823455598;2306.4925716342377;2310.90756369745;2258.119333459952;2261.536385041071;2284.5316710074394;2292.7821856923647;2293.048384920256;2195.7913998170147;2251.549690061994;2267.648514480258;2272.988520108552;2278.897449614771;1971.9309824156085;2038.3069756282787;2249.910003599854;2303.9654405183937;2318.8376813623054;8369.204925532125;8596.527191004492;8629.870551941725;8683.392162548624;8688.261497772697;4822.252550854623;5255.474452554752;5261.342332208474;5270.472952704698;5272.472752724735;3318.4690449528202;3368.7473439492137;3390.74569407293;3391.5251864738957;3526.8236588170744;1220.395904027503;1229.3054424250358;1256.9120161588692;1270.5959914294663;1276.170489182039;10888.128949684005;10896.836547451794;10968;11001.724956876062;11037.613683521038;4212.578742125763;4450.421445212101;4502.662300327489;4516.6160876325885;4545.499995000548;7396.5562066275115;8897.421667591585;8913.910860891438;8913.955430222808;8929.642814287356;4570.314452832102;5156.613254005964;5159.277701121846;5167.638265321467;5179.015986962465;3887.630675085862;4658.67389282747;4658.720476771405;4758.95241047592;4824.638152138604;3037.893673721409;3649.94525082124;3717.5724791648768;3744.64425879541;3771.830267637963;985.6205360936091;1161.512164890748;1163.7207070303066;1165.3998190931677;1172.9120315976336;837.9162083791572;853.2065179383109;860.4020205956925;887.8135591525722;900.3337530227716;5320.52115309624;5667.149927510906;5814.79648212319;5873.706314684334;5953.79161729346;880.933929955256;968.1915600473543;970.2092794372563;970.4177493503842;978.7455261631884;3706.6293370663257;3724.478572999782;3809.771413715186;3877.4765406670303;3900.902477438087;8735.43219690718;9839.311248212556;9966.950165249127;10259.333143345659;10328.122109620766;10192.439415832201;10226.744331391776;10246.436445995392;10252.333598316085;10312.329698569569;7074.929250707427;7931.801704957422;8087.959560202161;8098.635561399751;8110.026796784306;5601.383847776659;5774.740136693775;5776.480116789341;5821.214136091573;5857.4435428634215;7431.479796414199;9188.678396256098;9291.67479138227;9383.624655013997;9384.81230375375;8964.103589641245;9186.311026672893;9216.585253663467;9264.351495395258;9388.057254430647;7113.608751518716;7327.120745510573;7330.853382932418;7338.229485904117;7348.081489813773;7243.710251590088;7580.128285247267;7830.569318687527;7831.060272767304;7920.326772224425;7227.060482137288;7289.817754556178;7290.453216008927;7317.3780228679025;7361.668724907499;7053.4004609608755;7120.465965052538;7128.429725622042;7226.891596625949;7317.670704818403;6434.260060092962;6441.774537891339;6515.446187074152;6515.478761698958;6528.543001989815;4912.582430493448;4980.402351717817;5063.392392912727;5119.180931051014;5236.6857988520815;5023.422306434661;5068.746562671778;5079.263506791421;5129.230615407719;5318.8936221276135 09:55:40 INFO - PROCESS | 2533 | |4;prototype.html;364.5570631682506;367.426814169895;375.5324620847045;382.2870346803213;388.7531417549857;4395.340698895167;4741.8814529636775;5101.413337466192;5353.464653534645;5512.810264199213;5186.533212010918;5203.9219411708855;5212.582993360532;5223.503767142115;5232.529072383485;3689.3728066228805;3981.7810020448865;4030.415589739486;4032.1330913853517;4035.4955630546183;3654.2143439160577;4033.306011475173;4041.3937909313545;4042.2117687051036;4054.776987265699;3663.8534458621625;3884.4367566702954;3938.448617193595;3957.2085582883396;3981.9203615927663;3642.9271414571826;3943.5464921533962;3947.2106777493495;3962.4254483100076;3989.3218152914073;2905.956410653821;2907.767378609706;3164.357761269343;3484.651534846495;3497.3005398920063;4550.658700597435;4816.397950256218;4934.629902757308;5162.353881506674;5225.6603320784025;4177.663147792708;4357.934630980538;4444.488883778375;4604.769761511911;4654.976725116353;5547.417521160261;5568.9443105569235;5586.469285417878;5589.469000444951;5605.523530499912;3540.327337805809;3837.9808100959594;3841.3661745812187;3848.5766565677754;3859;5403.891922161574;5487.368952570466;5584.93886161628;5620.915686264669;5724.4561766632105;3859.4017927221325;3878.944159595419;3902.043999220209;3904.1996390739832;3939.4484772131923;3497.2306092659574;3609.3683605368956;3918.5689574146822;3951.5258169019903;3955.8219880105466;3971.324874771296;4273.508546517128;4617.792199351037;4619.399478067897;4631.884202894955;5078.359253188321;5618.129189975561;5640.238567793295;5663.207150998864;5673.383085820604;1125.9268147570544;1280.9103362764517;1282.7434513097419;1294.249335385474;1306.3337697774205;815.5718247919771;873.275181599271;878.8136016377839;883.8024476833798;886.7118186589255;4383.649308055348;5014.971930754186;5037.546620804072;5075.198304601813;5094.694318340911;5201.817936372209;5223.373195216598;5565.523342112802;5620.269364982608;5623.943760562423;4265.87202383929;4663.766811659403;4950.727709975986;5075.4115401144945;5107.233914912718;2630.526505229039;2854.4005758790886;2911.7233862783;2916.9270768230963;2945.5434407666844;4966.428860680996;5155.948440515622;5617.887642247132;5769.509591684669;5794.536437085023;4815.398075240595;4943.950560494421;5135.486451354835;5504.504594586427;5990.580659353804;5051.646384753032;6016.42843929826;6025.728842202111;6031.517478601701;6031.60794548353;4857.489963553776;5678.886422271614;5815.738291776965;5822.5633077518505;5846.883062338815;5477.287952566141;5702.232307984372;5777.277840269966;5804.111245465632;5828.912566311594;4992.975035124801;5029.466012866111;5774.56690748204;5887.498687834574;5984.910226346696;3423.767443720209;3574.428091505347;3896.1038961038553;3896.4998475586535;3956.248312820555;4840.741407234215;5370.704611246419;5610.85972850682;5709.942900570941;5813.912791308049;4650.46519650231;5169.586433085419;5550.250716153268;5556;5587.7485513152815;4937.506249375034;5579.721013949367;5580.135079062752;5620.269364982526;5642.774289028393;4088.7546747195265;5226.869328266824;5309.973450132725;5420;5494.8844694792;5110.923336149886;5222.033923724123;5514.696691681996;5550.5282051026115;5625.21247025425;4555.157295900269;5060.291559181644;5209.348831396075;5512.5589952804485;5525.806596769094 09:55:40 INFO - PROCESS | 2533 | |5;yui.html;716.6416791604198;726.7819654103768;776.9782735702554;824.653645468903;831.4595512916603;12155.635330940064;13162.407691653874;14488.492902748407;15238.695226095471;15321.693566128684;15495.147766872817;15658.295376708047;16118.677626447494;16128.112953787537;16129.354825806953;890.6749036601626;919.4667093086027;922.4280945813605;923.4551614547415;930.9255259579218;705.407457735502;888.6667499687617;909.6497848328376;923.9168474837263;927.4991504587515;955.0544960489101;958.884933807944;959.4099628728317;962.9711108666751;965.1169180200109;951.2675240065146;952.5618215620823;957.7749228931195;962.0619895601767;963.2197919685077;714.58196954781;715.8425146467821;719.9280071992758;721.3579913876654;723.6526467295674;14951.850481495154;14954.327055282429;15097.622559435993;15125.924370378078;15180.468683596131;14255.215963122024;14537.78193327101;14601.707965840624;14627.341769620392;14647.633809154857;11549.711257218552;11577.94211028948;11663.59177428786;11688.298702077818;11714.70713232176;3566.28674265148;3626.709863210937;3700.703943684499;3701.3337599232127;3854.69162467002;87363;109161;109303;110000.4499977503;111800;9224.37480780489;11112.499937502831;11422.657320280405;11470.197086203885;11586;19350.90324548368;23860.045598176224;24064;24190.274291771275;24566.754332456803;7771.533707977426;7843.490173138728;7879.251471110236;7934.404919631051;8044.557549334726;4133.91732165361;4179.558863032623;4224.134052519226;4250.213710463512;4253.468316460442;3492.1967947372245;3591.694705949971;3636.309101270803;3637.1089083174793;3641.4537819326783;529.1559961860826;530.2920600997711;531.805890849837;540.3758658749151;543.0252696409954;671.4058058618158;682.382443888282;686.9107016087877;693.9132608423947;702.4064665357764;9696.224302055818;10111.854139802792;10131.392116473035;10184.287099903084;10194.949025254975;657.283560918601;670.8188789027033;693.3309356471029;707.9469039822034;709.5990765217635;4750.311204875274;4807.663463557517;4863.367762190964;4868.586170175504;4873.244647079709;102698.45952310722;103533;104965;105885;105956;70284.94572581415;73902.63048684722;74495.62752186204;83828.58085709532;84876.57561712152;69553;69724.3027569728;70609.29390706027;71002.64498677473;71340.68034524945;9958.55186516594;10206.948965255126;10582.682519524427;10797.460126993776;10919.12646988223;33999;48654.513454864995;49269.260961084896;49531.75234123806;49872.25191622056;55554.166687500525;57348.853022940144;60476.697616511636;62032.689836550526;66623.66688166528;12880.098393112767;13022.80465792995;13307.46770129184;13329.66675833112;13520.323983800574;14470.565883023526;14508;14591.562253132422;14683.853161468249;15180.165090920105;11277.661670149908;13424.060315778192;13446.184765056592;13575.185488870698;13652.317384130953;10870.347779133277;12809.359532023547;12829.807552886901;12859.352392356508;13100.737985240432;11909.166358354832;12041.157119001586;12070.577529786415;12098.939505302416;12172.695682608006;9500.524973751422;10892.237543372205;11189.888101118884;11191.16066295015;11238.381888996184;10030.247731420026;10828.620998265023;10883.727906802393;10889.618863339745;10921.180911431833 09:55:40 INFO - PROCESS | 2533 | __end_tp_report 09:55:40 INFO - PROCESS | 2533 | __start_cc_report 09:55:40 INFO - PROCESS | 2533 | _x_x_mozilla_cycle_collect,414 09:55:40 INFO - PROCESS | 2533 | __end_cc_report 09:55:40 INFO - PROCESS | 2533 | __startTimestamp1486403740630__endTimestamp 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | ------- Summary: start ------- 09:55:40 INFO - PROCESS | 2533 | Number of tests: 6 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | [#0] dojo.html Cycles:165 Average:5588.09 Median:5781.31 stddev:649.04 (11.2%) stddev-sans-first:619.19 09:55:40 INFO - PROCESS | 2533 | Values: 3028.6 3267.7 3323.8 3325.8 3332.7 4807.7 5484.1 5525.7 5561.5 5565.9 5332.2 5415.6 5536.9 5572.8 5630.0 4988.9 4997.5 5069.3 5080.7 5082.2 4341.6 4994.4 5089.4 5092.2 5136.7 4925.4 5108.1 5122.4 5129.3 5136.7 4958.4 5009.8 5018.2 5025.7 5026.4 4926.7 4983.1 5001.2 5001.4 5005.6 5370.5 5508.2 5523.5 5565.4 5596.5 6066.0 6069.1 6070.2 6070.8 6086.4 5099.8 5902.4 6051.3 6172.1 6192.6 5573.5 5687.0 5715.8 5723.8 5796.6 6106.7 6124.1 6155.4 6174.3 6176.5 5986.9 6052.3 6068.1 6072.4 6079.0 5913.6 6039.0 6085.2 6104.3 6140.3 5155.8 5820.6 5910.4 6040.7 6060.3 6119.3 6120.1 6141.5 6144.3 6167.6 4860.4 4918.2 4927.4 4928.5 4968.6 4274.8 4276.5 4293.7 4321.6 4329.6 5705.7 5711.7 5718.6 5727.5 5741.9 6131.4 6153.8 6171.4 6172.8 6196.3 5523.9 5567.9 5623.8 5640.2 5678.6 5347.6 5356.5 5358.1 5369.7 5377.0 6182.0 6191.7 6203.3 6218.1 6227.1 5687.8 5759.1 6098.7 6146.7 6175.5 6071.6 6186.4 6192.8 6199.5 6230.3 5865.5 6014.2 6055.7 6080.4 6094.8 5781.3 5929.5 6121.1 6133.7 6138.4 5978.2 5978.9 6007.5 6027.4 6089.1 5984.3 5984.8 6059.8 6060.8 6065.1 4530.5 5566.5 5757.1 5766.7 5943.1 5974.8 5989.6 6003.1 6006.5 6032.3 5791.9 5818.4 5824.8 5835.4 5836.1 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | [#1] ext.html Cycles:180 Average:66579.27 Median:34445.07 stddev:145945.45 (423.7%) stddev-sans-first:146270.40 09:55:40 INFO - PROCESS | 2533 | Values: 448.8 449.5 459.8 478.2 495.2 27880.7 40926.4 40931.0 43765.6 44425.0 42248.8 42720.0 42896.0 42919.0 43009.1 9090.8 9300.6 9312.3 9322.0 10749.3 10737.9 11041.8 11043.7 11052.3 11058.8 10111.1 10373.6 11051.4 11090.1 11090.5 11013.3 11075.8 11081.7 11089.9 11099.5 11022.8 11082.9 11086.0 11096.9 11097.1 36163.5 36339.1 36502.3 36504.1 36534.0 3858.0 3889.2 3894.6 3896.7 3910.2 27226.9 27935.2 28033.0 28191.4 28230.7 3115.1 3232.7 3246.8 3296.6 3297.2 462272.0 469131.0 473231.0 473641.0 479476.6 44700.6 46017.1 47359.8 55165.0 55559.9 56857.7 57620.0 57661.7 61635.0 61815.4 14505.5 14647.0 14720.3 14724.3 14732.2 11077.3 11178.3 11214.8 11221.9 11260.4 17541.6 17670.4 17675.2 17699.3 17700.0 7927.0 7988.5 8055.5 8063.5 8122.6 730.1 845.3 847.8 859.0 869.5 27104.3 28506.1 29345.7 29346.6 29879.9 876.3 892.9 1008.9 1013.5 1190.2 14755.0 15225.4 15438.3 15515.7 15543.8 609792.0 627605.0 637673.0 639229.0 640481.0 59107.4 59137.7 59212.0 59295.8 59365.7 1354.1 1392.7 1398.7 1405.0 1409.9 21699.9 26955.6 28219.9 28453.9 29483.4 47928.8 48947.0 49049.0 49116.0 49155.5 421174.0 543650.0 544789.0 545686.0 548146.0 23764.9 24511.6 24545.0 25327.9 25981.4 40825.0 41029.4 41062.2 41593.4 41757.0 34543.8 34717.5 34764.0 35528.8 35853.6 26022.6 33711.5 33760.0 35067.5 35116.8 33498.5 34291.5 34346.3 35351.1 35354.8 26791.5 29350.0 31068.4 32737.5 32937.8 23884.5 24014.0 24052.5 24056.0 24550.5 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | [#2] jquery.html Cycles:180 Average:40250.74 Median:19652.97 stddev:122200.55 (621.8%) stddev-sans-first:122506.64 09:55:40 INFO - PROCESS | 2533 | Values: 356.9 389.3 396.2 404.7 425.9 14282.4 19982.9 20148.3 20677.4 20831.7 20802.0 20882.8 20901.8 21111.4 21169.3 5221.8 5601.1 5650.9 5660.5 5677.2 4959.3 5411.7 5533.4 5570.3 5619.4 5488.6 5534.9 5546.7 5549.4 5572.9 5382.5 5467.3 5469.9 5521.6 5554.2 4854.9 4900.5 4900.9 4909.2 4909.9 23760.8 24329.4 24438.5 24548.0 24665.6 2611.1 2651.5 2689.2 2689.6 2709.3 14489.0 14984.0 15068.8 15074.2 15567.3 1773.7 1781.0 1797.3 1798.4 1827.3 104738.0 108466.0 130221.7 133460.0 134354.3 11392.5 11889.9 12068.9 12241.4 12247.3 13771.4 14275.4 15531.1 15538.0 15540.3 10159.3 10450.7 10656.8 10715.9 10841.2 8433.4 8528.0 8566.6 8570.3 8927.3 10515.8 10562.3 10610.6 10698.7 10715.8 3490.7 4038.3 4140.2 4156.6 4177.2 984.8 990.2 991.4 1010.3 1038.1 20732.3 21561.8 21569.8 21738.3 21935.5 755.6 760.8 983.5 1003.6 1011.8 8635.8 10361.4 10626.6 10737.5 10753.2 730695.0 731499.0 733518.0 736687.0 752002.2 122455.4 136709.0 147207.0 148076.7 149978.0 852.3 986.9 1050.4 1057.6 1061.5 18726.0 18787.6 19091.3 19131.5 19323.0 41612.0 51570.7 57688.7 59129.4 60053.0 79800.0 82286.6 87575.0 90309.0 90846.1 11321.7 11587.8 11598.7 11708.1 12719.7 12649.0 13641.0 13690.6 13716.4 13885.5 11333.8 11472.4 11744.1 11985.9 11986.8 10547.4 10773.5 10882.8 11429.8 11503.8 11486.4 11489.3 11780.4 11945.6 11985.8 11569.0 12394.0 12451.5 12460.6 12651.2 9631.2 10925.6 11428.7 11743.7 11886.3 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | [#3] mootools.html Cycles:180 Average:5439.53 Median:5246.08 stddev:2987.34 (56.9%) stddev-sans-first:2980.40 09:55:40 INFO - PROCESS | 2533 | Values: 1413.8 1416.8 1428.7 1436.3 1437.8 8199.4 8341.9 8601.6 8640.7 8664.0 8501.3 8606.1 8650.3 8657.9 8701.3 2279.3 2303.5 2311.6 2313.3 2314.5 1890.4 2264.7 2304.7 2306.5 2310.9 2258.1 2261.5 2284.5 2292.8 2293.0 2195.8 2251.5 2267.6 2273.0 2278.9 1971.9 2038.3 2249.9 2304.0 2318.8 8369.2 8596.5 8629.9 8683.4 8688.3 4822.3 5255.5 5261.3 5270.5 5272.5 3318.5 3368.7 3390.7 3391.5 3526.8 1220.4 1229.3 1256.9 1270.6 1276.2 10888.1 10896.8 10968.0 11001.7 11037.6 4212.6 4450.4 4502.7 4516.6 4545.5 7396.6 8897.4 8913.9 8914.0 8929.6 4570.3 5156.6 5159.3 5167.6 5179.0 3887.6 4658.7 4658.7 4759.0 4824.6 3037.9 3649.9 3717.6 3744.6 3771.8 985.6 1161.5 1163.7 1165.4 1172.9 837.9 853.2 860.4 887.8 900.3 5320.5 5667.1 5814.8 5873.7 5953.8 880.9 968.2 970.2 970.4 978.7 3706.6 3724.5 3809.8 3877.5 3900.9 8735.4 9839.3 9967.0 10259.3 10328.1 10192.4 10226.7 10246.4 10252.3 10312.3 7074.9 7931.8 8088.0 8098.6 8110.0 5601.4 5774.7 5776.5 5821.2 5857.4 7431.5 9188.7 9291.7 9383.6 9384.8 8964.1 9186.3 9216.6 9264.4 9388.1 7113.6 7327.1 7330.9 7338.2 7348.1 7243.7 7580.1 7830.6 7831.1 7920.3 7227.1 7289.8 7290.5 7317.4 7361.7 7053.4 7120.5 7128.4 7226.9 7317.7 6434.3 6441.8 6515.4 6515.5 6528.5 4912.6 4980.4 5063.4 5119.2 5236.7 5023.4 5068.7 5079.3 5129.2 5318.9 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | [#4] prototype.html Cycles:180 Average:4464.48 Median:5033.51 stddev:1373.50 (27.3%) stddev-sans-first:1342.43 09:55:40 INFO - PROCESS | 2533 | Values: 364.6 367.4 375.5 382.3 388.8 4395.3 4741.9 5101.4 5353.5 5512.8 5186.5 5203.9 5212.6 5223.5 5232.5 3689.4 3981.8 4030.4 4032.1 4035.5 3654.2 4033.3 4041.4 4042.2 4054.8 3663.9 3884.4 3938.4 3957.2 3981.9 3642.9 3943.5 3947.2 3962.4 3989.3 2906.0 2907.8 3164.4 3484.7 3497.3 4550.7 4816.4 4934.6 5162.4 5225.7 4177.7 4357.9 4444.5 4604.8 4655.0 5547.4 5568.9 5586.5 5589.5 5605.5 3540.3 3838.0 3841.4 3848.6 3859.0 5403.9 5487.4 5584.9 5620.9 5724.5 3859.4 3878.9 3902.0 3904.2 3939.4 3497.2 3609.4 3918.6 3951.5 3955.8 3971.3 4273.5 4617.8 4619.4 4631.9 5078.4 5618.1 5640.2 5663.2 5673.4 1125.9 1280.9 1282.7 1294.2 1306.3 815.6 873.3 878.8 883.8 886.7 4383.6 5015.0 5037.5 5075.2 5094.7 5201.8 5223.4 5565.5 5620.3 5623.9 4265.9 4663.8 4950.7 5075.4 5107.2 2630.5 2854.4 2911.7 2916.9 2945.5 4966.4 5155.9 5617.9 5769.5 5794.5 4815.4 4944.0 5135.5 5504.5 5990.6 5051.6 6016.4 6025.7 6031.5 6031.6 4857.5 5678.9 5815.7 5822.6 5846.9 5477.3 5702.2 5777.3 5804.1 5828.9 4993.0 5029.5 5774.6 5887.5 5984.9 3423.8 3574.4 3896.1 3896.5 3956.2 4840.7 5370.7 5610.9 5709.9 5813.9 4650.5 5169.6 5550.3 5556.0 5587.7 4937.5 5579.7 5580.1 5620.3 5642.8 4088.8 5226.9 5310.0 5420.0 5494.9 5110.9 5222.0 5514.7 5550.5 5625.2 4555.2 5060.3 5209.3 5512.6 5525.8 09:55:40 INFO - PROCESS | 2533 | 09:55:40 INFO - PROCESS | 2533 | [#5] yui.html Cycles:180 Average:19695.69 Median:3636.71 stddev:28052.80 (771.4%) stddev-sans-first:28095.30 09:55:40 INFO - PROCESS | 2533 | Values: 716.6 726.8 777.0 824.7 831.5 12155.6 13162.4 14488.5 15238.7 15321.7 15495.1 15658.3 16118.7 16128.1 16129.4 890.7 919.5 922.4 923.5 930.9 705.4 888.7 909.6 923.9 927.5 955.1 958.9 959.4 963.0 965.1 951.3 952.6 957.8 962.1 963.2 714.6 715.8 719.9 721.4 723.7 14951.9 14954.3 15097.6 15125.9 15180.5 14255.2 14537.8 14601.7 14627.3 14647.6 11549.7 11577.9 11663.6 11688.3 11714.7 3566.3 3626.7 3700.7 3701.3 3854.7 87363.0 109161.0 109303.0 110000.4 111800.0 9224.4 11112.5 11422.7 11470.2 11586.0 19350.9 23860.0 24064.0 24190.3 24566.8 7771.5 7843.5 7879.3 7934.4 8044.6 4133.9 4179.6 4224.1 4250.2 4253.5 3492.2 3591.7 3636.3 3637.1 3641.5 529.2 530.3 531.8 540.4 543.0 671.4 682.4 686.9 693.9 702.4 9696.2 10111.9 10131.4 10184.3 10194.9 657.3 670.8 693.3 707.9 709.6 4750.3 4807.7 4863.4 4868.6 4873.2 102698.5 103533.0 104965.0 105885.0 105956.0 70284.9 73902.6 74495.6 83828.6 84876.6 69553.0 69724.3 70609.3 71002.6 71340.7 9958.6 10206.9 10582.7 10797.5 10919.1 33999.0 48654.5 49269.3 49531.8 49872.3 55554.2 57348.9 60476.7 62032.7 66623.7 12880.1 13022.8 13307.5 13329.7 13520.3 14470.6 14508.0 14591.6 14683.9 15180.2 11277.7 13424.1 13446.2 13575.2 13652.3 10870.3 12809.4 12829.8 12859.4 13100.7 11909.2 12041.2 12070.6 12098.9 12172.7 9500.5 10892.2 11189.9 11191.2 11238.4 10030.2 10828.6 10883.7 10889.6 10921.2 09:55:40 INFO - PROCESS | 2533 | -------- Summary: end -------- 09:55:40 INFO - PROCESS | 2533 | 09:55:41 INFO - TEST-INFO | 2533: exit 0 09:55:41 INFO - TEST-OK | dromaeo_css | took 1115436ms 09:55:41 INFO - TEST-START | kraken 09:55:41 INFO - operating with platform_type : mac_ 09:55:41 INFO - Initialising browser for kraken test... 09:55:41 INFO - TEST-INFO | started process 2538 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpEydzim/profile http://localhost:53689/getInfo.html) 09:55:44 INFO - PROCESS | 2538 | 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] 09:55:44 INFO - PROCESS | 2538 | 2017-02-06 09:55:44.154 plugin-container[2539:293863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9047, name = 'com.apple.tsm.portname' 09:55:44 INFO - PROCESS | 2538 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:44 INFO - PROCESS | 2538 | 2017-02-06 09:55:44.157 plugin-container[2539:293863] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 09:55:44 INFO - PROCESS | 2538 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:44 INFO - PROCESS | 2538 | 2017-02-06 09:55:44.157 plugin-container[2539:293863] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:55:44 INFO - PROCESS | 2538 | __metrics Screen width/height:1600/1200 09:55:44 INFO - PROCESS | 2538 | colorDepth:24 09:55:44 INFO - PROCESS | 2538 | Browser inner width/height: 1024/689 09:55:44 INFO - PROCESS | 2538 | __metrics 09:55:44 ERROR - PROCESS | 2538 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 09:55:44 INFO - PROCESS | 2538 | 1486403744301 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/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpEydzim/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpEydzim/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpEydzim/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpEydzim/profile/extensions/talos-powers@TalosPowersService.js:55:9 09:55:45 INFO - TEST-INFO | 2538: exit 0 09:55:45 INFO - Browser initialized. 09:55:45 INFO - Running cycle 1/1 for kraken test... 09:55:45 INFO - TEST-INFO | started process 2540 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/T/tmpEydzim/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:47 INFO - PROCESS | 2540 | 2017-02-06 09:55:47.618 plugin-container[2541:293978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 09:55:47 INFO - PROCESS | 2540 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:47 INFO - PROCESS | 2540 | 2017-02-06 09:55:47.618 plugin-container[2541:293978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4623, name = 'com.apple.CFPasteboardClient' 09:55:47 INFO - PROCESS | 2540 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:47 INFO - PROCESS | 2540 | 2017-02-06 09:55:47.618 plugin-container[2541:293978] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:55:57 INFO - PROCESS | 2540 | RSS: Main: 233713664 09:55:57 INFO - PROCESS | 2540 | 09:56:00 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-beat-detection) 09:56:01 INFO - PROCESS | 2540 | RSS: Main: 247668736 09:56:01 INFO - PROCESS | 2540 | 09:56:03 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-dft) 09:56:04 INFO - PROCESS | 2540 | RSS: Main: 255963136 09:56:04 INFO - PROCESS | 2540 | 09:56:07 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-fft) 09:56:08 INFO - PROCESS | 2540 | RSS: Main: 257773568 09:56:08 INFO - PROCESS | 2540 | 09:56:10 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-oscillator) 09:56:11 INFO - PROCESS | 2540 | RSS: Main: 258789376 09:56:11 INFO - PROCESS | 2540 | 09:56:13 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:56:13 INFO - PROCESS | 2540 | RSS: Main: 260300800 09:56:13 INFO - PROCESS | 2540 | 09:56:16 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53689/tests/kraken/driver.html?testName=imaging-darkroom) 09:56:17 INFO - PROCESS | 2540 | RSS: Main: 265859072 09:56:17 INFO - PROCESS | 2540 | 09:56:20 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53689/tests/kraken/driver.html?testName=imaging-desaturate) 09:56:21 INFO - PROCESS | 2540 | RSS: Main: 265666560 09:56:21 INFO - PROCESS | 2540 | 09:56:24 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53689/tests/kraken/driver.html?testName=json-parse-financial) 09:56:24 INFO - PROCESS | 2540 | RSS: Main: 265158656 09:56:24 INFO - PROCESS | 2540 | 09:56:26 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:56:27 INFO - PROCESS | 2540 | RSS: Main: 264585216 09:56:27 INFO - PROCESS | 2540 | 09:56:29 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:30 INFO - PROCESS | 2540 | RSS: Main: 264601600 09:56:30 INFO - PROCESS | 2540 | 09:56:32 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:32 INFO - PROCESS | 2540 | RSS: Main: 264667136 09:56:32 INFO - PROCESS | 2540 | 09:56:35 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:36 INFO - PROCESS | 2540 | RSS: Main: 265039872 09:56:36 INFO - PROCESS | 2540 | 09:56:39 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:40 INFO - PROCESS | 2540 | RSS: Main: 264839168 09:56:40 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53689/tests/kraken/driver.html?testName=ai-astar) 09:56:42 INFO - PROCESS | 2540 | RSS: Main: 266760192 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | __start_tp_report 09:56:42 INFO - PROCESS | 2540 | _x_x_mozilla_page_load 09:56:42 INFO - PROCESS | 2540 | _x_x_mozilla_page_load_details 09:56:42 INFO - PROCESS | 2540 | |i|pagename|runs| 09:56:42 INFO - PROCESS | 2540 | |0;ai-astar;106;118;117;116;118;115;115;116;116;118 09:56:42 INFO - PROCESS | 2540 | |1;audio-beat-detection;166;144;123;153;114;113;116;118;134;119 09:56:42 INFO - PROCESS | 2540 | |2;audio-dft;192;203;201;248;272;232;197;205;191;192 09:56:42 INFO - PROCESS | 2540 | |3;audio-fft;87;60;60;88;61;60;59;57;75;57 09:56:42 INFO - PROCESS | 2540 | |4;audio-oscillator;119;104;114;77;68;71;81;71;72;81 09:56:42 INFO - PROCESS | 2540 | |5;imaging-gaussian-blur;90;91;89;86;89;101;107;86;88;88 09:56:42 INFO - PROCESS | 2540 | |6;imaging-darkroom;131;100;100;101;101;112;175;176;179;101 09:56:42 INFO - PROCESS | 2540 | |7;imaging-desaturate;81;153;142;96;93;146;91;92;93;96 09:56:42 INFO - PROCESS | 2540 | |8;json-parse-financial;63;63;62;62;64;66;85;101;92;73 09:56:42 INFO - PROCESS | 2540 | |9;json-stringify-tinderbox;75;60;83;113;56;92;64;75;107;63 09:56:42 INFO - PROCESS | 2540 | |10;stanford-crypto-aes;88;87;91;85;99;76;108;110;90;87 09:56:42 INFO - PROCESS | 2540 | |11;stanford-crypto-ccm;134;177;153;156;160;148;151;160;272;160 09:56:42 INFO - PROCESS | 2540 | |12;stanford-crypto-pbkdf2;174;172;171;173;171;174;176;169;169;173 09:56:42 INFO - PROCESS | 2540 | |13;stanford-crypto-sha256-iterative;68;70;67;67;69;76;87;71;65;68 09:56:42 INFO - PROCESS | 2540 | __end_tp_report 09:56:42 INFO - PROCESS | 2540 | __start_cc_report 09:56:42 INFO - PROCESS | 2540 | _x_x_mozilla_cycle_collect,1005 09:56:42 INFO - PROCESS | 2540 | __end_cc_report 09:56:42 INFO - PROCESS | 2540 | __startTimestamp1486403802263__endTimestamp 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | ------- Summary: start ------- 09:56:42 INFO - PROCESS | 2540 | Number of tests: 14 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:3.54 (3.0%) stddev-sans-first:1.24 09:56:42 INFO - PROCESS | 2540 | Values: 106.0 118.0 117.0 116.0 118.0 115.0 115.0 116.0 116.0 118.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#1] audio-beat-detection Cycles:10 Average:130.00 Median:128.50 stddev:18.54 (14.4%) stddev-sans-first:14.37 09:56:42 INFO - PROCESS | 2540 | Values: 166.0 144.0 123.0 153.0 114.0 113.0 116.0 118.0 134.0 119.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#2] audio-dft Cycles:10 Average:213.30 Median:204.00 stddev:27.88 (13.7%) stddev-sans-first:28.49 09:56:42 INFO - PROCESS | 2540 | Values: 192.0 203.0 201.0 248.0 272.0 232.0 197.0 205.0 191.0 192.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#3] audio-fft Cycles:10 Average:66.40 Median:60.50 stddev:12.24 (20.2%) stddev-sans-first:10.47 09:56:42 INFO - PROCESS | 2540 | Values: 87.0 60.0 60.0 88.0 61.0 60.0 59.0 57.0 75.0 57.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:71.50 stddev:19.14 (26.8%) stddev-sans-first:16.10 09:56:42 INFO - PROCESS | 2540 | Values: 119.0 104.0 114.0 77.0 68.0 71.0 81.0 71.0 72.0 81.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:88.50 stddev:6.92 (7.8%) stddev-sans-first:7.31 09:56:42 INFO - PROCESS | 2540 | Values: 90.0 91.0 89.0 86.0 89.0 101.0 107.0 86.0 88.0 88.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#6] imaging-darkroom Cycles:10 Average:127.60 Median:121.50 stddev:35.17 (28.9%) stddev-sans-first:37.28 09:56:42 INFO - PROCESS | 2540 | Values: 131.0 100.0 100.0 101.0 101.0 112.0 175.0 176.0 179.0 101.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#7] imaging-desaturate Cycles:10 Average:108.30 Median:92.50 stddev:27.15 (29.4%) stddev-sans-first:26.94 09:56:42 INFO - PROCESS | 2540 | Values: 81.0 153.0 142.0 96.0 93.0 146.0 91.0 92.0 93.0 96.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#8] json-parse-financial Cycles:10 Average:73.10 Median:65.00 stddev:14.38 (22.1%) stddev-sans-first:14.78 09:56:42 INFO - PROCESS | 2540 | Values: 63.0 63.0 62.0 62.0 64.0 66.0 85.0 101.0 92.0 73.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#9] json-stringify-tinderbox Cycles:10 Average:78.80 Median:69.50 stddev:19.80 (28.5%) stddev-sans-first:20.95 09:56:42 INFO - PROCESS | 2540 | Values: 75.0 60.0 83.0 113.0 56.0 92.0 64.0 75.0 107.0 63.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:87.50 stddev:10.57 (12.1%) stddev-sans-first:11.10 09:56:42 INFO - PROCESS | 2540 | Values: 88.0 87.0 91.0 85.0 99.0 76.0 108.0 110.0 90.0 87.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#11] stanford-crypto-ccm Cycles:10 Average:167.10 Median:160.00 stddev:38.43 (24.0%) stddev-sans-first:38.85 09:56:42 INFO - PROCESS | 2540 | Values: 134.0 177.0 153.0 156.0 160.0 148.0 151.0 160.0 272.0 160.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:2.25 (1.3%) stddev-sans-first:2.29 09:56:42 INFO - PROCESS | 2540 | Values: 174.0 172.0 171.0 173.0 171.0 174.0 176.0 169.0 169.0 173.0 09:56:42 INFO - PROCESS | 2540 | 09:56:42 INFO - PROCESS | 2540 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:69.50 stddev:6.43 (9.2%) stddev-sans-first:6.74 09:56:42 INFO - PROCESS | 2540 | Values: 68.0 70.0 67.0 67.0 69.0 76.0 87.0 71.0 65.0 68.0 09:56:42 INFO - PROCESS | 2540 | -------- Summary: end -------- 09:56:42 INFO - PROCESS | 2540 | 09:56:43 INFO - TEST-INFO | 2540: exit 0 09:56:43 INFO - TEST-OK | kraken | took 61873ms 09:56:43 INFO - SUITE-END | took 1177s 09:56:43 INFO - Completed test suite (00:19:37) 09:56:43 INFO - javascript benchmark 09:56:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7283.434701859598, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3028.606281183446, 3267.673232676733, 3323.833808309584, 3325.833708314584, 3332.6833950774685, 4807.711537307764, 5484.067708489556, 5525.668459892409, 5561.47166019228, 5565.916511252334, 5332.200169974506, 5415.566754659628, 5536.916946245809, 5572.832815015556, 5630.0, 4988.925166122502, 4997.475265097149, 5069.315642388267, 5080.720560369178, 5082.186850103984, 4341.6092551670345, 4994.375703037121, 5089.389273287192, 5092.210707340369, 5136.743162841862, 4925.4335751388335, 5108.106081435771, 5122.436531981479, 5129.281900533928, 5136.666116702402, 4958.380202474691, 5009.824656137054, 5018.222175562793, 5025.748712564394, 5026.447090820006, 4926.704397736112, 4983.07813054586, 5001.24981252815, 5001.3998320201445, 5005.57452616528, 5370.489803468664, 5508.20131080995, 5523.530499907512, 5565.359983601857, 5596.524295434893, 6066.0, 6069.089636554508, 6070.180525629028, 6070.787522436738, 6086.360932102154, 5099.818149117725, 5902.380250073724, 6051.334353221142, 6172.135900973867, 6192.628442293477, 5573.498385145356, 5686.971565142189, 5715.799947001835, 5723.771049158028, 5796.594238403271, 6106.694665266719, 6124.142620033199, 6155.35368786271, 6174.25908890927, 6176.474999625082, 5986.9401305986385, 6052.303985041688, 6068.120122582201, 6072.39276072398, 6079.0, 5913.615614985012, 6039.033754599243, 6085.2393450818645, 6104.26748790148, 6140.263168419819, 5155.793768249303, 5820.592558520948, 5910.379410161957, 6040.697965101727, 6060.33336333003, 6119.318721178302, 6120.081987701791, 6141.455323060903, 6144.279601711528, 6167.599106058092, 4860.36815214027, 4918.163912134945, 4927.408710954708, 4928.457869634337, 4968.627352948543, 4274.829006839754, 4276.529581746067, 4293.677974151951, 4321.573880619388, 4329.610335069859, 5705.657660540381, 5711.685857277889, 5718.571107166979, 5727.4845263926445, 5741.88516229673, 6131.356207598227, 6153.815385538441, 6171.444569988633, 6172.845678858064, 6196.287426945959, 5523.8895222096135, 5567.944320556823, 5623.831285061455, 5640.238567793295, 5678.602497825113, 5347.625666203328, 5356.464353564613, 5358.142697168434, 5369.6509726867625, 5376.973115134399, 6182.0, 6191.690415479208, 6203.255609326729, 6218.06728990655, 6227.09707092469, 5687.77248910039, 5759.136129580596, 6098.695065246809, 6146.723397447215, 6175.536834737323, 6071.635701857903, 6186.443220110212, 6192.752289908353, 6199.535034872493, 6230.314665386713, 5865.501432378295, 6014.248218972629, 6055.666938318259, 6080.422359875804, 6094.847628809315, 5781.306243250837, 5929.495992840657, 6121.1430399743185, 6133.693315334126, 6138.416850399205, 5978.192943952685, 5978.9402105980125, 6007.459328660441, 6027.427394397525, 6089.147519347383, 5984.251968503937, 5984.790532331347, 6059.818205453844, 6060.757569697339, 6065.090236464565, 4530.546945305443, 5566.471185237396, 5757.050086735641, 5766.740496677576, 5943.138244954544, 5974.761009559569, 5989.610675306091, 6003.129546215687, 6006.459418652343, 6032.33644299118, 5791.9131213031, 5818.359980402068, 5824.825255242349, 5835.387284335084, 5836.095405212199], "value": 5546.264152851689, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.7733694484283, 449.4606472233321, 459.75862672097156, 478.23243693871314, 495.1631742355418, 27880.721192788067, 40926.38610420846, 40931.0, 43765.56234437654, 44425.0, 42248.78875605625, 42720.0, 42896.0, 42919.0, 43009.139817203715, 9090.772730681736, 9300.581473833694, 9312.30157738169, 9321.953390233039, 10749.301295415811, 10737.852429514089, 11041.779164416706, 11043.72390690231, 11052.281601695904, 11058.778824423507, 10111.140553052963, 10373.599564058868, 11051.447427628627, 11090.057345125633, 11090.500927458243, 11013.28413653114, 11075.833862492069, 11081.667549973514, 11089.944550277278, 11099.500522476508, 11022.779544409148, 11082.944585277102, 11086.002259796656, 11096.944515277453, 11097.056750176245, 36163.4575481368, 36339.091522712144, 36502.26995460076, 36504.087397815005, 36534.0, 3857.961420385788, 3889.1638297765835, 3894.6300101490315, 3896.7467114637457, 3910.2179564087296, 27226.86386568074, 27935.161945141677, 28033.0, 28191.436171276666, 28230.72961716707, 3115.12776422602, 3232.69289417505, 3246.821424821634, 3296.571445712042, 3297.241634424072, 462272.0, 469131.0, 473231.0, 473641.0, 479476.6026169882, 44700.55299446964, 46017.07965840664, 47359.76320118377, 55165.0, 55559.88880222373, 56857.715711422, 57620.0, 57661.711691441276, 61635.0, 61815.38184618186, 14505.492307769178, 14647.0, 14720.263986800832, 14724.33740481681, 14732.189729564763, 11077.335359878432, 11178.329300242012, 11214.831777523344, 11221.943890280496, 11260.38067906273, 17541.649167016843, 17670.381536646157, 17675.20461579232, 17699.29202831898, 17700.0, 7927.009123859518, 7988.520688758693, 8055.516668999879, 8063.475874068166, 8122.553259570662, 730.087390761548, 845.2899564365962, 847.8304339132075, 858.9613467393982, 869.5391442535466, 27104.32239194036, 28506.144815655563, 29345.7065429343, 29346.559801602994, 29879.850600746857, 876.2595606712318, 892.9464232146092, 1008.863803386548, 1013.5236438873718, 1190.1787766441128, 14755.0, 15225.390984360502, 15438.305276262596, 15515.689686206439, 15543.844561554466, 609792.0, 627605.0, 637673.0, 639229.0, 640481.0, 59107.40892591105, 59137.70431147903, 59212.0, 59295.81408371808, 59365.70317148473, 1354.1401210231575, 1392.6587985943509, 1398.6643205630576, 1404.9719005619831, 1409.8872090232962, 21699.891500542395, 26955.595666064633, 28219.858900706186, 28453.861845526775, 29483.41033179367, 47928.76035619799, 48947.02105957932, 49049.0, 49116.0, 49155.50844491652, 421174.0, 543650.0, 544789.0, 545686.0, 548146.0, 23764.88117559401, 24511.63232551549, 24545.0, 25327.860246288594, 25981.350466237738, 40825.0, 41029.38455923223, 41062.1787564253, 41593.37609935914, 41757.0, 34543.82728086444, 34717.47923781196, 34763.957081287605, 35528.82235588909, 35853.64146358607, 26022.60966085548, 33711.4943275856, 33760.0, 35067.473987889694, 35116.82441587776, 33498.497522536694, 34291.485627715105, 34346.313073738886, 35351.11622209465, 35354.82322588371, 26791.464170716867, 29350.0, 31068.434295716805, 32737.508937366434, 32937.84717534971, 23884.522309553366, 24014.0, 24052.51894962126, 24056.037758490165, 24550.508989819748], "value": 19260.316038274894, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.9089882080069, 389.3439554350917, 396.1843218709131, 404.69243375034966, 425.8913976935881, 14282.4287028519, 19982.900085499572, 20148.294809681665, 20677.379678609628, 20831.687524687124, 20801.959902004877, 20882.791172088273, 20901.790982090173, 21111.366659000254, 21169.259075932347, 5221.843344699665, 5601.131824567178, 5650.858728531799, 5660.518855897254, 5677.205191273225, 4959.280904268879, 5411.702356370398, 5533.418991005947, 5570.275864137657, 5619.381867994517, 5488.643238189525, 5534.944650553503, 5546.722663866811, 5549.38956714761, 5572.944270557304, 5382.4886635769535, 5467.289252397183, 5469.945300547023, 5521.558275337963, 5554.166874968767, 4854.878628034292, 4900.460949295574, 4900.877478063041, 4909.165441874889, 4909.8772530686665, 23760.7623923762, 24329.39176520601, 24438.511229775482, 24548.018079276986, 24665.63001554978, 2611.125273033536, 2651.469706058777, 2689.2066840282164, 2689.6329843839053, 2709.2684975056823, 14489.0, 14984.0, 15068.849311506854, 15074.170920599363, 15567.299471523695, 1773.6630040292303, 1780.97328540072, 1797.2810875649714, 1798.4245041586698, 1827.2964908510319, 104738.0, 108465.99999999921, 130221.69778302191, 133460.0, 134354.3282283592, 11392.487338069806, 11889.940550297193, 12068.948278792626, 12241.387930603434, 12247.32639704807, 13771.449142034407, 14275.357608907623, 15531.06813591188, 15538.0, 15540.30068646891, 10159.339642923187, 10450.738731531772, 10656.78686426267, 10715.892841071645, 10841.241113122005, 8433.40966132377, 8528.0, 8566.61450234741, 8570.271526920282, 8927.285817134743, 10515.84226236607, 10562.31344962575, 10610.575576976835, 10698.73253168677, 10715.83926241107, 3490.7207423406066, 4038.2529232092156, 4140.192662430797, 4156.625903668684, 4177.185448837508, 984.778424854402, 990.1929927109383, 991.4002028772488, 1010.2826992835022, 1038.0968557354997, 20732.274370397266, 21561.784382156293, 21569.78430215709, 21738.34784956454, 21935.451613709785, 755.5919803306153, 760.8097975506123, 983.5475681186591, 1003.5634498992962, 1011.7875246198233, 8635.784105397415, 10361.378317300987, 10626.574937002433, 10737.463126843782, 10753.193510486744, 730695.0, 731499.0, 733518.0, 736687.0, 752002.2399887965, 122455.38772306082, 136709.0, 147207.0, 148076.67309942158, 149978.0, 852.3351785607236, 986.9259805514615, 1050.364529459681, 1057.6139709006156, 1061.501094485575, 18726.0, 18787.624247515247, 19091.331803386816, 19131.521711957314, 19323.03384830725, 41611.95970100772, 51570.710732230495, 57688.71155644195, 59129.40870591239, 60053.0, 79800.0, 82286.58856705678, 87575.0, 90309.0, 90846.09153908376, 11321.660350189508, 11587.8261826071, 11598.652040438801, 11708.121890858049, 12719.682007949876, 12649.039398893186, 13640.970607523934, 13690.589282321545, 13716.382762775898, 13885.514007009706, 11333.829992549954, 11472.426378681199, 11744.119191060534, 11985.940070299594, 11986.820197696867, 10547.419891906018, 10773.461326933779, 10882.836757448804, 11429.771404572028, 11503.76992460163, 11486.425678715863, 11489.253198542068, 11780.410979450822, 11945.641630751092, 11985.760284794429, 11568.958793708607, 12393.963478947715, 12451.501939922302, 12460.563880264148, 12651.240925544496, 9631.181349585084, 10925.562977480811, 11428.657140285804, 11743.706407339885, 11886.34625095628], "value": 10529.677248455635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.8303403591572, 1416.8158139441864, 1428.692831041326, 1436.2531483628513, 1437.7987081808549, 8199.385046121535, 8341.874871876911, 8601.612927418266, 8640.697575584847, 8663.956680216597, 8501.277391421736, 8606.096359882216, 8650.307975361971, 8657.913420865789, 8701.260392866598, 2279.327598358488, 2303.527776805751, 2311.5839148953182, 2313.3060081975423, 2314.5023819878807, 1890.395073576456, 2264.7055882735303, 2304.665823455598, 2306.4925716342377, 2310.90756369745, 2258.119333459952, 2261.536385041071, 2284.5316710074394, 2292.7821856923647, 2293.048384920256, 2195.7913998170147, 2251.549690061994, 2267.648514480258, 2272.988520108552, 2278.897449614771, 1971.9309824156085, 2038.3069756282787, 2249.910003599854, 2303.9654405183937, 2318.8376813623054, 8369.204925532125, 8596.527191004492, 8629.870551941725, 8683.392162548624, 8688.261497772697, 4822.252550854623, 5255.474452554752, 5261.342332208474, 5270.472952704698, 5272.472752724735, 3318.4690449528202, 3368.7473439492137, 3390.74569407293, 3391.5251864738957, 3526.8236588170744, 1220.395904027503, 1229.3054424250358, 1256.9120161588692, 1270.5959914294663, 1276.170489182039, 10888.128949684005, 10896.836547451794, 10968.0, 11001.724956876062, 11037.613683521038, 4212.578742125763, 4450.421445212101, 4502.662300327489, 4516.6160876325885, 4545.499995000548, 7396.5562066275115, 8897.421667591585, 8913.910860891438, 8913.955430222808, 8929.642814287356, 4570.314452832102, 5156.613254005964, 5159.277701121846, 5167.638265321467, 5179.015986962465, 3887.630675085862, 4658.67389282747, 4658.720476771405, 4758.95241047592, 4824.638152138604, 3037.893673721409, 3649.94525082124, 3717.5724791648768, 3744.64425879541, 3771.830267637963, 985.6205360936091, 1161.512164890748, 1163.7207070303066, 1165.3998190931677, 1172.9120315976336, 837.9162083791572, 853.2065179383109, 860.4020205956925, 887.8135591525722, 900.3337530227716, 5320.52115309624, 5667.149927510906, 5814.79648212319, 5873.706314684334, 5953.79161729346, 880.933929955256, 968.1915600473543, 970.2092794372563, 970.4177493503842, 978.7455261631884, 3706.6293370663257, 3724.478572999782, 3809.771413715186, 3877.4765406670303, 3900.902477438087, 8735.43219690718, 9839.311248212556, 9966.950165249127, 10259.333143345659, 10328.122109620766, 10192.439415832201, 10226.744331391776, 10246.436445995392, 10252.333598316085, 10312.329698569569, 7074.929250707427, 7931.801704957422, 8087.959560202161, 8098.635561399751, 8110.026796784306, 5601.383847776659, 5774.740136693775, 5776.480116789341, 5821.214136091573, 5857.4435428634215, 7431.479796414199, 9188.678396256098, 9291.67479138227, 9383.624655013997, 9384.81230375375, 8964.103589641245, 9186.311026672893, 9216.585253663467, 9264.351495395258, 9388.057254430647, 7113.608751518716, 7327.120745510573, 7330.853382932418, 7338.229485904117, 7348.081489813773, 7243.710251590088, 7580.128285247267, 7830.569318687527, 7831.060272767304, 7920.326772224425, 7227.060482137288, 7289.817754556178, 7290.453216008927, 7317.3780228679025, 7361.668724907499, 7053.4004609608755, 7120.465965052538, 7128.429725622042, 7226.891596625949, 7317.670704818403, 6434.260060092962, 6441.774537891339, 6515.446187074152, 6515.478761698958, 6528.543001989815, 4912.582430493448, 4980.402351717817, 5063.392392912727, 5119.180931051014, 5236.6857988520815, 5023.422306434661, 5068.746562671778, 5079.263506791421, 5129.230615407719, 5318.8936221276135], "value": 4401.091897258475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.5570631682506, 367.426814169895, 375.5324620847045, 382.2870346803213, 388.7531417549857, 4395.340698895167, 4741.8814529636775, 5101.413337466192, 5353.464653534645, 5512.810264199213, 5186.533212010918, 5203.9219411708855, 5212.582993360532, 5223.503767142115, 5232.529072383485, 3689.3728066228805, 3981.7810020448865, 4030.415589739486, 4032.1330913853517, 4035.4955630546183, 3654.2143439160577, 4033.306011475173, 4041.3937909313545, 4042.2117687051036, 4054.776987265699, 3663.8534458621625, 3884.4367566702954, 3938.448617193595, 3957.2085582883396, 3981.9203615927663, 3642.9271414571826, 3943.5464921533962, 3947.2106777493495, 3962.4254483100076, 3989.3218152914073, 2905.956410653821, 2907.767378609706, 3164.357761269343, 3484.651534846495, 3497.3005398920063, 4550.658700597435, 4816.397950256218, 4934.629902757308, 5162.353881506674, 5225.6603320784025, 4177.663147792708, 4357.934630980538, 4444.488883778375, 4604.769761511911, 4654.976725116353, 5547.417521160261, 5568.9443105569235, 5586.469285417878, 5589.469000444951, 5605.523530499912, 3540.327337805809, 3837.9808100959594, 3841.3661745812187, 3848.5766565677754, 3859.0, 5403.891922161574, 5487.368952570466, 5584.93886161628, 5620.915686264669, 5724.4561766632105, 3859.4017927221325, 3878.944159595419, 3902.043999220209, 3904.1996390739832, 3939.4484772131923, 3497.2306092659574, 3609.3683605368956, 3918.5689574146822, 3951.5258169019903, 3955.8219880105466, 3971.324874771296, 4273.508546517128, 4617.792199351037, 4619.399478067897, 4631.884202894955, 5078.359253188321, 5618.129189975561, 5640.238567793295, 5663.207150998864, 5673.383085820604, 1125.9268147570544, 1280.9103362764517, 1282.7434513097419, 1294.249335385474, 1306.3337697774205, 815.5718247919771, 873.275181599271, 878.8136016377839, 883.8024476833798, 886.7118186589255, 4383.649308055348, 5014.971930754186, 5037.546620804072, 5075.198304601813, 5094.694318340911, 5201.817936372209, 5223.373195216598, 5565.523342112802, 5620.269364982608, 5623.943760562423, 4265.87202383929, 4663.766811659403, 4950.727709975986, 5075.4115401144945, 5107.233914912718, 2630.526505229039, 2854.4005758790886, 2911.7233862783, 2916.9270768230963, 2945.5434407666844, 4966.428860680996, 5155.948440515622, 5617.887642247132, 5769.509591684669, 5794.536437085023, 4815.398075240595, 4943.950560494421, 5135.486451354835, 5504.504594586427, 5990.580659353804, 5051.646384753032, 6016.42843929826, 6025.728842202111, 6031.517478601701, 6031.60794548353, 4857.489963553776, 5678.886422271614, 5815.738291776965, 5822.5633077518505, 5846.883062338815, 5477.287952566141, 5702.232307984372, 5777.277840269966, 5804.111245465632, 5828.912566311594, 4992.975035124801, 5029.466012866111, 5774.56690748204, 5887.498687834574, 5984.910226346696, 3423.767443720209, 3574.428091505347, 3896.1038961038553, 3896.4998475586535, 3956.248312820555, 4840.741407234215, 5370.704611246419, 5610.85972850682, 5709.942900570941, 5813.912791308049, 4650.46519650231, 5169.586433085419, 5550.250716153268, 5556.0, 5587.7485513152815, 4937.506249375034, 5579.721013949367, 5580.135079062752, 5620.269364982526, 5642.774289028393, 4088.7546747195265, 5226.869328266824, 5309.973450132725, 5420.0, 5494.8844694792, 5110.923336149886, 5222.033923724123, 5514.696691681996, 5550.5282051026115, 5625.21247025425, 4555.157295900269, 5060.291559181644, 5209.348831396075, 5512.5589952804485, 5525.806596769094], "value": 4045.3111110513287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.6416791604198, 726.7819654103768, 776.9782735702554, 824.653645468903, 831.4595512916603, 12155.635330940064, 13162.407691653874, 14488.492902748407, 15238.695226095471, 15321.693566128684, 15495.147766872817, 15658.295376708047, 16118.677626447494, 16128.112953787537, 16129.354825806953, 890.6749036601626, 919.4667093086027, 922.4280945813605, 923.4551614547415, 930.9255259579218, 705.407457735502, 888.6667499687617, 909.6497848328376, 923.9168474837263, 927.4991504587515, 955.0544960489101, 958.884933807944, 959.4099628728317, 962.9711108666751, 965.1169180200109, 951.2675240065146, 952.5618215620823, 957.7749228931195, 962.0619895601767, 963.2197919685077, 714.58196954781, 715.8425146467821, 719.9280071992758, 721.3579913876654, 723.6526467295674, 14951.850481495154, 14954.327055282429, 15097.622559435993, 15125.924370378078, 15180.468683596131, 14255.215963122024, 14537.78193327101, 14601.707965840624, 14627.341769620392, 14647.633809154857, 11549.711257218552, 11577.94211028948, 11663.59177428786, 11688.298702077818, 11714.70713232176, 3566.28674265148, 3626.709863210937, 3700.703943684499, 3701.3337599232127, 3854.69162467002, 87363.0, 109161.0, 109303.0, 110000.4499977503, 111800.0, 9224.37480780489, 11112.499937502831, 11422.657320280405, 11470.197086203885, 11586.0, 19350.90324548368, 23860.045598176224, 24064.0, 24190.274291771275, 24566.754332456803, 7771.533707977426, 7843.490173138728, 7879.251471110236, 7934.404919631051, 8044.557549334726, 4133.91732165361, 4179.558863032623, 4224.134052519226, 4250.213710463512, 4253.468316460442, 3492.1967947372245, 3591.694705949971, 3636.309101270803, 3637.1089083174793, 3641.4537819326783, 529.1559961860826, 530.2920600997711, 531.805890849837, 540.3758658749151, 543.0252696409954, 671.4058058618158, 682.382443888282, 686.9107016087877, 693.9132608423947, 702.4064665357764, 9696.224302055818, 10111.854139802792, 10131.392116473035, 10184.287099903084, 10194.949025254975, 657.283560918601, 670.8188789027033, 693.3309356471029, 707.9469039822034, 709.5990765217635, 4750.311204875274, 4807.663463557517, 4863.367762190964, 4868.586170175504, 4873.244647079709, 102698.45952310722, 103533.0, 104965.0, 105885.0, 105956.0, 70284.94572581415, 73902.63048684722, 74495.62752186204, 83828.58085709532, 84876.57561712152, 69553.0, 69724.3027569728, 70609.29390706027, 71002.64498677473, 71340.68034524945, 9958.55186516594, 10206.948965255126, 10582.682519524427, 10797.460126993776, 10919.12646988223, 33999.0, 48654.513454864995, 49269.260961084896, 49531.75234123806, 49872.25191622056, 55554.166687500525, 57348.853022940144, 60476.697616511636, 62032.689836550526, 66623.66688166528, 12880.098393112767, 13022.80465792995, 13307.46770129184, 13329.66675833112, 13520.323983800574, 14470.565883023526, 14508.0, 14591.562253132422, 14683.853161468249, 15180.165090920105, 11277.661670149908, 13424.060315778192, 13446.184765056592, 13575.185488870698, 13652.317384130953, 10870.347779133277, 12809.359532023547, 12829.807552886901, 12859.352392356508, 13100.737985240432, 11909.166358354832, 12041.157119001586, 12070.577529786415, 12098.939505302416, 12172.695682608006, 9500.524973751422, 10892.237543372205, 11189.888101118884, 11191.16066295015, 11238.381888996184, 10030.247731420026, 10828.620998265023, 10883.727906802393, 10889.618863339745, 10921.180911431833], "value": 7453.793967317062, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 117.0, 116.0, 118.0, 115.0, 115.0, 116.0, 116.0, 118.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 144.0, 123.0, 153.0, 114.0, 113.0, 116.0, 118.0, 134.0, 119.0], "value": 130.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 203.0, 201.0, 248.0, 272.0, 232.0, 197.0, 205.0, 191.0, 192.0], "value": 213.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 60.0, 60.0, 88.0, 61.0, 60.0, 59.0, 57.0, 75.0, 57.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 104.0, 114.0, 77.0, 68.0, 71.0, 81.0, 71.0, 72.0, 81.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 89.0, 86.0, 89.0, 101.0, 107.0, 86.0, 88.0, 88.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 100.0, 100.0, 101.0, 101.0, 112.0, 175.0, 176.0, 179.0, 101.0], "value": 127.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 153.0, 142.0, 96.0, 93.0, 146.0, 91.0, 92.0, 93.0, 96.0], "value": 108.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 64.0, 66.0, 85.0, 101.0, 92.0, 73.0], "value": 73.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 60.0, 83.0, 113.0, 56.0, 92.0, 64.0, 75.0, 107.0, 63.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 91.0, 85.0, 99.0, 76.0, 108.0, 110.0, 90.0, 87.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 177.0, 153.0, 156.0, 160.0, 148.0, 151.0, 160.0, 272.0, 160.0], "value": 167.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 171.0, 173.0, 171.0, 174.0, 176.0, 169.0, 169.0, 173.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 67.0, 69.0, 76.0, 87.0, 71.0, 65.0, 68.0], "value": 70.8, "unit": "score"}]}]} 09:56:43 INFO - Return code: 0 09:56:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:56:43 ERROR - # TBPL SUCCESS # 09:56:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:43 INFO - 2017-02-06 09:56:43.562 screenresolution[2545:294358] starting screenresolution argv=screenresolution get 09:56:43 INFO - 2017-02-06 09:56:43.565 screenresolution[2545:294358] Display 0: 1600x1200x32@60 09:56:43 INFO - 2017-02-06 09:56:43.572 screenresolution[2546:294361] starting screenresolution argv=screenresolution list 09:56:43 INFO - Available Modes on Display 0 09:56:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:43 INFO - Intel Iris: 09:56:43 INFO - Chipset Model: Intel Iris 09:56:43 INFO - Type: GPU 09:56:43 INFO - Bus: Built-In 09:56:43 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:43 INFO - Vendor: Intel (0x8086) 09:56:43 INFO - Device ID: 0x0a2e 09:56:43 INFO - Revision ID: 0x0009 09:56:43 INFO - Displays: 09:56:43 INFO - Display: 09:56:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:43 INFO - Display Serial Number: 1600x1200 60 09:56:43 INFO - Main Display: Yes 09:56:43 INFO - Mirror: Off 09:56:43 INFO - Online: Yes 09:56:43 INFO - Rotation: Supported 09:56:43 INFO - Return code: 0 09:56:43 INFO - Running post-action listener: _resource_record_post_action 09:56:43 INFO - [mozharness: 2017-02-06 17:56:43.812111Z] Finished run-tests step (success) 09:56:43 INFO - Running post-run listener: _resource_record_post_run 09:56:43 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 307200; Write bytes: 557691392; Read time: 3; Write time: 1713 09:56:43 INFO - TinderboxPrint: CPU usage
54.6% 09:56:43 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 3 09:56:43 INFO - TinderboxPrint: I/O write bytes / time
557,691,392 / 1,713 09:56:43 INFO - TinderboxPrint: CPU idle
2,179.1 (45.4%) 09:56:43 INFO - TinderboxPrint: CPU system
970.4 (20.2%) 09:56:43 INFO - TinderboxPrint: CPU user
1,652.2 (34.4%) 09:56:43 INFO - TinderboxPrint: Swap in / out
251,752,448 / 0 09:56:43 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252979712; Write bytes: 254797312; Read time: 18138; Write time: 550 09:56:43 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 233472; Write bytes: 301370368; Read time: 1; Write time: 1153 09:56:44 INFO - Running post-run listener: _upload_blobber_files 09:56:44 INFO - Blob upload gear active. 09:56:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:44 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 09:56:44 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'] 09:56:44 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 09:56:44 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:45 INFO - (blobuploader) - INFO - Done attempting. 09:56:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:56:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:56:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:46 INFO - (blobuploader) - INFO - Done attempting. 09:56:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:56:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:56:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:47 INFO - (blobuploader) - INFO - Done attempting. 09:56:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:56:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:50 INFO - (blobuploader) - INFO - Done attempting. 09:56:50 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:50 INFO - Return code: 0 09:56:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/513183fbb708f0b22bfa0d98316500b99a6c33ed7f9f20124697fe71871761f3f541340f5d5a8343ead028585a68fd4c2b91be008d1da872a55240b8607fab8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d106d34c93f9ef53a364aceae43f7a807dab9681ad858e4d37b301524e82c3f6a9fa1d38f188be98993edd41dddddf8fbe4990809d5c1eed3f2f8c5e2c95f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfeb77eca8de2a2c7113bea6e1b8e5845f2fabdf920484c2cc08f319e40bec582d735fb8b083104b212232e648591fdc4ce07f81a2894ab645fbe4658a4fdc1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d7cac3f949e11fcef0d93e344bdc80cd9f17b26a1af40e5ed4a7b625dc285a8bc03322e3653ffbe49c54b1729268cbd91d133b4435f0278c10dcf7a6aeebb6"} 09:56:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:50 INFO - Contents: 09:56:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/513183fbb708f0b22bfa0d98316500b99a6c33ed7f9f20124697fe71871761f3f541340f5d5a8343ead028585a68fd4c2b91be008d1da872a55240b8607fab8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d106d34c93f9ef53a364aceae43f7a807dab9681ad858e4d37b301524e82c3f6a9fa1d38f188be98993edd41dddddf8fbe4990809d5c1eed3f2f8c5e2c95f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfeb77eca8de2a2c7113bea6e1b8e5845f2fabdf920484c2cc08f319e40bec582d735fb8b083104b212232e648591fdc4ce07f81a2894ab645fbe4658a4fdc1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d7cac3f949e11fcef0d93e344bdc80cd9f17b26a1af40e5ed4a7b625dc285a8bc03322e3653ffbe49c54b1729268cbd91d133b4435f0278c10dcf7a6aeebb6"} 09:56:50 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:50 INFO - Copying logs to upload dir... 09:56:50 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.916123 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-06 09:56:50.120306) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 09:56:50.123665) ========= 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.kfkhJPysaH/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.ix2TDN3PDr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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/513183fbb708f0b22bfa0d98316500b99a6c33ed7f9f20124697fe71871761f3f541340f5d5a8343ead028585a68fd4c2b91be008d1da872a55240b8607fab8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d106d34c93f9ef53a364aceae43f7a807dab9681ad858e4d37b301524e82c3f6a9fa1d38f188be98993edd41dddddf8fbe4990809d5c1eed3f2f8c5e2c95f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfeb77eca8de2a2c7113bea6e1b8e5845f2fabdf920484c2cc08f319e40bec582d735fb8b083104b212232e648591fdc4ce07f81a2894ab645fbe4658a4fdc1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d7cac3f949e11fcef0d93e344bdc80cd9f17b26a1af40e5ed4a7b625dc285a8bc03322e3653ffbe49c54b1729268cbd91d133b4435f0278c10dcf7a6aeebb6"} build_url:https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011529 build_url: 'https://queue.taskcluster.net/v1/task/KuCoahtmRT2PlZp8C5Kwew/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/513183fbb708f0b22bfa0d98316500b99a6c33ed7f9f20124697fe71871761f3f541340f5d5a8343ead028585a68fd4c2b91be008d1da872a55240b8607fab8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d106d34c93f9ef53a364aceae43f7a807dab9681ad858e4d37b301524e82c3f6a9fa1d38f188be98993edd41dddddf8fbe4990809d5c1eed3f2f8c5e2c95f6c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bfeb77eca8de2a2c7113bea6e1b8e5845f2fabdf920484c2cc08f319e40bec582d735fb8b083104b212232e648591fdc4ce07f81a2894ab645fbe4658a4fdc1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/35d7cac3f949e11fcef0d93e344bdc80cd9f17b26a1af40e5ed4a7b625dc285a8bc03322e3653ffbe49c54b1729268cbd91d133b4435f0278c10dcf7a6aeebb6"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 09:56:50.287153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:56:50.287489) ========= 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.kfkhJPysaH/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.ix2TDN3PDr/Listeners TMPDIR=/var/folders/w3/7fy15l1j28z1pjs9bdqr5pjm00000w/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.005505 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 09:56:50.314958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 09:56:50.315273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 09:56:50.315946) ========= ========= Total master_lag: 0.29 =========