builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0220 starttime: 1486384185.01 results: success (0) buildid: 20170206030211 builduid: cc07653b2c2b4c4f917f0cb42279d413 revision: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:45.005396) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:45.005827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:45.006097) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:45.033206) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 04:29:45.033552) ========= 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.vmHu8Favbn/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.s2dr7FAZzR/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:29:45-- 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% 143M=0s 2017-02-06 04:29:46 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=1.024233 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 04:29:46.085798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:46.086122) ========= 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.vmHu8Favbn/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.s2dr7FAZzR/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.037119 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:46.148818) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 04:29:46.149159) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 20a8536b0bfac74389d3a57bd8dd957d98779ce1 --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 20a8536b0bfac74389d3a57bd8dd957d98779ce1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vmHu8Favbn/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.s2dr7FAZzR/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:29:46,259 truncating revision to first 12 chars 2017-02-06 04:29:46,259 Setting DEBUG logging. 2017-02-06 04:29:46,259 attempt 1/10 2017-02-06 04:29:46,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/20a8536b0bfa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-06 04:29:47,510 unpacking tar archive at: mozilla-central-20a8536b0bfa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.517869 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-06 04:29:47.697627) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:47.697958) ========= script_repo_revision: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:47.698384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:47.698649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-06 04:29:47.718830) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2017-02-06 04:29:47.719219) ========= /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.vmHu8Favbn/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.s2dr7FAZzR/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:29:47 INFO - MultiFileLogger online at 20170206 04:29:47 in /builds/slave/test 04:29:47 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 04:29:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:29:47 INFO - {'append_to_log': False, 04:29:47 INFO - 'base_work_dir': '/builds/slave/test', 04:29:47 INFO - 'blob_upload_branch': 'Firefox', 04:29:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:29:47 INFO - 'branch': 'Firefox', 04:29:47 INFO - 'buildbot_json_path': 'buildprops.json', 04:29:47 INFO - 'config_files': ('talos/mac_config.py',), 04:29:47 INFO - 'default_actions': ('clobber', 04:29:47 INFO - 'read-buildbot-config', 04:29:47 INFO - 'download-and-extract', 04:29:47 INFO - 'populate-webroot', 04:29:47 INFO - 'create-virtualenv', 04:29:47 INFO - 'install', 04:29:47 INFO - 'run-tests'), 04:29:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:29:47 INFO - 'download_minidump_stackwalk': True, 04:29:47 INFO - 'download_symbols': 'ondemand', 04:29:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:29:47 INFO - 'tooltool.py': '/tools/tooltool.py', 04:29:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:29:47 INFO - '/tools/misc-python/virtualenv.py')}, 04:29:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:29:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:29:47 INFO - 'installer_path': 'installer.exe', 04:29:47 INFO - 'log_level': 'info', 04:29:47 INFO - 'log_name': 'talos', 04:29:47 INFO - 'log_to_console': True, 04:29:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:29:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:29:47 INFO - 'opt_config_files': (), 04:29:47 INFO - 'pip_index': False, 04:29:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:47 INFO - 'cmd': ('bash', 04:29:47 INFO - '-c', 04:29:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:47 INFO - 'enabled': True, 04:29:47 INFO - 'halt_on_failure': False, 04:29:47 INFO - 'name': 'check_screen_resolution'},), 04:29:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:29:47 INFO - 'cmd': ('bash', 04:29:47 INFO - '-c', 04:29:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:29:47 INFO - 'enabled': True, 04:29:47 INFO - 'halt_on_failure': False, 04:29:47 INFO - 'name': 'check_screen_resolution'},), 04:29:47 INFO - 'run_cmd_checks_enabled': True, 04:29:47 INFO - 'sps_profile': False, 04:29:47 INFO - 'sps_profile_interval': 0, 04:29:47 INFO - 'suite': 'dromaeojs-e10s', 04:29:47 INFO - 'system_bits': '32', 04:29:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:29:47 INFO - 'title': 't-yosemite-r7-0220', 04:29:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:29:47 INFO - 'use_talos_json': True, 04:29:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:29:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:29:47 INFO - 'work_dir': 'build'} 04:29:47 INFO - [mozharness: 2017-02-06 12:29:47.934360Z] Running clobber step. 04:29:47 INFO - Running pre-action listener: _resource_record_pre_action 04:29:47 INFO - Running main action method: clobber 04:29:47 INFO - rmtree: /builds/slave/test/build 04:29:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:50 INFO - Running post-action listener: _resource_record_post_action 04:29:50 INFO - [mozharness: 2017-02-06 12:29:50.266739Z] Finished clobber step (success) 04:29:50 INFO - [mozharness: 2017-02-06 12:29:50.266885Z] Running read-buildbot-config step. 04:29:50 INFO - Running pre-action listener: _resource_record_pre_action 04:29:50 INFO - Running main action method: read_buildbot_config 04:29:50 INFO - Using buildbot properties: 04:29:50 INFO - { 04:29:50 INFO - "project": "", 04:29:50 INFO - "product": "firefox", 04:29:50 INFO - "script_repo_revision": "production", 04:29:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:29:50 INFO - "repository": "", 04:29:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:29:50 INFO - "buildid": "20170206030211", 04:29:50 INFO - "stage_platform": "macosx64", 04:29:50 INFO - "basedir": "/builds/slave/test", 04:29:50 INFO - "nightly_build": "True", 04:29:50 INFO - "buildnumber": 51, 04:29:50 INFO - "slavename": "t-yosemite-r7-0220", 04:29:50 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:29:50 INFO - "platform": "yosemite_r7", 04:29:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:29:50 INFO - "branch": "mozilla-central", 04:29:50 INFO - "repo_path": "mozilla-central", 04:29:50 INFO - "revision": "20a8536b0bfac74389d3a57bd8dd957d98779ce1", 04:29:50 INFO - "pgo_build": "False", 04:29:50 INFO - "builduid": "cc07653b2c2b4c4f917f0cb42279d413", 04:29:50 INFO - "slavebuilddir": "test" 04:29:50 INFO - } 04:29:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:29:50 INFO - Running post-action listener: _resource_record_post_action 04:29:50 INFO - [mozharness: 2017-02-06 12:29:50.272625Z] Finished read-buildbot-config step (success) 04:29:50 INFO - [mozharness: 2017-02-06 12:29:50.272898Z] Running download-and-extract step. 04:29:50 INFO - Running pre-action listener: _resource_record_pre_action 04:29:50 INFO - Running main action method: download_and_extract 04:29:50 INFO - mkdir: /builds/slave/test/build/tests 04:29:50 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')]} 04:29:50 INFO - trying https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:29:50 INFO - Downloading https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/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 04:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/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 04:29:52 INFO - Downloaded 1199 bytes. 04:29:52 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:29:52 INFO - Using the following test package requirements: 04:29:52 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:29:52 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:29:52 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:29:52 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'jsshell-mac.zip'], 04:29:52 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:29:52 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:29:52 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:29:52 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:29:52 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:29:52 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:29:52 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:29:52 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:29:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:29:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:29:52 INFO - Fetch https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:29:53 INFO - Expected file size: 34851177 04:29:53 INFO - Obtained file size: 34851177 04:30:00 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 04:30:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:30:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:30:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:30:01 INFO - Expected file size: 34851177 04:30:01 INFO - Obtained file size: 34851177 04:30:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:30:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:30:07 INFO - Fetch https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:30:19 INFO - Expected file size: 14403454 04:30:19 INFO - Obtained file size: 14403454 04:30: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')]} 04:30:19 INFO - trying https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:30:19 INFO - Downloading https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:30:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/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 04:30:39 INFO - Downloaded 70362832 bytes. 04:30:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:30:39 INFO - mkdir: /builds/slave/test/properties 04:30:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:30:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:30:39 INFO - Contents: 04:30:39 INFO - build_url:https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:30:40 INFO - Running post-action listener: _resource_record_post_action 04:30:40 INFO - Running post-action listener: set_extra_try_arguments 04:30:40 INFO - [mozharness: 2017-02-06 12:30:40.195684Z] Finished download-and-extract step (success) 04:30:40 INFO - [mozharness: 2017-02-06 12:30:40.195809Z] Running populate-webroot step. 04:30:40 INFO - Running pre-action listener: _resource_record_pre_action 04:30:40 INFO - Running main action method: populate_webroot 04:30:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:30:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:30:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:30:40 INFO - '--tppagecycles', 04:30:40 INFO - '7'], 04:30:40 INFO - 'tests': ['tsvgm']}}, 04:30:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:30:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:30:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:30:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:30:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:30:40 INFO - 'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:30:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:30:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:30:40 INFO - 'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['damp', 'tps']}, 04:30:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:30:40 INFO - 'tests': ['damp', 'tps']}, 04:30:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['dromaeo_dom']}, 04:30:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:30:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['basic_compositor_video']}, 04:30:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:30:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['a11yr', 04:30:40 INFO - 'ts_paint', 04:30:40 INFO - 'tpaint', 04:30:40 INFO - 'sessionrestore', 04:30:40 INFO - 'sessionrestore_no_auto_restore', 04:30:40 INFO - 'tabpaint']}, 04:30:40 INFO - 'other-e10s': {'tests': ['a11yr', 04:30:40 INFO - 'ts_paint', 04:30:40 INFO - 'tpaint', 04:30:40 INFO - 'sessionrestore', 04:30:40 INFO - 'sessionrestore_no_auto_restore', 04:30:40 INFO - 'tabpaint']}, 04:30:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:30:40 INFO - 'ts_paint', 04:30:40 INFO - 'tpaint', 04:30:40 INFO - 'sessionrestore', 04:30:40 INFO - 'sessionrestore_no_auto_restore', 04:30:40 INFO - 'tabpaint']}, 04:30:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:30:40 INFO - 'ts_paint', 04:30:40 INFO - 'tpaint', 04:30:40 INFO - 'sessionrestore', 04:30:40 INFO - 'sessionrestore_no_auto_restore', 04:30:40 INFO - 'tabpaint']}, 04:30:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['a11yr', 04:30:40 INFO - 'ts_paint', 04:30:40 INFO - 'tpaint', 04:30:40 INFO - 'sessionrestore', 04:30:40 INFO - 'sessionrestore_no_auto_restore', 04:30:40 INFO - 'tabpaint']}, 04:30:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['a11yr', 04:30:40 INFO - 'ts_paint', 04:30:40 INFO - 'tpaint', 04:30:40 INFO - 'sessionrestore', 04:30:40 INFO - 'sessionrestore_no_auto_restore', 04:30:40 INFO - 'tabpaint']}, 04:30:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['tsvgx', 04:30:40 INFO - 'tsvgr_opacity', 04:30:40 INFO - 'tart', 04:30:40 INFO - 'tscrollx', 04:30:40 INFO - 'cart', 04:30:40 INFO - 'tsvg_static']}, 04:30:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:30:40 INFO - 'tsvgr_opacity', 04:30:40 INFO - 'tart', 04:30:40 INFO - 'tscrollx', 04:30:40 INFO - 'cart', 04:30:40 INFO - 'tsvg_static']}, 04:30:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:30:40 INFO - 'talos_options': ['--disable-e10s'], 04:30:40 INFO - 'tests': ['tp5o']}, 04:30:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:30:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:30:40 INFO - 'talos_options': ['--disable-e10s', 04:30:40 INFO - '--xperf_path', 04:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:40 INFO - 'tests': ['tp5n']}, 04:30:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:30:40 INFO - 'talos_options': ['--xperf_path', 04:30:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:30:40 INFO - 'tests': ['tp5n']}}, 04:30:40 INFO - 'talos.zip': {'path': '', 04:30:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:30:40 INFO - Running post-action listener: _resource_record_post_action 04:30:40 INFO - [mozharness: 2017-02-06 12:30:40.213974Z] Finished populate-webroot step (success) 04:30:40 INFO - [mozharness: 2017-02-06 12:30:40.214116Z] Running create-virtualenv step. 04:30:40 INFO - Running pre-action listener: _resource_record_pre_action 04:30:40 INFO - Running main action method: create_virtualenv 04:30:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:30:40 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 04:30:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:30:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:30:40 INFO - Using real prefix '/tools/python27' 04:30:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:30:41 INFO - Installing distribute.............................................................................................................................................................................................done. 04:30:43 INFO - Installing pip.................done. 04:30:43 INFO - Return code: 0 04:30:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:30:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:30:44 INFO - Reading from file tmpfile_stdout 04:30:44 INFO - Output received: 04:30:44 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) 04:30:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:30:44 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')]} 04:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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')]} 04:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:30:44 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 04:30:44 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 04:30:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:30:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:44 INFO - 'HOME': '/Users/cltbld', 04:30:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:44 INFO - 'LOGNAME': 'cltbld', 04:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:44 INFO - 'MOZ_NO_REMOTE': '1', 04:30:44 INFO - 'NO_EM_RESTART': '1', 04:30:44 INFO - 'PAGER': '/bin/cat', 04:30:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:44 INFO - 'PWD': '/builds/slave/test', 04:30:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:44 INFO - 'SHELL': '/bin/bash', 04:30:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:30:44 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:30:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:44 INFO - 'USER': 'cltbld', 04:30:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:44 INFO - 'XPC_FLAGS': '0x0', 04:30:44 INFO - 'XPC_SERVICE_NAME': '0', 04:30:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:44 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 04:30:44 INFO - Cleaning up... 04:30:44 INFO - Return code: 0 04:30:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:30:44 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')]} 04:30:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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')]} 04:30:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:44 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:30:44 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 04:30:44 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 04:30:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:30:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:44 INFO - 'HOME': '/Users/cltbld', 04:30:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:44 INFO - 'LOGNAME': 'cltbld', 04:30:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:44 INFO - 'MOZ_NO_REMOTE': '1', 04:30:44 INFO - 'NO_EM_RESTART': '1', 04:30:44 INFO - 'PAGER': '/bin/cat', 04:30:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:44 INFO - 'PWD': '/builds/slave/test', 04:30:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:44 INFO - 'SHELL': '/bin/bash', 04:30:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:30:44 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:30:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:44 INFO - 'USER': 'cltbld', 04:30:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:44 INFO - 'XPC_FLAGS': '0x0', 04:30:44 INFO - 'XPC_SERVICE_NAME': '0', 04:30:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:44 INFO - Downloading/unpacking psutil>=3.1.1 04:30:44 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 04:30:44 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 04:30:44 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 04:30:44 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 04:30:44 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 04:30:44 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 04:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:30:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:48 INFO - Installing collected packages: psutil 04:30:48 INFO - Running setup.py install for psutil 04:30:49 INFO - building 'psutil._psutil_osx' extension 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 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 04:30:49 INFO - building 'psutil._psutil_posix' extension 04:30:49 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 04:30:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:30:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:30:49 INFO - ^ 04:30:49 INFO - 1 warning generated. 04:30:49 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 04:30:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:30:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:30:50 INFO - Successfully installed psutil 04:30:50 INFO - Cleaning up... 04:30:50 INFO - Return code: 0 04:30:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:30:50 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')]} 04:30:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 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')]} 04:30:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:50 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:30:50 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 04:30:50 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 04:30:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:30:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:50 INFO - 'HOME': '/Users/cltbld', 04:30:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:50 INFO - 'LOGNAME': 'cltbld', 04:30:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:50 INFO - 'MOZ_NO_REMOTE': '1', 04:30:50 INFO - 'NO_EM_RESTART': '1', 04:30:50 INFO - 'PAGER': '/bin/cat', 04:30:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:50 INFO - 'PWD': '/builds/slave/test', 04:30:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:50 INFO - 'SHELL': '/bin/bash', 04:30:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:30:50 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:30:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:50 INFO - 'USER': 'cltbld', 04:30:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:50 INFO - 'XPC_FLAGS': '0x0', 04:30:50 INFO - 'XPC_SERVICE_NAME': '0', 04:30:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:50 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 04:30:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:30:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:30:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:30:54 INFO - Installing collected packages: mozsystemmonitor 04:30:54 INFO - Running setup.py install for mozsystemmonitor 04:30:54 INFO - Successfully installed mozsystemmonitor 04:30:54 INFO - Cleaning up... 04:30:54 INFO - Return code: 0 04:30:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:54 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:30:54 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 04:30:54 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 04:30:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:30:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:54 INFO - 'HOME': '/Users/cltbld', 04:30:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:54 INFO - 'LOGNAME': 'cltbld', 04:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:54 INFO - 'MOZ_NO_REMOTE': '1', 04:30:54 INFO - 'NO_EM_RESTART': '1', 04:30:54 INFO - 'PAGER': '/bin/cat', 04:30:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:54 INFO - 'PWD': '/builds/slave/test', 04:30:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:54 INFO - 'SHELL': '/bin/bash', 04:30:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:30:54 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:30:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:54 INFO - 'USER': 'cltbld', 04:30:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:54 INFO - 'XPC_FLAGS': '0x0', 04:30:54 INFO - 'XPC_SERVICE_NAME': '0', 04:30:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:54 INFO - Downloading/unpacking jsonschema==2.5.1 04:30:54 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 04:30:54 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 04:30:54 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 04:30:54 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 04:30:54 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 04:30:54 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 04:30:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:30:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:30:57 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 04:30:57 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 04:30:57 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 04:30:57 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 04:30:57 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 04:30:57 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 04:30:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:30:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:30:58 INFO - warning: no files found matching '*.txt' 04:30:58 INFO - no previously-included directories found matching 'build' 04:30:58 INFO - no previously-included directories found matching 'dist' 04:30:58 INFO - no previously-included directories found matching '.git*' 04:30:58 INFO - Installing collected packages: jsonschema, functools32 04:30:58 INFO - Running setup.py install for functools32 04:30:58 INFO - warning: no files found matching '*.txt' 04:30:58 INFO - no previously-included directories found matching 'build' 04:30:58 INFO - no previously-included directories found matching 'dist' 04:30:58 INFO - no previously-included directories found matching '.git*' 04:30:58 INFO - Successfully installed jsonschema functools32 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:30:58 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')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:30:58 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 04:30:58 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 04:30:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:30:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:58 INFO - 'HOME': '/Users/cltbld', 04:30:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:58 INFO - 'LOGNAME': 'cltbld', 04:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:58 INFO - 'MOZ_NO_REMOTE': '1', 04:30:58 INFO - 'NO_EM_RESTART': '1', 04:30:58 INFO - 'PAGER': '/bin/cat', 04:30:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:58 INFO - 'PWD': '/builds/slave/test', 04:30:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:58 INFO - 'SHELL': '/bin/bash', 04:30:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:30:58 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:30:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:58 INFO - 'USER': 'cltbld', 04:30:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:58 INFO - 'XPC_FLAGS': '0x0', 04:30:58 INFO - 'XPC_SERVICE_NAME': '0', 04:30:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:30:58 INFO - Cleaning up... 04:30:58 INFO - Return code: 0 04:30:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:30:58 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')]} 04:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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')]} 04:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:30:58 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:30:58 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 04:30:58 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 04:30:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:30:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:30:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:30:58 INFO - 'HOME': '/Users/cltbld', 04:30:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:30:58 INFO - 'LOGNAME': 'cltbld', 04:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:58 INFO - 'MOZ_NO_REMOTE': '1', 04:30:58 INFO - 'NO_EM_RESTART': '1', 04:30:58 INFO - 'PAGER': '/bin/cat', 04:30:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:58 INFO - 'PWD': '/builds/slave/test', 04:30:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:30:58 INFO - 'SHELL': '/bin/bash', 04:30:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:30:58 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:30:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:30:58 INFO - 'USER': 'cltbld', 04:30:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:30:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:58 INFO - 'XPC_FLAGS': '0x0', 04:30:58 INFO - 'XPC_SERVICE_NAME': '0', 04:30:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:30:59 INFO - Downloading/unpacking blobuploader==1.2.4 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:30:59 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 04:31:01 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 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 04:31:02 INFO - Downloading docopt-0.6.1.tar.gz 04:31:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:03 INFO - Running setup.py install for blobuploader 04:31:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:03 INFO - Running setup.py install for requests 04:31:03 INFO - Running setup.py install for docopt 04:31:03 INFO - Successfully installed blobuploader requests docopt 04:31:03 INFO - Cleaning up... 04:31:03 INFO - Return code: 0 04:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:03 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')]} 04:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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')]} 04:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:03 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:31:03 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 04:31:03 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 04:31:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:31:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:03 INFO - 'HOME': '/Users/cltbld', 04:31:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:03 INFO - 'LOGNAME': 'cltbld', 04:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:03 INFO - 'MOZ_NO_REMOTE': '1', 04:31:03 INFO - 'NO_EM_RESTART': '1', 04:31:03 INFO - 'PAGER': '/bin/cat', 04:31:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:03 INFO - 'PWD': '/builds/slave/test', 04:31:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:03 INFO - 'SHELL': '/bin/bash', 04:31:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:31:03 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:31:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:03 INFO - 'USER': 'cltbld', 04:31:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:03 INFO - 'XPC_FLAGS': '0x0', 04:31:03 INFO - 'XPC_SERVICE_NAME': '0', 04:31:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-96Si6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-WAW0DB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-SbHeEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3Auz_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-oM0NlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Bdzd3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-4j9q55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:04 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-gZdnMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-w0zt24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-7RrnXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-hzcedW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-2im5fI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-MEuqok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-E4QXCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zCdSxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-EMFmjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:05 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-GmazR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:05 INFO - Running setup.py install for manifestparser 04:31:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:06 INFO - Running setup.py install for mozcrash 04:31:06 INFO - Running setup.py install for mozdebug 04:31:06 INFO - Running setup.py install for mozdevice 04:31:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:06 INFO - Running setup.py install for mozfile 04:31:06 INFO - Running setup.py install for mozhttpd 04:31:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:06 INFO - Running setup.py install for mozinfo 04:31:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozInstall 04:31:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozleak 04:31:07 INFO - Running setup.py install for mozlog 04:31:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for moznetwork 04:31:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozprocess 04:31:07 INFO - Running setup.py install for mozprofile 04:31:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:07 INFO - Running setup.py install for mozrunner 04:31:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Running setup.py install for mozscreenshot 04:31:08 INFO - Running setup.py install for moztest 04:31:08 INFO - Running setup.py install for mozversion 04:31:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:08 INFO - Cleaning up... 04:31:08 INFO - Return code: 0 04:31:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:08 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')]} 04:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:08 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')]} 04:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:08 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:31:08 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 04:31:08 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 04:31:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:31:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:08 INFO - 'HOME': '/Users/cltbld', 04:31:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:08 INFO - 'LOGNAME': 'cltbld', 04:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:08 INFO - 'MOZ_NO_REMOTE': '1', 04:31:08 INFO - 'NO_EM_RESTART': '1', 04:31:08 INFO - 'PAGER': '/bin/cat', 04:31:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:08 INFO - 'PWD': '/builds/slave/test', 04:31:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:08 INFO - 'SHELL': '/bin/bash', 04:31:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:31:08 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:31:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:08 INFO - 'USER': 'cltbld', 04:31:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:08 INFO - 'XPC_FLAGS': '0x0', 04:31:08 INFO - 'XPC_SERVICE_NAME': '0', 04:31:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ts0Igw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:08 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)) 04:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:08 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-qIxTJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-MoD6XO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-dRKWGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-5xfwRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-M9exmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-vwC5Sn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-EyDBum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ISWz76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Lc_SGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:09 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)) 04:31:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:09 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-qduixI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:10 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-A9puqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:10 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-_6u3N0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:10 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3k8cDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:10 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-5wP5n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:10 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-1ZzCoa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:10 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)) 04:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:10 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-7lsNV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:10 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)) 04:31:10 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)) 04:31:10 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)) 04:31:10 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)) 04:31:10 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)) 04:31:10 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)) 04:31:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:13 INFO - Downloading blessings-1.6.tar.gz 04:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:13 INFO - Installing collected packages: blessings 04:31:13 INFO - Running setup.py install for blessings 04:31:13 INFO - Successfully installed blessings 04:31:13 INFO - Cleaning up... 04:31:13 INFO - Return code: 0 04:31:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:13 INFO - Reading from file tmpfile_stdout 04:31:13 INFO - Current package versions: 04:31:13 INFO - blessings == 1.6 04:31:13 INFO - blobuploader == 1.2.4 04:31:13 INFO - docopt == 0.6.1 04:31:13 INFO - functools32 == 3.2.3-2 04:31:13 INFO - jsonschema == 2.5.1 04:31:13 INFO - manifestparser == 1.1 04:31:13 INFO - mozInstall == 1.12 04:31:13 INFO - mozcrash == 1.0 04:31:13 INFO - mozdebug == 0.1 04:31:13 INFO - mozdevice == 0.49 04:31:13 INFO - mozfile == 1.2 04:31:13 INFO - mozhttpd == 0.7 04:31:13 INFO - mozinfo == 0.9 04:31:13 INFO - mozleak == 0.1 04:31:13 INFO - mozlog == 3.4 04:31:13 INFO - moznetwork == 0.27 04:31:13 INFO - mozprocess == 0.24 04:31:13 INFO - mozprofile == 0.28 04:31:13 INFO - mozrunner == 6.13 04:31:13 INFO - mozscreenshot == 0.1 04:31:13 INFO - mozsystemmonitor == 0.3 04:31:13 INFO - moztest == 0.8 04:31:13 INFO - mozversion == 1.4 04:31:13 INFO - psutil == 3.1.1 04:31:13 INFO - requests == 1.2.3 04:31:13 INFO - wsgiref == 0.1.2 04:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:13 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 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:31:13 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 04:31:13 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 04:31:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:31:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:13 INFO - 'HOME': '/Users/cltbld', 04:31:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:13 INFO - 'LOGNAME': 'cltbld', 04:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:13 INFO - 'MOZ_NO_REMOTE': '1', 04:31:13 INFO - 'NO_EM_RESTART': '1', 04:31:13 INFO - 'PAGER': '/bin/cat', 04:31:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:13 INFO - 'PWD': '/builds/slave/test', 04:31:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:13 INFO - 'SHELL': '/bin/bash', 04:31:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:31:13 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:31:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:13 INFO - 'USER': 'cltbld', 04:31:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:13 INFO - 'XPC_FLAGS': '0x0', 04:31:13 INFO - 'XPC_SERVICE_NAME': '0', 04:31:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 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)) 04:31:14 INFO - Cleaning up... 04:31:14 INFO - Return code: 0 04:31:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108155b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108158768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa120c6bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, '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.vmHu8Favbn/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.s2dr7FAZzR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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 04:31: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', 'jsonschema'] in /builds/slave/test/build 04:31: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 jsonschema 04:31:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:31:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:14 INFO - 'HOME': '/Users/cltbld', 04:31:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:14 INFO - 'LOGNAME': 'cltbld', 04:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:14 INFO - 'MOZ_NO_REMOTE': '1', 04:31:14 INFO - 'NO_EM_RESTART': '1', 04:31:14 INFO - 'PAGER': '/bin/cat', 04:31:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:14 INFO - 'PWD': '/builds/slave/test', 04:31:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:14 INFO - 'SHELL': '/bin/bash', 04:31:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:31:14 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:31:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:14 INFO - 'USER': 'cltbld', 04:31:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:14 INFO - 'XPC_FLAGS': '0x0', 04:31:14 INFO - 'XPC_SERVICE_NAME': '0', 04:31:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:14 INFO - Cleaning up... 04:31:14 INFO - Return code: 0 04:31:14 INFO - Running post-action listener: _resource_record_post_action 04:31:14 INFO - Running post-action listener: _start_resource_monitoring 04:31:14 INFO - Starting resource monitoring. 04:31:14 INFO - [mozharness: 2017-02-06 12:31:14.542529Z] Finished create-virtualenv step (success) 04:31:14 INFO - [mozharness: 2017-02-06 12:31:14.543433Z] Running install step. 04:31:14 INFO - Running pre-action listener: _resource_record_pre_action 04:31:14 INFO - Running main action method: install 04:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:14 INFO - Reading from file tmpfile_stdout 04:31:14 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:14 INFO - Reading from file tmpfile_stdout 04:31:14 INFO - Output received: 04:31:14 INFO - Usage: mozinstall [options] installer 04:31:14 INFO - Options: 04:31:14 INFO - -h, --help show this help message and exit 04:31:14 INFO - -d DEST, --destination=DEST 04:31:14 INFO - Directory to install application into. [default: 04:31:14 INFO - "/builds/slave/test"] 04:31:14 INFO - --app=APP Application being installed. [default: firefox] 04:31:14 INFO - mkdir: /builds/slave/test/build/application 04:31:14 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'] 04:31:14 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 04:31:36 INFO - Reading from file tmpfile_stdout 04:31:36 INFO - Output received: 04:31:36 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:31:36 INFO - Running post-action listener: _resource_record_post_action 04:31:36 INFO - [mozharness: 2017-02-06 12:31:36.978061Z] Finished install step (success) 04:31:36 INFO - [mozharness: 2017-02-06 12:31:36.978230Z] Running run-tests step. 04:31:36 INFO - Running pre-action listener: _resource_record_pre_action 04:31:36 INFO - Running main action method: run_tests 04:31:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:31:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:31:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:31:36 INFO - 2017-02-06 04:31:36.992 screenresolution[1639:8199] starting screenresolution argv=screenresolution get 04:31:36 INFO - 2017-02-06 04:31:36.995 screenresolution[1639:8199] Display 0: 1600x1200x32@60 04:31:37 INFO - 2017-02-06 04:31:37.001 screenresolution[1640:8202] starting screenresolution argv=screenresolution list 04:31:37 INFO - Available Modes on Display 0 04:31:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:31:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:31:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:31:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:31:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:31:37 INFO - Intel Iris: 04:31:37 INFO - Chipset Model: Intel Iris 04:31:37 INFO - Type: GPU 04:31:37 INFO - Bus: Built-In 04:31:37 INFO - VRAM (Dynamic, Max): 1536 MB 04:31:37 INFO - Vendor: Intel (0x8086) 04:31:37 INFO - Device ID: 0x0a2e 04:31:37 INFO - Revision ID: 0x0009 04:31:37 INFO - Displays: 04:31:37 INFO - Display: 04:31:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:31:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:31:37 INFO - Display Serial Number: 1600x1200 60 04:31:37 INFO - Main Display: Yes 04:31:37 INFO - Mirror: Off 04:31:37 INFO - Online: Yes 04:31:37 INFO - Rotation: Supported 04:31:37 INFO - Return code: 0 04:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:37 INFO - Python 2.7.3 04:31:37 INFO - Return code: 0 04:31:37 INFO - grabbing minidump binary from tooltool 04:31: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')]} 04:31:37 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 0x107f33d30>, '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 0x107e5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107f28be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:37 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 04:31:37 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 04:31:37 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 04:31:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:37 INFO - Return code: 0 04:31:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:31:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:31:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:37 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 04:31:37 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --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 04:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vmHu8Favbn/Render', 04:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:31:37 INFO - 'HOME': '/Users/cltbld', 04:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:31:37 INFO - 'LOGNAME': 'cltbld', 04:31:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:37 INFO - 'MOZ_NO_REMOTE': '1', 04:31:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:37 INFO - 'NO_EM_RESTART': '1', 04:31:37 INFO - 'PAGER': '/bin/cat', 04:31:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:37 INFO - 'PWD': '/builds/slave/test', 04:31:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:31:37 INFO - 'SHELL': '/bin/bash', 04:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.s2dr7FAZzR/Listeners', 04:31:37 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 04:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:31:37 INFO - 'USER': 'cltbld', 04:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:37 INFO - 'XPC_FLAGS': '0x0', 04:31:37 INFO - 'XPC_SERVICE_NAME': '0', 04:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:31:37 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--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 04:31:37 INFO - mozversion application_buildid: 20170206030211 04:31:37 INFO - mozversion application_changeset: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 04:31:37 INFO - mozversion application_display_name: Nightly 04:31:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:37 INFO - mozversion application_name: Firefox 04:31:37 INFO - mozversion application_remotingname: firefox 04:31:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:31:37 INFO - mozversion application_vendor: Mozilla 04:31:37 INFO - mozversion application_version: 54.0a1 04:31:37 INFO - mozversion platform_buildid: 20170206030211 04:31:37 INFO - mozversion platform_changeset: 20a8536b0bfac74389d3a57bd8dd957d98779ce1 04:31:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:31:37 INFO - mozversion platform_version: 54.0a1 04:31:37 INFO - using testdate: 1486384297 04:31:37 INFO - actual date: 1486384297 04:31:37 INFO - starting webserver on 'localhost:49241' 04:31:37 INFO - SUITE-START | Running 2 tests 04:31:37 INFO - TEST-START | dromaeo_css 04:31:37 INFO - operating with platform_type : mac_ 04:31:37 INFO - Initialising browser for dromaeo_css test... 04:31:37 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpIoIwoC/profile http://localhost:49241/getInfo.html) 04:31:40 INFO - PROCESS | 1650 | 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] 04:31:40 INFO - PROCESS | 1650 | 2017-02-06 04:31:40.757 plugin-container[1653:8375] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9043, name = 'com.apple.tsm.portname' 04:31:40 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:40 INFO - PROCESS | 1650 | 2017-02-06 04:31:40.758 plugin-container[1653:8375] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e07, name = 'com.apple.CFPasteboardClient' 04:31:40 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:40 INFO - PROCESS | 1650 | 2017-02-06 04:31:40.758 plugin-container[1653:8375] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:31:40 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 04:31:40 INFO - PROCESS | 1650 | colorDepth:24 04:31:40 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 04:31:40 INFO - PROCESS | 1650 | __metrics 04:31:40 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:31:40 INFO - PROCESS | 1650 | 1486384300885 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/FirefoxNightly.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/FirefoxNightly.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/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpIoIwoC/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpIoIwoC/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpIoIwoC/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpIoIwoC/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:31:41 INFO - TEST-INFO | 1650: exit 0 04:31:41 INFO - Browser initialized. 04:31:41 INFO - Running cycle 1/1 for dromaeo_css test... 04:31:41 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpIoIwoC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:44 INFO - PROCESS | 1655 | 2017-02-06 04:31:44.090 plugin-container[1656:8506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 04:31:44 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:44 INFO - PROCESS | 1655 | 2017-02-06 04:31:44.091 plugin-container[1656:8506] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:31:44 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:31:44 INFO - PROCESS | 1655 | 2017-02-06 04:31:44.091 plugin-container[1656:8506] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:31:53 INFO - PROCESS | 1655 | RSS: Main: 234348544 04:31:53 INFO - PROCESS | 1655 | 04:34:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:34:57 INFO - PROCESS | 1655 | RSS: Main: 262746112 04:34:57 INFO - PROCESS | 1655 | 04:36:41 INFO - PROCESS | 1655 | ************************* 04:36:41 INFO - PROCESS | 1655 | A coding exception was thrown and uncaught in a Task. 04:36:41 INFO - PROCESS | 1655 | 04:36:41 ERROR - PROCESS | 1655 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:36:41 INFO - PROCESS | 1655 | Full stack: 04:36:41 INFO - PROCESS | 1655 | ************************* 04:38:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:38:00 INFO - PROCESS | 1655 | RSS: Main: 269885440 04:38:00 INFO - PROCESS | 1655 | 04:41:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:41:03 INFO - PROCESS | 1655 | RSS: Main: 280367104 04:41:03 INFO - PROCESS | 1655 | 04:44:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:44:06 INFO - PROCESS | 1655 | RSS: Main: 273756160 04:44:06 INFO - PROCESS | 1655 | 04:47:09 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:47:09 INFO - PROCESS | 1655 | RSS: Main: 278663168 04:47:09 INFO - PROCESS | 1655 | 04:50:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 04:50:13 INFO - PROCESS | 1655 | RSS: Main: 280965120 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | __start_tp_report 04:50:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 04:50:13 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 04:50:13 INFO - PROCESS | 1655 | |i|pagename|runs| 04:50:13 INFO - PROCESS | 1655 | |0;dojo.html;3104.953425698615;3253.3168034712708;3271.607407111147;3276.164578032601;3320.9335813283733;5342.973285133574;5347.037533244014;5398.2712333834925;5404.189371594262;5474.233607294982;5369.463053694629;5434.429384914576;5442.510174084332;5502.0921547944645;5528.9723551382285;4894.486078961711;4973.626977976648;5045.419776725668;5084.288199652052;5084.339035925324;4869.099216644914;5034.899302013958;5072.9492705073035;5099.847004589868;5119.283300337956;4331.805068771912;4616.307553866914;4855.83004594841;4990.25146228065;5007.649464537502;4895.926561101586;4966.031623833354;4976.651634385595;4989.57588604969;4995.625328100371;4925.630577706686;4932.8520144395725;4933.161362568336;4942.283368911488;4942.629302802305;5263.44733802949;5343.118385466393;5358.3569971603265;5402.594805389572;5473.917891231635;5971.4327138921735;6030.9396906030815;6046.6069705469445;6056.152138700585;6108.236470441195;6086.056661217518;6093.207882975229;6096.664683442409;6097.69511524422;6106.572539922207;5458.0721277382145;5657.8585535361535;5664.150377443375;5675.829725108253;5684.914726279109;5987.491063259585;6108.725107370179;6117.005394430368;6127.5404344674325;6148.231471066117;5924.437178468039;5961.910571341434;5972.134040564094;5987.461128498369;5999.310079340931;5923.229980102646;5944.346121926585;6050.878982420327;6063.181470501426;6065.969670151621;5675.120356344773;5677.716114194356;5687.630304030225;5761.85595360111;5873.647581145145;4675.4155730533685;5763.135529670583;5772.826815195551;5774.971125144348;5784.768609255667;4665.6034237090225;4676.462206846256;4688.507706690816;4708.599769019604;4730.455997560256;3626.601073881871;4202.054537729047;4219.599138081878;4230.661547076226;4249.3625956106835;5531.115021596525;5544.556435485151;5547.611667183259;5552.305961754781;5573.804916827891;6010.2186715726675;6073.696315184223;6091.573589848668;6104.877902441926;6120.479759220427;5354.732263386815;5404.702741349185;5469.480399362054;5502.0921547944945;5515.641483303572;5289.603279754034;5291.629585928948;5302.973485132549;5333.466653334713;5335.1730481775385;6136.447719705248;6162.691865406712;6165.260168779775;6169.784057557964;6169.876602467836;5903.91144132847;5967.91048134287;6110.969445152746;6116.26604807426;6138.109974053827;6107.6640784757265;6116.025181289445;6124.899720462962;6133.08984587437;6151.015837465984;5948.910766338595;5990.850228744316;5998.34018258;6007.12896629995;6029.909551356821;5890.7054647266605;6058.3335833057445;6061.515078793598;6067.150598916067;6072.726727297194;4887.731174785279;5152.871178220575;5676.375598684224;5759;5853.531717462678;5941;5954.37479064692;5962.850928726816;5975.402459754164;5981.850453738517;4201.579842015774;4386.1447017831215;5503.229547863382;5551.417101204315;5657.2928383952;5782.855428614318;5809.883802324014;5811.1573821794755;5813.534917206529;5837.562182836389;4763.618910487222;5029.371328583927;5657.236273103078;5715.057015592547;5721.542276617777 04:50:13 INFO - PROCESS | 1655 | |1;ext.html;433.68557795598196;494.09333872344257;498.2103366164629;508.8119241570932;525.990099009901;39552.80223598881;41361.79319103404;41583.58416415835;41651.58348416515;41669.37495937559;41539.376909346385;41890.16219675605;42052;42088.57911420885;42191;9214.723558293244;9412.952935235315;9416.10546998034;9428.952855235715;10652.946735266312;10824.079953203947;10928.836067458995;10932.56269749209;10944.343339399622;10988.340699558012;10941.12471002322;10962.451877406098;10973.780524389547;11000.339979601209;11027.558897644085;10888.61889833856;10942.23404361695;10946.671599852058;10947.945260273647;10958.780824383468;9071.59177836999;10784.946075269652;10863.076638485738;10866.076383507412;10887;36132.81933590341;36420.81789591035;36430;36478.8176059118;36624.45063324052;3346.380919529895;3860.976841137101;3871.709621778378;3911.3546264866263;3912.7065470089856;27648.861755691294;27835.86082069597;28004.859975700194;28099;28945.131646050653;2776.486350025252;3097.566340712302;3107.1144723753846;3122.2350524121507;3209.6148462184456;439715;441124;444011;446144;446177.30734039017;46802.76598617053;48063.51936480591;55399.723001385544;55780.442195577525;55860;58086;58414;59071.40928590659;62783;62826.74346513044;14536.63658408527;14671;14696.485623003357;14715.484958026418;14738.042027268193;11170.329780213213;11181.944090279496;11282.94358528202;11285.605003824827;11347.773044539063;17880.28478860831;17935.461936141935;17951.55121121956;17963.461096166873;17963.461096167135;7141.392981596622;7524.495100979826;7860.567668778158;7971.322437592754;8033.7991550210545;738.770980995893;857.5326447086353;868.1718285683057;890.7283278599959;904.3850181876387;28159.87360505598;29158.271043223664;29463.558046629318;29808.701912981025;30049;1031.2781053262597;1043.3687618990402;1045.9163266938626;1077.876044254905;1080.222239987208;14749.041312314665;15308.234588270765;15423;15495.14776687293;15828.841711582967;558779;559660;565031;565543;566029;58885.41114588885;59256;59642.70178649079;59668.40331596715;59861.700691497135;1374.2785037855206;1409.6757745718337;1430.6280367104628;1432.9825823665105;1443.4370595467776;23885.164019259242;25714.742852571235;26574.06990755314;28033.738481767963;29093.7090629091;50687.746561266955;50906;50945.74527127341;51065.74467127641;51067.2339914909;487998;491141;492268;493210;493291;22450.550988980456;23096.769032310134;26249.606255905794;26370.20889373322;27121.321966950985;44568;45433.77283113563;45600.08799824051;45641.54358456506;46566;37413;37442.50689917227;37466;38130.23739525139;38512.844614661604;36434.90695279146;36574.268514629024;37624.811875940446;37860.24279514339;38164.809175953946;34492.65507344894;35518.64481355153;35542.933711988684;36573.08567285839;36879.893603191944;28108.71891281143;30497.510448119552;31112.444377781474;31290;34073.97778066662;29149.85425072861;29981.550276746304;30798.69201307958;31505.054848354586;32247.35505289928 04:50:13 INFO - PROCESS | 1655 | |2;jquery.html;355.9483874838148;392.6132759232156;395.05745634903485;403.41706234491164;425.5234137765703;13606.591802245948;15286;19495.707564386546;20710.585788284243;20731.378058658247;19916.70124948127;20286.999999999964;20850.791492085074;21021.789782102176;21282.14871405146;5773.047447171211;5801.390853960336;5840.591158618899;5887.087501437262;5909.615874968134;5848.385919478457;5915.911261331084;5959.970200148993;5966.015607424792;5978.940210597903;5613.242212301348;5782.595218334718;5836.037053886103;5855.941440585603;5859.472647461727;5683.147527870811;5826.912596311059;5875.059990401536;5943.732532036069;5967.492763115162;5819.418058194189;5965.642061476326;5966.343702192756;5976.8505787355225;5989.580729348947;13466.057375983684;13681.384337704727;13690.657733556642;13971.371288292052;13974.161550307013;2138.978610213909;2609.9869500652567;2610.151700697281;2878.1221727373145;2989.088328059941;9418.95290523543;10136.797264054678;10596.364218146937;11320.886791132065;15349.695275901562;1758.4900378890106;1808.5026617680112;1808.8643351748672;1813.0481497214068;1829.350580543901;89577.86477473257;93085;109393.45303273432;114333.42833285863;131456;9524.666636667684;11966.162368634286;11998.940005299917;12084.274943503418;12089.395530223454;15576.844231557767;15696.450624228326;15789.447369342019;15818.446354377771;15838.12890291022;6943.9931209974275;8265.8346833063;8380.287675547524;8391.916080839113;8487.363447741443;6582.506312026617;7876.488028278143;7896.960515197387;7898.328642065374;8023.1976802319305;4813.205821039559;4894.975525122351;4899.3385892904;4950.504949505021;4954.133026720309;1905.685561882274;1958.6964020576834;2044.2538473457082;2074.7510298764246;2083.1354987679942;398.1439904205923;819.074445876168;872.816708491224;881.6994932474548;896.211334026066;11703.122265829927;11861.46623401949;11928.224665396894;12220.633380998584;12272.570460033856;448.8204718112781;460.09361557731216;463.2680365023322;472.3623108803088;476.2427739893517;5153.871153221125;6281.497480201573;6318.84723463088;6323.7786677466065;6405.551611387158;690120.5493972498;701985;702274.4658830122;709243;712916;156734.21632891762;160783.39216607917;160786;160874;160994;444.9176902273025;451.9638428925678;453.81847261095163;454.4206137175128;457.6613306153489;9675.564599592895;11136.220464567403;11193.27243729155;11417.657470275904;11492.597759078391;50944.471665850084;54233.72883135559;54957.504249574726;55340.72329638326;56510;86911;86930;87171.56414217889;87322;87415.56967657566;6768.883134282985;7247.311505406978;7255.238199989136;8380.329573633973;8829.426087304304;7667.923320766721;11494.735579086127;12042.578509752117;12661.860432561114;13926.791098133333;8312.584370781558;9139.543022848964;10519.790224124323;11010.50452729613;11373.474222990899;10946.835797462885;10977.451127443755;11012.449377530931;11381.601643942422;11469.254498457574;10850;11357.54569817198;11758.70603234926;11822.467988940347;11846.052315814886;5865.706714664335;7416.924545940917;7594.658240379306;7641.2740789624895;7763.2236776321915;9153.588088535898;11559.248648837798;11600.883991160317;11603.6518904433;11691.883081169079 04:50:13 INFO - PROCESS | 1655 | |3;mootools.html;1299.1685321394307;1416.8087308213387;1432.9426822927082;1440.5318271561746;1449.8840092792577;8168.877466837995;8264.173582641733;8556;8592.957035214831;8710.695125670603;8433.746987590366;8527.530985795778;8537.701180458685;8562.614682339294;8567.357448191395;2274.090363854459;2296.4718114833513;2304.089884495623;2304.5506126305377;2304.5966955782756;2270.103309192868;2305.7809508096702;2306.0545176477563;2307.273208939179;2310.422394401391;2265.8413911026237;2269.6028195065796;2286.6684330772027;2288.896999635012;2292.2321022457495;2190.8247340212743;2247.741509726378;2272.8409011369213;2277.3851060213815;2278.100150440575;1962.479942815155;2031.14691829432;2250.459889626478;2280.692106565609;2300.7814257645496;8104.1085480597085;8314.667413303461;8350.164983501661;8395.664173433117;8403;4999.475055119196;5161.870953226162;5167.7932882684645;5169.147090730063;5170.095233334151;3498.4752287156875;3503.2292895562937;3532.4348104303444;3560.2701446203464;3619.2037751694584;1029.9124574411185;1209.9697507562382;1227.3679055286534;1243.975120497594;1266.1326991011188;8955;10775.461226938622;10843.186760992958;10896.509657065371;10915;4195.370694395804;4433.4236549249035;4499.392582001454;4509.751963642031;4541.795619197144;8764.693235736719;8797.252233560092;8799.384043117048;8800.295976321879;8811.295096392274;5118.948810511847;5123.052235336475;5125.641205115606;5129.487051294841;5135.717535535507;4632.25883858581;4653.674242803039;4660.277656963176;4746;4816.181249187646;3578.928421431609;3607.8917632471066;3624.52881125452;3646.890593282206;3705.3886108792285;1140.3044143072718;1146.1804809561204;1152.8010868696629;1158.5655379232787;1162.9360385178727;887.9600417981206;909.7498187998353;918.3984490158956;933.6863689753247;949.3734135470556;5543.667379957215;5607.45794906404;5710.65736055838;5809.215755872903;5974.223350964434;854.3891117850767;953.7472569769017;958.0802429667458;984.6898227058454;1005.587709039305;3260.755443341759;3599.9043214798257;3748;3758.342290099222;3849.3263678856088;9858.80282394348;10091.899081009096;10208.897911020795;10231.43727095002;10259.794804103876;10018.048285412875;10168.745781355377;10200.489975501196;10215.642452514126;10215.897841021495;6143.201383820075;6802.93197068023;7451.254874512614;7579.711449053674;7893.644785984645;5107.336046313955;5663.915041274467;5811.186433899173;5850.3857095006115;5880.176775251553;8887.422317549339;9102;9220.492872891788;9295.488748118918;9400.15398614128;9307.650390693176;9419.62321507132;9422.764430889283;9479.431234125974;9523.952380238332;7155.069840920647;7338.412926965723;7345.412367010519;7364.742234021784;7398.59307738058;7830.804229894298;7863.803404914923;7871.016122984627;7911.84176316482;7955.5226686399;7191.604461754445;7195.244499327705;7215.963920180366;7220.1696804866015;7286.271372862671;7022.227554969051;7096.787096387116;7108.253633368422;7172.995780590826;7188.7124515020905;6287.528435367274;6340.175777148941;6395.912694841795;6403.391677790602;6428.774992875227;4916.287138364989;4987.401511818605;5016.59867210615;5064.215046667772;5238.0833354162105;4305.31115021595;5050.343455350928;5050.924236136534;5062.215356619729;5232.424433312256 04:50:13 INFO - PROCESS | 1655 | |4;prototype.html;346.8138964740587;359.98200089995504;360.38374379810523;371.9944200836986;372.5194499096166;4221.915561688768;4648.977225010496;4842.782074806638;5113.011850756416;5113.565346945505;4337.436133302666;4774.641901857366;4986.401631804189;5214.504622060898;5226.268322434862;3914.2758589660934;4149.543550209474;4157.438745769313;4159.9600099975005;4171.456561072408;3441.638627944055;3638.3450978823803;3932.5280966284085;4120.587941205886;4189.366147202593;4050.554439011721;4100.5489396166395;4100.815463304143;4119.794010299488;4140.523839758436;4088.5707000764787;4090.1819636072755;4093.52633052101;4094.3858421236755;4119.773412462313;3374.8481318340732;3591.3356029134693;3625.1299688074673;3660.5241318628673;3674.577423596294;4186.790660466995;4567.766702990208;4852.611791056707;5101.362329708786;5115.386153661584;3843.5195600549932;4213.91572168558;4597.517260687647;4607.995521947963;4608.400907881954;4710.057988402299;5177.896442071175;5599.964006658741;5621;5645.5483561315405;3093.5050391937184;3699.5375578052744;3845.365514690073;3853.325668008087;3881.9805900970596;5602.299712535933;5745.683987380692;5768.682722450264;5850.414958504158;5939.792107276225;3959.089409435846;4168.43726096973;4169.791510424467;4173.895652608649;4182.832686692498;3561.465780133001;4159.980804702867;4196.3705444183615;4218.873433796991;4271.5514870938105;4003.3994900764537;4595.563421474954;4795.856124316276;4835.202191638411;4891.951080489221;4749.311349854252;5367.463253674601;5403.918941215885;5649.209110724501;5679.069116500327;1378.5662910572892;1383.6471699716508;1386.7226554689103;1388.9097208681403;1392.9930350348184;844.3878188313423;890.617034675083;917.4357769971552;993.4039576254189;1001.0040010189907;4540.77296135192;4674.626029917598;4830.4444988826035;5066.847994560169;5067.113255180328;5297.251906870723;5327.81352652663;5453.972730136324;5466.316710411199;5712.942870571241;4086.4074709167003;4519.254323036662;4622.722636641745;4824.817919609718;4843.346148270009;2600.5189040027653;2609.1560199382766;2690.192942117357;2840.346720254353;2959.3045634275927;5292.655977361459;5746.793173433626;5801.303843538718;5807.5644326675665;5811.970940145272;5098.439171691111;5304.628675992721;5421.825194600136;5428.792685668638;5787.768489260467;4996.976829018464;5344.385395679469;5418.431064738224;5798.129925686812;5829;5335.559398962181;5337.813176538958;5610.354809196994;5622.176919694647;5643.238162848127;4974.726390048582;5184.611154163377;5471.72641367922;5548.583856210719;5560.499555039904;5295.947040529545;5636.408177141505;5835.94164058354;5856.560757943256;6033;3876.8061596920606;3991.261616600938;4161.2301724181125;4176.248275310351;4205.642520385679;4918.95081049185;5161.406438259498;5343.492368225013;5830;5832.533397328289;5148.613853960893;5236.711980840938;5639.64648484369;5696.401877802771;5747.626404283708;5634.971825140848;5667.858303542444;5703.372629010889;5709;5716.628419152742;4430.091831174537;5222.127829693729;5434.619576629598;5486.780528778804;5494.615376923737;5677.77288908439;5686.573506987075;5698.888716700204;5700;5715.8571035724435;5050.217216331474;5255.658382205144;5362.862725305584;5560.277163968658;5618.831435056954 04:50:13 INFO - PROCESS | 1655 | |5;yui.html;700.9929900700992;706.9257727938564;724.6159535446216;728.8105092675904;827.9834403311934;14090.718185636293;15205.847941520582;15213.315400806963;15217.695646087072;15227.847721522781;13755.518556850513;13886.513972010982;13921.30393480327;13942.163470191796;13956.651083722913;845.4715802623376;858.7767180533044;860.9870851937226;861.625193041026;861.9655213791441;846.4455781463151;863.2921004776086;864.3042350907517;878.0210065776645;879.4547380624022;928.972130836076;932.4964519159646;934.1125930366145;934.4533447932968;935.3452583191759;905.44767691708;931.0503286647615;931.4364809290417;931.5807886451124;935.3592788939599;689.8034060292842;692.2661978303015;692.8441100752341;693.5180049865346;703.8697840899399;14041.78937315941;14416.567502974927;14999.400023999027;15080.849191508163;15119.092854428769;13540.59378218655;13820;13839.861601384058;13861.306934653227;14176.29118544079;11524.481398337011;11717.824232636518;11730.472128754227;12013.57952471668;12309.076819238504;3611.205534782344;3658.432942893856;3666.2484190740834;3687.6128006559193;3813.866514671973;107328;107431.46284268529;108431.91568084297;108576.4571177139;109762;8008.559529225949;9637.42175469474;9705.611775529042;10000.199984001263;10000.749981250381;21490.78509214919;21994.120235190734;22040.88979555092;22168.667469987962;22474.550508989727;7537.095548534211;7555.773326800205;7600.771976840703;7630.847383052308;7698;4105.794710264475;4191.7694526801315;4217.683673724483;4221.767802770815;4324.329728892027;3608.9278214435562;3685.5208822852856;3715.5912849586525;3815.9427608585893;3975.7018223633345;667.0661074495745;667.6061123936901;701.5369855895085;710.616267215708;727.7307396263417;646.2568046746186;653.5294587896707;677.2617846547287;681.7750142452978;703.2510376449065;9234.89181298235;9433.292503062297;9467.715968520955;9541.856872146924;9542.42745435276;660.8645227728305;672.744357144282;686.9416099631587;687.4603436302478;688.6591137386926;4576.519465456146;4819.204831202883;5034.89930201394;5142.434332223453;5176.068307704574;99941;100064.49967750115;104537.47731261294;106316;110634;62917.42706432376;70979.64510177416;74204.25795741973;81330.59334703289;85435.57282213673;68420;68738.65630671814;71395.2860471399;73694.26305737089;75288.62355688187;9573.952130239582;10348.068673819393;10404.947975260075;10647.414392208502;10688.038076573146;46770.76614616905;47657.76171119122;47676.284855726495;49972.75013624909;50316.213635432396;55406.33780986577;67292;68006;68175.3182468169;70658.2335441618;11766.705832353917;11985.28088314704;12200.145989780985;12250.938745306217;12581.370931453574;12297.631071067883;12746.597874234012;12929.54746583865;13537.796933045815;13696.109752866032;12253.326067066397;12368.1960672556;12370.876291236973;12464.376781161087;12764.61706148817;12773.169743966613;12822.422990965615;12947;12948.935255323662;13379.598612041655;11895.888613935404;11934.940325298317;12157.574484892986;12279.938600306941;12535.623931282076;8505.574721264036;8726.345524085593;8931.73204803857;9122.31582631292;9224.262059035394;6502.122213501117;7207.359775261929;7329.963350183215;7680.500767450098;7994.360451163777 04:50:13 INFO - PROCESS | 1655 | __end_tp_report 04:50:13 INFO - PROCESS | 1655 | __start_cc_report 04:50:13 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,409 04:50:13 INFO - PROCESS | 1655 | __end_cc_report 04:50:13 INFO - PROCESS | 1655 | __startTimestamp1486385413011__endTimestamp 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | ------- Summary: start ------- 04:50:13 INFO - PROCESS | 1655 | Number of tests: 6 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5470.85 Median:5657.86 stddev:664.56 (11.7%) stddev-sans-first:640.16 04:50:13 INFO - PROCESS | 1655 | Values: 3105.0 3253.3 3271.6 3276.2 3320.9 5343.0 5347.0 5398.3 5404.2 5474.2 5369.5 5434.4 5442.5 5502.1 5529.0 4894.5 4973.6 5045.4 5084.3 5084.3 4869.1 5034.9 5072.9 5099.8 5119.3 4331.8 4616.3 4855.8 4990.3 5007.6 4895.9 4966.0 4976.7 4989.6 4995.6 4925.6 4932.9 4933.2 4942.3 4942.6 5263.4 5343.1 5358.4 5402.6 5473.9 5971.4 6030.9 6046.6 6056.2 6108.2 6086.1 6093.2 6096.7 6097.7 6106.6 5458.1 5657.9 5664.2 5675.8 5684.9 5987.5 6108.7 6117.0 6127.5 6148.2 5924.4 5961.9 5972.1 5987.5 5999.3 5923.2 5944.3 6050.9 6063.2 6066.0 5675.1 5677.7 5687.6 5761.9 5873.6 4675.4 5763.1 5772.8 5775.0 5784.8 4665.6 4676.5 4688.5 4708.6 4730.5 3626.6 4202.1 4219.6 4230.7 4249.4 5531.1 5544.6 5547.6 5552.3 5573.8 6010.2 6073.7 6091.6 6104.9 6120.5 5354.7 5404.7 5469.5 5502.1 5515.6 5289.6 5291.6 5303.0 5333.5 5335.2 6136.4 6162.7 6165.3 6169.8 6169.9 5903.9 5967.9 6111.0 6116.3 6138.1 6107.7 6116.0 6124.9 6133.1 6151.0 5948.9 5990.9 5998.3 6007.1 6029.9 5890.7 6058.3 6061.5 6067.2 6072.7 4887.7 5152.9 5676.4 5759.0 5853.5 5941.0 5954.4 5962.9 5975.4 5981.9 4201.6 4386.1 5503.2 5551.4 5657.3 5782.9 5809.9 5811.2 5813.5 5837.6 4763.6 5029.4 5657.2 5715.1 5721.5 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:63847.78 Median:36425.41 stddev:133545.79 (366.6%) stddev-sans-first:133835.55 04:50:13 INFO - PROCESS | 1655 | Values: 433.7 494.1 498.2 508.8 526.0 39552.8 41361.8 41583.6 41651.6 41669.4 41539.4 41890.2 42052.0 42088.6 42191.0 9214.7 9413.0 9416.1 9429.0 10652.9 10824.1 10928.8 10932.6 10944.3 10988.3 10941.1 10962.5 10973.8 11000.3 11027.6 10888.6 10942.2 10946.7 10947.9 10958.8 9071.6 10784.9 10863.1 10866.1 10887.0 36132.8 36420.8 36430.0 36478.8 36624.5 3346.4 3861.0 3871.7 3911.4 3912.7 27648.9 27835.9 28004.9 28099.0 28945.1 2776.5 3097.6 3107.1 3122.2 3209.6 439715.0 441124.0 444011.0 446144.0 446177.3 46802.8 48063.5 55399.7 55780.4 55860.0 58086.0 58414.0 59071.4 62783.0 62826.7 14536.6 14671.0 14696.5 14715.5 14738.0 11170.3 11181.9 11282.9 11285.6 11347.8 17880.3 17935.5 17951.6 17963.5 17963.5 7141.4 7524.5 7860.6 7971.3 8033.8 738.8 857.5 868.2 890.7 904.4 28159.9 29158.3 29463.6 29808.7 30049.0 1031.3 1043.4 1045.9 1077.9 1080.2 14749.0 15308.2 15423.0 15495.1 15828.8 558779.0 559660.0 565031.0 565543.0 566029.0 58885.4 59256.0 59642.7 59668.4 59861.7 1374.3 1409.7 1430.6 1433.0 1443.4 23885.2 25714.7 26574.1 28033.7 29093.7 50687.7 50906.0 50945.7 51065.7 51067.2 487998.0 491141.0 492268.0 493210.0 493291.0 22450.6 23096.8 26249.6 26370.2 27121.3 44568.0 45433.8 45600.1 45641.5 46566.0 37413.0 37442.5 37466.0 38130.2 38512.8 36434.9 36574.3 37624.8 37860.2 38164.8 34492.7 35518.6 35542.9 36573.1 36879.9 28108.7 30497.5 31112.4 31290.0 34074.0 29149.9 29981.6 30798.7 31505.1 32247.4 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:37820.20 Median:454.12 stddev:117471.25 (25867.9%) stddev-sans-first:117767.10 04:50:13 INFO - PROCESS | 1655 | Values: 355.9 392.6 395.1 403.4 425.5 13606.6 15286.0 19495.7 20710.6 20731.4 19916.7 20287.0 20850.8 21021.8 21282.1 5773.0 5801.4 5840.6 5887.1 5909.6 5848.4 5915.9 5960.0 5966.0 5978.9 5613.2 5782.6 5836.0 5855.9 5859.5 5683.1 5826.9 5875.1 5943.7 5967.5 5819.4 5965.6 5966.3 5976.9 5989.6 13466.1 13681.4 13690.7 13971.4 13974.2 2139.0 2610.0 2610.2 2878.1 2989.1 9419.0 10136.8 10596.4 11320.9 15349.7 1758.5 1808.5 1808.9 1813.0 1829.4 89577.9 93085.0 109393.5 114333.4 131456.0 9524.7 11966.2 11998.9 12084.3 12089.4 15576.8 15696.5 15789.4 15818.4 15838.1 6944.0 8265.8 8380.3 8391.9 8487.4 6582.5 7876.5 7897.0 7898.3 8023.2 4813.2 4895.0 4899.3 4950.5 4954.1 1905.7 1958.7 2044.3 2074.8 2083.1 398.1 819.1 872.8 881.7 896.2 11703.1 11861.5 11928.2 12220.6 12272.6 448.8 460.1 463.3 472.4 476.2 5153.9 6281.5 6318.8 6323.8 6405.6 690120.5 701985.0 702274.5 709243.0 712916.0 156734.2 160783.4 160786.0 160874.0 160994.0 444.9 452.0 453.8 454.4 457.7 9675.6 11136.2 11193.3 11417.7 11492.6 50944.5 54233.7 54957.5 55340.7 56510.0 86911.0 86930.0 87171.6 87322.0 87415.6 6768.9 7247.3 7255.2 8380.3 8829.4 7667.9 11494.7 12042.6 12661.9 13926.8 8312.6 9139.5 10519.8 11010.5 11373.5 10946.8 10977.5 11012.4 11381.6 11469.3 10850.0 11357.5 11758.7 11822.5 11846.1 5865.7 7416.9 7594.7 7641.3 7763.2 9153.6 11559.2 11600.9 11603.7 11691.9 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5418.96 Median:5124.35 stddev:2965.25 (57.9%) stddev-sans-first:2957.40 04:50:13 INFO - PROCESS | 1655 | Values: 1299.2 1416.8 1432.9 1440.5 1449.9 8168.9 8264.2 8556.0 8593.0 8710.7 8433.7 8527.5 8537.7 8562.6 8567.4 2274.1 2296.5 2304.1 2304.6 2304.6 2270.1 2305.8 2306.1 2307.3 2310.4 2265.8 2269.6 2286.7 2288.9 2292.2 2190.8 2247.7 2272.8 2277.4 2278.1 1962.5 2031.1 2250.5 2280.7 2300.8 8104.1 8314.7 8350.2 8395.7 8403.0 4999.5 5161.9 5167.8 5169.1 5170.1 3498.5 3503.2 3532.4 3560.3 3619.2 1029.9 1210.0 1227.4 1244.0 1266.1 8955.0 10775.5 10843.2 10896.5 10915.0 4195.4 4433.4 4499.4 4509.8 4541.8 8764.7 8797.3 8799.4 8800.3 8811.3 5118.9 5123.1 5125.6 5129.5 5135.7 4632.3 4653.7 4660.3 4746.0 4816.2 3578.9 3607.9 3624.5 3646.9 3705.4 1140.3 1146.2 1152.8 1158.6 1162.9 888.0 909.7 918.4 933.7 949.4 5543.7 5607.5 5710.7 5809.2 5974.2 854.4 953.7 958.1 984.7 1005.6 3260.8 3599.9 3748.0 3758.3 3849.3 9858.8 10091.9 10208.9 10231.4 10259.8 10018.0 10168.7 10200.5 10215.6 10215.9 6143.2 6802.9 7451.3 7579.7 7893.6 5107.3 5663.9 5811.2 5850.4 5880.2 8887.4 9102.0 9220.5 9295.5 9400.2 9307.7 9419.6 9422.8 9479.4 9524.0 7155.1 7338.4 7345.4 7364.7 7398.6 7830.8 7863.8 7871.0 7911.8 7955.5 7191.6 7195.2 7216.0 7220.2 7286.3 7022.2 7096.8 7108.3 7173.0 7188.7 6287.5 6340.2 6395.9 6403.4 6428.8 4916.3 4987.4 5016.6 5064.2 5238.1 4305.3 5050.3 5050.9 5062.2 5232.4 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4500.53 Median:4946.84 stddev:1341.27 (27.1%) stddev-sans-first:1308.29 04:50:13 INFO - PROCESS | 1655 | Values: 346.8 360.0 360.4 372.0 372.5 4221.9 4649.0 4842.8 5113.0 5113.6 4337.4 4774.6 4986.4 5214.5 5226.3 3914.3 4149.5 4157.4 4160.0 4171.5 3441.6 3638.3 3932.5 4120.6 4189.4 4050.6 4100.5 4100.8 4119.8 4140.5 4088.6 4090.2 4093.5 4094.4 4119.8 3374.8 3591.3 3625.1 3660.5 3674.6 4186.8 4567.8 4852.6 5101.4 5115.4 3843.5 4213.9 4597.5 4608.0 4608.4 4710.1 5177.9 5600.0 5621.0 5645.5 3093.5 3699.5 3845.4 3853.3 3882.0 5602.3 5745.7 5768.7 5850.4 5939.8 3959.1 4168.4 4169.8 4173.9 4182.8 3561.5 4160.0 4196.4 4218.9 4271.6 4003.4 4595.6 4795.9 4835.2 4892.0 4749.3 5367.5 5403.9 5649.2 5679.1 1378.6 1383.6 1386.7 1388.9 1393.0 844.4 890.6 917.4 993.4 1001.0 4540.8 4674.6 4830.4 5066.8 5067.1 5297.3 5327.8 5454.0 5466.3 5712.9 4086.4 4519.3 4622.7 4824.8 4843.3 2600.5 2609.2 2690.2 2840.3 2959.3 5292.7 5746.8 5801.3 5807.6 5812.0 5098.4 5304.6 5421.8 5428.8 5787.8 4997.0 5344.4 5418.4 5798.1 5829.0 5335.6 5337.8 5610.4 5622.2 5643.2 4974.7 5184.6 5471.7 5548.6 5560.5 5295.9 5636.4 5835.9 5856.6 6033.0 3876.8 3991.3 4161.2 4176.2 4205.6 4919.0 5161.4 5343.5 5830.0 5832.5 5148.6 5236.7 5639.6 5696.4 5747.6 5635.0 5667.9 5703.4 5709.0 5716.6 4430.1 5222.1 5434.6 5486.8 5494.6 5677.8 5686.6 5698.9 5700.0 5715.9 5050.2 5255.7 5362.9 5560.3 5618.8 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:19565.96 Median:50144.48 stddev:28544.02 (56.9%) stddev-sans-first:28588.95 04:50:13 INFO - PROCESS | 1655 | Values: 701.0 706.9 724.6 728.8 828.0 14090.7 15205.8 15213.3 15217.7 15227.8 13755.5 13886.5 13921.3 13942.2 13956.7 845.5 858.8 861.0 861.6 862.0 846.4 863.3 864.3 878.0 879.5 929.0 932.5 934.1 934.5 935.3 905.4 931.1 931.4 931.6 935.4 689.8 692.3 692.8 693.5 703.9 14041.8 14416.6 14999.4 15080.8 15119.1 13540.6 13820.0 13839.9 13861.3 14176.3 11524.5 11717.8 11730.5 12013.6 12309.1 3611.2 3658.4 3666.2 3687.6 3813.9 107328.0 107431.5 108431.9 108576.5 109762.0 8008.6 9637.4 9705.6 10000.2 10000.7 21490.8 21994.1 22040.9 22168.7 22474.6 7537.1 7555.8 7600.8 7630.8 7698.0 4105.8 4191.8 4217.7 4221.8 4324.3 3608.9 3685.5 3715.6 3815.9 3975.7 667.1 667.6 701.5 710.6 727.7 646.3 653.5 677.3 681.8 703.3 9234.9 9433.3 9467.7 9541.9 9542.4 660.9 672.7 686.9 687.5 688.7 4576.5 4819.2 5034.9 5142.4 5176.1 99941.0 100064.5 104537.5 106316.0 110634.0 62917.4 70979.6 74204.3 81330.6 85435.6 68420.0 68738.7 71395.3 73694.3 75288.6 9574.0 10348.1 10404.9 10647.4 10688.0 46770.8 47657.8 47676.3 49972.8 50316.2 55406.3 67292.0 68006.0 68175.3 70658.2 11766.7 11985.3 12200.1 12250.9 12581.4 12297.6 12746.6 12929.5 13537.8 13696.1 12253.3 12368.2 12370.9 12464.4 12764.6 12773.2 12822.4 12947.0 12948.9 13379.6 11895.9 11934.9 12157.6 12279.9 12535.6 8505.6 8726.3 8931.7 9122.3 9224.3 6502.1 7207.4 7330.0 7680.5 7994.4 04:50:13 INFO - PROCESS | 1655 | -------- Summary: end -------- 04:50:13 INFO - PROCESS | 1655 | 04:50:13 INFO - TEST-INFO | 1655: exit 0 04:50:13 INFO - TEST-OK | dromaeo_css | took 1116085ms 04:50:13 INFO - TEST-START | kraken 04:50:13 INFO - operating with platform_type : mac_ 04:50:13 INFO - Initialising browser for kraken test... 04:50:13 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpChqk_b/profile http://localhost:49241/getInfo.html) 04:50:16 INFO - PROCESS | 1664 | 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] 04:50:16 INFO - PROCESS | 1664 | 2017-02-06 04:50:16.507 plugin-container[1666:10485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 04:50:16 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:16 INFO - PROCESS | 1664 | 2017-02-06 04:50:16.507 plugin-container[1666:10485] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a53, name = 'com.apple.CFPasteboardClient' 04:50:16 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:16 INFO - PROCESS | 1664 | 2017-02-06 04:50:16.507 plugin-container[1666:10485] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:16 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 04:50:16 INFO - PROCESS | 1664 | colorDepth:24 04:50:16 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 04:50:16 INFO - PROCESS | 1664 | __metrics 04:50:16 ERROR - PROCESS | 1664 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:50:16 INFO - PROCESS | 1664 | 1486385416641 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/FirefoxNightly.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/FirefoxNightly.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/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpChqk_b/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpChqk_b/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpChqk_b/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpChqk_b/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:50:17 INFO - TEST-INFO | 1664: exit 0 04:50:17 INFO - Browser initialized. 04:50:17 INFO - Running cycle 1/1 for kraken test... 04:50:17 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpChqk_b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:19 INFO - PROCESS | 1667 | 2017-02-06 04:50:19.700 plugin-container[1668:10607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473f, name = 'com.apple.tsm.portname' 04:50:19 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:19 INFO - PROCESS | 1667 | 2017-02-06 04:50:19.701 plugin-container[1668:10607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 04:50:19 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:50:19 INFO - PROCESS | 1667 | 2017-02-06 04:50:19.701 plugin-container[1668:10607] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:50:29 INFO - PROCESS | 1667 | RSS: Main: 233689088 04:50:29 INFO - PROCESS | 1667 | 04:50:32 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:33 INFO - PROCESS | 1667 | RSS: Main: 247181312 04:50:33 INFO - PROCESS | 1667 | 04:50:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 04:50:36 INFO - PROCESS | 1667 | RSS: Main: 254971904 04:50:36 INFO - PROCESS | 1667 | 04:50:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 04:50:40 INFO - PROCESS | 1667 | RSS: Main: 257593344 04:50:40 INFO - PROCESS | 1667 | 04:50:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 04:50:43 INFO - PROCESS | 1667 | RSS: Main: 258842624 04:50:43 INFO - PROCESS | 1667 | 04:50:45 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:45 INFO - PROCESS | 1667 | RSS: Main: 260591616 04:50:45 INFO - PROCESS | 1667 | 04:50:48 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:49 INFO - PROCESS | 1667 | RSS: Main: 266338304 04:50:49 INFO - PROCESS | 1667 | 04:50:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:53 INFO - PROCESS | 1667 | RSS: Main: 265203712 04:50:53 INFO - PROCESS | 1667 | 04:50:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 04:50:57 INFO - PROCESS | 1667 | RSS: Main: 265383936 04:50:57 INFO - PROCESS | 1667 | 04:50:59 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:50:59 INFO - PROCESS | 1667 | RSS: Main: 264859648 04:50:59 INFO - PROCESS | 1667 | 04:51:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:02 INFO - PROCESS | 1667 | RSS: Main: 264912896 04:51:02 INFO - PROCESS | 1667 | 04:51:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:05 INFO - PROCESS | 1667 | RSS: Main: 264921088 04:51:05 INFO - PROCESS | 1667 | 04:51:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:08 INFO - PROCESS | 1667 | RSS: Main: 265228288 04:51:08 INFO - PROCESS | 1667 | 04:51:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:12 INFO - PROCESS | 1667 | RSS: Main: 265252864 04:51:12 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 04:51:14 INFO - PROCESS | 1667 | RSS: Main: 267051008 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | __start_tp_report 04:51:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 04:51:14 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 04:51:14 INFO - PROCESS | 1667 | |i|pagename|runs| 04:51:14 INFO - PROCESS | 1667 | |0;ai-astar;105;117;118;117;117;119;117;118;117;118 04:51:14 INFO - PROCESS | 1667 | |1;audio-beat-detection;144;125;114;147;126;143;141;115;156;146 04:51:14 INFO - PROCESS | 1667 | |2;audio-dft;203;210;203;213;199;195;203;194;194;194 04:51:14 INFO - PROCESS | 1667 | |3;audio-fft;82;59;60;87;62;78;83;86;63;75 04:51:14 INFO - PROCESS | 1667 | |4;audio-oscillator;87;71;82;73;70;71;82;70;74;82 04:51:14 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;135;122;89;95;124;85;91;85;110;131 04:51:14 INFO - PROCESS | 1667 | |6;imaging-darkroom;100;149;134;173;100;101;100;101;136;110 04:51:14 INFO - PROCESS | 1667 | |7;imaging-desaturate;114;149;90;149;86;148;151;82;151;76 04:51:14 INFO - PROCESS | 1667 | |8;json-parse-financial;64;63;62;68;101;55;59;64;99;99 04:51:14 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;68;74;68;72;78;76;69;69;70;70 04:51:14 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;90;87;87;84;87;87;89;85;87;80 04:51:14 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;136;137;128;131;178;172;162;155;205;169 04:51:14 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;173;179;211;175;175;173;177;218;184;237 04:51:14 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;67;67;67;70;67;68;69;66;67;68 04:51:14 INFO - PROCESS | 1667 | __end_tp_report 04:51:14 INFO - PROCESS | 1667 | __start_cc_report 04:51:14 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,984 04:51:14 INFO - PROCESS | 1667 | __end_cc_report 04:51:14 INFO - PROCESS | 1667 | __startTimestamp1486385474671__endTimestamp 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | ------- Summary: start ------- 04:51:14 INFO - PROCESS | 1667 | Number of tests: 14 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:116.30 Median:117.50 stddev:4.03 (3.4%) stddev-sans-first:0.73 04:51:14 INFO - PROCESS | 1667 | Values: 105.0 117.0 118.0 117.0 117.0 119.0 117.0 118.0 117.0 118.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:143.50 stddev:14.55 (10.1%) stddev-sans-first:15.11 04:51:14 INFO - PROCESS | 1667 | Values: 144.0 125.0 114.0 147.0 126.0 143.0 141.0 115.0 156.0 146.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:200.80 Median:203.00 stddev:6.86 (3.4%) stddev-sans-first:7.23 04:51:14 INFO - PROCESS | 1667 | Values: 203.0 210.0 203.0 213.0 199.0 195.0 203.0 194.0 194.0 194.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:73.50 Median:80.00 stddev:11.35 (14.2%) stddev-sans-first:11.61 04:51:14 INFO - PROCESS | 1667 | Values: 82.0 59.0 60.0 87.0 62.0 78.0 83.0 86.0 63.0 75.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:78.00 stddev:6.36 (8.1%) stddev-sans-first:5.41 04:51:14 INFO - PROCESS | 1667 | Values: 87.0 71.0 82.0 73.0 70.0 71.0 82.0 70.0 74.0 82.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:106.70 Median:85.00 stddev:19.93 (23.4%) stddev-sans-first:18.32 04:51:14 INFO - PROCESS | 1667 | Values: 135.0 122.0 89.0 95.0 124.0 85.0 91.0 85.0 110.0 131.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:120.40 Median:122.00 stddev:26.08 (21.4%) stddev-sans-first:26.60 04:51:14 INFO - PROCESS | 1667 | Values: 100.0 149.0 134.0 173.0 100.0 101.0 100.0 101.0 136.0 110.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:119.60 Median:113.50 stddev:33.10 (29.2%) stddev-sans-first:35.04 04:51:14 INFO - PROCESS | 1667 | Values: 114.0 149.0 90.0 149.0 86.0 148.0 151.0 82.0 151.0 76.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:73.40 Median:64.00 stddev:18.45 (28.8%) stddev-sans-first:19.25 04:51:14 INFO - PROCESS | 1667 | Values: 64.0 63.0 62.0 68.0 101.0 55.0 59.0 64.0 99.0 99.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:71.00 stddev:3.50 (4.9%) stddev-sans-first:3.49 04:51:14 INFO - PROCESS | 1667 | Values: 68.0 74.0 68.0 72.0 78.0 76.0 69.0 69.0 70.0 70.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:87.00 stddev:2.79 (3.2%) stddev-sans-first:2.62 04:51:14 INFO - PROCESS | 1667 | Values: 90.0 87.0 87.0 84.0 87.0 87.0 89.0 85.0 87.0 80.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:157.30 Median:165.50 stddev:24.72 (14.9%) stddev-sans-first:24.99 04:51:14 INFO - PROCESS | 1667 | Values: 136.0 137.0 128.0 131.0 178.0 172.0 162.0 155.0 205.0 169.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.20 Median:181.50 stddev:23.06 (12.7%) stddev-sans-first:23.61 04:51:14 INFO - PROCESS | 1667 | Values: 173.0 179.0 211.0 175.0 175.0 173.0 177.0 218.0 184.0 237.0 04:51:14 INFO - PROCESS | 1667 | 04:51:14 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.17 (1.7%) stddev-sans-first:1.22 04:51:14 INFO - PROCESS | 1667 | Values: 67.0 67.0 67.0 70.0 67.0 68.0 69.0 66.0 67.0 68.0 04:51:14 INFO - PROCESS | 1667 | -------- Summary: end -------- 04:51:14 INFO - PROCESS | 1667 | 04:51:15 INFO - TEST-INFO | 1667: exit 0 04:51:15 INFO - TEST-OK | kraken | took 61911ms 04:51:15 INFO - SUITE-END | took 1177s 04:51:15 INFO - Completed test suite (00:19:38) 04:51:15 INFO - javascript benchmark 04:51:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7023.354507032521, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3104.953425698615, 3253.3168034712708, 3271.607407111147, 3276.164578032601, 3320.9335813283733, 5342.973285133574, 5347.037533244014, 5398.2712333834925, 5404.189371594262, 5474.233607294982, 5369.463053694629, 5434.429384914576, 5442.510174084332, 5502.0921547944645, 5528.9723551382285, 4894.486078961711, 4973.626977976648, 5045.419776725668, 5084.288199652052, 5084.339035925324, 4869.099216644914, 5034.899302013958, 5072.9492705073035, 5099.847004589868, 5119.283300337956, 4331.805068771912, 4616.307553866914, 4855.83004594841, 4990.25146228065, 5007.649464537502, 4895.926561101586, 4966.031623833354, 4976.651634385595, 4989.57588604969, 4995.625328100371, 4925.630577706686, 4932.8520144395725, 4933.161362568336, 4942.283368911488, 4942.629302802305, 5263.44733802949, 5343.118385466393, 5358.3569971603265, 5402.594805389572, 5473.917891231635, 5971.4327138921735, 6030.9396906030815, 6046.6069705469445, 6056.152138700585, 6108.236470441195, 6086.056661217518, 6093.207882975229, 6096.664683442409, 6097.69511524422, 6106.572539922207, 5458.0721277382145, 5657.8585535361535, 5664.150377443375, 5675.829725108253, 5684.914726279109, 5987.491063259585, 6108.725107370179, 6117.005394430368, 6127.5404344674325, 6148.231471066117, 5924.437178468039, 5961.910571341434, 5972.134040564094, 5987.461128498369, 5999.310079340931, 5923.229980102646, 5944.346121926585, 6050.878982420327, 6063.181470501426, 6065.969670151621, 5675.120356344773, 5677.716114194356, 5687.630304030225, 5761.85595360111, 5873.647581145145, 4675.4155730533685, 5763.135529670583, 5772.826815195551, 5774.971125144348, 5784.768609255667, 4665.6034237090225, 4676.462206846256, 4688.507706690816, 4708.599769019604, 4730.455997560256, 3626.601073881871, 4202.054537729047, 4219.599138081878, 4230.661547076226, 4249.3625956106835, 5531.115021596525, 5544.556435485151, 5547.611667183259, 5552.305961754781, 5573.804916827891, 6010.2186715726675, 6073.696315184223, 6091.573589848668, 6104.877902441926, 6120.479759220427, 5354.732263386815, 5404.702741349185, 5469.480399362054, 5502.0921547944945, 5515.641483303572, 5289.603279754034, 5291.629585928948, 5302.973485132549, 5333.466653334713, 5335.1730481775385, 6136.447719705248, 6162.691865406712, 6165.260168779775, 6169.784057557964, 6169.876602467836, 5903.91144132847, 5967.91048134287, 6110.969445152746, 6116.26604807426, 6138.109974053827, 6107.6640784757265, 6116.025181289445, 6124.899720462962, 6133.08984587437, 6151.015837465984, 5948.910766338595, 5990.850228744316, 5998.34018258, 6007.12896629995, 6029.909551356821, 5890.7054647266605, 6058.3335833057445, 6061.515078793598, 6067.150598916067, 6072.726727297194, 4887.731174785279, 5152.871178220575, 5676.375598684224, 5759.0, 5853.531717462678, 5941.0, 5954.37479064692, 5962.850928726816, 5975.402459754164, 5981.850453738517, 4201.579842015774, 4386.1447017831215, 5503.229547863382, 5551.417101204315, 5657.2928383952, 5782.855428614318, 5809.883802324014, 5811.1573821794755, 5813.534917206529, 5837.562182836389, 4763.618910487222, 5029.371328583927, 5657.236273103078, 5715.057015592547, 5721.542276617777], "value": 5427.731182948103, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.68557795598196, 494.09333872344257, 498.2103366164629, 508.8119241570932, 525.990099009901, 39552.80223598881, 41361.79319103404, 41583.58416415835, 41651.58348416515, 41669.37495937559, 41539.376909346385, 41890.16219675605, 42052.0, 42088.57911420885, 42191.0, 9214.723558293244, 9412.952935235315, 9416.10546998034, 9428.952855235715, 10652.946735266312, 10824.079953203947, 10928.836067458995, 10932.56269749209, 10944.343339399622, 10988.340699558012, 10941.12471002322, 10962.451877406098, 10973.780524389547, 11000.339979601209, 11027.558897644085, 10888.61889833856, 10942.23404361695, 10946.671599852058, 10947.945260273647, 10958.780824383468, 9071.59177836999, 10784.946075269652, 10863.076638485738, 10866.076383507412, 10887.0, 36132.81933590341, 36420.81789591035, 36430.0, 36478.8176059118, 36624.45063324052, 3346.380919529895, 3860.976841137101, 3871.709621778378, 3911.3546264866263, 3912.7065470089856, 27648.861755691294, 27835.86082069597, 28004.859975700194, 28099.0, 28945.131646050653, 2776.486350025252, 3097.566340712302, 3107.1144723753846, 3122.2350524121507, 3209.6148462184456, 439715.0, 441124.0, 444011.0, 446144.0, 446177.30734039017, 46802.76598617053, 48063.51936480591, 55399.723001385544, 55780.442195577525, 55860.0, 58086.0, 58414.0, 59071.40928590659, 62783.0, 62826.74346513044, 14536.63658408527, 14671.0, 14696.485623003357, 14715.484958026418, 14738.042027268193, 11170.329780213213, 11181.944090279496, 11282.94358528202, 11285.605003824827, 11347.773044539063, 17880.28478860831, 17935.461936141935, 17951.55121121956, 17963.461096166873, 17963.461096167135, 7141.392981596622, 7524.495100979826, 7860.567668778158, 7971.322437592754, 8033.7991550210545, 738.770980995893, 857.5326447086353, 868.1718285683057, 890.7283278599959, 904.3850181876387, 28159.87360505598, 29158.271043223664, 29463.558046629318, 29808.701912981025, 30049.0, 1031.2781053262597, 1043.3687618990402, 1045.9163266938626, 1077.876044254905, 1080.222239987208, 14749.041312314665, 15308.234588270765, 15423.0, 15495.14776687293, 15828.841711582967, 558779.0, 559660.0, 565031.0, 565543.0, 566029.0, 58885.41114588885, 59256.0, 59642.70178649079, 59668.40331596715, 59861.700691497135, 1374.2785037855206, 1409.6757745718337, 1430.6280367104628, 1432.9825823665105, 1443.4370595467776, 23885.164019259242, 25714.742852571235, 26574.06990755314, 28033.738481767963, 29093.7090629091, 50687.746561266955, 50906.0, 50945.74527127341, 51065.74467127641, 51067.2339914909, 487998.0, 491141.0, 492268.0, 493210.0, 493291.0, 22450.550988980456, 23096.769032310134, 26249.606255905794, 26370.20889373322, 27121.321966950985, 44568.0, 45433.77283113563, 45600.08799824051, 45641.54358456506, 46566.0, 37413.0, 37442.50689917227, 37466.0, 38130.23739525139, 38512.844614661604, 36434.90695279146, 36574.268514629024, 37624.811875940446, 37860.24279514339, 38164.809175953946, 34492.65507344894, 35518.64481355153, 35542.933711988684, 36573.08567285839, 36879.893603191944, 28108.71891281143, 30497.510448119552, 31112.444377781474, 31290.0, 34073.97778066662, 29149.85425072861, 29981.550276746304, 30798.69201307958, 31505.054848354586, 32247.35505289928], "value": 19549.20584580622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.9483874838148, 392.6132759232156, 395.05745634903485, 403.41706234491164, 425.5234137765703, 13606.591802245948, 15286.0, 19495.707564386546, 20710.585788284243, 20731.378058658247, 19916.70124948127, 20286.999999999964, 20850.791492085074, 21021.789782102176, 21282.14871405146, 5773.047447171211, 5801.390853960336, 5840.591158618899, 5887.087501437262, 5909.615874968134, 5848.385919478457, 5915.911261331084, 5959.970200148993, 5966.015607424792, 5978.940210597903, 5613.242212301348, 5782.595218334718, 5836.037053886103, 5855.941440585603, 5859.472647461727, 5683.147527870811, 5826.912596311059, 5875.059990401536, 5943.732532036069, 5967.492763115162, 5819.418058194189, 5965.642061476326, 5966.343702192756, 5976.8505787355225, 5989.580729348947, 13466.057375983684, 13681.384337704727, 13690.657733556642, 13971.371288292052, 13974.161550307013, 2138.978610213909, 2609.9869500652567, 2610.151700697281, 2878.1221727373145, 2989.088328059941, 9418.95290523543, 10136.797264054678, 10596.364218146937, 11320.886791132065, 15349.695275901562, 1758.4900378890106, 1808.5026617680112, 1808.8643351748672, 1813.0481497214068, 1829.350580543901, 89577.86477473257, 93085.0, 109393.45303273432, 114333.42833285863, 131456.0, 9524.666636667684, 11966.162368634286, 11998.940005299917, 12084.274943503418, 12089.395530223454, 15576.844231557767, 15696.450624228326, 15789.447369342019, 15818.446354377771, 15838.12890291022, 6943.9931209974275, 8265.8346833063, 8380.287675547524, 8391.916080839113, 8487.363447741443, 6582.506312026617, 7876.488028278143, 7896.960515197387, 7898.328642065374, 8023.1976802319305, 4813.205821039559, 4894.975525122351, 4899.3385892904, 4950.504949505021, 4954.133026720309, 1905.685561882274, 1958.6964020576834, 2044.2538473457082, 2074.7510298764246, 2083.1354987679942, 398.1439904205923, 819.074445876168, 872.816708491224, 881.6994932474548, 896.211334026066, 11703.122265829927, 11861.46623401949, 11928.224665396894, 12220.633380998584, 12272.570460033856, 448.8204718112781, 460.09361557731216, 463.2680365023322, 472.3623108803088, 476.2427739893517, 5153.871153221125, 6281.497480201573, 6318.84723463088, 6323.7786677466065, 6405.551611387158, 690120.5493972498, 701985.0, 702274.4658830122, 709243.0, 712916.0, 156734.21632891762, 160783.39216607917, 160786.0, 160874.0, 160994.0, 444.9176902273025, 451.9638428925678, 453.81847261095163, 454.4206137175128, 457.6613306153489, 9675.564599592895, 11136.220464567403, 11193.27243729155, 11417.657470275904, 11492.597759078391, 50944.471665850084, 54233.72883135559, 54957.504249574726, 55340.72329638326, 56510.0, 86911.0, 86930.0, 87171.56414217889, 87322.0, 87415.56967657566, 6768.883134282985, 7247.311505406978, 7255.238199989136, 8380.329573633973, 8829.426087304304, 7667.923320766721, 11494.735579086127, 12042.578509752117, 12661.860432561114, 13926.791098133333, 8312.584370781558, 9139.543022848964, 10519.790224124323, 11010.50452729613, 11373.474222990899, 10946.835797462885, 10977.451127443755, 11012.449377530931, 11381.601643942422, 11469.254498457574, 10850.0, 11357.54569817198, 11758.70603234926, 11822.467988940347, 11846.052315814886, 5865.706714664335, 7416.924545940917, 7594.658240379306, 7641.2740789624895, 7763.2236776321915, 9153.588088535898, 11559.248648837798, 11600.883991160317, 11603.6518904433, 11691.883081169079], "value": 8673.617739270869, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.1685321394307, 1416.8087308213387, 1432.9426822927082, 1440.5318271561746, 1449.8840092792577, 8168.877466837995, 8264.173582641733, 8556.0, 8592.957035214831, 8710.695125670603, 8433.746987590366, 8527.530985795778, 8537.701180458685, 8562.614682339294, 8567.357448191395, 2274.090363854459, 2296.4718114833513, 2304.089884495623, 2304.5506126305377, 2304.5966955782756, 2270.103309192868, 2305.7809508096702, 2306.0545176477563, 2307.273208939179, 2310.422394401391, 2265.8413911026237, 2269.6028195065796, 2286.6684330772027, 2288.896999635012, 2292.2321022457495, 2190.8247340212743, 2247.741509726378, 2272.8409011369213, 2277.3851060213815, 2278.100150440575, 1962.479942815155, 2031.14691829432, 2250.459889626478, 2280.692106565609, 2300.7814257645496, 8104.1085480597085, 8314.667413303461, 8350.164983501661, 8395.664173433117, 8403.0, 4999.475055119196, 5161.870953226162, 5167.7932882684645, 5169.147090730063, 5170.095233334151, 3498.4752287156875, 3503.2292895562937, 3532.4348104303444, 3560.2701446203464, 3619.2037751694584, 1029.9124574411185, 1209.9697507562382, 1227.3679055286534, 1243.975120497594, 1266.1326991011188, 8955.0, 10775.461226938622, 10843.186760992958, 10896.509657065371, 10915.0, 4195.370694395804, 4433.4236549249035, 4499.392582001454, 4509.751963642031, 4541.795619197144, 8764.693235736719, 8797.252233560092, 8799.384043117048, 8800.295976321879, 8811.295096392274, 5118.948810511847, 5123.052235336475, 5125.641205115606, 5129.487051294841, 5135.717535535507, 4632.25883858581, 4653.674242803039, 4660.277656963176, 4746.0, 4816.181249187646, 3578.928421431609, 3607.8917632471066, 3624.52881125452, 3646.890593282206, 3705.3886108792285, 1140.3044143072718, 1146.1804809561204, 1152.8010868696629, 1158.5655379232787, 1162.9360385178727, 887.9600417981206, 909.7498187998353, 918.3984490158956, 933.6863689753247, 949.3734135470556, 5543.667379957215, 5607.45794906404, 5710.65736055838, 5809.215755872903, 5974.223350964434, 854.3891117850767, 953.7472569769017, 958.0802429667458, 984.6898227058454, 1005.587709039305, 3260.755443341759, 3599.9043214798257, 3748.0, 3758.342290099222, 3849.3263678856088, 9858.80282394348, 10091.899081009096, 10208.897911020795, 10231.43727095002, 10259.794804103876, 10018.048285412875, 10168.745781355377, 10200.489975501196, 10215.642452514126, 10215.897841021495, 6143.201383820075, 6802.93197068023, 7451.254874512614, 7579.711449053674, 7893.644785984645, 5107.336046313955, 5663.915041274467, 5811.186433899173, 5850.3857095006115, 5880.176775251553, 8887.422317549339, 9102.0, 9220.492872891788, 9295.488748118918, 9400.15398614128, 9307.650390693176, 9419.62321507132, 9422.764430889283, 9479.431234125974, 9523.952380238332, 7155.069840920647, 7338.412926965723, 7345.412367010519, 7364.742234021784, 7398.59307738058, 7830.804229894298, 7863.803404914923, 7871.016122984627, 7911.84176316482, 7955.5226686399, 7191.604461754445, 7195.244499327705, 7215.963920180366, 7220.1696804866015, 7286.271372862671, 7022.227554969051, 7096.787096387116, 7108.253633368422, 7172.995780590826, 7188.7124515020905, 6287.528435367274, 6340.175777148941, 6395.912694841795, 6403.391677790602, 6428.774992875227, 4916.287138364989, 4987.401511818605, 5016.59867210615, 5064.215046667772, 5238.0833354162105, 4305.31115021595, 5050.343455350928, 5050.924236136534, 5062.215356619729, 5232.424433312256], "value": 4394.029517235164, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.8138964740587, 359.98200089995504, 360.38374379810523, 371.9944200836986, 372.5194499096166, 4221.915561688768, 4648.977225010496, 4842.782074806638, 5113.011850756416, 5113.565346945505, 4337.436133302666, 4774.641901857366, 4986.401631804189, 5214.504622060898, 5226.268322434862, 3914.2758589660934, 4149.543550209474, 4157.438745769313, 4159.9600099975005, 4171.456561072408, 3441.638627944055, 3638.3450978823803, 3932.5280966284085, 4120.587941205886, 4189.366147202593, 4050.554439011721, 4100.5489396166395, 4100.815463304143, 4119.794010299488, 4140.523839758436, 4088.5707000764787, 4090.1819636072755, 4093.52633052101, 4094.3858421236755, 4119.773412462313, 3374.8481318340732, 3591.3356029134693, 3625.1299688074673, 3660.5241318628673, 3674.577423596294, 4186.790660466995, 4567.766702990208, 4852.611791056707, 5101.362329708786, 5115.386153661584, 3843.5195600549932, 4213.91572168558, 4597.517260687647, 4607.995521947963, 4608.400907881954, 4710.057988402299, 5177.896442071175, 5599.964006658741, 5621.0, 5645.5483561315405, 3093.5050391937184, 3699.5375578052744, 3845.365514690073, 3853.325668008087, 3881.9805900970596, 5602.299712535933, 5745.683987380692, 5768.682722450264, 5850.414958504158, 5939.792107276225, 3959.089409435846, 4168.43726096973, 4169.791510424467, 4173.895652608649, 4182.832686692498, 3561.465780133001, 4159.980804702867, 4196.3705444183615, 4218.873433796991, 4271.5514870938105, 4003.3994900764537, 4595.563421474954, 4795.856124316276, 4835.202191638411, 4891.951080489221, 4749.311349854252, 5367.463253674601, 5403.918941215885, 5649.209110724501, 5679.069116500327, 1378.5662910572892, 1383.6471699716508, 1386.7226554689103, 1388.9097208681403, 1392.9930350348184, 844.3878188313423, 890.617034675083, 917.4357769971552, 993.4039576254189, 1001.0040010189907, 4540.77296135192, 4674.626029917598, 4830.4444988826035, 5066.847994560169, 5067.113255180328, 5297.251906870723, 5327.81352652663, 5453.972730136324, 5466.316710411199, 5712.942870571241, 4086.4074709167003, 4519.254323036662, 4622.722636641745, 4824.817919609718, 4843.346148270009, 2600.5189040027653, 2609.1560199382766, 2690.192942117357, 2840.346720254353, 2959.3045634275927, 5292.655977361459, 5746.793173433626, 5801.303843538718, 5807.5644326675665, 5811.970940145272, 5098.439171691111, 5304.628675992721, 5421.825194600136, 5428.792685668638, 5787.768489260467, 4996.976829018464, 5344.385395679469, 5418.431064738224, 5798.129925686812, 5829.0, 5335.559398962181, 5337.813176538958, 5610.354809196994, 5622.176919694647, 5643.238162848127, 4974.726390048582, 5184.611154163377, 5471.72641367922, 5548.583856210719, 5560.499555039904, 5295.947040529545, 5636.408177141505, 5835.94164058354, 5856.560757943256, 6033.0, 3876.8061596920606, 3991.261616600938, 4161.2301724181125, 4176.248275310351, 4205.642520385679, 4918.95081049185, 5161.406438259498, 5343.492368225013, 5830.0, 5832.533397328289, 5148.613853960893, 5236.711980840938, 5639.64648484369, 5696.401877802771, 5747.626404283708, 5634.971825140848, 5667.858303542444, 5703.372629010889, 5709.0, 5716.628419152742, 4430.091831174537, 5222.127829693729, 5434.619576629598, 5486.780528778804, 5494.615376923737, 5677.77288908439, 5686.573506987075, 5698.888716700204, 5700.0, 5715.8571035724435, 5050.217216331474, 5255.658382205144, 5362.862725305584, 5560.277163968658, 5618.831435056954], "value": 4093.4010495893435, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.9929900700992, 706.9257727938564, 724.6159535446216, 728.8105092675904, 827.9834403311934, 14090.718185636293, 15205.847941520582, 15213.315400806963, 15217.695646087072, 15227.847721522781, 13755.518556850513, 13886.513972010982, 13921.30393480327, 13942.163470191796, 13956.651083722913, 845.4715802623376, 858.7767180533044, 860.9870851937226, 861.625193041026, 861.9655213791441, 846.4455781463151, 863.2921004776086, 864.3042350907517, 878.0210065776645, 879.4547380624022, 928.972130836076, 932.4964519159646, 934.1125930366145, 934.4533447932968, 935.3452583191759, 905.44767691708, 931.0503286647615, 931.4364809290417, 931.5807886451124, 935.3592788939599, 689.8034060292842, 692.2661978303015, 692.8441100752341, 693.5180049865346, 703.8697840899399, 14041.78937315941, 14416.567502974927, 14999.400023999027, 15080.849191508163, 15119.092854428769, 13540.59378218655, 13820.0, 13839.861601384058, 13861.306934653227, 14176.29118544079, 11524.481398337011, 11717.824232636518, 11730.472128754227, 12013.57952471668, 12309.076819238504, 3611.205534782344, 3658.432942893856, 3666.2484190740834, 3687.6128006559193, 3813.866514671973, 107328.0, 107431.46284268529, 108431.91568084297, 108576.4571177139, 109762.0, 8008.559529225949, 9637.42175469474, 9705.611775529042, 10000.199984001263, 10000.749981250381, 21490.78509214919, 21994.120235190734, 22040.88979555092, 22168.667469987962, 22474.550508989727, 7537.095548534211, 7555.773326800205, 7600.771976840703, 7630.847383052308, 7698.0, 4105.794710264475, 4191.7694526801315, 4217.683673724483, 4221.767802770815, 4324.329728892027, 3608.9278214435562, 3685.5208822852856, 3715.5912849586525, 3815.9427608585893, 3975.7018223633345, 667.0661074495745, 667.6061123936901, 701.5369855895085, 710.616267215708, 727.7307396263417, 646.2568046746186, 653.5294587896707, 677.2617846547287, 681.7750142452978, 703.2510376449065, 9234.89181298235, 9433.292503062297, 9467.715968520955, 9541.856872146924, 9542.42745435276, 660.8645227728305, 672.744357144282, 686.9416099631587, 687.4603436302478, 688.6591137386926, 4576.519465456146, 4819.204831202883, 5034.89930201394, 5142.434332223453, 5176.068307704574, 99941.0, 100064.49967750115, 104537.47731261294, 106316.0, 110634.0, 62917.42706432376, 70979.64510177416, 74204.25795741973, 81330.59334703289, 85435.57282213673, 68420.0, 68738.65630671814, 71395.2860471399, 73694.26305737089, 75288.62355688187, 9573.952130239582, 10348.068673819393, 10404.947975260075, 10647.414392208502, 10688.038076573146, 46770.76614616905, 47657.76171119122, 47676.284855726495, 49972.75013624909, 50316.213635432396, 55406.33780986577, 67292.0, 68006.0, 68175.3182468169, 70658.2335441618, 11766.705832353917, 11985.28088314704, 12200.145989780985, 12250.938745306217, 12581.370931453574, 12297.631071067883, 12746.597874234012, 12929.54746583865, 13537.796933045815, 13696.109752866032, 12253.326067066397, 12368.1960672556, 12370.876291236973, 12464.376781161087, 12764.61706148817, 12773.169743966613, 12822.422990965615, 12947.0, 12948.935255323662, 13379.598612041655, 11895.888613935404, 11934.940325298317, 12157.574484892986, 12279.938600306941, 12535.623931282076, 8505.574721264036, 8726.345524085593, 8931.73204803857, 9122.31582631292, 9224.262059035394, 6502.122213501117, 7207.359775261929, 7329.963350183215, 7680.500767450098, 7994.360451163777], "value": 7249.8068390216695, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1595.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 118.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0, 118.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 114.0, 147.0, 126.0, 143.0, 141.0, 115.0, 156.0, 146.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 210.0, 203.0, 213.0, 199.0, 195.0, 203.0, 194.0, 194.0, 194.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 87.0, 62.0, 78.0, 83.0, 86.0, 63.0, 75.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 82.0, 73.0, 70.0, 71.0, 82.0, 70.0, 74.0, 82.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 122.0, 89.0, 95.0, 124.0, 85.0, 91.0, 85.0, 110.0, 131.0], "value": 106.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 149.0, 134.0, 173.0, 100.0, 101.0, 100.0, 101.0, 136.0, 110.0], "value": 120.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 149.0, 90.0, 149.0, 86.0, 148.0, 151.0, 82.0, 151.0, 76.0], "value": 119.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 62.0, 68.0, 101.0, 55.0, 59.0, 64.0, 99.0, 99.0], "value": 73.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 68.0, 72.0, 78.0, 76.0, 69.0, 69.0, 70.0, 70.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 87.0, 84.0, 87.0, 87.0, 89.0, 85.0, 87.0, 80.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 128.0, 131.0, 178.0, 172.0, 162.0, 155.0, 205.0, 169.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 179.0, 211.0, 175.0, 175.0, 173.0, 177.0, 218.0, 184.0, 237.0], "value": 190.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 70.0, 67.0, 68.0, 69.0, 66.0, 67.0, 68.0], "value": 67.6, "unit": "score"}]}]} 04:51:15 INFO - Return code: 0 04:51:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:15 ERROR - # TBPL SUCCESS # 04:51:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:51:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:51:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:51:16 INFO - 2017-02-06 04:51:16.004 screenresolution[1672:10998] starting screenresolution argv=screenresolution get 04:51:16 INFO - 2017-02-06 04:51:16.007 screenresolution[1672:10998] Display 0: 1600x1200x32@60 04:51:16 INFO - 2017-02-06 04:51:16.013 screenresolution[1673:11001] starting screenresolution argv=screenresolution list 04:51:16 INFO - Available Modes on Display 0 04:51:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:51:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:51:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:51:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:51:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:51:16 INFO - Intel Iris: 04:51:16 INFO - Chipset Model: Intel Iris 04:51:16 INFO - Type: GPU 04:51:16 INFO - Bus: Built-In 04:51:16 INFO - VRAM (Dynamic, Max): 1536 MB 04:51:16 INFO - Vendor: Intel (0x8086) 04:51:16 INFO - Device ID: 0x0a2e 04:51:16 INFO - Revision ID: 0x0009 04:51:16 INFO - Displays: 04:51:16 INFO - Display: 04:51:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:51:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:51:16 INFO - Display Serial Number: 1600x1200 60 04:51:16 INFO - Main Display: Yes 04:51:16 INFO - Mirror: Off 04:51:16 INFO - Online: Yes 04:51:16 INFO - Rotation: Supported 04:51:16 INFO - Return code: 0 04:51:16 INFO - Running post-action listener: _resource_record_post_action 04:51:16 INFO - [mozharness: 2017-02-06 12:51:16.252086Z] Finished run-tests step (success) 04:51:16 INFO - Running post-run listener: _resource_record_post_run 04:51:16 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 33415168; Write bytes: 558886912; Read time: 203; Write time: 1711 04:51:16 INFO - TinderboxPrint: CPU usage
54.5% 04:51:16 INFO - TinderboxPrint: I/O read bytes / time
33,415,168 / 203 04:51:16 INFO - TinderboxPrint: I/O write bytes / time
558,886,912 / 1,711 04:51:16 INFO - TinderboxPrint: CPU idle
2,188.9 (45.5%) 04:51:16 INFO - TinderboxPrint: CPU system
968.0 (20.1%) 04:51:16 INFO - TinderboxPrint: CPU user
1,648.8 (34.3%) 04:51:16 INFO - TinderboxPrint: Swap in / out
281,645,056 / 0 04:51:16 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 246178304; Write bytes: 238567424; Read time: 17721; Write time: 488 04:51:16 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31391744; Write bytes: 305102848; Read time: 184; Write time: 1177 04:51:16 INFO - Running post-run listener: _upload_blobber_files 04:51:16 INFO - Blob upload gear active. 04:51:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:16 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 04:51:16 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'] 04:51:16 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 04:51:17 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:51:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:18 INFO - (blobuploader) - INFO - Done attempting. 04:51:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:51:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:51:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:18 INFO - (blobuploader) - INFO - Done attempting. 04:51:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:51:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:51:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:19 INFO - (blobuploader) - INFO - Done attempting. 04:51:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:51:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:23 INFO - (blobuploader) - INFO - Done attempting. 04:51:23 INFO - (blobuploader) - INFO - Iteration through files over. 04:51:23 INFO - Return code: 0 04:51:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:51:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:51:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fe32a3c0191c92ad855a3663f148a00ad758caa18a139a9108ee0fd35d32539589e87bf6803c6d96dd15dee18eb115d8c944ed86a088226719d0113a0a3992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a40f86ae3bc2b4b84abb3eb26e35c3ea8d688a6f22f839fdfe56b1a805dcd7652499037956139420480be7c043156a0a7ce8562400b77419f297fd5fa3eb69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/693c2883f38b302a581ae7214d593b230a1b84c05551ac2bcf91a6868a5384b884b7d00af16e19967732cf1ae27cdbede57763f2b2bbe5024940bc5994989981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066e16fdff7278e0dc44a153dff10fb59b2cb59b15f13322465159a2f5d7822137e787da2d307e6d84addde739e92059b26de6a079b4b605de4dde7c931d520b"} 04:51:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:51:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:51:23 INFO - Contents: 04:51:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9fe32a3c0191c92ad855a3663f148a00ad758caa18a139a9108ee0fd35d32539589e87bf6803c6d96dd15dee18eb115d8c944ed86a088226719d0113a0a3992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a40f86ae3bc2b4b84abb3eb26e35c3ea8d688a6f22f839fdfe56b1a805dcd7652499037956139420480be7c043156a0a7ce8562400b77419f297fd5fa3eb69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/693c2883f38b302a581ae7214d593b230a1b84c05551ac2bcf91a6868a5384b884b7d00af16e19967732cf1ae27cdbede57763f2b2bbe5024940bc5994989981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066e16fdff7278e0dc44a153dff10fb59b2cb59b15f13322465159a2f5d7822137e787da2d307e6d84addde739e92059b26de6a079b4b605de4dde7c931d520b"} 04:51:23 INFO - Running post-run listener: copy_logs_to_upload_dir 04:51:23 INFO - Copying logs to upload dir... 04:51:23 INFO - mkdir: /builds/slave/test/build/upload/logs 04:51:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.314079 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2017-02-06 04:51:23.090372) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 04:51:23.094632) ========= 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.vmHu8Favbn/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.s2dr7FAZzR/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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/e9fe32a3c0191c92ad855a3663f148a00ad758caa18a139a9108ee0fd35d32539589e87bf6803c6d96dd15dee18eb115d8c944ed86a088226719d0113a0a3992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a40f86ae3bc2b4b84abb3eb26e35c3ea8d688a6f22f839fdfe56b1a805dcd7652499037956139420480be7c043156a0a7ce8562400b77419f297fd5fa3eb69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/693c2883f38b302a581ae7214d593b230a1b84c05551ac2bcf91a6868a5384b884b7d00af16e19967732cf1ae27cdbede57763f2b2bbe5024940bc5994989981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066e16fdff7278e0dc44a153dff10fb59b2cb59b15f13322465159a2f5d7822137e787da2d307e6d84addde739e92059b26de6a079b4b605de4dde7c931d520b"} build_url:https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011004 build_url: 'https://queue.taskcluster.net/v1/task/OTDf6WIzR6y5-dtsa2FChA/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/e9fe32a3c0191c92ad855a3663f148a00ad758caa18a139a9108ee0fd35d32539589e87bf6803c6d96dd15dee18eb115d8c944ed86a088226719d0113a0a3992", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8a40f86ae3bc2b4b84abb3eb26e35c3ea8d688a6f22f839fdfe56b1a805dcd7652499037956139420480be7c043156a0a7ce8562400b77419f297fd5fa3eb69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/693c2883f38b302a581ae7214d593b230a1b84c05551ac2bcf91a6868a5384b884b7d00af16e19967732cf1ae27cdbede57763f2b2bbe5024940bc5994989981", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/066e16fdff7278e0dc44a153dff10fb59b2cb59b15f13322465159a2f5d7822137e787da2d307e6d84addde739e92059b26de6a079b4b605de4dde7c931d520b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-06 04:51:23.131415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:51:23.131739) ========= 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.vmHu8Favbn/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.s2dr7FAZzR/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/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.005217 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-06 04:51:23.179953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 04:51:23.182319) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-06 04:51:23.182687) ========= ========= Total master_lag: 0.21 =========