builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0103 starttime: 1488630877.19 results: success (0) buildid: 20170304030205 builduid: 5fe185ce45144f099b11cdbafd0be53a revision: 80c06df83395314697d464f88f8daa98bf05465c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:37.191333) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:37.191796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:37.192091) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:37.366787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:37.367173) ========= 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.i8CD7pyuNw/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.XTKlwe9l13/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03-04 04:34:37-- 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% 7.97M=0.001s 2017-03-04 04:34:37 (7.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.562849 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:37.963061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:37.963382) ========= 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.i8CD7pyuNw/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.XTKlwe9l13/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.020991 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:38.011868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 04:34:38.012244) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 80c06df83395314697d464f88f8daa98bf05465c --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 80c06df83395314697d464f88f8daa98bf05465c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.i8CD7pyuNw/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.XTKlwe9l13/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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-03-04 04:34:38,089 truncating revision to first 12 chars 2017-03-04 04:34:38,089 Setting DEBUG logging. 2017-03-04 04:34:38,089 attempt 1/10 2017-03-04 04:34:38,089 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/80c06df83395?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-04 04:34:39,081 unpacking tar archive at: mozilla-central-80c06df83395/testing/mozharness/ program finished with exit code 0 elapsedTime=1.251221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-04 04:34:39.287651) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:39.287991) ========= script_repo_revision: 80c06df83395314697d464f88f8daa98bf05465c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:39.288377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:39.288651) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-04 04:34:39.309280) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-04 04:34:39.309659) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.i8CD7pyuNw/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.XTKlwe9l13/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:34:39 INFO - MultiFileLogger online at 20170304 04:34:39 in /builds/slave/test 04:34:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:34:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:34:39 INFO - {'append_to_log': False, 04:34:39 INFO - 'base_work_dir': '/builds/slave/test', 04:34:39 INFO - 'blob_upload_branch': 'Firefox', 04:34:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:34:39 INFO - 'branch': 'Firefox', 04:34:39 INFO - 'buildbot_json_path': 'buildprops.json', 04:34:39 INFO - 'config_files': ('talos/mac_config.py',), 04:34:39 INFO - 'default_actions': ('clobber', 04:34:39 INFO - 'read-buildbot-config', 04:34:39 INFO - 'download-and-extract', 04:34:39 INFO - 'populate-webroot', 04:34:39 INFO - 'create-virtualenv', 04:34:39 INFO - 'install', 04:34:39 INFO - 'run-tests'), 04:34:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:34:39 INFO - 'download_minidump_stackwalk': True, 04:34:39 INFO - 'download_symbols': 'ondemand', 04:34:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:34:39 INFO - 'tooltool.py': '/tools/tooltool.py', 04:34:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:34:39 INFO - '/tools/misc-python/virtualenv.py')}, 04:34:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:34:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:34:39 INFO - 'gecko_profile': False, 04:34:39 INFO - 'gecko_profile_interval': 0, 04:34:39 INFO - 'installer_path': 'installer.exe', 04:34:39 INFO - 'log_level': 'info', 04:34:39 INFO - 'log_name': 'talos', 04:34:39 INFO - 'log_to_console': True, 04:34:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:34:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:34:39 INFO - 'opt_config_files': (), 04:34:39 INFO - 'pip_index': False, 04:34:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:39 INFO - 'cmd': ('bash', 04:34:39 INFO - '-c', 04:34:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:39 INFO - 'enabled': True, 04:34:39 INFO - 'halt_on_failure': False, 04:34:39 INFO - 'name': 'check_screen_resolution'},), 04:34:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:34:39 INFO - 'cmd': ('bash', 04:34:39 INFO - '-c', 04:34:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:34:39 INFO - 'enabled': True, 04:34:39 INFO - 'halt_on_failure': False, 04:34:39 INFO - 'name': 'check_screen_resolution'},), 04:34:39 INFO - 'run_cmd_checks_enabled': True, 04:34:39 INFO - 'suite': 'dromaeojs', 04:34:39 INFO - 'system_bits': '32', 04:34:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:34:39 INFO - 'title': 't-yosemite-r7-0103', 04:34:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:34:39 INFO - 'use_talos_json': True, 04:34:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:34:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:34:39 INFO - 'work_dir': 'build'} 04:34:39 INFO - [mozharness: 2017-03-04 12:34:39.517194Z] Running clobber step. 04:34:39 INFO - Running pre-action listener: _resource_record_pre_action 04:34:39 INFO - Running main action method: clobber 04:34:39 INFO - rmtree: /builds/slave/test/build 04:34:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:41 INFO - Running post-action listener: _resource_record_post_action 04:34:41 INFO - [mozharness: 2017-03-04 12:34:41.672384Z] Finished clobber step (success) 04:34:41 INFO - [mozharness: 2017-03-04 12:34:41.672513Z] Running read-buildbot-config step. 04:34:41 INFO - Running pre-action listener: _resource_record_pre_action 04:34:41 INFO - Running main action method: read_buildbot_config 04:34:41 INFO - Using buildbot properties: 04:34:41 INFO - { 04:34:41 INFO - "project": "", 04:34:41 INFO - "product": "firefox", 04:34:41 INFO - "script_repo_revision": "production", 04:34:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:34:41 INFO - "repository": "", 04:34:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:34:41 INFO - "buildid": "20170304030205", 04:34:41 INFO - "stage_platform": "macosx64", 04:34:41 INFO - "basedir": "/builds/slave/test", 04:34:41 INFO - "nightly_build": "True", 04:34:41 INFO - "buildnumber": 10, 04:34:41 INFO - "slavename": "t-yosemite-r7-0103", 04:34:41 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:34:41 INFO - "platform": "yosemite_r7", 04:34:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:34:41 INFO - "branch": "mozilla-central", 04:34:41 INFO - "repo_path": "mozilla-central", 04:34:41 INFO - "revision": "80c06df83395314697d464f88f8daa98bf05465c", 04:34:41 INFO - "pgo_build": "False", 04:34:41 INFO - "builduid": "5fe185ce45144f099b11cdbafd0be53a", 04:34:41 INFO - "slavebuilddir": "test" 04:34:41 INFO - } 04:34:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:34:41 INFO - Running post-action listener: _resource_record_post_action 04:34:41 INFO - [mozharness: 2017-03-04 12:34:41.676002Z] Finished read-buildbot-config step (success) 04:34:41 INFO - [mozharness: 2017-03-04 12:34:41.676145Z] Running download-and-extract step. 04:34:41 INFO - Running pre-action listener: _resource_record_pre_action 04:34:41 INFO - Running main action method: download_and_extract 04:34:41 INFO - mkdir: /builds/slave/test/build/tests 04:34:41 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:34:41 INFO - trying https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:34:41 INFO - Downloading https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/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:34:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/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:34:42 INFO - Downloaded 1199 bytes. 04:34:42 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:34:42 INFO - Using the following test package requirements: 04:34:42 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:34:42 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:34:42 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:34:42 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'jsshell-mac.zip'], 04:34:42 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:34:42 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:34:42 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:34:42 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:34:42 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:34:42 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:34:42 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:34:42 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:34:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:34:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:42 INFO - Fetch https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:34:44 INFO - Expected file size: 51775505 04:34:44 INFO - Obtained file size: 51775505 04:34:59 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:34:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:34:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:34:59 INFO - Fetch https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:35:01 INFO - Expected file size: 51775505 04:35:01 INFO - Obtained file size: 51775505 04:35:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:35:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:35:16 INFO - Fetch https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:35:17 INFO - Expected file size: 14404424 04:35:17 INFO - Obtained file size: 14404424 04:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:18 INFO - trying https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:35:18 INFO - Downloading https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/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:35:20 INFO - Downloaded 75263770 bytes. 04:35:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:35:20 INFO - mkdir: /builds/slave/test/properties 04:35:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:35:20 INFO - Writing to file /builds/slave/test/properties/build_url 04:35:20 INFO - Contents: 04:35:20 INFO - build_url:https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:35:21 INFO - Running post-action listener: _resource_record_post_action 04:35:21 INFO - Running post-action listener: set_extra_try_arguments 04:35:21 INFO - [mozharness: 2017-03-04 12:35:21.013271Z] Finished download-and-extract step (success) 04:35:21 INFO - [mozharness: 2017-03-04 12:35:21.013403Z] Running populate-webroot step. 04:35:21 INFO - Running pre-action listener: _resource_record_pre_action 04:35:21 INFO - Running main action method: populate_webroot 04:35:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:35:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:35:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:35:21 INFO - '--tppagecycles', 04:35:21 INFO - '7'], 04:35:21 INFO - 'tests': ['tsvgm']}}, 04:35:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:35:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:35:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:35:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:35:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:35:21 INFO - 'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:35:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:35:21 INFO - 'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['damp', 'tps']}, 04:35:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:35:21 INFO - 'tests': ['damp', 'tps']}, 04:35:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['dromaeo_dom']}, 04:35:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:35:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['basic_compositor_video']}, 04:35:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:35:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['a11yr', 04:35:21 INFO - 'ts_paint', 04:35:21 INFO - 'tpaint', 04:35:21 INFO - 'sessionrestore', 04:35:21 INFO - 'sessionrestore_no_auto_restore', 04:35:21 INFO - 'tabpaint']}, 04:35:21 INFO - 'other-e10s': {'tests': ['a11yr', 04:35:21 INFO - 'ts_paint', 04:35:21 INFO - 'tpaint', 04:35:21 INFO - 'sessionrestore', 04:35:21 INFO - 'sessionrestore_no_auto_restore', 04:35:21 INFO - 'tabpaint']}, 04:35:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:35:21 INFO - 'ts_paint', 04:35:21 INFO - 'tpaint', 04:35:21 INFO - 'sessionrestore', 04:35:21 INFO - 'sessionrestore_no_auto_restore', 04:35:21 INFO - 'tabpaint']}, 04:35:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:35:21 INFO - 'ts_paint', 04:35:21 INFO - 'tpaint', 04:35:21 INFO - 'sessionrestore', 04:35:21 INFO - 'sessionrestore_no_auto_restore', 04:35:21 INFO - 'tabpaint']}, 04:35:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['a11yr', 04:35:21 INFO - 'ts_paint', 04:35:21 INFO - 'tpaint', 04:35:21 INFO - 'sessionrestore', 04:35:21 INFO - 'sessionrestore_no_auto_restore', 04:35:21 INFO - 'tabpaint']}, 04:35:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['a11yr', 04:35:21 INFO - 'ts_paint', 04:35:21 INFO - 'tpaint', 04:35:21 INFO - 'sessionrestore', 04:35:21 INFO - 'sessionrestore_no_auto_restore', 04:35:21 INFO - 'tabpaint']}, 04:35:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['tsvgx', 04:35:21 INFO - 'tsvgr_opacity', 04:35:21 INFO - 'tart', 04:35:21 INFO - 'tscrollx', 04:35:21 INFO - 'cart', 04:35:21 INFO - 'tsvg_static']}, 04:35:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:35:21 INFO - 'tsvgr_opacity', 04:35:21 INFO - 'tart', 04:35:21 INFO - 'tscrollx', 04:35:21 INFO - 'cart', 04:35:21 INFO - 'tsvg_static']}, 04:35:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:35:21 INFO - 'talos_options': ['--disable-e10s'], 04:35:21 INFO - 'tests': ['tp5o']}, 04:35:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:35:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:35:21 INFO - 'talos_options': ['--disable-e10s', 04:35:21 INFO - '--xperf_path', 04:35:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:21 INFO - 'tests': ['tp5n']}, 04:35:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:35:21 INFO - 'talos_options': ['--xperf_path', 04:35:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:21 INFO - 'tests': ['tp5n']}}, 04:35:21 INFO - 'talos.zip': {'path': '', 04:35:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:35:21 INFO - Running post-action listener: _resource_record_post_action 04:35:21 INFO - [mozharness: 2017-03-04 12:35:21.031773Z] Finished populate-webroot step (success) 04:35:21 INFO - [mozharness: 2017-03-04 12:35:21.031910Z] Running create-virtualenv step. 04:35:21 INFO - Running pre-action listener: _resource_record_pre_action 04:35:21 INFO - Running main action method: create_virtualenv 04:35:21 INFO - Creating virtualenv /builds/slave/test/build/venv 04:35:21 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:35:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:35:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:35:21 INFO - Using real prefix '/tools/python27' 04:35:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:35:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:24 INFO - Installing pip.................done. 04:35:24 INFO - Return code: 0 04:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:35:24 INFO - Reading from file tmpfile_stdout 04:35:24 INFO - Output received: 04:35:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:35:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:35:24 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:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:24 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:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:24 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:35:24 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:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:24 INFO - 'HOME': '/Users/cltbld', 04:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:24 INFO - 'LOGNAME': 'cltbld', 04:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:24 INFO - 'MOZ_NO_REMOTE': '1', 04:35:24 INFO - 'NO_EM_RESTART': '1', 04:35:24 INFO - 'PAGER': '/bin/cat', 04:35:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:24 INFO - 'PWD': '/builds/slave/test', 04:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:24 INFO - 'SHELL': '/bin/bash', 04:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:24 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:24 INFO - 'USER': 'cltbld', 04:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:24 INFO - 'XPC_FLAGS': '0x0', 04:35:24 INFO - 'XPC_SERVICE_NAME': '0', 04:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:25 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:35:25 INFO - Cleaning up... 04:35:25 INFO - Return code: 0 04:35:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:35:25 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:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:25 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:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:25 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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:25 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:35:25 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:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:25 INFO - 'HOME': '/Users/cltbld', 04:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:25 INFO - 'LOGNAME': 'cltbld', 04:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:25 INFO - 'MOZ_NO_REMOTE': '1', 04:35:25 INFO - 'NO_EM_RESTART': '1', 04:35:25 INFO - 'PAGER': '/bin/cat', 04:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:25 INFO - 'PWD': '/builds/slave/test', 04:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:25 INFO - 'SHELL': '/bin/bash', 04:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:25 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:25 INFO - 'USER': 'cltbld', 04:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:25 INFO - 'XPC_FLAGS': '0x0', 04:35:25 INFO - 'XPC_SERVICE_NAME': '0', 04:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:25 INFO - Downloading/unpacking psutil>=3.1.1 04:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:29 INFO - Installing collected packages: psutil 04:35:29 INFO - Running setup.py install for psutil 04:35:29 INFO - building 'psutil._psutil_osx' extension 04:35:29 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:35:30 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:35:30 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:35:30 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:35:30 INFO - building 'psutil._psutil_posix' extension 04:35:30 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:35:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:35:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:35:30 INFO - ^ 04:35:30 INFO - 1 warning generated. 04:35:30 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:35:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:30 INFO - Successfully installed psutil 04:35:30 INFO - Cleaning up... 04:35:30 INFO - Return code: 0 04:35:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:35:30 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:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:30 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:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:30 INFO - 'HOME': '/Users/cltbld', 04:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:30 INFO - 'LOGNAME': 'cltbld', 04:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:30 INFO - 'MOZ_NO_REMOTE': '1', 04:35:30 INFO - 'NO_EM_RESTART': '1', 04:35:30 INFO - 'PAGER': '/bin/cat', 04:35:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:30 INFO - 'PWD': '/builds/slave/test', 04:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:30 INFO - 'SHELL': '/bin/bash', 04:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:30 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:30 INFO - 'USER': 'cltbld', 04:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:30 INFO - 'XPC_FLAGS': '0x0', 04:35:30 INFO - 'XPC_SERVICE_NAME': '0', 04:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:35:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:35:33 INFO - Installing collected packages: mozsystemmonitor 04:35:33 INFO - Running setup.py install for mozsystemmonitor 04:35:33 INFO - Successfully installed mozsystemmonitor 04:35:33 INFO - Cleaning up... 04:35:33 INFO - Return code: 0 04:35:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:35:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:33 INFO - 'HOME': '/Users/cltbld', 04:35:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:33 INFO - 'LOGNAME': 'cltbld', 04:35:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:33 INFO - 'MOZ_NO_REMOTE': '1', 04:35:33 INFO - 'NO_EM_RESTART': '1', 04:35:33 INFO - 'PAGER': '/bin/cat', 04:35:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:33 INFO - 'PWD': '/builds/slave/test', 04:35:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:33 INFO - 'SHELL': '/bin/bash', 04:35:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:33 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:33 INFO - 'USER': 'cltbld', 04:35:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:33 INFO - 'XPC_FLAGS': '0x0', 04:35:33 INFO - 'XPC_SERVICE_NAME': '0', 04:35:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:34 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:35:34 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:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:35:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:35:36 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:35:36 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:35:36 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:35:36 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:35:36 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:35:36 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:35:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:35:37 INFO - warning: no files found matching '*.txt' 04:35:37 INFO - no previously-included directories found matching 'build' 04:35:37 INFO - no previously-included directories found matching 'dist' 04:35:37 INFO - no previously-included directories found matching '.git*' 04:35:37 INFO - Installing collected packages: jsonschema, functools32 04:35:37 INFO - Running setup.py install for functools32 04:35:37 INFO - warning: no files found matching '*.txt' 04:35:37 INFO - no previously-included directories found matching 'build' 04:35:37 INFO - no previously-included directories found matching 'dist' 04:35:37 INFO - no previously-included directories found matching '.git*' 04:35:37 INFO - Successfully installed jsonschema functools32 04:35:37 INFO - Cleaning up... 04:35:37 INFO - Return code: 0 04:35:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:35: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:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:37 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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:37 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:35:37 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:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:37 INFO - 'HOME': '/Users/cltbld', 04:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:37 INFO - 'LOGNAME': 'cltbld', 04:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:37 INFO - 'MOZ_NO_REMOTE': '1', 04:35:37 INFO - 'NO_EM_RESTART': '1', 04:35:37 INFO - 'PAGER': '/bin/cat', 04:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:37 INFO - 'PWD': '/builds/slave/test', 04:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:37 INFO - 'SHELL': '/bin/bash', 04:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:37 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:37 INFO - 'USER': 'cltbld', 04:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:37 INFO - 'XPC_FLAGS': '0x0', 04:35:37 INFO - 'XPC_SERVICE_NAME': '0', 04:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:35:37 INFO - Cleaning up... 04:35:37 INFO - Return code: 0 04:35:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:35: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:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35: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:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:37 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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:37 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:35:37 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:35:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:37 INFO - 'HOME': '/Users/cltbld', 04:35:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:37 INFO - 'LOGNAME': 'cltbld', 04:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:37 INFO - 'MOZ_NO_REMOTE': '1', 04:35:37 INFO - 'NO_EM_RESTART': '1', 04:35:37 INFO - 'PAGER': '/bin/cat', 04:35:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:37 INFO - 'PWD': '/builds/slave/test', 04:35:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:37 INFO - 'SHELL': '/bin/bash', 04:35:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:37 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:37 INFO - 'USER': 'cltbld', 04:35:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:37 INFO - 'XPC_FLAGS': '0x0', 04:35:37 INFO - 'XPC_SERVICE_NAME': '0', 04:35:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:35:38 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:35:38 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:35:38 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:35:38 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:35:38 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:35:38 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:35:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:35:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:35:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:35:40 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:35:40 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:35:40 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:35:40 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:35:40 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:35:40 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:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:35:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 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:35:41 INFO - Downloading docopt-0.6.1.tar.gz 04:35:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:35:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:35:41 INFO - Running setup.py install for blobuploader 04:35:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:35:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:35:42 INFO - Running setup.py install for requests 04:35:42 INFO - Running setup.py install for docopt 04:35:42 INFO - Successfully installed blobuploader requests docopt 04:35:42 INFO - Cleaning up... 04:35:42 INFO - Return code: 0 04:35:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:42 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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:42 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:35:42 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:35:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:42 INFO - 'HOME': '/Users/cltbld', 04:35:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:42 INFO - 'LOGNAME': 'cltbld', 04:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:42 INFO - 'MOZ_NO_REMOTE': '1', 04:35:42 INFO - 'NO_EM_RESTART': '1', 04:35:42 INFO - 'PAGER': '/bin/cat', 04:35:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:42 INFO - 'PWD': '/builds/slave/test', 04:35:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:42 INFO - 'SHELL': '/bin/bash', 04:35:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:42 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:42 INFO - 'USER': 'cltbld', 04:35:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:42 INFO - 'XPC_FLAGS': '0x0', 04:35:42 INFO - 'XPC_SERVICE_NAME': '0', 04:35:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-xaMRea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-oakhwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-zfQdH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-sbYX70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-f91ozh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-HZ7rdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-CHK6vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-jigOfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:43 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-VKd9Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-xvNoNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-QxGIc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-MV_XY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-VjBgkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ch6PSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ZLwG2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-i9Dtvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:44 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-_Rp6yX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:35:44 INFO - Running setup.py install for manifestparser 04:35:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:35:45 INFO - Running setup.py install for mozcrash 04:35:45 INFO - Running setup.py install for mozdebug 04:35:45 INFO - Running setup.py install for mozdevice 04:35:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:35:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:35:45 INFO - Running setup.py install for mozfile 04:35:45 INFO - Running setup.py install for mozhttpd 04:35:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:35:45 INFO - Running setup.py install for mozinfo 04:35:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:35:45 INFO - Running setup.py install for mozInstall 04:35:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Running setup.py install for mozleak 04:35:46 INFO - Running setup.py install for mozlog 04:35:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Running setup.py install for moznetwork 04:35:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Running setup.py install for mozprocess 04:35:46 INFO - Running setup.py install for mozprofile 04:35:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:35:46 INFO - Running setup.py install for mozrunner 04:35:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:35:47 INFO - Running setup.py install for mozscreenshot 04:35:47 INFO - Running setup.py install for moztest 04:35:47 INFO - Running setup.py install for mozversion 04:35:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:35:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:35:47 INFO - Cleaning up... 04:35:47 INFO - Return code: 0 04:35:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:47 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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:47 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:35:47 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:35:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:47 INFO - 'HOME': '/Users/cltbld', 04:35:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:47 INFO - 'LOGNAME': 'cltbld', 04:35:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:47 INFO - 'MOZ_NO_REMOTE': '1', 04:35:47 INFO - 'NO_EM_RESTART': '1', 04:35:47 INFO - 'PAGER': '/bin/cat', 04:35:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:47 INFO - 'PWD': '/builds/slave/test', 04:35:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:47 INFO - 'SHELL': '/bin/bash', 04:35:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:47 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:47 INFO - 'USER': 'cltbld', 04:35:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:47 INFO - 'XPC_FLAGS': '0x0', 04:35:47 INFO - 'XPC_SERVICE_NAME': '0', 04:35:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:35:47 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-9iaVEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:35:47 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:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:35:47 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-kkVyPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:35:47 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:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-NRENgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-CCnvMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ku6DKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-m93DCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-2iCbcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-4c09NX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Ss88Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-MfYFFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-jTDrTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:35:48 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:35:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:35:48 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-_PICZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:35:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-GXkeOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:35:49 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:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:35:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-ZfZQyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:35:49 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:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-B1ixDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:35:49 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:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:35:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-Nv9zm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:35:49 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:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:35:49 INFO - Running setup.py (path:/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/pip-0DKjpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:35:49 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:35:49 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:35:49 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:35:49 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:35:49 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:35:49 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:35:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:35:49 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:35:49 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:35:49 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:35:49 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:35:49 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:35:49 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:35:52 INFO - Downloading blessings-1.6.tar.gz 04:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:35:52 INFO - Installing collected packages: blessings 04:35:52 INFO - Running setup.py install for blessings 04:35:52 INFO - Successfully installed blessings 04:35:52 INFO - Cleaning up... 04:35:52 INFO - Return code: 0 04:35:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:35:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:52 INFO - Reading from file tmpfile_stdout 04:35:52 INFO - Current package versions: 04:35:52 INFO - blessings == 1.6 04:35:52 INFO - blobuploader == 1.2.4 04:35:52 INFO - docopt == 0.6.1 04:35:52 INFO - functools32 == 3.2.3-2 04:35:52 INFO - jsonschema == 2.5.1 04:35:52 INFO - manifestparser == 1.1 04:35:52 INFO - mozInstall == 1.12 04:35:52 INFO - mozcrash == 1.0 04:35:52 INFO - mozdebug == 0.1 04:35:52 INFO - mozdevice == 0.49 04:35:52 INFO - mozfile == 1.2 04:35:52 INFO - mozhttpd == 0.7 04:35:52 INFO - mozinfo == 0.9 04:35:52 INFO - mozleak == 0.1 04:35:52 INFO - mozlog == 3.4 04:35:52 INFO - moznetwork == 0.27 04:35:52 INFO - mozprocess == 0.25 04:35:52 INFO - mozprofile == 0.28 04:35:52 INFO - mozrunner == 6.13 04:35:52 INFO - mozscreenshot == 0.1 04:35:52 INFO - mozsystemmonitor == 0.3 04:35:52 INFO - moztest == 0.8 04:35:52 INFO - mozversion == 1.4 04:35:52 INFO - psutil == 3.1.1 04:35:52 INFO - requests == 1.2.3 04:35:52 INFO - wsgiref == 0.1.2 04:35:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:35:52 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:35:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:52 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:35:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:52 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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:52 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:35:52 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:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:52 INFO - 'HOME': '/Users/cltbld', 04:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:52 INFO - 'LOGNAME': 'cltbld', 04:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:52 INFO - 'MOZ_NO_REMOTE': '1', 04:35:52 INFO - 'NO_EM_RESTART': '1', 04:35:52 INFO - 'PAGER': '/bin/cat', 04:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:52 INFO - 'PWD': '/builds/slave/test', 04:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:52 INFO - 'SHELL': '/bin/bash', 04:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:52 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:52 INFO - 'USER': 'cltbld', 04:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:52 INFO - 'XPC_FLAGS': '0x0', 04:35:52 INFO - 'XPC_SERVICE_NAME': '0', 04:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:53 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:35:53 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:35:53 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:35:53 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:35:53 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:35:53 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:35:53 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:35:53 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:35:53 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:35:53 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:35:53 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:35:53 INFO - Cleaning up... 04:35:53 INFO - Return code: 0 04:35:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:35:53 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:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:53 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:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:53 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 0x10531fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105322768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbd1c54490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, '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.i8CD7pyuNw/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.XTKlwe9l13/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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:35:53 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:35:53 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:35:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:35:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:53 INFO - 'HOME': '/Users/cltbld', 04:35:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:53 INFO - 'LOGNAME': 'cltbld', 04:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:53 INFO - 'MOZ_NO_REMOTE': '1', 04:35:53 INFO - 'NO_EM_RESTART': '1', 04:35:53 INFO - 'PAGER': '/bin/cat', 04:35:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:53 INFO - 'PWD': '/builds/slave/test', 04:35:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:53 INFO - 'SHELL': '/bin/bash', 04:35:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:35:53 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:35:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:53 INFO - 'USER': 'cltbld', 04:35:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:53 INFO - 'XPC_FLAGS': '0x0', 04:35:53 INFO - 'XPC_SERVICE_NAME': '0', 04:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:35:53 INFO - Cleaning up... 04:35:53 INFO - Return code: 0 04:35:53 INFO - Running post-action listener: _resource_record_post_action 04:35:53 INFO - Running post-action listener: _start_resource_monitoring 04:35:53 INFO - Starting resource monitoring. 04:35:53 INFO - [mozharness: 2017-03-04 12:35:53.444637Z] Finished create-virtualenv step (success) 04:35:53 INFO - [mozharness: 2017-03-04 12:35:53.445608Z] Running install step. 04:35:53 INFO - Running pre-action listener: _resource_record_pre_action 04:35:53 INFO - Running main action method: install 04:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:35:53 INFO - Reading from file tmpfile_stdout 04:35:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:35:53 INFO - Reading from file tmpfile_stdout 04:35:53 INFO - Output received: 04:35:53 INFO - Usage: mozinstall [options] installer 04:35:53 INFO - Options: 04:35:53 INFO - -h, --help show this help message and exit 04:35:53 INFO - -d DEST, --destination=DEST 04:35:53 INFO - Directory to install application into. [default: 04:35:53 INFO - "/builds/slave/test"] 04:35:53 INFO - --app=APP Application being installed. [default: firefox] 04:35:53 INFO - mkdir: /builds/slave/test/build/application 04:35:53 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:35:53 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:36:13 INFO - Reading from file tmpfile_stdout 04:36:13 INFO - Output received: 04:36:13 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:36:13 INFO - Running post-action listener: _resource_record_post_action 04:36:13 INFO - [mozharness: 2017-03-04 12:36:13.835812Z] Finished install step (success) 04:36:13 INFO - [mozharness: 2017-03-04 12:36:13.835997Z] Running run-tests step. 04:36:13 INFO - Running pre-action listener: _resource_record_pre_action 04:36:13 INFO - Running main action method: run_tests 04:36:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:36:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:36:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:36:13 INFO - 2017-03-04 04:36:13.850 screenresolution[1939:14624] starting screenresolution argv=screenresolution get 04:36:13 INFO - 2017-03-04 04:36:13.853 screenresolution[1939:14624] Display 0: 1600x1200x32@60 04:36:13 INFO - 2017-03-04 04:36:13.859 screenresolution[1940:14626] starting screenresolution argv=screenresolution list 04:36:13 INFO - Available Modes on Display 0 04:36:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:36:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:36:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:36:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:36:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:36:14 INFO - Intel Iris: 04:36:14 INFO - Chipset Model: Intel Iris 04:36:14 INFO - Type: GPU 04:36:14 INFO - Bus: Built-In 04:36:14 INFO - VRAM (Dynamic, Max): 1536 MB 04:36:14 INFO - Vendor: Intel (0x8086) 04:36:14 INFO - Device ID: 0x0a2e 04:36:14 INFO - Revision ID: 0x0009 04:36:14 INFO - Displays: 04:36:14 INFO - Display: 04:36:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:36:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:36:14 INFO - Display Serial Number: 1600x1200 60 04:36:14 INFO - Main Display: Yes 04:36:14 INFO - Mirror: Off 04:36:14 INFO - Online: Yes 04:36:14 INFO - Rotation: Supported 04:36:14 INFO - Return code: 0 04:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:14 INFO - Python 2.7.3 04:36:14 INFO - Return code: 0 04:36:14 INFO - grabbing minidump binary from tooltool 04:36:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:14 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 0x1050fdd30>, '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 0x105024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1050f2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:14 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:36:14 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:36:14 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:36:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:14 INFO - Return code: 0 04:36:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:36:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:14 INFO - ENV: RUST_BACKTRACE is now 1 04:36:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:36:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0103 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.i8CD7pyuNw/Render', 04:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:14 INFO - 'HOME': '/Users/cltbld', 04:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:14 INFO - 'LOGNAME': 'cltbld', 04:36:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:14 INFO - 'MOZ_NO_REMOTE': '1', 04:36:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:14 INFO - 'NO_EM_RESTART': '1', 04:36:14 INFO - 'PAGER': '/bin/cat', 04:36:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:14 INFO - 'PWD': '/builds/slave/test', 04:36:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:14 INFO - 'RUST_BACKTRACE': '1', 04:36:14 INFO - 'SHELL': '/bin/bash', 04:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XTKlwe9l13/Listeners', 04:36:14 INFO - 'TMPDIR': '/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/', 04:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:14 INFO - 'USER': 'cltbld', 04:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:14 INFO - 'XPC_FLAGS': '0x0', 04:36:14 INFO - 'XPC_SERVICE_NAME': '0', 04:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0103', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:36:14 INFO - mozversion application_buildid: 20170304030205 04:36:14 INFO - mozversion application_changeset: 80c06df83395314697d464f88f8daa98bf05465c 04:36:14 INFO - mozversion application_display_name: Nightly 04:36:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:14 INFO - mozversion application_name: Firefox 04:36:14 INFO - mozversion application_remotingname: firefox 04:36:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:36:14 INFO - mozversion application_vendor: Mozilla 04:36:14 INFO - mozversion application_version: 54.0a1 04:36:14 INFO - mozversion platform_buildid: 20170304030205 04:36:14 INFO - mozversion platform_changeset: 80c06df83395314697d464f88f8daa98bf05465c 04:36:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:36:14 INFO - mozversion platform_version: 54.0a1 04:36:14 INFO - using testdate: 1488630974 04:36:14 INFO - actual date: 1488630974 04:36:14 INFO - starting webserver on 'localhost:49720' 04:36:14 INFO - SUITE-START | Running 2 tests 04:36:14 INFO - TEST-START | dromaeo_css 04:36:14 INFO - operating with platform_type : mac_ 04:36:14 INFO - Initialising browser for dromaeo_css test... 04:36:14 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpS7ZyD1/profile http://localhost:49720/getInfo.html) 04:36:17 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 04:36:17 INFO - PROCESS | 1950 | colorDepth:24 04:36:17 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 04:36:17 INFO - PROCESS | 1950 | __metrics 04:36:17 INFO - PROCESS | 1950 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:36:17 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:36:17 INFO - TEST-INFO | 1950: exit 0 04:36:17 INFO - Browser initialized. 04:36:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:17 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmpS7ZyD1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:30 INFO - PROCESS | 1953 | RSS: Main: 232607744 04:36:30 INFO - PROCESS | 1953 | 04:39:34 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49720/tests/dromaeo/cssquery-ext.html) 04:39:37 INFO - PROCESS | 1953 | RSS: Main: 462979072 04:39:37 INFO - PROCESS | 1953 | 04:41:20 INFO - PROCESS | 1953 | ************************* 04:41:20 INFO - PROCESS | 1953 | A coding exception was thrown and uncaught in a Task. 04:41:20 INFO - PROCESS | 1953 | 04:41:20 ERROR - PROCESS | 1953 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:41:20 INFO - PROCESS | 1953 | Full stack: 04:41:20 INFO - PROCESS | 1953 | ************************* 04:42:40 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-ext.html (next: http://localhost:49720/tests/dromaeo/cssquery-jquery.html) 04:42:40 INFO - PROCESS | 1953 | RSS: Main: 362971136 04:42:40 INFO - PROCESS | 1953 | 04:45:43 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49720/tests/dromaeo/cssquery-mootools.html) 04:45:44 INFO - PROCESS | 1953 | RSS: Main: 345034752 04:45:44 INFO - PROCESS | 1953 | 04:48:46 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49720/tests/dromaeo/cssquery-prototype.html) 04:48:47 INFO - PROCESS | 1953 | RSS: Main: 349786112 04:48:47 INFO - PROCESS | 1953 | 04:51:50 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49720/tests/dromaeo/cssquery-yui.html) 04:51:51 INFO - PROCESS | 1953 | RSS: Main: 348241920 04:51:51 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49720/tests/dromaeo/cssquery-yui.html (next: http://localhost:49720/tests/dromaeo/cssquery-dojo.html) 04:54:55 INFO - PROCESS | 1953 | RSS: Main: 421003264 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | __start_tp_report 04:54:55 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 04:54:55 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 04:54:55 INFO - PROCESS | 1953 | |i|pagename|runs| 04:54:55 INFO - PROCESS | 1953 | |0;dojo.html;2881.7118288171187;3319.336132773446;3321.850516726747;3330.8834190803327;3335.933281334374;5497.505224529791;5633.690147041911;5731.226284451603;5840.240768700063;5859.9707001464985;5641.548676105912;5695.316562012554;5696.515796157331;5707.058335374669;5711.114777209529;5124.590032797386;5167.405748338932;5182.4299327073995;5198.324217851693;5229.137192363255;5258.737063146847;5268.841934741964;5278.1291086970605;5288.497592728685;5293.814716484924;5265.8946821063555;5274.894502109955;5279.947200528003;5282.445343238962;5288.788448462057;5263.868403289948;5266;5267;5274.472552744734;5276.498732620395;5100.362454693163;5191.428942816287;5211.583073354161;5216.478352164791;5218.13900706383;5867.178594996704;5908.763649454059;5912.3496415394275;5917.55618328627;5918.40815918409;5182.378114626231;6267.185265915447;6274.56078074535;6303;6305.14880491137;4520.344550040259;4925.793180670723;5917.319508256563;6162.568620196588;6204.007358822567;5213.452587478336;5716.885662286731;5789.971050144764;5791.82624521265;5793.507551858055;5354.223637572531;6311.179546658905;6319.24169099711;6320.968395157995;6370.713317900706;6202.100695399142;6224.253089629274;6228.6574238416415;6242.75028998844;6246.312905580383;6150.753969841246;6306.990881458944;6328.303886572473;6343.429091381798;6348.587341822767;5143.7685304161405;6115.113308570232;6196.0705894116245;6214.036824292242;6336.873262534816;6302.968485157545;6318.557700960981;6320.241571011508;6340.365963403715;6340.619562826245;4859.246816743411;4985.875353116128;5008.273800298936;5016.097102521581;5041.621878359065;3731.328360895065;4422.358757980075;4443.0669559392245;4465.977670111693;4471.485779135376;5638.069718496402;5658.122990936411;5675.858103547444;5680.289963754531;5689.459501347365;6238.625682459067;6238.656873871981;6242.781502647476;6251.78118765841;6260.060990851318;5645.2096706461125;5654.660720356709;5661.830145095653;5662.518685911744;5664.235328230719;5425.972870135624;5439.592030597721;5440.646357986719;5445.455454454602;5452.972735136378;6301.275353334334;6305.842353941005;6306.747730090837;6311.2426508819235;6318.399752023551;6241.563090583615;6299.496040316855;6311.842203944938;6316.368363163647;6337.873242535031;6372.74509019634;6379.808605741835;6386.361363863576;6391.48868090561;6404.231492220963;6047.455728984412;6121.663308518075;6125.84596676928;6126.609281623611;6267.4045965633195;6142.3857614240005;6216.875662486816;6218.347073557211;6224.128621993015;6246.937530624636;5928.8814223716145;6034.39656034393;6074.544409169242;6077.3011103721865;6103.389661033861;6163.753449862134;6171.84570385744;6175.135481032748;6176.35148309421;6183.536234782319;6046.879062418815;6051.706225525404;6055.212822333245;6058.606190597597;6087.756489740361;5158.8392611662075;5951.345352011362;6065.757369705162;6196.411340922605;6209.410106039919;5741.91387129185;5854.648721076579;5856.648601083949;5860.619059761102;5878 04:54:55 INFO - PROCESS | 1953 | |1;ext.html;772.173774061754;787.2717736094112;851.7019043334834;860.5955201055501;863.8531449653558;27588.310292242702;28966.565501517493;29035.56446653302;29082.85458572707;39314.60685393145;41022.7948860256;41463;41547.75356739295;41548;41610;9106.635734570626;9249.352545321797;9259.95370023149;9270.536473176347;9278.675246366378;7290.635468226594;7426.591537465437;9155.267578593697;9289.024652411466;9289.814203715921;7443.925560744405;7472.4395670324675;7485.887711684302;10835.83746243807;11007.06439952605;9270.39742416744;10220.386776793343;10928.398938058404;10989.835152472719;10996.615118470894;10625.73435664107;10658.680239592824;10676.786464270748;10702.518386672618;10723.088537474325;27682.892684292605;27744.861275693693;38621.80689096537;38713.225735485415;38937.80531097355;3795.2409518096492;3838.980805095957;3842.2891765023282;3879.8060096995036;3893.5717071122153;24831.62752558713;26498.470030599474;28343;28526.144215673354;29219.415611687647;3059.7858149929516;3122.6252849658185;3136.3570468053995;3208.4866421372467;3225.870965161414;286473;291645;316977;319535.40232298925;323389;51794.74102629463;51873.2219016715;51958.74020629948;51959;51970.740146299024;44559.55440445619;45195.12463379739;47580.28629570559;47691.523084769404;53950.92098158094;12515.374231288399;12534.874651253553;12581.874181258254;13874.375653095634;14122.940779441584;12139.210951288314;12166;12188.20776649515;12201.816972745415;12208.267503949792;12568.685782855502;12611.369431528386;12622.747545049231;12637;12650.43073061696;5199.974000130051;5353.759080841293;5359.196120581866;5366.758495867695;5375.274337964324;1099.120703437247;1113.432149603708;1130.988690113105;1143.7426579019655;1157.7727608734767;26359.364063593486;26667.599985999837;26864;26976.460470790473;27078.729212708015;1078.800421921947;1210.3855671749156;1242.8570714367963;1251.1492185314073;1280.3982128399637;12726.045546584044;13299.734005319839;13474.663133421744;13775;13869;420717;422390;422746;423990;425481;53956;54309.72845135749;54338.45661543413;54410.72794636001;54413;1366.9863301367059;1432.0977783996016;1433.3334999224994;1435.7702767557141;1438.0652575825588;24554.63168052445;25079.49841003206;25899.352516187246;26095;26131;42373.57626423697;42420.57579424166;42471;42652.57347426486;42673.78663106664;391972;393690.0315498404;393743;394229;394243.0287848542;33647.99056028323;34120.317593648484;34230.65769342275;34246.80136195321;34268.48898709237;32453.35093298168;43495.130097398505;44849.1030179388;46375;46891;34092.829535853154;34806.82596587001;36144.457833132;37544.249115018094;37916.43125353177;35788.642113579575;35814.46278305775;37071.07322316964;37137.25725485529;37185.628143719296;35334.46998295079;35692.75075372349;35937.28125437529;36057.63942360648;36358;30135.69864301329;30344.544831827097;30573.08280751581;30623.846880765454;30871.536926946563;23577.33281609054;23617.88191059034;24090;24515.632265515676;24572 04:54:55 INFO - PROCESS | 1953 | |2;jquery.html;323.88502081760987;373.96260373962605;399.73817149766916;411.9073208528081;438.3206030652488;13500.594982150538;14984.550463486099;19752.60494790105;21362.252321168762;21632.89183554084;21244.36266911995;21781.891090544566;22120.778792212073;22175.556488870214;22441.765702886336;5481.561475081984;6487.7729279475225;6685.765998190064;6728.360805723449;6788.287229840869;6628.502862285324;6667.566608170478;6720.59676419414;6732.1921369435495;6743.550136720604;6462.192225971754;6693.6318502482345;6763.019362192504;6782.084418603475;6785.964210736784;6606.273309935903;6625.436837868787;6691.565048271896;6711.094002309699;6712.664366781642;6206.045095794811;6450.6452145132;6465.579737317059;6466.93533064668;6475.74097036118;24392.024319027394;25432.745672543224;26303.21090367292;26371.868140659364;26392.076277330394;3115.7663175261946;3169.350283191963;3177.4598318285716;3231.935361292761;3335.633080361158;14199.148051116967;14256.928715356356;14420.855791442056;14435.422583096664;14524.70950580993;1368.8699573540598;1869.1588785046783;1897.9051047447572;1942.1163370666454;1976.9703454448195;115439;128781;138130;139552.60447395497;139904;14559.126452412676;14760.966732328634;15303.540893773205;15426;15677.921610391875;28885.56671649927;29874.551881721793;29897.402051958838;31078.75684972621;31165.597548109938;8343.499390036617;9411.388259763093;9916.479649724388;9935.05616966387;10067.546960386653;6917.654117294216;7330.157031941289;7370;7395.2235015323695;8342.165783421731;8918.286537077018;9060.184583387527;9166.67916622915;9212.723618291462;9215.493147876798;3562.7249038342225;3657.6350402627454;3662;3664.578573464086;3668.944965825515;993.4784238274964;1007.1640538353149;1010.3988127064385;1061.092765685328;1063.0591926145416;19940.401787946386;21171.470713231985;21181.68227476589;21413.46466338354;21459.29592136811;1015.8730158730159;1029.5469993202967;1063.2557209953063;1065.1532032034552;1067.391586795519;10288.030915018779;10823.732890669276;10860.757977927242;10870.552762815725;10875.396488423723;667412;682512;704376;710893;715930;115124;117508;123603;149217;154704;1228.6928267933017;1236.097648716442;1280.2830414967648;1283.9679008024875;1287.929163895976;17217;19222.8077719221;19257.614847703248;19771.901140494207;19779.802201977796;46249;49312.50687493079;54561.72719136379;56752.71623641856;60919.086213705945;82366.17633823585;82883;83143.5842820782;83405.58297208475;83783.5810820942;7560.168381478143;8937.73186804397;9053.728388148365;10948.56205751761;11347.262427942158;12233.226182203709;12301.44643491027;12344.321062341658;12345.753084938071;12536.059795515555;10281.9485902573;10353.896461035594;10770.946145269538;10790.514426850968;10815.35107893529;8418.95790521068;10011.299209055296;10287.43419111926;10301.124404425707;10342.32774869631;10566.207534434794;10651.840222396826;10996.835047474455;11054.944725276322;11079.446027698421;10698.03717665414;10698.946505267424;11083.501242443948;11096.44517774092;11147.609833655782;10450.42522661261;10789.56841726322;10825.133989280996;10871.619493317696;10917.399543024892 04:54:55 INFO - PROCESS | 1953 | |3;mootools.html;1407.5988343322151;1486.5317425011121;1491.8731907787837;1565.5459916624172;1600.8719302455802;10398.844017339736;10939.45302734864;10948;10953.890461095387;10956.671299861016;10369;10738.785224295509;10908.400037997926;10941.179411544146;10989.670309890696;2319.3737690823427;2366.6450032495177;2367.3253122859987;2377.263048454976;2377.785999260066;2302.3323236261463;2336.532693461306;2345.7302410222787;2345.812335013203;2352.0591763294733;2208.7349518057854;2325.651152327156;2336.4626135988733;2349.318697577709;2349.3656712687566;2095.434232757155;2304.320225533472;2330.8951097200584;2332.486852892361;2335.6846825678654;2256.9322920312416;2297.253392647396;2311.0755697721047;2315.166540045582;2353.5645905507363;10876.510557024953;10940.343579385262;10961.780764384668;10969;10986.560537578487;5683.744231509592;5875.529957603381;5878.265216847894;5893.675847828411;5936.554758393095;3324.8720818676065;3428.297199074184;3641.963580364189;3642.1987162824403;3654.7624404413627;1096.369587487198;1118.3569447567681;1149.9252548584316;1198.9988359719644;1217.8112392579164;13196.274204918725;13616.18302901829;13923.30383480822;15055.397784088624;15095.924520377437;4145.689073319513;4261;4261.808218630169;4514.322851572225;4696;11417.145713571606;11435.199536032564;11438;11440.084793216523;11466.885331146581;5616.073347897551;5616.157576363578;5618.185363122325;5624.015797235467;5633;4329.458817647794;4762.78567464465;5214.7914083437;5229.424763276036;5253.080710875658;3615.9096022599647;3731.757435766721;3768.717346199046;3814.7138964577766;3820.5988371220624;1017.8982101789762;1021.7752094539189;1022.8874823769379;1031.8710161229847;1031.9535620897077;915.4690279637794;944.650479322655;946;959.69289827256;984.0946329376991;6422.550421470546;6667.799966001027;6686.866262674719;6763;6785.42323902464;809.6356639512243;950.3727539823822;968.9757756056155;983.233078199006;1022.1669339488293;4032.7580345179385;4138.13099249161;4405.647548196137;4473.4408198975125;4619.122366750306;12822.615321540368;13126.868731312756;13132.015098867623;13132.212067275994;13139.67150821218;12668.93665531685;13005.544805931937;13010.934945325213;13090.672733181556;13184.472621095241;9916.504174791231;10186.694399168036;10193.796124077626;10197;10207.642732504326;6415.006141498024;6739.157605299338;6828.566001139816;6834.897476537955;6858.965705171442;11848.28910265387;12152.817707734568;12164.39178041112;12188.45151968146;12230.633081007583;10889.891101089204;11100;11507.769844603228;12248.142630015813;12405;8034.076081250497;8277.172282771915;8425.578721064045;8515.148485151436;8532.573371331533;8318.334533237448;8450.704225352083;9620.71137865865;9709.223262139154;9717.708468745948;8793.29653627721;8827.337949653673;8878;8938.553072346227;9000.774980625536;8626.654933802578;8689.044205137556;8768.78078048054;8780.51707156087;8976.640934362553;7434.219406962191;7691.692332306869;7718.922810772045;7773.455858089879;7801.9609901950125;5702.45826646468;5845.41545845412;5908.881822363614;6054.910116178954;6156.29202641702;4930.457649658606;5728.341240757366;5817.5055120313555;5996.970015149896;6035.517158627212 04:54:55 INFO - PROCESS | 1953 | |4;prototype.html;362.8748081911741;373.89530931339226;378.3152493985884;382.3194713410129;386.069572330683;5140.897182056361;5162.974185129069;5194.818181363653;5214.322138122044;5218.21726740989;4574.216055738265;4802.927956080662;4950.7277099759585;4973.801047958077;5017.774200160992;3638.5815631202486;3687.400382730169;3806.7906265155334;4122.361034039729;4148.577423625506;3555.6310820334097;3767.5478942526934;4172.812223449937;4178;4186.225548273564;3867.0332416895776;4060.5585017318867;4147.917041659165;4176.66346769034;4202.886235147688;3677.4441762974743;4116.773577453238;4129.710920235585;4149;4159.480064991892;2990.9551356729667;3359.3113411750533;3515.3145136698354;3811.5235595550557;3840.7503512271614;4141.5271506772615;4308.978455107705;4783.545563171493;4843.321934929113;4858.902821943541;3879.650831425185;3921.4706014687936;4580.839670611513;4594.586487216133;4826.782794774209;4521.909561808746;5134;5225.320708307896;5232.043895199238;5380.982131700613;3816.484774555455;4095.4846706718704;4134.896627584304;4193.622573968358;4383.890402739957;5129.666571672904;5361.195820626898;5519.558435325164;5657.57568182388;5786.247787787603;4263.936040959388;4311.590398912098;4394.714343567658;4454.331850222493;4457.375967364572;4192.555890755809;4397.273690311963;4567.81236878414;4579.450465944108;4593.150267200579;4043.6562892153906;4294.656427485794;4493.820247190076;4501.977490112528;4683.227267500824;4809.711417314972;4942.291653140628;5244.449332820075;5373.7581808818695;5395.271638328853;1360.9523666671816;1403.684171061503;1509.260462373451;1523.9542813715607;1536.8463153684543;1033.7105610429091;1050.669039252633;1147.4836323654388;1150.7169506000748;1170.3329102411544;4284.4430224070675;4479.417675702138;4930;4934.136526107988;4982.7259500727805;4690.624750019991;4730.834420795256;5055.87360315995;5482.616216864861;5585.888282234414;3804.6766024888193;4266.509351424564;4980.243867106904;5020.272060551272;5048.924266136011;2653.3234025323804;2882.9135125946254;2894.8407837568716;2924.7715959297147;2960.407918416325;5094.15946368845;5416.9729151353995;5432.728363581805;5761.337446193657;5893.027650437715;5370.892582148335;5736.77052917887;5761.378572749389;5804.477597016289;5824.563157763185;4929.950700493021;5232.92150617741;5766.509846662912;5798.130280457881;5818.7672493100645;4681.765911704333;4997.1303607829805;5085.77114029877;5427.945720542744;5631.986887015427;4638.489766125656;5490.670559766427;5496.532794712334;5581.49766521015;5614.354349249888;4963.815920994751;5023.824166154167;5105.489451055013;5329.467053294639;5812.564057695605;3712.401319076603;3752.962470375261;3912.6869850412468;3923.5487918889694;4189.874303770892;4909.26361045846;5008.697738588066;5562.413477732874;5578;5629.802956896653;5380.300560927211;5427.457254274699;5446.183072538993;5470.8085217017215;5473.698946557977;4912.852614421573;5059.406287019577;5209.947900521098;5469.808556700656;5476.822483166138;5329.987302412529;5349.304590403222;5359.383670877899;5361.437049109787;5374.7312634367345;4824.734639594856;5031.874203144951;5389.380221274447;5494.423160492183;5530.668159910419;4524.932126018178;4769.093872164278;5232.401330576246;5296.443873393238;5344.839654810362 04:54:55 INFO - PROCESS | 1953 | |5;yui.html;750.2572453271262;759.3507551043857;787.2481779900196;826.0871736730916;844.9704260350885;14948.476803311887;15201.619959501004;15222.162781047053;15240.542783716479;15280.617984550392;13974;14116.364763585638;14118.364673589687;14120;14140;847.3433089355768;931.9068093190695;949.5157469690456;966.7776411425376;985.2462865907551;974.741693451236;981.2640519610293;988.4168340678998;989.6833013435703;990.6136606723384;1016.7305663999047;1031.7369070886914;1033.9327943683675;1034.4414016431117;1037.6316407675279;1021.1218352217087;1021.213665477578;1021.7241344836926;1023.9385636861775;1033.0908800255766;767.2710924621576;767.7005967672612;769.0732667136087;770.0836005153849;770.468376819998;15123.395064197419;15484.225788710632;15542.61143471411;15673.373065077383;15966.201689915457;13744.106633068819;13806.17162970215;13901.721965560631;14006.579802605836;14074.648133796634;11628.244164129304;11807.350595717233;11879.22785018971;12113;12424.875751242462;3574.285142971416;3636.9621490595846;3676.246369494247;3677.7057835373107;3787.6023017583307;86110;92371.07628923692;96564.51717741437;97093.5145324276;98964.50517747365;10585.470726463645;10694.304870183412;10747.408892510986;10795.136389088853;11229.85310046369;21220.469488262916;21625.56748865014;21630.675539866916;21672.458188545414;21712.240071597418;7534.811629709191;7630.313271805453;7643.69425222996;7734.690612375442;7821.256980586835;4162.708610397303;4168.7707176105605;4175.436316097349;4214.4099826024385;4311.741295522279;2859.47099786536;3522.982385088058;3527.4356103023392;3532.3994920863515;3555.6088830228655;529.4784637132421;629.6757170057424;632.1686981619156;646.689588997284;650.8665723526666;658.8550518885837;659.9245373300942;688.5455599304435;694.1669996004714;716.2837162837163;8185.672573097009;8467.66129354819;9198.95400522993;10082.546285417175;10140.391576505433;645.5513418174418;653.2520264297353;679.3681875855502;682.8302820385948;703.8803403421431;4664.370310008106;4820.9517904821205;4825.276208568743;4830.855074347775;4849.418069831643;95530.56704149443;95914;96092;98706.5064674672;99646;45690.77154614206;57496.85006299934;65002.67498662571;72475.2752472479;85377;60869.69565152234;67111;68775.65612171908;69670;69975.65012174906;10158.251097035722;10438.843417348899;10575.524101415609;10688.305260158066;10719.839202411815;44798.76006199742;45194.77402612966;45608;46403.83990400267;46605.873353930365;50833.49166508435;51373.71565710887;53112.73443632757;58789.11816322844;60299.79400412055;11010.009099181112;12489.500419983462;12499.437525311201;12799.976001919638;12818.005866272966;14068.437262509795;14122.929385353007;14142.646433839236;14149.221792801494;14156.150630962175;13204;13834.347448155966;14072.366743496363;14095.295235237993;14198.503052393116;11811.468483918072;12893.161944473579;12904.290264035568;13094.672633184247;13635.386407611879;12849.486020559072;13116.093672147485;13221.669458263621;13303.667408314483;13649.795253071014;10397.48012599352;10401;10430.374177549067;10492.685219443429;11183.720406989565;6243;7483.476156668981;8182.959085204536;9317;10324 04:54:55 INFO - PROCESS | 1953 | __end_tp_report 04:54:55 INFO - PROCESS | 1953 | __start_cc_report 04:54:55 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,2834 04:54:55 INFO - PROCESS | 1953 | __end_cc_report 04:54:55 INFO - PROCESS | 1953 | __startTimestamp1488632095335__endTimestamp 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | ------- Summary: start ------- 04:54:55 INFO - PROCESS | 1953 | Number of tests: 6 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5717.51 Median:5908.76 stddev:676.95 (11.5%) stddev-sans-first:641.43 04:54:55 INFO - PROCESS | 1953 | Values: 2881.7 3319.3 3321.9 3330.9 3335.9 5497.5 5633.7 5731.2 5840.2 5860.0 5641.5 5695.3 5696.5 5707.1 5711.1 5124.6 5167.4 5182.4 5198.3 5229.1 5258.7 5268.8 5278.1 5288.5 5293.8 5265.9 5274.9 5279.9 5282.4 5288.8 5263.9 5266.0 5267.0 5274.5 5276.5 5100.4 5191.4 5211.6 5216.5 5218.1 5867.2 5908.8 5912.3 5917.6 5918.4 5182.4 6267.2 6274.6 6303.0 6305.1 4520.3 4925.8 5917.3 6162.6 6204.0 5213.5 5716.9 5790.0 5791.8 5793.5 5354.2 6311.2 6319.2 6321.0 6370.7 6202.1 6224.3 6228.7 6242.8 6246.3 6150.8 6307.0 6328.3 6343.4 6348.6 5143.8 6115.1 6196.1 6214.0 6336.9 6303.0 6318.6 6320.2 6340.4 6340.6 4859.2 4985.9 5008.3 5016.1 5041.6 3731.3 4422.4 4443.1 4466.0 4471.5 5638.1 5658.1 5675.9 5680.3 5689.5 6238.6 6238.7 6242.8 6251.8 6260.1 5645.2 5654.7 5661.8 5662.5 5664.2 5426.0 5439.6 5440.6 5445.5 5453.0 6301.3 6305.8 6306.7 6311.2 6318.4 6241.6 6299.5 6311.8 6316.4 6337.9 6372.7 6379.8 6386.4 6391.5 6404.2 6047.5 6121.7 6125.8 6126.6 6267.4 6142.4 6216.9 6218.3 6224.1 6246.9 5928.9 6034.4 6074.5 6077.3 6103.4 6163.8 6171.8 6175.1 6176.4 6183.5 6046.9 6051.7 6055.2 6058.6 6087.8 5158.8 5951.3 6065.8 6196.4 6209.4 5741.9 5854.6 5856.6 5860.6 5878.0 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:51756.61 Median:34175.49 stddev:99961.92 (292.5%) stddev-sans-first:100169.05 04:54:55 INFO - PROCESS | 1953 | Values: 772.2 787.3 851.7 860.6 863.9 27588.3 28966.6 29035.6 29082.9 39314.6 41022.8 41463.0 41547.8 41548.0 41610.0 9106.6 9249.4 9260.0 9270.5 9278.7 7290.6 7426.6 9155.3 9289.0 9289.8 7443.9 7472.4 7485.9 10835.8 11007.1 9270.4 10220.4 10928.4 10989.8 10996.6 10625.7 10658.7 10676.8 10702.5 10723.1 27682.9 27744.9 38621.8 38713.2 38937.8 3795.2 3839.0 3842.3 3879.8 3893.6 24831.6 26498.5 28343.0 28526.1 29219.4 3059.8 3122.6 3136.4 3208.5 3225.9 286473.0 291645.0 316977.0 319535.4 323389.0 51794.7 51873.2 51958.7 51959.0 51970.7 44559.6 45195.1 47580.3 47691.5 53950.9 12515.4 12534.9 12581.9 13874.4 14122.9 12139.2 12166.0 12188.2 12201.8 12208.3 12568.7 12611.4 12622.7 12637.0 12650.4 5200.0 5353.8 5359.2 5366.8 5375.3 1099.1 1113.4 1131.0 1143.7 1157.8 26359.4 26667.6 26864.0 26976.5 27078.7 1078.8 1210.4 1242.9 1251.1 1280.4 12726.0 13299.7 13474.7 13775.0 13869.0 420717.0 422390.0 422746.0 423990.0 425481.0 53956.0 54309.7 54338.5 54410.7 54413.0 1367.0 1432.1 1433.3 1435.8 1438.1 24554.6 25079.5 25899.4 26095.0 26131.0 42373.6 42420.6 42471.0 42652.6 42673.8 391972.0 393690.0 393743.0 394229.0 394243.0 33648.0 34120.3 34230.7 34246.8 34268.5 32453.4 43495.1 44849.1 46375.0 46891.0 34092.8 34806.8 36144.5 37544.2 37916.4 35788.6 35814.5 37071.1 37137.3 37185.6 35334.5 35692.8 35937.3 36057.6 36358.0 30135.7 30344.5 30573.1 30623.8 30871.5 23577.3 23617.9 24090.0 24515.6 24572.0 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:39449.83 Median:21546.09 stddev:115696.79 (537.0%) stddev-sans-first:115984.05 04:54:55 INFO - PROCESS | 1953 | Values: 323.9 374.0 399.7 411.9 438.3 13500.6 14984.6 19752.6 21362.3 21632.9 21244.4 21781.9 22120.8 22175.6 22441.8 5481.6 6487.8 6685.8 6728.4 6788.3 6628.5 6667.6 6720.6 6732.2 6743.6 6462.2 6693.6 6763.0 6782.1 6786.0 6606.3 6625.4 6691.6 6711.1 6712.7 6206.0 6450.6 6465.6 6466.9 6475.7 24392.0 25432.7 26303.2 26371.9 26392.1 3115.8 3169.4 3177.5 3231.9 3335.6 14199.1 14256.9 14420.9 14435.4 14524.7 1368.9 1869.2 1897.9 1942.1 1977.0 115439.0 128781.0 138130.0 139552.6 139904.0 14559.1 14761.0 15303.5 15426.0 15677.9 28885.6 29874.6 29897.4 31078.8 31165.6 8343.5 9411.4 9916.5 9935.1 10067.5 6917.7 7330.2 7370.0 7395.2 8342.2 8918.3 9060.2 9166.7 9212.7 9215.5 3562.7 3657.6 3662.0 3664.6 3668.9 993.5 1007.2 1010.4 1061.1 1063.1 19940.4 21171.5 21181.7 21413.5 21459.3 1015.9 1029.5 1063.3 1065.2 1067.4 10288.0 10823.7 10860.8 10870.6 10875.4 667412.0 682512.0 704376.0 710893.0 715930.0 115124.0 117508.0 123603.0 149217.0 154704.0 1228.7 1236.1 1280.3 1284.0 1287.9 17217.0 19222.8 19257.6 19771.9 19779.8 46249.0 49312.5 54561.7 56752.7 60919.1 82366.2 82883.0 83143.6 83405.6 83783.6 7560.2 8937.7 9053.7 10948.6 11347.3 12233.2 12301.4 12344.3 12345.8 12536.1 10281.9 10353.9 10770.9 10790.5 10815.4 8419.0 10011.3 10287.4 10301.1 10342.3 10566.2 10651.8 10996.8 11054.9 11079.4 10698.0 10698.9 11083.5 11096.4 11147.6 10450.4 10789.6 10825.1 10871.6 10917.4 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:6546.04 Median:3376.58 stddev:4039.63 (119.6%) stddev-sans-first:4032.50 04:54:55 INFO - PROCESS | 1953 | Values: 1407.6 1486.5 1491.9 1565.5 1600.9 10398.8 10939.5 10948.0 10953.9 10956.7 10369.0 10738.8 10908.4 10941.2 10989.7 2319.4 2366.6 2367.3 2377.3 2377.8 2302.3 2336.5 2345.7 2345.8 2352.1 2208.7 2325.7 2336.5 2349.3 2349.4 2095.4 2304.3 2330.9 2332.5 2335.7 2256.9 2297.3 2311.1 2315.2 2353.6 10876.5 10940.3 10961.8 10969.0 10986.6 5683.7 5875.5 5878.3 5893.7 5936.6 3324.9 3428.3 3642.0 3642.2 3654.8 1096.4 1118.4 1149.9 1199.0 1217.8 13196.3 13616.2 13923.3 15055.4 15095.9 4145.7 4261.0 4261.8 4514.3 4696.0 11417.1 11435.2 11438.0 11440.1 11466.9 5616.1 5616.2 5618.2 5624.0 5633.0 4329.5 4762.8 5214.8 5229.4 5253.1 3615.9 3731.8 3768.7 3814.7 3820.6 1017.9 1021.8 1022.9 1031.9 1032.0 915.5 944.7 946.0 959.7 984.1 6422.6 6667.8 6686.9 6763.0 6785.4 809.6 950.4 969.0 983.2 1022.2 4032.8 4138.1 4405.6 4473.4 4619.1 12822.6 13126.9 13132.0 13132.2 13139.7 12668.9 13005.5 13010.9 13090.7 13184.5 9916.5 10186.7 10193.8 10197.0 10207.6 6415.0 6739.2 6828.6 6834.9 6859.0 11848.3 12152.8 12164.4 12188.5 12230.6 10889.9 11100.0 11507.8 12248.1 12405.0 8034.1 8277.2 8425.6 8515.1 8532.6 8318.3 8450.7 9620.7 9709.2 9717.7 8793.3 8827.3 8878.0 8938.6 9000.8 8626.7 8689.0 8768.8 8780.5 8976.6 7434.2 7691.7 7718.9 7773.5 7802.0 5702.5 5845.4 5908.9 6054.9 6156.3 4930.5 5728.3 5817.5 5997.0 6035.5 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4442.42 Median:4817.22 stddev:1260.14 (26.2%) stddev-sans-first:1225.91 04:54:55 INFO - PROCESS | 1953 | Values: 362.9 373.9 378.3 382.3 386.1 5140.9 5163.0 5194.8 5214.3 5218.2 4574.2 4802.9 4950.7 4973.8 5017.8 3638.6 3687.4 3806.8 4122.4 4148.6 3555.6 3767.5 4172.8 4178.0 4186.2 3867.0 4060.6 4147.9 4176.7 4202.9 3677.4 4116.8 4129.7 4149.0 4159.5 2991.0 3359.3 3515.3 3811.5 3840.8 4141.5 4309.0 4783.5 4843.3 4858.9 3879.7 3921.5 4580.8 4594.6 4826.8 4521.9 5134.0 5225.3 5232.0 5381.0 3816.5 4095.5 4134.9 4193.6 4383.9 5129.7 5361.2 5519.6 5657.6 5786.2 4263.9 4311.6 4394.7 4454.3 4457.4 4192.6 4397.3 4567.8 4579.5 4593.2 4043.7 4294.7 4493.8 4502.0 4683.2 4809.7 4942.3 5244.4 5373.8 5395.3 1361.0 1403.7 1509.3 1524.0 1536.8 1033.7 1050.7 1147.5 1150.7 1170.3 4284.4 4479.4 4930.0 4934.1 4982.7 4690.6 4730.8 5055.9 5482.6 5585.9 3804.7 4266.5 4980.2 5020.3 5048.9 2653.3 2882.9 2894.8 2924.8 2960.4 5094.2 5417.0 5432.7 5761.3 5893.0 5370.9 5736.8 5761.4 5804.5 5824.6 4930.0 5232.9 5766.5 5798.1 5818.8 4681.8 4997.1 5085.8 5427.9 5632.0 4638.5 5490.7 5496.5 5581.5 5614.4 4963.8 5023.8 5105.5 5329.5 5812.6 3712.4 3753.0 3912.7 3923.5 4189.9 4909.3 5008.7 5562.4 5578.0 5629.8 5380.3 5427.5 5446.2 5470.8 5473.7 4912.9 5059.4 5209.9 5469.8 5476.8 5330.0 5349.3 5359.4 5361.4 5374.7 4824.7 5031.9 5389.4 5494.4 5530.7 4524.9 4769.1 5232.4 5296.4 5344.8 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:18441.48 Median:3676.98 stddev:25443.90 (692.0%) stddev-sans-first:25480.60 04:54:55 INFO - PROCESS | 1953 | Values: 750.3 759.4 787.2 826.1 845.0 14948.5 15201.6 15222.2 15240.5 15280.6 13974.0 14116.4 14118.4 14120.0 14140.0 847.3 931.9 949.5 966.8 985.2 974.7 981.3 988.4 989.7 990.6 1016.7 1031.7 1033.9 1034.4 1037.6 1021.1 1021.2 1021.7 1023.9 1033.1 767.3 767.7 769.1 770.1 770.5 15123.4 15484.2 15542.6 15673.4 15966.2 13744.1 13806.2 13901.7 14006.6 14074.6 11628.2 11807.4 11879.2 12113.0 12424.9 3574.3 3637.0 3676.2 3677.7 3787.6 86110.0 92371.1 96564.5 97093.5 98964.5 10585.5 10694.3 10747.4 10795.1 11229.9 21220.5 21625.6 21630.7 21672.5 21712.2 7534.8 7630.3 7643.7 7734.7 7821.3 4162.7 4168.8 4175.4 4214.4 4311.7 2859.5 3523.0 3527.4 3532.4 3555.6 529.5 629.7 632.2 646.7 650.9 658.9 659.9 688.5 694.2 716.3 8185.7 8467.7 9199.0 10082.5 10140.4 645.6 653.3 679.4 682.8 703.9 4664.4 4821.0 4825.3 4830.9 4849.4 95530.6 95914.0 96092.0 98706.5 99646.0 45690.8 57496.9 65002.7 72475.3 85377.0 60869.7 67111.0 68775.7 69670.0 69975.7 10158.3 10438.8 10575.5 10688.3 10719.8 44798.8 45194.8 45608.0 46403.8 46605.9 50833.5 51373.7 53112.7 58789.1 60299.8 11010.0 12489.5 12499.4 12800.0 12818.0 14068.4 14122.9 14142.6 14149.2 14156.2 13204.0 13834.3 14072.4 14095.3 14198.5 11811.5 12893.2 12904.3 13094.7 13635.4 12849.5 13116.1 13221.7 13303.7 13649.8 10397.5 10401.0 10430.4 10492.7 11183.7 6243.0 7483.5 8183.0 9317.0 10324.0 04:54:55 INFO - PROCESS | 1953 | -------- Summary: end -------- 04:54:55 INFO - PROCESS | 1953 | 04:54:55 INFO - TEST-INFO | 1953: exit 0 04:54:56 INFO - TEST-OK | dromaeo_css | took 1121558ms 04:54:56 INFO - TEST-START | kraken 04:54:56 INFO - operating with platform_type : mac_ 04:54:56 INFO - Initialising browser for kraken test... 04:54:56 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmphIWNxV/profile http://localhost:49720/getInfo.html) 04:54:58 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 04:54:58 INFO - PROCESS | 1955 | colorDepth:24 04:54:58 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 04:54:58 INFO - PROCESS | 1955 | __metrics 04:54:58 INFO - PROCESS | 1955 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:54:58 INFO - PROCESS | 1955 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:54:59 INFO - TEST-INFO | 1955: exit 0 04:54:59 INFO - Browser initialized. 04:54:59 INFO - Running cycle 1/1 for kraken test... 04:54:59 INFO - TEST-INFO | started process 1957 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/tmphIWNxV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:11 INFO - PROCESS | 1957 | RSS: Main: 232079360 04:55:11 INFO - PROCESS | 1957 | 04:55:14 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:15 INFO - PROCESS | 1957 | RSS: Main: 283914240 04:55:15 INFO - PROCESS | 1957 | 04:55:17 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-dft) 04:55:18 INFO - PROCESS | 1957 | RSS: Main: 286023680 04:55:18 INFO - PROCESS | 1957 | 04:55:21 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-fft) 04:55:22 INFO - PROCESS | 1957 | RSS: Main: 375779328 04:55:22 INFO - PROCESS | 1957 | 04:55:24 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49720/tests/kraken/driver.html?testName=audio-oscillator) 04:55:25 INFO - PROCESS | 1957 | RSS: Main: 281575424 04:55:25 INFO - PROCESS | 1957 | 04:55:27 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:28 INFO - PROCESS | 1957 | RSS: Main: 283766784 04:55:28 INFO - PROCESS | 1957 | 04:55:31 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:31 INFO - PROCESS | 1957 | RSS: Main: 325640192 04:55:31 INFO - PROCESS | 1957 | 04:55:34 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49720/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:35 INFO - PROCESS | 1957 | RSS: Main: 329011200 04:55:35 INFO - PROCESS | 1957 | 04:55:38 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49720/tests/kraken/driver.html?testName=json-parse-financial) 04:55:39 INFO - PROCESS | 1957 | RSS: Main: 323801088 04:55:39 INFO - PROCESS | 1957 | 04:55:40 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49720/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:55:41 INFO - PROCESS | 1957 | RSS: Main: 299745280 04:55:41 INFO - PROCESS | 1957 | 04:55:43 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:55:44 INFO - PROCESS | 1957 | RSS: Main: 304226304 04:55:44 INFO - PROCESS | 1957 | 04:55:46 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:55:46 INFO - PROCESS | 1957 | RSS: Main: 311189504 04:55:46 INFO - PROCESS | 1957 | 04:55:49 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:55:50 INFO - PROCESS | 1957 | RSS: Main: 325054464 04:55:50 INFO - PROCESS | 1957 | 04:55:53 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:55:54 INFO - PROCESS | 1957 | RSS: Main: 319229952 04:55:54 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | Cycle 1(1): loaded http://localhost:49720/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49720/tests/kraken/driver.html?testName=ai-astar) 04:55:56 INFO - PROCESS | 1957 | RSS: Main: 363479040 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | __start_tp_report 04:55:56 INFO - PROCESS | 1957 | _x_x_mozilla_page_load 04:55:56 INFO - PROCESS | 1957 | _x_x_mozilla_page_load_details 04:55:56 INFO - PROCESS | 1957 | |i|pagename|runs| 04:55:56 INFO - PROCESS | 1957 | |0;ai-astar;116;117;117;116;114;114;115;115;115;116 04:55:56 INFO - PROCESS | 1957 | |1;audio-beat-detection;133;113;123;180;109;112;109;109;129;110 04:55:56 INFO - PROCESS | 1957 | |2;audio-dft;188;184;184;186;182;184;182;187;186;200 04:55:56 INFO - PROCESS | 1957 | |3;audio-fft;87;67;86;116;65;61;62;60;75;59 04:55:56 INFO - PROCESS | 1957 | |4;audio-oscillator;96;93;123;103;70;68;85;71;70;84 04:55:56 INFO - PROCESS | 1957 | |5;imaging-gaussian-blur;87;87;86;86;87;95;135;86;86;85 04:55:56 INFO - PROCESS | 1957 | |6;imaging-darkroom;94;101;94;94;94;101;94;93;94;96 04:55:56 INFO - PROCESS | 1957 | |7;imaging-desaturate;83;85;85;86;87;84;86;82;83;86 04:55:56 INFO - PROCESS | 1957 | |8;json-parse-financial;63;63;63;60;61;64;61;61;62;62 04:55:56 INFO - PROCESS | 1957 | |9;json-stringify-tinderbox;54;62;57;64;60;58;55;59;58;59 04:55:56 INFO - PROCESS | 1957 | |10;stanford-crypto-aes;90;89;87;87;86;89;89;88;90;92 04:55:56 INFO - PROCESS | 1957 | |11;stanford-crypto-ccm;155;154;152;140;140;141;138;141;179;158 04:55:56 INFO - PROCESS | 1957 | |12;stanford-crypto-pbkdf2;170;174;171;174;173;172;174;172;172;169 04:55:56 INFO - PROCESS | 1957 | |13;stanford-crypto-sha256-iterative;69;67;69;78;88;88;68;66;64;67 04:55:56 INFO - PROCESS | 1957 | __end_tp_report 04:55:56 INFO - PROCESS | 1957 | __start_cc_report 04:55:56 INFO - PROCESS | 1957 | _x_x_mozilla_cycle_collect,2133 04:55:56 INFO - PROCESS | 1957 | __end_cc_report 04:55:56 INFO - PROCESS | 1957 | __startTimestamp1488632156306__endTimestamp 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | ------- Summary: start ------- 04:55:56 INFO - PROCESS | 1957 | Number of tests: 14 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.00 stddev:1.08 (0.9%) stddev-sans-first:1.13 04:55:56 INFO - PROCESS | 1957 | Values: 116.0 117.0 117.0 116.0 114.0 114.0 115.0 115.0 115.0 116.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:118.00 stddev:22.02 (18.7%) stddev-sans-first:23.03 04:55:56 INFO - PROCESS | 1957 | Values: 133.0 113.0 123.0 180.0 109.0 112.0 109.0 109.0 129.0 110.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#2] audio-dft Cycles:10 Average:186.30 Median:186.00 stddev:5.21 (2.8%) stddev-sans-first:5.49 04:55:56 INFO - PROCESS | 1957 | Values: 188.0 184.0 184.0 186.0 182.0 184.0 182.0 187.0 186.0 200.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#3] audio-fft Cycles:10 Average:73.80 Median:66.00 stddev:18.08 (27.4%) stddev-sans-first:18.53 04:55:56 INFO - PROCESS | 1957 | Values: 87.0 67.0 86.0 116.0 65.0 61.0 62.0 60.0 75.0 59.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#4] audio-oscillator Cycles:10 Average:86.30 Median:77.50 stddev:17.86 (23.1%) stddev-sans-first:18.60 04:55:56 INFO - PROCESS | 1957 | Values: 96.0 93.0 123.0 103.0 70.0 68.0 85.0 71.0 70.0 84.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:86.50 stddev:15.37 (17.8%) stddev-sans-first:16.19 04:55:56 INFO - PROCESS | 1957 | Values: 87.0 87.0 86.0 86.0 87.0 95.0 135.0 86.0 86.0 85.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:94.00 stddev:2.99 (3.2%) stddev-sans-first:3.12 04:55:56 INFO - PROCESS | 1957 | Values: 94.0 101.0 94.0 94.0 94.0 101.0 94.0 93.0 94.0 96.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.64 (1.9%) stddev-sans-first:1.62 04:55:56 INFO - PROCESS | 1957 | Values: 83.0 85.0 85.0 86.0 87.0 84.0 86.0 82.0 83.0 86.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:1.27 04:55:56 INFO - PROCESS | 1957 | Values: 63.0 63.0 63.0 60.0 61.0 64.0 61.0 61.0 62.0 62.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:2.99 (5.1%) stddev-sans-first:2.67 04:55:56 INFO - PROCESS | 1957 | Values: 54.0 62.0 57.0 64.0 60.0 58.0 55.0 59.0 58.0 59.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:89.00 stddev:1.77 (2.0%) stddev-sans-first:1.81 04:55:56 INFO - PROCESS | 1957 | Values: 90.0 89.0 87.0 87.0 86.0 89.0 89.0 88.0 90.0 92.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:153.00 stddev:12.72 (8.3%) stddev-sans-first:13.35 04:55:56 INFO - PROCESS | 1957 | Values: 155.0 154.0 152.0 140.0 140.0 141.0 138.0 141.0 179.0 158.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.10 Median:172.50 stddev:1.73 (1.0%) stddev-sans-first:1.66 04:55:56 INFO - PROCESS | 1957 | Values: 170.0 174.0 171.0 174.0 173.0 172.0 174.0 172.0 172.0 169.0 04:55:56 INFO - PROCESS | 1957 | 04:55:56 INFO - PROCESS | 1957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:69.00 stddev:9.01 (13.1%) stddev-sans-first:9.47 04:55:56 INFO - PROCESS | 1957 | Values: 69.0 67.0 69.0 78.0 88.0 88.0 68.0 66.0 64.0 67.0 04:55:56 INFO - PROCESS | 1957 | -------- Summary: end -------- 04:55:56 INFO - PROCESS | 1957 | 04:55:57 INFO - TEST-INFO | 1957: exit 0 04:55:57 INFO - TEST-OK | kraken | took 61269ms 04:55:57 INFO - SUITE-END | took 1182s 04:55:57 INFO - Completed test suite (00:19:43) 04:55:57 INFO - javascript benchmark 04:55:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7441.553541808784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2881.7118288171187, 3319.336132773446, 3321.850516726747, 3330.8834190803327, 3335.933281334374, 5497.505224529791, 5633.690147041911, 5731.226284451603, 5840.240768700063, 5859.9707001464985, 5641.548676105912, 5695.316562012554, 5696.515796157331, 5707.058335374669, 5711.114777209529, 5124.590032797386, 5167.405748338932, 5182.4299327073995, 5198.324217851693, 5229.137192363255, 5258.737063146847, 5268.841934741964, 5278.1291086970605, 5288.497592728685, 5293.814716484924, 5265.8946821063555, 5274.894502109955, 5279.947200528003, 5282.445343238962, 5288.788448462057, 5263.868403289948, 5266.0, 5267.0, 5274.472552744734, 5276.498732620395, 5100.362454693163, 5191.428942816287, 5211.583073354161, 5216.478352164791, 5218.13900706383, 5867.178594996704, 5908.763649454059, 5912.3496415394275, 5917.55618328627, 5918.40815918409, 5182.378114626231, 6267.185265915447, 6274.56078074535, 6303.0, 6305.14880491137, 4520.344550040259, 4925.793180670723, 5917.319508256563, 6162.568620196588, 6204.007358822567, 5213.452587478336, 5716.885662286731, 5789.971050144764, 5791.82624521265, 5793.507551858055, 5354.223637572531, 6311.179546658905, 6319.24169099711, 6320.968395157995, 6370.713317900706, 6202.100695399142, 6224.253089629274, 6228.6574238416415, 6242.75028998844, 6246.312905580383, 6150.753969841246, 6306.990881458944, 6328.303886572473, 6343.429091381798, 6348.587341822767, 5143.7685304161405, 6115.113308570232, 6196.0705894116245, 6214.036824292242, 6336.873262534816, 6302.968485157545, 6318.557700960981, 6320.241571011508, 6340.365963403715, 6340.619562826245, 4859.246816743411, 4985.875353116128, 5008.273800298936, 5016.097102521581, 5041.621878359065, 3731.328360895065, 4422.358757980075, 4443.0669559392245, 4465.977670111693, 4471.485779135376, 5638.069718496402, 5658.122990936411, 5675.858103547444, 5680.289963754531, 5689.459501347365, 6238.625682459067, 6238.656873871981, 6242.781502647476, 6251.78118765841, 6260.060990851318, 5645.2096706461125, 5654.660720356709, 5661.830145095653, 5662.518685911744, 5664.235328230719, 5425.972870135624, 5439.592030597721, 5440.646357986719, 5445.455454454602, 5452.972735136378, 6301.275353334334, 6305.842353941005, 6306.747730090837, 6311.2426508819235, 6318.399752023551, 6241.563090583615, 6299.496040316855, 6311.842203944938, 6316.368363163647, 6337.873242535031, 6372.74509019634, 6379.808605741835, 6386.361363863576, 6391.48868090561, 6404.231492220963, 6047.455728984412, 6121.663308518075, 6125.84596676928, 6126.609281623611, 6267.4045965633195, 6142.3857614240005, 6216.875662486816, 6218.347073557211, 6224.128621993015, 6246.937530624636, 5928.8814223716145, 6034.39656034393, 6074.544409169242, 6077.3011103721865, 6103.389661033861, 6163.753449862134, 6171.84570385744, 6175.135481032748, 6176.35148309421, 6183.536234782319, 6046.879062418815, 6051.706225525404, 6055.212822333245, 6058.606190597597, 6087.756489740361, 5158.8392611662075, 5951.345352011362, 6065.757369705162, 6196.411340922605, 6209.410106039919, 5741.91387129185, 5854.648721076579, 5856.648601083949, 5860.619059761102, 5878.0], "value": 5673.587024325363, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.173774061754, 787.2717736094112, 851.7019043334834, 860.5955201055501, 863.8531449653558, 27588.310292242702, 28966.565501517493, 29035.56446653302, 29082.85458572707, 39314.60685393145, 41022.7948860256, 41463.0, 41547.75356739295, 41548.0, 41610.0, 9106.635734570626, 9249.352545321797, 9259.95370023149, 9270.536473176347, 9278.675246366378, 7290.635468226594, 7426.591537465437, 9155.267578593697, 9289.024652411466, 9289.814203715921, 7443.925560744405, 7472.4395670324675, 7485.887711684302, 10835.83746243807, 11007.06439952605, 9270.39742416744, 10220.386776793343, 10928.398938058404, 10989.835152472719, 10996.615118470894, 10625.73435664107, 10658.680239592824, 10676.786464270748, 10702.518386672618, 10723.088537474325, 27682.892684292605, 27744.861275693693, 38621.80689096537, 38713.225735485415, 38937.80531097355, 3795.2409518096492, 3838.980805095957, 3842.2891765023282, 3879.8060096995036, 3893.5717071122153, 24831.62752558713, 26498.470030599474, 28343.0, 28526.144215673354, 29219.415611687647, 3059.7858149929516, 3122.6252849658185, 3136.3570468053995, 3208.4866421372467, 3225.870965161414, 286473.0, 291645.0, 316977.0, 319535.40232298925, 323389.0, 51794.74102629463, 51873.2219016715, 51958.74020629948, 51959.0, 51970.740146299024, 44559.55440445619, 45195.12463379739, 47580.28629570559, 47691.523084769404, 53950.92098158094, 12515.374231288399, 12534.874651253553, 12581.874181258254, 13874.375653095634, 14122.940779441584, 12139.210951288314, 12166.0, 12188.20776649515, 12201.816972745415, 12208.267503949792, 12568.685782855502, 12611.369431528386, 12622.747545049231, 12637.0, 12650.43073061696, 5199.974000130051, 5353.759080841293, 5359.196120581866, 5366.758495867695, 5375.274337964324, 1099.120703437247, 1113.432149603708, 1130.988690113105, 1143.7426579019655, 1157.7727608734767, 26359.364063593486, 26667.599985999837, 26864.0, 26976.460470790473, 27078.729212708015, 1078.800421921947, 1210.3855671749156, 1242.8570714367963, 1251.1492185314073, 1280.3982128399637, 12726.045546584044, 13299.734005319839, 13474.663133421744, 13775.0, 13869.0, 420717.0, 422390.0, 422746.0, 423990.0, 425481.0, 53956.0, 54309.72845135749, 54338.45661543413, 54410.72794636001, 54413.0, 1366.9863301367059, 1432.0977783996016, 1433.3334999224994, 1435.7702767557141, 1438.0652575825588, 24554.63168052445, 25079.49841003206, 25899.352516187246, 26095.0, 26131.0, 42373.57626423697, 42420.57579424166, 42471.0, 42652.57347426486, 42673.78663106664, 391972.0, 393690.0315498404, 393743.0, 394229.0, 394243.0287848542, 33647.99056028323, 34120.317593648484, 34230.65769342275, 34246.80136195321, 34268.48898709237, 32453.35093298168, 43495.130097398505, 44849.1030179388, 46375.0, 46891.0, 34092.829535853154, 34806.82596587001, 36144.457833132, 37544.249115018094, 37916.43125353177, 35788.642113579575, 35814.46278305775, 37071.07322316964, 37137.25725485529, 37185.628143719296, 35334.46998295079, 35692.75075372349, 35937.28125437529, 36057.63942360648, 36358.0, 30135.69864301329, 30344.544831827097, 30573.08280751581, 30623.846880765454, 30871.536926946563, 23577.33281609054, 23617.88191059034, 24090.0, 24515.632265515676, 24572.0], "value": 18280.45302287987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.88502081760987, 373.96260373962605, 399.73817149766916, 411.9073208528081, 438.3206030652488, 13500.594982150538, 14984.550463486099, 19752.60494790105, 21362.252321168762, 21632.89183554084, 21244.36266911995, 21781.891090544566, 22120.778792212073, 22175.556488870214, 22441.765702886336, 5481.561475081984, 6487.7729279475225, 6685.765998190064, 6728.360805723449, 6788.287229840869, 6628.502862285324, 6667.566608170478, 6720.59676419414, 6732.1921369435495, 6743.550136720604, 6462.192225971754, 6693.6318502482345, 6763.019362192504, 6782.084418603475, 6785.964210736784, 6606.273309935903, 6625.436837868787, 6691.565048271896, 6711.094002309699, 6712.664366781642, 6206.045095794811, 6450.6452145132, 6465.579737317059, 6466.93533064668, 6475.74097036118, 24392.024319027394, 25432.745672543224, 26303.21090367292, 26371.868140659364, 26392.076277330394, 3115.7663175261946, 3169.350283191963, 3177.4598318285716, 3231.935361292761, 3335.633080361158, 14199.148051116967, 14256.928715356356, 14420.855791442056, 14435.422583096664, 14524.70950580993, 1368.8699573540598, 1869.1588785046783, 1897.9051047447572, 1942.1163370666454, 1976.9703454448195, 115439.0, 128781.0, 138130.0, 139552.60447395497, 139904.0, 14559.126452412676, 14760.966732328634, 15303.540893773205, 15426.0, 15677.921610391875, 28885.56671649927, 29874.551881721793, 29897.402051958838, 31078.75684972621, 31165.597548109938, 8343.499390036617, 9411.388259763093, 9916.479649724388, 9935.05616966387, 10067.546960386653, 6917.654117294216, 7330.157031941289, 7370.0, 7395.2235015323695, 8342.165783421731, 8918.286537077018, 9060.184583387527, 9166.67916622915, 9212.723618291462, 9215.493147876798, 3562.7249038342225, 3657.6350402627454, 3662.0, 3664.578573464086, 3668.944965825515, 993.4784238274964, 1007.1640538353149, 1010.3988127064385, 1061.092765685328, 1063.0591926145416, 19940.401787946386, 21171.470713231985, 21181.68227476589, 21413.46466338354, 21459.29592136811, 1015.8730158730159, 1029.5469993202967, 1063.2557209953063, 1065.1532032034552, 1067.391586795519, 10288.030915018779, 10823.732890669276, 10860.757977927242, 10870.552762815725, 10875.396488423723, 667412.0, 682512.0, 704376.0, 710893.0, 715930.0, 115124.0, 117508.0, 123603.0, 149217.0, 154704.0, 1228.6928267933017, 1236.097648716442, 1280.2830414967648, 1283.9679008024875, 1287.929163895976, 17217.0, 19222.8077719221, 19257.614847703248, 19771.901140494207, 19779.802201977796, 46249.0, 49312.50687493079, 54561.72719136379, 56752.71623641856, 60919.086213705945, 82366.17633823585, 82883.0, 83143.5842820782, 83405.58297208475, 83783.5810820942, 7560.168381478143, 8937.73186804397, 9053.728388148365, 10948.56205751761, 11347.262427942158, 12233.226182203709, 12301.44643491027, 12344.321062341658, 12345.753084938071, 12536.059795515555, 10281.9485902573, 10353.896461035594, 10770.946145269538, 10790.514426850968, 10815.35107893529, 8418.95790521068, 10011.299209055296, 10287.43419111926, 10301.124404425707, 10342.32774869631, 10566.207534434794, 10651.840222396826, 10996.835047474455, 11054.944725276322, 11079.446027698421, 10698.03717665414, 10698.946505267424, 11083.501242443948, 11096.44517774092, 11147.609833655782, 10450.42522661261, 10789.56841726322, 10825.133989280996, 10871.619493317696, 10917.399543024892], "value": 10905.313614395025, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.5988343322151, 1486.5317425011121, 1491.8731907787837, 1565.5459916624172, 1600.8719302455802, 10398.844017339736, 10939.45302734864, 10948.0, 10953.890461095387, 10956.671299861016, 10369.0, 10738.785224295509, 10908.400037997926, 10941.179411544146, 10989.670309890696, 2319.3737690823427, 2366.6450032495177, 2367.3253122859987, 2377.263048454976, 2377.785999260066, 2302.3323236261463, 2336.532693461306, 2345.7302410222787, 2345.812335013203, 2352.0591763294733, 2208.7349518057854, 2325.651152327156, 2336.4626135988733, 2349.318697577709, 2349.3656712687566, 2095.434232757155, 2304.320225533472, 2330.8951097200584, 2332.486852892361, 2335.6846825678654, 2256.9322920312416, 2297.253392647396, 2311.0755697721047, 2315.166540045582, 2353.5645905507363, 10876.510557024953, 10940.343579385262, 10961.780764384668, 10969.0, 10986.560537578487, 5683.744231509592, 5875.529957603381, 5878.265216847894, 5893.675847828411, 5936.554758393095, 3324.8720818676065, 3428.297199074184, 3641.963580364189, 3642.1987162824403, 3654.7624404413627, 1096.369587487198, 1118.3569447567681, 1149.9252548584316, 1198.9988359719644, 1217.8112392579164, 13196.274204918725, 13616.18302901829, 13923.30383480822, 15055.397784088624, 15095.924520377437, 4145.689073319513, 4261.0, 4261.808218630169, 4514.322851572225, 4696.0, 11417.145713571606, 11435.199536032564, 11438.0, 11440.084793216523, 11466.885331146581, 5616.073347897551, 5616.157576363578, 5618.185363122325, 5624.015797235467, 5633.0, 4329.458817647794, 4762.78567464465, 5214.7914083437, 5229.424763276036, 5253.080710875658, 3615.9096022599647, 3731.757435766721, 3768.717346199046, 3814.7138964577766, 3820.5988371220624, 1017.8982101789762, 1021.7752094539189, 1022.8874823769379, 1031.8710161229847, 1031.9535620897077, 915.4690279637794, 944.650479322655, 946.0, 959.69289827256, 984.0946329376991, 6422.550421470546, 6667.799966001027, 6686.866262674719, 6763.0, 6785.42323902464, 809.6356639512243, 950.3727539823822, 968.9757756056155, 983.233078199006, 1022.1669339488293, 4032.7580345179385, 4138.13099249161, 4405.647548196137, 4473.4408198975125, 4619.122366750306, 12822.615321540368, 13126.868731312756, 13132.015098867623, 13132.212067275994, 13139.67150821218, 12668.93665531685, 13005.544805931937, 13010.934945325213, 13090.672733181556, 13184.472621095241, 9916.504174791231, 10186.694399168036, 10193.796124077626, 10197.0, 10207.642732504326, 6415.006141498024, 6739.157605299338, 6828.566001139816, 6834.897476537955, 6858.965705171442, 11848.28910265387, 12152.817707734568, 12164.39178041112, 12188.45151968146, 12230.633081007583, 10889.891101089204, 11100.0, 11507.769844603228, 12248.142630015813, 12405.0, 8034.076081250497, 8277.172282771915, 8425.578721064045, 8515.148485151436, 8532.573371331533, 8318.334533237448, 8450.704225352083, 9620.71137865865, 9709.223262139154, 9717.708468745948, 8793.29653627721, 8827.337949653673, 8878.0, 8938.553072346227, 9000.774980625536, 8626.654933802578, 8689.044205137556, 8768.78078048054, 8780.51707156087, 8976.640934362553, 7434.219406962191, 7691.692332306869, 7718.922810772045, 7773.455858089879, 7801.9609901950125, 5702.45826646468, 5845.41545845412, 5908.881822363614, 6054.910116178954, 6156.29202641702, 4930.457649658606, 5728.341240757366, 5817.5055120313555, 5996.970015149896, 6035.517158627212], "value": 5009.9561711395, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.8748081911741, 373.89530931339226, 378.3152493985884, 382.3194713410129, 386.069572330683, 5140.897182056361, 5162.974185129069, 5194.818181363653, 5214.322138122044, 5218.21726740989, 4574.216055738265, 4802.927956080662, 4950.7277099759585, 4973.801047958077, 5017.774200160992, 3638.5815631202486, 3687.400382730169, 3806.7906265155334, 4122.361034039729, 4148.577423625506, 3555.6310820334097, 3767.5478942526934, 4172.812223449937, 4178.0, 4186.225548273564, 3867.0332416895776, 4060.5585017318867, 4147.917041659165, 4176.66346769034, 4202.886235147688, 3677.4441762974743, 4116.773577453238, 4129.710920235585, 4149.0, 4159.480064991892, 2990.9551356729667, 3359.3113411750533, 3515.3145136698354, 3811.5235595550557, 3840.7503512271614, 4141.5271506772615, 4308.978455107705, 4783.545563171493, 4843.321934929113, 4858.902821943541, 3879.650831425185, 3921.4706014687936, 4580.839670611513, 4594.586487216133, 4826.782794774209, 4521.909561808746, 5134.0, 5225.320708307896, 5232.043895199238, 5380.982131700613, 3816.484774555455, 4095.4846706718704, 4134.896627584304, 4193.622573968358, 4383.890402739957, 5129.666571672904, 5361.195820626898, 5519.558435325164, 5657.57568182388, 5786.247787787603, 4263.936040959388, 4311.590398912098, 4394.714343567658, 4454.331850222493, 4457.375967364572, 4192.555890755809, 4397.273690311963, 4567.81236878414, 4579.450465944108, 4593.150267200579, 4043.6562892153906, 4294.656427485794, 4493.820247190076, 4501.977490112528, 4683.227267500824, 4809.711417314972, 4942.291653140628, 5244.449332820075, 5373.7581808818695, 5395.271638328853, 1360.9523666671816, 1403.684171061503, 1509.260462373451, 1523.9542813715607, 1536.8463153684543, 1033.7105610429091, 1050.669039252633, 1147.4836323654388, 1150.7169506000748, 1170.3329102411544, 4284.4430224070675, 4479.417675702138, 4930.0, 4934.136526107988, 4982.7259500727805, 4690.624750019991, 4730.834420795256, 5055.87360315995, 5482.616216864861, 5585.888282234414, 3804.6766024888193, 4266.509351424564, 4980.243867106904, 5020.272060551272, 5048.924266136011, 2653.3234025323804, 2882.9135125946254, 2894.8407837568716, 2924.7715959297147, 2960.407918416325, 5094.15946368845, 5416.9729151353995, 5432.728363581805, 5761.337446193657, 5893.027650437715, 5370.892582148335, 5736.77052917887, 5761.378572749389, 5804.477597016289, 5824.563157763185, 4929.950700493021, 5232.92150617741, 5766.509846662912, 5798.130280457881, 5818.7672493100645, 4681.765911704333, 4997.1303607829805, 5085.77114029877, 5427.945720542744, 5631.986887015427, 4638.489766125656, 5490.670559766427, 5496.532794712334, 5581.49766521015, 5614.354349249888, 4963.815920994751, 5023.824166154167, 5105.489451055013, 5329.467053294639, 5812.564057695605, 3712.401319076603, 3752.962470375261, 3912.6869850412468, 3923.5487918889694, 4189.874303770892, 4909.26361045846, 5008.697738588066, 5562.413477732874, 5578.0, 5629.802956896653, 5380.300560927211, 5427.457254274699, 5446.183072538993, 5470.8085217017215, 5473.698946557977, 4912.852614421573, 5059.406287019577, 5209.947900521098, 5469.808556700656, 5476.822483166138, 5329.987302412529, 5349.304590403222, 5359.383670877899, 5361.437049109787, 5374.7312634367345, 4824.734639594856, 5031.874203144951, 5389.380221274447, 5494.423160492183, 5530.668159910419, 4524.932126018178, 4769.093872164278, 5232.401330576246, 5296.443873393238, 5344.839654810362], "value": 4079.4256573353146, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2572453271262, 759.3507551043857, 787.2481779900196, 826.0871736730916, 844.9704260350885, 14948.476803311887, 15201.619959501004, 15222.162781047053, 15240.542783716479, 15280.617984550392, 13974.0, 14116.364763585638, 14118.364673589687, 14120.0, 14140.0, 847.3433089355768, 931.9068093190695, 949.5157469690456, 966.7776411425376, 985.2462865907551, 974.741693451236, 981.2640519610293, 988.4168340678998, 989.6833013435703, 990.6136606723384, 1016.7305663999047, 1031.7369070886914, 1033.9327943683675, 1034.4414016431117, 1037.6316407675279, 1021.1218352217087, 1021.213665477578, 1021.7241344836926, 1023.9385636861775, 1033.0908800255766, 767.2710924621576, 767.7005967672612, 769.0732667136087, 770.0836005153849, 770.468376819998, 15123.395064197419, 15484.225788710632, 15542.61143471411, 15673.373065077383, 15966.201689915457, 13744.106633068819, 13806.17162970215, 13901.721965560631, 14006.579802605836, 14074.648133796634, 11628.244164129304, 11807.350595717233, 11879.22785018971, 12113.0, 12424.875751242462, 3574.285142971416, 3636.9621490595846, 3676.246369494247, 3677.7057835373107, 3787.6023017583307, 86110.0, 92371.07628923692, 96564.51717741437, 97093.5145324276, 98964.50517747365, 10585.470726463645, 10694.304870183412, 10747.408892510986, 10795.136389088853, 11229.85310046369, 21220.469488262916, 21625.56748865014, 21630.675539866916, 21672.458188545414, 21712.240071597418, 7534.811629709191, 7630.313271805453, 7643.69425222996, 7734.690612375442, 7821.256980586835, 4162.708610397303, 4168.7707176105605, 4175.436316097349, 4214.4099826024385, 4311.741295522279, 2859.47099786536, 3522.982385088058, 3527.4356103023392, 3532.3994920863515, 3555.6088830228655, 529.4784637132421, 629.6757170057424, 632.1686981619156, 646.689588997284, 650.8665723526666, 658.8550518885837, 659.9245373300942, 688.5455599304435, 694.1669996004714, 716.2837162837163, 8185.672573097009, 8467.66129354819, 9198.95400522993, 10082.546285417175, 10140.391576505433, 645.5513418174418, 653.2520264297353, 679.3681875855502, 682.8302820385948, 703.8803403421431, 4664.370310008106, 4820.9517904821205, 4825.276208568743, 4830.855074347775, 4849.418069831643, 95530.56704149443, 95914.0, 96092.0, 98706.5064674672, 99646.0, 45690.77154614206, 57496.85006299934, 65002.67498662571, 72475.2752472479, 85377.0, 60869.69565152234, 67111.0, 68775.65612171908, 69670.0, 69975.65012174906, 10158.251097035722, 10438.843417348899, 10575.524101415609, 10688.305260158066, 10719.839202411815, 44798.76006199742, 45194.77402612966, 45608.0, 46403.83990400267, 46605.873353930365, 50833.49166508435, 51373.71565710887, 53112.73443632757, 58789.11816322844, 60299.79400412055, 11010.009099181112, 12489.500419983462, 12499.437525311201, 12799.976001919638, 12818.005866272966, 14068.437262509795, 14122.929385353007, 14142.646433839236, 14149.221792801494, 14156.150630962175, 13204.0, 13834.347448155966, 14072.366743496363, 14095.295235237993, 14198.503052393116, 11811.468483918072, 12893.161944473579, 12904.290264035568, 13094.672633184247, 13635.386407611879, 12849.486020559072, 13116.093672147485, 13221.669458263621, 13303.667408314483, 13649.795253071014, 10397.48012599352, 10401.0, 10430.374177549067, 10492.685219443429, 11183.720406989565, 6243.0, 7483.476156668981, 8182.959085204536, 9317.0, 10324.0], "value": 7345.538836449987, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 114.0, 114.0, 115.0, 115.0, 115.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 113.0, 123.0, 180.0, 109.0, 112.0, 109.0, 109.0, 129.0, 110.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 184.0, 184.0, 186.0, 182.0, 184.0, 182.0, 187.0, 186.0, 200.0], "value": 186.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 67.0, 86.0, 116.0, 65.0, 61.0, 62.0, 60.0, 75.0, 59.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 123.0, 103.0, 70.0, 68.0, 85.0, 71.0, 70.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 87.0, 95.0, 135.0, 86.0, 86.0, 85.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 94.0, 94.0, 94.0, 101.0, 94.0, 93.0, 94.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 85.0, 86.0, 87.0, 84.0, 86.0, 82.0, 83.0, 86.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 60.0, 61.0, 64.0, 61.0, 61.0, 62.0, 62.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 57.0, 64.0, 60.0, 58.0, 55.0, 59.0, 58.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 87.0, 87.0, 86.0, 89.0, 89.0, 88.0, 90.0, 92.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 154.0, 152.0, 140.0, 140.0, 141.0, 138.0, 141.0, 179.0, 158.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 171.0, 174.0, 173.0, 172.0, 174.0, 172.0, 172.0, 169.0], "value": 172.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 78.0, 88.0, 88.0, 68.0, 66.0, 64.0, 67.0], "value": 72.4, "unit": "score"}]}]} 04:55:57 INFO - Return code: 0 04:55:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:55:57 ERROR - # TBPL SUCCESS # 04:55:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:55:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:55:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:55:57 INFO - 2017-03-04 04:55:57.659 screenresolution[1961:17208] starting screenresolution argv=screenresolution get 04:55:57 INFO - 2017-03-04 04:55:57.662 screenresolution[1961:17208] Display 0: 1600x1200x32@60 04:55:57 INFO - 2017-03-04 04:55:57.668 screenresolution[1962:17211] starting screenresolution argv=screenresolution list 04:55:57 INFO - Available Modes on Display 0 04:55:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:55:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:55:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:55:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:55:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:55:57 INFO - Intel Iris: 04:55:57 INFO - Chipset Model: Intel Iris 04:55:57 INFO - Type: GPU 04:55:57 INFO - Bus: Built-In 04:55:57 INFO - VRAM (Dynamic, Max): 1536 MB 04:55:57 INFO - Vendor: Intel (0x8086) 04:55:57 INFO - Device ID: 0x0a2e 04:55:57 INFO - Revision ID: 0x0009 04:55:57 INFO - Displays: 04:55:57 INFO - Display: 04:55:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:55:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:55:57 INFO - Display Serial Number: 1600x1200 60 04:55:57 INFO - Main Display: Yes 04:55:57 INFO - Mirror: Off 04:55:57 INFO - Online: Yes 04:55:57 INFO - Rotation: Supported 04:55:57 INFO - Return code: 0 04:55:57 INFO - Running post-action listener: _resource_record_post_action 04:55:57 INFO - [mozharness: 2017-03-04 12:55:57.906215Z] Finished run-tests step (success) 04:55:57 INFO - Running post-run listener: _resource_record_post_run 04:55:57 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 45056; Write bytes: 510242304; Read time: 2; Write time: 2140 04:55:57 INFO - TinderboxPrint: CPU usage
54.1% 04:55:57 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 2 04:55:57 INFO - TinderboxPrint: I/O write bytes / time
510,242,304 / 2,140 04:55:57 INFO - TinderboxPrint: CPU idle
2,207.8 (45.9%) 04:55:57 INFO - TinderboxPrint: CPU system
961.5 (20.0%) 04:55:57 INFO - TinderboxPrint: CPU user
1,644.5 (34.2%) 04:55:57 INFO - TinderboxPrint: Swap in / out
209,448,960 / 0 04:55:57 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207487488; Write bytes: 203118592; Read time: 15742; Write time: 561 04:55:57 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 45056; Write bytes: 296211968; Read time: 2; Write time: 1542 04:55:58 INFO - Running post-run listener: _upload_blobber_files 04:55:58 INFO - Blob upload gear active. 04:55:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:55:58 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:55:58 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:55:58 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:55:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:55:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:55:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:55:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:55:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:55:59 INFO - (blobuploader) - INFO - Done attempting. 04:55:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:55:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:55:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:56:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:00 INFO - (blobuploader) - INFO - Done attempting. 04:56:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:56:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:56:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:01 INFO - (blobuploader) - INFO - Done attempting. 04:56:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:56:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:04 INFO - (blobuploader) - INFO - Done attempting. 04:56:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:04 INFO - Return code: 0 04:56:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4643696841cb74d3b6f075445a64b9e226f628a1c98b97dc98d85858eb72fb8a4ac534e930776d2334f17a5b1cf49b633e957a731d3e6f73dd03105460a338e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa1e0f1cae69aad2f7d3bf273796f312393750575f845c81ad2c1434bf9d21f451dfac81ce2ae90fa9349987b98a9a0f245d2986ee2a8bf979574c10877d8c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82f8ad6e1f93953ca9b7f16ce155a77228b4c85b3148e00befed3f1ea53d5c24c5dd24f61dc3776b26630b3521852ae5fd3bc54dd7719b122f4a378d366cc31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22157356481fb65e3a4a519b3e6d5448a7c9774eed3791d9128aa169aed72e35c26078385efaeb43b72f17ff8dc5b85b1391b1f00402fb177b061feae73b6d42"} 04:56:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:04 INFO - Contents: 04:56:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4643696841cb74d3b6f075445a64b9e226f628a1c98b97dc98d85858eb72fb8a4ac534e930776d2334f17a5b1cf49b633e957a731d3e6f73dd03105460a338e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa1e0f1cae69aad2f7d3bf273796f312393750575f845c81ad2c1434bf9d21f451dfac81ce2ae90fa9349987b98a9a0f245d2986ee2a8bf979574c10877d8c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82f8ad6e1f93953ca9b7f16ce155a77228b4c85b3148e00befed3f1ea53d5c24c5dd24f61dc3776b26630b3521852ae5fd3bc54dd7719b122f4a378d366cc31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22157356481fb65e3a4a519b3e6d5448a7c9774eed3791d9128aa169aed72e35c26078385efaeb43b72f17ff8dc5b85b1391b1f00402fb177b061feae73b6d42"} 04:56:04 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:04 INFO - Copying logs to upload dir... 04:56:04 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.509655 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-03-04 04:56:04.857169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 04:56:04.860411) ========= 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.i8CD7pyuNw/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.XTKlwe9l13/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4643696841cb74d3b6f075445a64b9e226f628a1c98b97dc98d85858eb72fb8a4ac534e930776d2334f17a5b1cf49b633e957a731d3e6f73dd03105460a338e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa1e0f1cae69aad2f7d3bf273796f312393750575f845c81ad2c1434bf9d21f451dfac81ce2ae90fa9349987b98a9a0f245d2986ee2a8bf979574c10877d8c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82f8ad6e1f93953ca9b7f16ce155a77228b4c85b3148e00befed3f1ea53d5c24c5dd24f61dc3776b26630b3521852ae5fd3bc54dd7719b122f4a378d366cc31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22157356481fb65e3a4a519b3e6d5448a7c9774eed3791d9128aa169aed72e35c26078385efaeb43b72f17ff8dc5b85b1391b1f00402fb177b061feae73b6d42"} build_url:https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/N6xH2fyjRAeyti_iN6jZEg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4643696841cb74d3b6f075445a64b9e226f628a1c98b97dc98d85858eb72fb8a4ac534e930776d2334f17a5b1cf49b633e957a731d3e6f73dd03105460a338e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa1e0f1cae69aad2f7d3bf273796f312393750575f845c81ad2c1434bf9d21f451dfac81ce2ae90fa9349987b98a9a0f245d2986ee2a8bf979574c10877d8c42", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82f8ad6e1f93953ca9b7f16ce155a77228b4c85b3148e00befed3f1ea53d5c24c5dd24f61dc3776b26630b3521852ae5fd3bc54dd7719b122f4a378d366cc31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22157356481fb65e3a4a519b3e6d5448a7c9774eed3791d9128aa169aed72e35c26078385efaeb43b72f17ff8dc5b85b1391b1f00402fb177b061feae73b6d42"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-04 04:56:04.895560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 04:56:04.895879) ========= 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.i8CD7pyuNw/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.XTKlwe9l13/Listeners TMPDIR=/var/folders/cn/kbjph2xn3s502v35v9_fg26800000w/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.005412 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-04 04:56:04.945014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 04:56:04.945321) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-04 04:56:04.945641) ========= ========= Total master_lag: 0.19 =========