builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0220 starttime: 1476708360.77 results: success (0) buildid: 20161017025535 builduid: 9349f1af526043e48718e6bf2a2072f1 revision: 198c4bf0c8df9765e9eba5f12eb1f7a899c277e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.767816) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.768290) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.768567) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.795029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.795634) ========= 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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-17 05:46:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.4M=0s 2016-10-17 05:46:00 (29.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114795 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.934294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.934765) ========= 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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.024370 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:00.983108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:46:00.983490) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 198c4bf0c8df9765e9eba5f12eb1f7a899c277e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 198c4bf0c8df9765e9eba5f12eb1f7a899c277e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x33MUxog4x/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.7oMsdlQ2Dq/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-17 05:46:01,066 truncating revision to first 12 chars 2016-10-17 05:46:01,066 Setting DEBUG logging. 2016-10-17 05:46:01,066 attempt 1/10 2016-10-17 05:46:01,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/198c4bf0c8df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 05:46:01,855 unpacking tar archive at: autoland-198c4bf0c8df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:46:02.057466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:02.057875) ========= script_repo_revision: 198c4bf0c8df9765e9eba5f12eb1f7a899c277e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:02.058305) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:02.058577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:46:02.077432) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-17 05:46:02.077820) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.x33MUxog4x/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.7oMsdlQ2Dq/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:46:02 INFO - MultiFileLogger online at 20161017 05:46:02 in /builds/slave/test 05:46:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 05:46:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:46:02 INFO - {'append_to_log': False, 05:46:02 INFO - 'base_work_dir': '/builds/slave/test', 05:46:02 INFO - 'blob_upload_branch': 'Autoland', 05:46:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:46:02 INFO - 'branch': 'Autoland', 05:46:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:46:02 INFO - 'config_files': ('talos/mac_config.py',), 05:46:02 INFO - 'default_actions': ('clobber', 05:46:02 INFO - 'read-buildbot-config', 05:46:02 INFO - 'download-and-extract', 05:46:02 INFO - 'populate-webroot', 05:46:02 INFO - 'create-virtualenv', 05:46:02 INFO - 'install', 05:46:02 INFO - 'run-tests'), 05:46:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:46:02 INFO - 'download_minidump_stackwalk': True, 05:46:02 INFO - 'download_symbols': 'ondemand', 05:46:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:46:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:46:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:46:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:46:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:46:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:46:02 INFO - 'installer_path': 'installer.exe', 05:46:02 INFO - 'log_level': 'info', 05:46:02 INFO - 'log_name': 'talos', 05:46:02 INFO - 'log_to_console': True, 05:46:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:46:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:46:02 INFO - 'opt_config_files': (), 05:46:02 INFO - 'pip_index': False, 05:46:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:46:02 INFO - 'cmd': ('bash', 05:46:02 INFO - '-c', 05:46:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:46:02 INFO - 'enabled': True, 05:46:02 INFO - 'halt_on_failure': False, 05:46:02 INFO - 'name': 'check_screen_resolution'},), 05:46:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:46:02 INFO - 'cmd': ('bash', 05:46:02 INFO - '-c', 05:46:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:46:02 INFO - 'enabled': True, 05:46:02 INFO - 'halt_on_failure': False, 05:46:02 INFO - 'name': 'check_screen_resolution'},), 05:46:02 INFO - 'run_cmd_checks_enabled': True, 05:46:02 INFO - 'sps_profile': False, 05:46:02 INFO - 'sps_profile_interval': 0, 05:46:02 INFO - 'suite': 'dromaeojs', 05:46:02 INFO - 'system_bits': '32', 05:46:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:46:02 INFO - 'title': 't-yosemite-r7-0220', 05:46:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:46:02 INFO - 'use_talos_json': True, 05:46:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:46:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:46:02 INFO - 'work_dir': 'build'} 05:46:02 INFO - [mozharness: 2016-10-17 12:46:02.278103Z] Running clobber step. 05:46:02 INFO - Running pre-action listener: _resource_record_pre_action 05:46:02 INFO - Running main action method: clobber 05:46:02 INFO - rmtree: /builds/slave/test/build 05:46:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:46:04 INFO - Running post-action listener: _resource_record_post_action 05:46:04 INFO - [mozharness: 2016-10-17 12:46:04.308868Z] Finished clobber step (success) 05:46:04 INFO - [mozharness: 2016-10-17 12:46:04.308998Z] Running read-buildbot-config step. 05:46:04 INFO - Running pre-action listener: _resource_record_pre_action 05:46:04 INFO - Running main action method: read_buildbot_config 05:46:04 INFO - Using buildbot properties: 05:46:04 INFO - { 05:46:04 INFO - "project": "", 05:46:04 INFO - "product": "firefox", 05:46:04 INFO - "script_repo_revision": "production", 05:46:04 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 05:46:04 INFO - "repository": "", 05:46:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 05:46:04 INFO - "buildid": "20161017025535", 05:46:04 INFO - "pgo_build": "False", 05:46:04 INFO - "basedir": "/builds/slave/test", 05:46:04 INFO - "buildnumber": 443, 05:46:04 INFO - "slavename": "t-yosemite-r7-0220", 05:46:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:46:04 INFO - "platform": "yosemite_r7", 05:46:04 INFO - "scheduler": "tests-autoland-macosx64-talos", 05:46:04 INFO - "branch": "autoland", 05:46:04 INFO - "repo_path": "integration/autoland", 05:46:04 INFO - "revision": "198c4bf0c8df9765e9eba5f12eb1f7a899c277e5", 05:46:04 INFO - "stage_platform": "macosx64", 05:46:04 INFO - "builduid": "9349f1af526043e48718e6bf2a2072f1", 05:46:04 INFO - "slavebuilddir": "test" 05:46:04 INFO - } 05:46:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:46:04 INFO - Running post-action listener: _resource_record_post_action 05:46:04 INFO - [mozharness: 2016-10-17 12:46:04.312213Z] Finished read-buildbot-config step (success) 05:46:04 INFO - [mozharness: 2016-10-17 12:46:04.312315Z] Running download-and-extract step. 05:46:04 INFO - Running pre-action listener: _resource_record_pre_action 05:46:04 INFO - Running main action method: download_and_extract 05:46:04 INFO - mkdir: /builds/slave/test/build/tests 05:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:04 INFO - trying https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:46:04 INFO - Downloading https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:46:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:46:05 INFO - Downloaded 1199 bytes. 05:46:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:46:05 INFO - Using the following test package requirements: 05:46:05 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:46:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:46:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:46:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'jsshell-mac.zip'], 05:46:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:46:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:46:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:46:05 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:46:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:46:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:46:05 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:46:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:46:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:46:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:46:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:46:06 INFO - Http code: 200 05:46:06 INFO - via: 1.1 296faebadd40feee8b2eb0e10d5786d2.cloudfront.net (CloudFront) 05:46:06 INFO - x-amz-cf-id: pI9PGQoLeVT9dPeGpehHvzzsA_JNTkS_5tn3wBGxha1sLPGGZk_a8g== 05:46:06 INFO - x-amz-version-id: RNO4idwwTgECFvSbTxgj66QasxJL0AEP 05:46:06 INFO - Expected file size: 16483188 05:46:06 INFO - Obtained file size: 16483188 05:46:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:46:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:46:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:46:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:46:13 INFO - Http code: 200 05:46:13 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 05:46:13 INFO - x-amz-cf-id: uzVswTDRHq7mskHs3PqJk76K5T14pvT0ukY_GDxHDTPoWaWoQCfyQg== 05:46:13 INFO - x-amz-version-id: RNO4idwwTgECFvSbTxgj66QasxJL0AEP 05:46:14 INFO - Expected file size: 16483188 05:46:14 INFO - Obtained file size: 16483188 05:46:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:46:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:46:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:46:21 INFO - Http code: 200 05:46:21 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 05:46:21 INFO - x-amz-cf-id: NbvSF3segoepJ2BciOOxgzuHJ8jS1Gm2o9Ll9B3dKB5nMtM8FH87FQ== 05:46:21 INFO - x-amz-version-id: iTFChR1H_CG9OGbk94hK_ydV5a5gvytn 05:46:22 INFO - Expected file size: 14409028 05:46:22 INFO - Obtained file size: 14409028 05:46:22 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')]} 05:46:22 INFO - trying https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:46:22 INFO - Downloading https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:46:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:46:25 INFO - Downloaded 111650870 bytes. 05:46:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:46:25 INFO - mkdir: /builds/slave/test/properties 05:46:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:25 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:25 INFO - Contents: 05:46:25 INFO - build_url:https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:46:25 INFO - Running post-action listener: _resource_record_post_action 05:46:25 INFO - Running post-action listener: set_extra_try_arguments 05:46:25 INFO - [mozharness: 2016-10-17 12:46:25.916916Z] Finished download-and-extract step (success) 05:46:25 INFO - [mozharness: 2016-10-17 12:46:25.917055Z] Running populate-webroot step. 05:46:25 INFO - Running pre-action listener: _resource_record_pre_action 05:46:25 INFO - Running main action method: populate_webroot 05:46:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:25 INFO - '--tppagecycles', 05:46:25 INFO - '7'], 05:46:25 INFO - 'tests': ['tsvgm']}}, 05:46:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:46:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['damp', 'tps']}, 05:46:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'tests': ['damp', 'tps']}, 05:46:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['dromaeo_dom']}, 05:46:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['basic_compositor_video']}, 05:46:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:46:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['a11yr', 05:46:25 INFO - 'ts_paint', 05:46:25 INFO - 'tpaint', 05:46:25 INFO - 'sessionrestore', 05:46:25 INFO - 'sessionrestore_no_auto_restore', 05:46:25 INFO - 'tabpaint']}, 05:46:25 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:25 INFO - 'ts_paint', 05:46:25 INFO - 'tpaint', 05:46:25 INFO - 'sessionrestore', 05:46:25 INFO - 'sessionrestore_no_auto_restore', 05:46:25 INFO - 'tabpaint']}, 05:46:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:25 INFO - 'ts_paint', 05:46:25 INFO - 'tpaint', 05:46:25 INFO - 'sessionrestore', 05:46:25 INFO - 'sessionrestore_no_auto_restore', 05:46:25 INFO - 'tabpaint']}, 05:46:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:25 INFO - 'ts_paint', 05:46:25 INFO - 'tpaint', 05:46:25 INFO - 'sessionrestore', 05:46:25 INFO - 'sessionrestore_no_auto_restore', 05:46:25 INFO - 'tabpaint']}, 05:46:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['a11yr', 05:46:25 INFO - 'ts_paint', 05:46:25 INFO - 'tpaint', 05:46:25 INFO - 'sessionrestore', 05:46:25 INFO - 'sessionrestore_no_auto_restore', 05:46:25 INFO - 'tabpaint']}, 05:46:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['a11yr', 05:46:25 INFO - 'ts_paint', 05:46:25 INFO - 'tpaint', 05:46:25 INFO - 'sessionrestore', 05:46:25 INFO - 'sessionrestore_no_auto_restore', 05:46:25 INFO - 'tabpaint']}, 05:46:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['tsvgx', 05:46:25 INFO - 'tsvgr_opacity', 05:46:25 INFO - 'tart', 05:46:25 INFO - 'tscrollx', 05:46:25 INFO - 'cart']}, 05:46:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:25 INFO - 'tsvgr_opacity', 05:46:25 INFO - 'tart', 05:46:25 INFO - 'tscrollx', 05:46:25 INFO - 'cart']}, 05:46:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'talos_options': ['--disable-e10s'], 05:46:25 INFO - 'tests': ['tp5o']}, 05:46:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'tests': ['tp5o']}, 05:46:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'talos_options': ['--disable-e10s', 05:46:25 INFO - '--xperf_path', 05:46:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:25 INFO - 'tests': ['tp5n']}, 05:46:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:46:25 INFO - 'talos_options': ['--xperf_path', 05:46:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:25 INFO - 'tests': ['tp5n']}}, 05:46:25 INFO - 'talos.zip': {'path': '', 05:46:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:25 INFO - Running post-action listener: _resource_record_post_action 05:46:25 INFO - [mozharness: 2016-10-17 12:46:25.935660Z] Finished populate-webroot step (success) 05:46:25 INFO - [mozharness: 2016-10-17 12:46:25.935795Z] Running create-virtualenv step. 05:46:25 INFO - Running pre-action listener: _resource_record_pre_action 05:46:25 INFO - Running main action method: create_virtualenv 05:46:25 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46:25 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 05:46:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:26 INFO - Using real prefix '/tools/python27' 05:46:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:26 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:29 INFO - Installing pip.................done. 05:46:29 INFO - Return code: 0 05:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:29 INFO - Reading from file tmpfile_stdout 05:46:29 INFO - Output received: 05:46:29 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) 05:46:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:29 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:29 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 05:46:29 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 05:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:29 INFO - 'HOME': '/Users/cltbld', 05:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:29 INFO - 'LOGNAME': 'cltbld', 05:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:29 INFO - 'MOZ_NO_REMOTE': '1', 05:46:29 INFO - 'NO_EM_RESTART': '1', 05:46:29 INFO - 'PAGER': '/bin/cat', 05:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:29 INFO - 'PWD': '/builds/slave/test', 05:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:29 INFO - 'SHELL': '/bin/bash', 05:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:29 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:29 INFO - 'USER': 'cltbld', 05:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:29 INFO - 'XPC_FLAGS': '0x0', 05:46:29 INFO - 'XPC_SERVICE_NAME': '0', 05:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:30 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 05:46:30 INFO - Cleaning up... 05:46:30 INFO - Return code: 0 05:46:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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', '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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:46: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 psutil>=3.1.1 05:46:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:30 INFO - 'HOME': '/Users/cltbld', 05:46:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:30 INFO - 'LOGNAME': 'cltbld', 05:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:30 INFO - 'MOZ_NO_REMOTE': '1', 05:46:30 INFO - 'NO_EM_RESTART': '1', 05:46:30 INFO - 'PAGER': '/bin/cat', 05:46:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:30 INFO - 'PWD': '/builds/slave/test', 05:46:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:30 INFO - 'SHELL': '/bin/bash', 05:46:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:30 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:30 INFO - 'USER': 'cltbld', 05:46:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:30 INFO - 'XPC_FLAGS': '0x0', 05:46:30 INFO - 'XPC_SERVICE_NAME': '0', 05:46:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:30 INFO - Downloading/unpacking psutil>=3.1.1 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:33 INFO - Installing collected packages: psutil 05:46:33 INFO - Running setup.py install for psutil 05:46:33 INFO - building 'psutil._psutil_osx' extension 05:46:33 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 05:46:34 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 05:46:34 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 05:46:34 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 05:46:34 INFO - building 'psutil._psutil_posix' extension 05:46:34 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 05:46:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:46:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:46:34 INFO - ^ 05:46:34 INFO - 1 warning generated. 05:46:34 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 05:46:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:34 INFO - Successfully installed psutil 05:46:34 INFO - Cleaning up... 05:46:34 INFO - Return code: 0 05:46:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46:34 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')]} 05:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:34 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')]} 05:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:34 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:34 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 05:46:34 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 05:46:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:34 INFO - 'HOME': '/Users/cltbld', 05:46:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:34 INFO - 'LOGNAME': 'cltbld', 05:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:34 INFO - 'MOZ_NO_REMOTE': '1', 05:46:34 INFO - 'NO_EM_RESTART': '1', 05:46:34 INFO - 'PAGER': '/bin/cat', 05:46:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:34 INFO - 'PWD': '/builds/slave/test', 05:46:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:34 INFO - 'SHELL': '/bin/bash', 05:46:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:34 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:34 INFO - 'USER': 'cltbld', 05:46:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:34 INFO - 'XPC_FLAGS': '0x0', 05:46:34 INFO - 'XPC_SERVICE_NAME': '0', 05:46:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:35 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 05:46:35 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 05:46:35 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 05:46:35 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 05:46:35 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 05:46:35 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 05:46:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:37 INFO - Installing collected packages: mozsystemmonitor 05:46:37 INFO - Running setup.py install for mozsystemmonitor 05:46:37 INFO - Successfully installed mozsystemmonitor 05:46:37 INFO - Cleaning up... 05:46:37 INFO - Return code: 0 05:46:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:38 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:38 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 05:46:38 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 05:46:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:38 INFO - 'HOME': '/Users/cltbld', 05:46:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:38 INFO - 'LOGNAME': 'cltbld', 05:46:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:38 INFO - 'MOZ_NO_REMOTE': '1', 05:46:38 INFO - 'NO_EM_RESTART': '1', 05:46:38 INFO - 'PAGER': '/bin/cat', 05:46:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:38 INFO - 'PWD': '/builds/slave/test', 05:46:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:38 INFO - 'SHELL': '/bin/bash', 05:46:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:38 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:38 INFO - 'USER': 'cltbld', 05:46:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:38 INFO - 'XPC_FLAGS': '0x0', 05:46:38 INFO - 'XPC_SERVICE_NAME': '0', 05:46:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:38 INFO - Downloading/unpacking jsonschema==2.5.1 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46: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 05:46:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:41 INFO - warning: no files found matching '*.txt' 05:46:41 INFO - no previously-included directories found matching 'build' 05:46:41 INFO - no previously-included directories found matching 'dist' 05:46:41 INFO - no previously-included directories found matching '.git*' 05:46:41 INFO - Installing collected packages: jsonschema, functools32 05:46:41 INFO - Running setup.py install for functools32 05:46:41 INFO - warning: no files found matching '*.txt' 05:46:41 INFO - no previously-included directories found matching 'build' 05:46:41 INFO - no previously-included directories found matching 'dist' 05:46:41 INFO - no previously-included directories found matching '.git*' 05:46:41 INFO - Successfully installed jsonschema functools32 05:46:41 INFO - Cleaning up... 05:46:41 INFO - Return code: 0 05:46:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:41 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 05:46:41 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 05:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:41 INFO - 'HOME': '/Users/cltbld', 05:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:41 INFO - 'LOGNAME': 'cltbld', 05:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:41 INFO - 'MOZ_NO_REMOTE': '1', 05:46:41 INFO - 'NO_EM_RESTART': '1', 05:46:41 INFO - 'PAGER': '/bin/cat', 05:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:41 INFO - 'PWD': '/builds/slave/test', 05:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:41 INFO - 'SHELL': '/bin/bash', 05:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:41 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:41 INFO - 'USER': 'cltbld', 05:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:41 INFO - 'XPC_FLAGS': '0x0', 05:46:41 INFO - 'XPC_SERVICE_NAME': '0', 05:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:41 INFO - Cleaning up... 05:46:41 INFO - Return code: 0 05:46:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46: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')]} 05:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:41 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:41 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 05:46:41 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 05:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:41 INFO - 'HOME': '/Users/cltbld', 05:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:41 INFO - 'LOGNAME': 'cltbld', 05:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:41 INFO - 'MOZ_NO_REMOTE': '1', 05:46:41 INFO - 'NO_EM_RESTART': '1', 05:46:41 INFO - 'PAGER': '/bin/cat', 05:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:41 INFO - 'PWD': '/builds/slave/test', 05:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:41 INFO - 'SHELL': '/bin/bash', 05:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:41 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:41 INFO - 'USER': 'cltbld', 05:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:41 INFO - 'XPC_FLAGS': '0x0', 05:46:41 INFO - 'XPC_SERVICE_NAME': '0', 05:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:42 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 05:46:42 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 05:46:42 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 05:46:42 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 05:46:42 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 05:46:42 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 05:46:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 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 05:46:45 INFO - Downloading docopt-0.6.1.tar.gz 05:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:45 INFO - Running setup.py install for blobuploader 05:46:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:45 INFO - Running setup.py install for requests 05:46:46 INFO - Running setup.py install for docopt 05:46:46 INFO - Successfully installed blobuploader requests docopt 05:46:46 INFO - Cleaning up... 05:46:46 INFO - Return code: 0 05:46:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:46 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')]} 05:46:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:46 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')]} 05:46:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:46 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:46 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 05:46:46 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 05:46:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:46 INFO - 'HOME': '/Users/cltbld', 05:46:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:46 INFO - 'LOGNAME': 'cltbld', 05:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:46 INFO - 'MOZ_NO_REMOTE': '1', 05:46:46 INFO - 'NO_EM_RESTART': '1', 05:46:46 INFO - 'PAGER': '/bin/cat', 05:46:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:46 INFO - 'PWD': '/builds/slave/test', 05:46:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:46 INFO - 'SHELL': '/bin/bash', 05:46:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:46 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:46 INFO - 'USER': 'cltbld', 05:46:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:46 INFO - 'XPC_FLAGS': '0x0', 05:46:46 INFO - 'XPC_SERVICE_NAME': '0', 05:46:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:46 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-C6J6zN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-UY2_Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-OYvEAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-t9EjCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-763UkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-1ycK1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-Q8DmCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VOIOoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-B4fnpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-xfsfDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:47 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VGoTNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-rRzm_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-XlPbhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-CqicUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-P_pTsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-WFei8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:48 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-qanE_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:48 INFO - Running setup.py install for manifestparser 05:46:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:48 INFO - Running setup.py install for mozcrash 05:46:48 INFO - Running setup.py install for mozdebug 05:46:49 INFO - Running setup.py install for mozdevice 05:46:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozfile 05:46:49 INFO - Running setup.py install for mozhttpd 05:46:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozinfo 05:46:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozInstall 05:46:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:49 INFO - Running setup.py install for mozleak 05:46:49 INFO - Running setup.py install for mozlog 05:46:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for moznetwork 05:46:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozprocess 05:46:50 INFO - Running setup.py install for mozprofile 05:46:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozrunner 05:46:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:50 INFO - Running setup.py install for mozscreenshot 05:46:50 INFO - Running setup.py install for moztest 05:46:51 INFO - Running setup.py install for mozversion 05:46:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:51 INFO - Cleaning up... 05:46:51 INFO - Return code: 0 05:46:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:51 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:51 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 05:46:51 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 05:46:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:51 INFO - 'HOME': '/Users/cltbld', 05:46:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:51 INFO - 'LOGNAME': 'cltbld', 05:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:51 INFO - 'MOZ_NO_REMOTE': '1', 05:46:51 INFO - 'NO_EM_RESTART': '1', 05:46:51 INFO - 'PAGER': '/bin/cat', 05:46:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:51 INFO - 'PWD': '/builds/slave/test', 05:46:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:51 INFO - 'SHELL': '/bin/bash', 05:46:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:51 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:51 INFO - 'USER': 'cltbld', 05:46:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:51 INFO - 'XPC_FLAGS': '0x0', 05:46:51 INFO - 'XPC_SERVICE_NAME': '0', 05:46:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-s342pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-zKkqHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-QCInqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:51 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-5eDMVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:51 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-VIVTjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-qN45LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ChqMWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-ZyPSfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-qw9uM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-2X3dKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-oQ1FLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-3zRZ6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-TS3wUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:52 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)) 05:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:52 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-_HUxmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-RSKRlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:53 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)) 05:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-mgki1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:46:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:53 INFO - Running setup.py (path:/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/pip-BC6t9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:53 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)) 05:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:53 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)) 05:46:53 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:53 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:53 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 05:46:53 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 05:46:53 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 05:46:53 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 05:46:53 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 05:46:53 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 05:46:55 INFO - Downloading blessings-1.6.tar.gz 05:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:55 INFO - Installing collected packages: blessings 05:46:55 INFO - Running setup.py install for blessings 05:46:56 INFO - Successfully installed blessings 05:46:56 INFO - Cleaning up... 05:46:56 INFO - Return code: 0 05:46:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:56 INFO - Reading from file tmpfile_stdout 05:46:56 INFO - Current package versions: 05:46:56 INFO - blessings == 1.6 05:46:56 INFO - blobuploader == 1.2.4 05:46:56 INFO - docopt == 0.6.1 05:46:56 INFO - functools32 == 3.2.3-2 05:46:56 INFO - jsonschema == 2.5.1 05:46:56 INFO - manifestparser == 1.1 05:46:56 INFO - mozInstall == 1.12 05:46:56 INFO - mozcrash == 0.17 05:46:56 INFO - mozdebug == 0.1 05:46:56 INFO - mozdevice == 0.48 05:46:56 INFO - mozfile == 1.2 05:46:56 INFO - mozhttpd == 0.7 05:46:56 INFO - mozinfo == 0.9 05:46:56 INFO - mozleak == 0.1 05:46:56 INFO - mozlog == 3.4 05:46:56 INFO - moznetwork == 0.27 05:46:56 INFO - mozprocess == 0.23 05:46:56 INFO - mozprofile == 0.28 05:46:56 INFO - mozrunner == 6.12 05:46:56 INFO - mozscreenshot == 0.1 05:46:56 INFO - mozsystemmonitor == 0.3 05:46:56 INFO - moztest == 0.7 05:46:56 INFO - mozversion == 1.4 05:46:56 INFO - psutil == 3.1.1 05:46:56 INFO - requests == 1.2.3 05:46:56 INFO - wsgiref == 0.1.2 05:46:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:56 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 05:46:56 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 05:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:56 INFO - 'HOME': '/Users/cltbld', 05:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:56 INFO - 'LOGNAME': 'cltbld', 05:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:56 INFO - 'MOZ_NO_REMOTE': '1', 05:46:56 INFO - 'NO_EM_RESTART': '1', 05:46:56 INFO - 'PAGER': '/bin/cat', 05:46:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:56 INFO - 'PWD': '/builds/slave/test', 05:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:56 INFO - 'SHELL': '/bin/bash', 05:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:56 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:56 INFO - 'USER': 'cltbld', 05:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:56 INFO - 'XPC_FLAGS': '0x0', 05:46:56 INFO - 'XPC_SERVICE_NAME': '0', 05:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 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)) 05:46:56 INFO - Cleaning up... 05:46:56 INFO - Return code: 0 05:46:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:56 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 0x1091b7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10912d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba28da4ee0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, '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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:46:56 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 05:46:56 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 05:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:56 INFO - 'HOME': '/Users/cltbld', 05:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:56 INFO - 'LOGNAME': 'cltbld', 05:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:56 INFO - 'MOZ_NO_REMOTE': '1', 05:46:56 INFO - 'NO_EM_RESTART': '1', 05:46:56 INFO - 'PAGER': '/bin/cat', 05:46:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:56 INFO - 'PWD': '/builds/slave/test', 05:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:56 INFO - 'SHELL': '/bin/bash', 05:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:46:56 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:56 INFO - 'USER': 'cltbld', 05:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:56 INFO - 'XPC_FLAGS': '0x0', 05:46:56 INFO - 'XPC_SERVICE_NAME': '0', 05:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:57 INFO - Cleaning up... 05:46:57 INFO - Return code: 0 05:46:57 INFO - Running post-action listener: _resource_record_post_action 05:46:57 INFO - Running post-action listener: _start_resource_monitoring 05:46:57 INFO - Starting resource monitoring. 05:46:57 INFO - [mozharness: 2016-10-17 12:46:57.049903Z] Finished create-virtualenv step (success) 05:46:57 INFO - [mozharness: 2016-10-17 12:46:57.050902Z] Running install step. 05:46:57 INFO - Running pre-action listener: _resource_record_pre_action 05:46:57 INFO - Running main action method: install 05:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:57 INFO - Reading from file tmpfile_stdout 05:46:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:57 INFO - Reading from file tmpfile_stdout 05:46:57 INFO - Output received: 05:46:57 INFO - Usage: mozinstall [options] installer 05:46:57 INFO - Options: 05:46:57 INFO - -h, --help show this help message and exit 05:46:57 INFO - -d DEST, --destination=DEST 05:46:57 INFO - Directory to install application into. [default: 05:46:57 INFO - "/builds/slave/test"] 05:46:57 INFO - --app=APP Application being installed. [default: firefox] 05:46:57 INFO - mkdir: /builds/slave/test/build/application 05:46:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:47:31 INFO - Reading from file tmpfile_stdout 05:47:31 INFO - Output received: 05:47:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:47:31 INFO - Running post-action listener: _resource_record_post_action 05:47:31 INFO - [mozharness: 2016-10-17 12:47:31.466145Z] Finished install step (success) 05:47:31 INFO - [mozharness: 2016-10-17 12:47:31.466302Z] Running run-tests step. 05:47:31 INFO - Running pre-action listener: _resource_record_pre_action 05:47:31 INFO - Running main action method: run_tests 05:47:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:47:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:47:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:47:31 INFO - 2016-10-17 05:47:31.480 screenresolution[1645:7564] starting screenresolution argv=screenresolution get 05:47:31 INFO - 2016-10-17 05:47:31.483 screenresolution[1645:7564] Display 0: 1600x1200x32@60 05:47:31 INFO - 2016-10-17 05:47:31.489 screenresolution[1646:7566] starting screenresolution argv=screenresolution list 05:47:31 INFO - Available Modes on Display 0 05:47:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:47:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:47:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:47:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:47:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:47:31 INFO - Intel Iris: 05:47:31 INFO - Chipset Model: Intel Iris 05:47:31 INFO - Type: GPU 05:47:31 INFO - Bus: Built-In 05:47:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:47:31 INFO - Vendor: Intel (0x8086) 05:47:31 INFO - Device ID: 0x0a2e 05:47:31 INFO - Revision ID: 0x0009 05:47:31 INFO - Displays: 05:47:31 INFO - Display: 05:47:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:47:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:47:31 INFO - Display Serial Number: 1600x1200 60 05:47:31 INFO - Main Display: Yes 05:47:31 INFO - Mirror: Off 05:47:31 INFO - Online: Yes 05:47:31 INFO - Rotation: Supported 05:47:31 INFO - Return code: 0 05:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:47:31 INFO - Python 2.7.3 05:47:31 INFO - Return code: 0 05:47:31 INFO - grabbing minidump binary from tooltool 05:47:31 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')]} 05:47:31 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 0x108fcbd30>, '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 0x108df1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108fc3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:47:31 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 05:47:31 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 05:47:31 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 05:47:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:47:31 INFO - Return code: 0 05:47:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:47:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:47:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:47:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:47:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0220 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:47:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.x33MUxog4x/Render', 05:47:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:47:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:47:31 INFO - 'HOME': '/Users/cltbld', 05:47:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:47:31 INFO - 'LOGNAME': 'cltbld', 05:47:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:47:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:47:31 INFO - 'MOZ_NO_REMOTE': '1', 05:47:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:47:31 INFO - 'NO_EM_RESTART': '1', 05:47:31 INFO - 'PAGER': '/bin/cat', 05:47:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:47:31 INFO - 'PWD': '/builds/slave/test', 05:47:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:47:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:47:31 INFO - 'SHELL': '/bin/bash', 05:47:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7oMsdlQ2Dq/Listeners', 05:47:31 INFO - 'TMPDIR': '/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/', 05:47:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:47:31 INFO - 'USER': 'cltbld', 05:47:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:47:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:47:31 INFO - 'XPC_FLAGS': '0x0', 05:47:31 INFO - 'XPC_SERVICE_NAME': '0', 05:47:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:47:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0220', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:47:32 INFO - mozversion application_buildid: 20161017025535 05:47:32 INFO - mozversion application_changeset: 198c4bf0c8df9765e9eba5f12eb1f7a899c277e5 05:47:32 INFO - mozversion application_display_name: Nightly 05:47:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:47:32 INFO - mozversion application_name: Firefox 05:47:32 INFO - mozversion application_remotingname: firefox 05:47:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 05:47:32 INFO - mozversion application_vendor: Mozilla 05:47:32 INFO - mozversion application_version: 52.0a1 05:47:32 INFO - mozversion platform_buildid: 20161017025535 05:47:32 INFO - mozversion platform_changeset: 198c4bf0c8df9765e9eba5f12eb1f7a899c277e5 05:47:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 05:47:32 INFO - mozversion platform_version: 52.0a1 05:47:32 INFO - using testdate: 1476708452 05:47:32 INFO - actual date: 1476708452 05:47:32 INFO - starting webserver on 'localhost:49267' 05:47:32 INFO - SUITE-START | Running 2 tests 05:47:32 INFO - TEST-START | dromaeo_css 05:47:32 INFO - operating with platform_type : mac_ 05:47:32 INFO - Initialising browser for dromaeo_css test... 05:47:32 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpeCDDss/profile http://localhost:49267/getInfo.html) 05:47:34 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 05:47:34 INFO - PROCESS | 1656 | colorDepth:24 05:47:34 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 05:47:34 INFO - PROCESS | 1656 | __metrics 05:47:34 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:47:34 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:47:35 INFO - TEST-INFO | 1656: exit 0 05:47:35 INFO - Browser initialized. 05:47:35 INFO - Running cycle 1/1 for dromaeo_css test... 05:47:35 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpeCDDss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:47 INFO - PROCESS | 1658 | RSS: Main: 232144896 05:47:47 INFO - PROCESS | 1658 | 05:48:38 INFO - PROCESS | 1658 | 1476708518140 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:50:53 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 05:50:55 INFO - PROCESS | 1658 | RSS: Main: 412606464 05:50:55 INFO - PROCESS | 1658 | 05:53:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 05:53:58 INFO - PROCESS | 1658 | RSS: Main: 376242176 05:53:58 INFO - PROCESS | 1658 | 05:57:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 05:57:01 INFO - PROCESS | 1658 | RSS: Main: 337252352 05:57:01 INFO - PROCESS | 1658 | 06:00:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 06:00:04 INFO - PROCESS | 1658 | RSS: Main: 339800064 06:00:04 INFO - PROCESS | 1658 | 06:03:08 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 06:03:08 INFO - PROCESS | 1658 | RSS: Main: 326656000 06:03:08 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 06:06:12 INFO - PROCESS | 1658 | RSS: Main: 385650688 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | __start_tp_report 06:06:12 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 06:06:12 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 06:06:12 INFO - PROCESS | 1658 | |i|pagename|runs| 06:06:12 INFO - PROCESS | 1658 | |0;dojo.html;3347.7489188310874;3384.9323013539715;3388.2884594235215;3402.727781777458;3451.7583769136154;5703.429657034295;5837.941620583793;5864.5015173710235;5950.523958083354;5956.136360227764;5862.179294898718;5888.470037696607;5903.911441328383;5909.320428150764;5922.082077278029;5237.9785941741375;5275.419703832576;5283.894322113555;5308.991291654593;5327.067763141435;4441.267190913495;5364.329458817648;5372;5373.140297552392;5378.757955891994;5276.287701160351;5321.494458026481;5333.706646134461;5339.813106541272;5348.304720386344;5380.973095134499;5394.973025134849;5411.648242864201;5418.349798024262;5418.485243901823;5130.820421285237;5243.134882744343;5253.737313134328;5329.866753331159;5365.570754339644;5796.420357964212;5825.446582574648;5855.473007429309;5865.090910908816;5879.382664820175;6120.050983828579;6181.907271390933;6184.226971628546;6194.845128871769;6195.81412557624;6241.375862413768;6268.937310626881;6277.654728989904;6278.748850045993;6283.340249273806;5840.970795145997;5841.182234487175;5861.17943487912;5879.853003674857;5906.084556893688;6320.652364120017;6373.948298530783;6378.489720822323;6385.138006369174;6387.169667943231;6135.478484328793;6171.197744293303;6193.659348735863;6197.380261973766;6198.752049917953;6107.552954153525;6212.72042758077;6234.501239900887;6275.435210831047;6298.590591611531;5700.030994730906;5866.6186697864505;6239.032949892774;6279.937200628026;6287.182666253358;6202.937970620236;6266.937330626726;6272.2473303203;6282.277538083087;6284.968575157186;4911.287863259808;4945.307656928033;4998.375203099613;4999.3000979862845;5031.77357018935;4426.11477704454;4429.734215947054;4493.303537951622;4493.707908985905;4519.322101684774;5924.170616113747;5937;5940.762369505258;5941.257342832146;5984.760609575568;6212.192414986023;6233.252009758858;6237.875242495124;6239.563230573907;6243.37566243372;5685.204071430003;5726.3128424588485;5742.483176514133;5889.793857214977;5924.259467566554;5417.3770016447825;5446.591505637093;5457.072297709399;5457.154141108134;5459.208414779914;6268.4671802897265;6272.40412160844;6273.278572964167;6277;6280.5289603279025;6191.071339299141;6246.1255424239735;6256.718447669775;6259.374062593704;6263.4362907338555;6259;6274.780382686584;6327.3988971047675;6407.199100112486;6408.327125651926;6247.0629405589525;6259.687015649109;6265.122882796503;6271.686415679289;6274.215723034621;6152.507799376129;6251.812445626639;6254.405831446005;6255.0617407387435;6260.718267677874;5999.70001499932;6101.126216676282;6112.1995365628145;6146.969265153645;6168.568200225941;6205.286392064971;6223.253209614875;6228.844278892882;6230.7819226328675;6239.407256310643;5969.701514924323;6119.479844213113;6128.846778830565;6130.417610327012;6145.508359331154;6111.297200821785;6131.957816599936;6134.957077261001;6137.867325793431;6138.419052470106;6105.186826067751;6118.862843290023;6119.136988619874;6119.550973836674;6133.202683651097 06:06:12 INFO - PROCESS | 1658 | |1;ext.html;507.75881456308247;519.997400013;531.9654222475539;532.7294402849209;553.6401339129566;30096.849515752445;39555.01112472186;40984.59015409845;42910;42984.14031719364;42058.57941420585;42532;42570.36144457835;42615.78692106543;42662.57337426625;9617.471039092865;9824.557894894748;9847.507624618776;9849.704508864745;9861.161801246866;9661.17879980199;9672.419654820698;9687.903120968771;9780.951095244549;9784.804303913917;9728;9781.510924453785;9792.16766574842;9793.559289831976;9807.215422766161;9050.547472626407;9116.31627627924;9694.369865958726;9741.951290243574;9756.4633945133;8317;9611.990740972167;9634.75913102171;9728;9737.610495580167;39983;40623;40711.79644101761;40724.18551628951;40770.38844417336;3340.9331813363597;3390.4066788311948;3391.423458012144;3414.778039427429;3506.50908872758;29975;31351;31370.37259254802;31445;31507.746454228614;3218.9356212875846;3236.223306406469;3325.318309746496;3354.8490317935753;3356.6978971892404;466612;468148;470242;471058;471843;52979.470205298225;53060.73469632627;53082.099327087235;53090.46909530932;53136;59586;59600.70199648974;59680.70159649261;59726;59852.70073649604;16163.595910102342;16386.26261818221;16398.180090995404;16406.933549319256;16412.343506259855;12794.360281985864;12864.421101050475;12866;12867.22796632205;12880.484780608858;13666.385012674453;15044.473443429428;15070.472533461276;15075.623109422353;15273.770893436607;5693.971530142323;6309.369063093745;6557.5081868860025;6588.122385120314;6905.240423553405;912.4023764434306;947.6209516193578;969.6315400147898;995.9840962218497;1002.5238011944268;28599;28793.85603072013;29494.8202071919;29649.555256671167;30344.696553034628;1048.8688913885765;1079.8002369561657;1120.255030404788;1161.9948744336089;1167.6222057971675;14793.92603036978;15413.691726165414;15428.691426171414;15475;15769.44806931752;575478;584163.0791846098;588981;589398;590127;47199.76400117978;55648.887022259325;55659.721701392045;55743.44256557464;55805.7209713957;1252.3863306979697;1302.47900839663;1302.7655022096114;1410.7108042851191;1436.490046033664;25064.498710026062;25769.742302576735;31143.23455374777;32077.839610801795;32408;51508.74245628748;52125.21812172745;52154;52193.478065218864;52432.47567524276;577959;583592;583740;583891.0941577568;584977;25059;25790.871045644653;25790.871045644653;26737.465250695266;37982.620173797906;44184.779076104416;46517.06965860732;46685.766571166925;47269.76365118152;47609;32700;38421;38828.80585597054;39033.41449878311;39823.80088099541;32149.678503215604;38578.6142138575;38596.42105368478;38700.41949370706;39665.60334396619;37666;38132;38255.42616860694;38286.80856595699;38329.42505862359;32536.83731581327;33092.503612445355;34005.319893602486;34372;34566;22801.543969120856;23947;25115.120970765936;25340.746592534575;25777.355566110997 06:06:12 INFO - PROCESS | 1658 | |2;jquery.html;359.6170078866009;376.40903781063724;384.139527458493;386.2815163795341;411.51852332770653;12444.937775311122;15065.62335941602;19908.303209387675;21505.032273547688;22053;20051.699224511645;20319.18723251068;20818.16727330905;21104.68342974853;21715.131394744232;4774.9761251193695;5347.331583552056;5618.831435056954;5661;5677.460641239097;5280.260763493114;5478.643888147278;5546.805861794838;5576.776928922838;5598.412166722496;5441.401445840955;5538.861528461781;5545.916811247835;5550.69471179085;5555.194496797962;5307.628466007381;5462.262594549725;5501.587380946405;5507.394186639466;5524.944750552483;5231.110711179109;5285.127953887604;5366.4633536646415;5367.2485851980755;5367.329083864517;11751.588694395656;12778.23330600167;13310.467581296833;13670.52153174634;13683.384247708877;2152.2036846366946;2157.30966090851;2218.7617781833465;2253.143805353955;2370.9407264818346;10091.29360944734;10291.742706432398;10491.842622360671;10594.31136976094;11705.063594912386;1847.445766270127;1862.7392165096896;1916.961660766777;1978.3193772438426;2028.7666918304437;121096;125526.37236813849;126141.36929315387;126268.36865815704;126549.36725316315;11167.441627918572;11371.167253917052;11543.249688770204;11567.42162891852;11765.352905590104;13136.40886160125;13649.590512284647;13707.520236791665;13707.588772336845;14473.421063157566;6405.455536279375;7022.508424410345;8267.077964077838;8481.83036339282;8717.12828717136;7536.8492630148185;8103.068147163034;8466.66133354659;8504.532250726146;8738.825223495494;4483.55164483549;4564.497905230422;4621.145088158702;4625.930611040837;4632.305154226826;1717.2959086774613;1857.8327950484252;1908.9331873384365;1931.304730297092;1982.3557343863301;869.3566760597113;917.4999625204147;948.5541795356172;960.279790157382;1010.5200029985698;21645.783542164376;22217.555648887253;22226.44433889166;22227.333180004625;22282.554348913254;933.1182032978905;940.149165005671;952.7087354911449;955.3694561589457;969.6703120938914;7592.544447333067;9773.706788796348;11599.188056835941;11703.414829258503;11707.414629268502;472434;477471.2252877496;478473;589371;595416;140707;140817.28558001888;145015.27492362683;148949;153215;966.367029595616;990.277097718655;1023.518946095334;1024.1653052761976;1026.1124127629696;17536.386226482013;19230;19381.70927436118;19775.802241977395;19923.402297931087;57482.42517574938;57631;59449.702751485966;59820.40179598323;60415;81241.59379203066;83158;85715;87641.37075887734;88489.55755221183;7931.484453510503;7947.642356093874;8066.395020373378;8112.22933821286;8349.83300334002;12880.613581592566;12954.611361659165;13097.934510327388;13182.60452186436;13265.734685306434;11039.503222354853;11325.377104259345;11406.942965285121;11483.712907177052;11578.189526733047;9485.810283794424;10066.043725846033;10080.596776129167;10477.895221047693;11115;11395.715107122389;11442.199046066695;11591.710207244887;11660.941695291469;11758.294502329887;7953.0515023819535;8005.318883034395;8132.308753755997;8203.630836612247;8219.506829590244;10825.074650556047;11230.21388502797;11485.540578376771;11794.056475482112;11810.291382517076 06:06:12 INFO - PROCESS | 1658 | |3;mootools.html;1393.5819254223743;1400.3278426355348;1585.9207039648018;1830.322780571188;2017.6065667194903;7914.802129946747;8402.285805706515;8682.869756953634;8954.776130596738;8978.595963181657;8818.162274583905;8914.866277005834;8915.598798054087;8929.28565714743;8929.73210803677;2040.36748607932;2365.44412063165;2375.869327187004;2379.4527258730504;2383.749706280837;2362.2558893948435;2383.3207535852284;2408.1932552594903;2410.313060777679;2410.6384042393606;2367.763223677636;2385.33210701004;2389.9283021509295;2397.9520409591796;2403.170906037414;2356.2460012795914;2375.7861792438675;2383.5709572276983;2387.248016874679;2390.151496218835;2346.62454007358;2375.2874137758777;2385.6302273147517;2387.236084452976;2391.892364843586;8724.258438032775;8868.8669669955;8901.821963560757;8944.23973962214;8978.86531702025;5227.764750586232;5452.318460192476;5459.153831156177;5466.043442397565;5474.753636086386;3652.196516766307;3654.2958210923725;3735.6264373562426;3735.62643735627;3735.6465426781224;1084.7233955341417;1096.199774164864;1097.9945100274526;1118.5246270335156;1123.685368096926;11695.298282103016;11749.471273792615;11800.763984720257;11815.586454474053;11849.40752962357;4353.564643535621;4465.665075119379;4633.675642705046;4638.072385522909;4659.091477161988;9272.953635231916;9280.071992800666;9287;9304.069593040642;9318.767030824283;5320.467953204648;5327.227552004938;5329.520343169133;5333.679979201261;5341.893162136736;3851.30676478231;4135.958640413617;4374.431323927933;4529.071540334224;5001.324821149171;3224.5324427957817;3758.962410375861;3836.5396152461885;3871.7870517121264;3893.6885049196;1165.539611853313;1171.917965742407;1173.5716463490764;1178.8467499225046;1185.6265276437894;785.8310463250428;866.4541338956543;884.712468447757;930.2883294279882;945.9972429225044;4630.3748993886065;5898.793542226002;5934.287885453687;5962.910556341659;6133.969330153321;815.2418251026602;955.6464108279841;968.660968660963;983.7245571240064;1010.7422607235108;3415.9316813664086;3755.5681096673684;3763.717721170923;3839.9424008639894;3984.541777695544;10518.947405262925;11033.337999719883;11039.83440248397;11057.834132488018;11069.833952490719;10254.230932680079;10834.404107773991;10961.616343427942;10981.835272470918;10997;6972.860542789217;8443.197896199852;8445.239928406472;8453.450525715809;8464.05326774833;5777.94222057774;5830.62100963436;5836.649801011953;6065.848353791014;6192.173308873983;9782.168515676247;10141.340812847142;10149.898501014895;10164.64423745195;10175.7456063599;9088.818223635359;9447.24422046221;10226.82391524984;10310.536025879004;10385.532651030571;5732.828015159552;7065.116860392451;7596.468247222641;7665.88501172494;7764.84470310602;8262.628181731716;8351.874721879056;8393.622286996977;8437.957810211155;8452.478553860365;7522.473426860067;7556.319931205998;7592.8481430372185;7612.1246056704185;7614.048243969504;7199.532030418006;7387.667554959932;7448.329650331496;7480.027596412431;7569.1295501018085;6049.909251361145;7059.541129826544;7083.185433675193;7141.392981596622;7147.678354473957;4865.099956508057;4932.136876046749;4972.950270497248;5042.243663450512;5096.031753966735;4123.175364926967;4896.436909755281;4929.975350123226;4984.950150498594;5052.368453943257 06:06:12 INFO - PROCESS | 1658 | |4;prototype.html;258.6172464752167;265.4664125108531;304.4990989821742;307.70767770617914;317.5538368592126;4971;5197.506236907498;5269.314989051422;5293.258943747878;5376.596755243358;4071.7149799514045;4466.263066594016;4975.626827987898;5184.807494276319;5324.307839980797;3586.0952628370974;3859.0352411897024;4051.230266249418;4058.736182148151;4114.485689288839;3358.3619112368574;3409.318136372723;4074.1851629674184;4088.284550203717;4099.877003689894;3309.7352211823118;3948.7828169450668;3954.268460334847;3971.60283971602;4031.21391328691;3978.3634618460906;3981.8606348777944;3981.9004524886964;3982.4357200305853;3996.481337091901;3295.7198638115788;3444.330643751088;3472.3576138414473;3475.4439289713523;3483;4763.214069678499;4904.82284251777;4999.975000124976;5253.080710875582;5256.132738098209;3854.1713531590844;4533;4588.564086411819;4634.536546345372;4636.466806317283;5388.245645609618;5444.564434845203;5544.889102217973;5562.916556251659;5635.267415235993;3282.720968717638;3641.526601541809;3739.439084137374;3779.4897688811934;3801.004472651852;5003.374578177728;5140.897182056376;5752.194692743019;5795.043817770021;5797.565182611321;3586.0276847733644;3837;3856.46009558662;3857.537095548496;3880.701403806742;3907.628775266345;3916.9608303917166;3926.2540117377607;3956.6043395660204;3965.6034396560112;3821.407681809324;4514.977425112854;4565.840195593139;4583.816647334136;4619.076184762994;5360.65155764874;5582.413846546055;5589.273394458775;5596.888062238814;5599.348192283286;1118.5078565431184;1235.3946566182685;1315.960521184366;1343.4626149540068;1347.0871362665039;780.9336206422518;804.8511025460308;805.1264378149773;809.9028116625925;810.9797255068553;3851.826667799956;3996.1408297215658;4247.299195632686;4253.255680255943;4273.820351620696;4056.3104272273786;4484.865454036384;4677.672562920563;4683.976580117078;4727.463574338354;3927.410888366711;3943.546492153439;4254.723442976197;4278.614924656796;4317.84887528935;2055.7357225306628;2270.3880245025885;2337.883105844701;2465.149523414419;2504.3488692939604;3868.9613103869165;3941.763494190358;4727.858164255078;4791.952080479151;4831.95168048315;4410.794602698651;4489.19194544985;4843.467218605951;4924.808460235161;4962.8759281018265;4260.743080791174;4375.47494300686;4862.9544647900875;4870.9269360959615;4873.658843880965;4139.379093136054;4213.199492096492;4410.390207574276;4781.374332726889;4821.769414492369;3959.7130932446494;4363;4437.0460351024685;4473.329000649798;4668.875661573908;4003.57962413954;4387.446168603441;4465.1962646723905;4669.463011753692;4755.671030278888;3201.982750866939;3326.8835590754206;3618.565772107364;3724.6089160638826;3755.4930084439343;4899.657024008286;4939.802407903788;5073.807655200951;5352.742105605257;5742.712864356849;5183.937292855031;5325.440828713085;5633.746481408264;5680.460356266148;5704.743286552032;4618.720708297146;5266.6833291677085;5541.919325731444;5590.937721832839;5642.322921249476;5468.48049435303;5487.8749856280165;5504.954058728828;5505.9724701376235;5507.394186639386;4204.096119334357;5177.107633286508;5506;5513.558915286687;5624.915626265692;4524.963766305242;4744.644151688706;5435.83692489226;5473.31583552056;5493.890122197614 06:06:12 INFO - PROCESS | 1658 | |5;yui.html;713.8037039814054;725.5827898958099;777.1024466740913;804.364552003917;818.1450384348353;14768.6307842304;15510.069395836257;15594.922025389886;15787.84212157878;15878.920605396972;14483.493077742281;14554.854451455481;14567;14572.417103315882;14610.634734131652;710.6624353432104;731.6049333359979;733.1788396995373;884.5179377239388;890.3366991591241;894.4230971023686;896.4307664632972;908.4640062363204;909.7862002429424;910.4673765846987;961.735522731251;964.2334344196381;965.3580369054605;965.5944503308592;965.8840939087285;742.9368503677194;955.2262667239559;958.075457183821;959.7840485890689;961.6826447272454;562.963407378519;565.7623798004848;565.9915101273484;566.4675205306999;696.2967402923034;15263.542093737206;15646.687066258612;15652.686946261125;15654.843451565452;15676.68646627061;13953.023288369819;14068.296585170803;14336.92831535846;14503.347349369304;14571.344289506891;12690.11169218155;12754.865095654006;12840.55058072963;12867.034972377109;12893.935530322382;4518.5481451854885;4576.519465456146;4623.375844261015;4797.664163508556;4801.5438533339275;114230;116464.83535164625;116883;117043.4147829264;119039;11088.22382433238;11211.159163062803;11343.20597558163;11497.425128743529;11674.357910314844;21798.019089141028;21974.780252197274;22753;22777.544449110927;22823.543529129325;7681.5775132367135;7956.840863182704;8040.316573091236;8121.634526446324;8136.918630813616;4325.43769309994;4438.667099967515;4541.591256786905;4581.289900065495;4584.014436896084;3400.1159698478573;3646.1796095878217;3650.1239702471216;3652.6164752701116;3652.6895213907114;670.2258890980925;676.5129107042922;676.9187697476236;677.478341676906;677.7390704578772;619.9783007594802;623.5136593457111;626.117174783553;629.3391938464594;642.8360768004129;7332.790089635258;8705.434146780439;8765.38642295046;8922.420042697333;8983.595738191798;564.8474911773881;596.8699031821487;610.9694515274307;614.3089024847047;623.9642193958099;3656.341858465502;4235.9621892636505;4284.479009951485;4406.889827754268;4513.593776560059;137375;138262;148611;155425;158498;137797;139031;139136.91294630588;139288.30355848157;143813;69825.60348793097;74770;96536.0346396527;96551.51724241333;104229.47885260677;6877.552959057645;8257.710980115668;8517.403781735218;8939.240164586083;9295.349325547148;45753.771231144965;54490;55297;64340.356596433434;64809.35190648222;91753;95968;97886;98047;100823;11420.94289528547;11437.656870293904;11592.88407115918;11719.414029298672;11787.823182652095;12563.623091307276;12598.496015189894;12659.430325635185;12800.48798048105;12816.166949148275;11694.181407301407;11941;12049.698757531132;12332.075094368138;12353.876461235273;11695.415229238673;11973.820392694292;12366.19619724715;12383.071269654632;12399.75200496003;11685.182037257311;12007;12020.699482512657;12198.268103913793;12268.44791984345;9688.224942004763;9781.804363912825;9810.509474526103;9929.702108936743;10061.798764024825;9997.850032249667;10053.399361594178;10056.508377118947;10067.14406943676;10160.717390764457 06:06:12 INFO - PROCESS | 1658 | __end_tp_report 06:06:12 INFO - PROCESS | 1658 | __start_cc_report 06:06:12 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2115 06:06:12 INFO - PROCESS | 1658 | __end_cc_report 06:06:12 INFO - PROCESS | 1658 | __startTimestamp1476709572646__endTimestamp 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | ------- Summary: start ------- 06:06:12 INFO - PROCESS | 1658 | Number of tests: 6 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5811.76 Median:6111.30 stddev:632.49 (10.3%) stddev-sans-first:604.17 06:06:12 INFO - PROCESS | 1658 | Values: 3347.7 3384.9 3388.3 3402.7 3451.8 5703.4 5837.9 5864.5 5950.5 5956.1 5862.2 5888.5 5903.9 5909.3 5922.1 5238.0 5275.4 5283.9 5309.0 5327.1 4441.3 5364.3 5372.0 5373.1 5378.8 5276.3 5321.5 5333.7 5339.8 5348.3 5381.0 5395.0 5411.6 5418.3 5418.5 5130.8 5243.1 5253.7 5329.9 5365.6 5796.4 5825.4 5855.5 5865.1 5879.4 6120.1 6181.9 6184.2 6194.8 6195.8 6241.4 6268.9 6277.7 6278.7 6283.3 5841.0 5841.2 5861.2 5879.9 5906.1 6320.7 6373.9 6378.5 6385.1 6387.2 6135.5 6171.2 6193.7 6197.4 6198.8 6107.6 6212.7 6234.5 6275.4 6298.6 5700.0 5866.6 6239.0 6279.9 6287.2 6202.9 6266.9 6272.2 6282.3 6285.0 4911.3 4945.3 4998.4 4999.3 5031.8 4426.1 4429.7 4493.3 4493.7 4519.3 5924.2 5937.0 5940.8 5941.3 5984.8 6212.2 6233.3 6237.9 6239.6 6243.4 5685.2 5726.3 5742.5 5889.8 5924.3 5417.4 5446.6 5457.1 5457.2 5459.2 6268.5 6272.4 6273.3 6277.0 6280.5 6191.1 6246.1 6256.7 6259.4 6263.4 6259.0 6274.8 6327.4 6407.2 6408.3 6247.1 6259.7 6265.1 6271.7 6274.2 6152.5 6251.8 6254.4 6255.1 6260.7 5999.7 6101.1 6112.2 6147.0 6168.6 6205.3 6223.3 6228.8 6230.8 6239.4 5969.7 6119.5 6128.8 6130.4 6145.5 6111.3 6132.0 6135.0 6137.9 6138.4 6105.2 6118.9 6119.1 6119.6 6133.2 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:67782.66 Median:40717.99 stddev:146465.89 (359.7%) stddev-sans-first:146789.67 06:06:12 INFO - PROCESS | 1658 | Values: 507.8 520.0 532.0 532.7 553.6 30096.8 39555.0 40984.6 42910.0 42984.1 42058.6 42532.0 42570.4 42615.8 42662.6 9617.5 9824.6 9847.5 9849.7 9861.2 9661.2 9672.4 9687.9 9781.0 9784.8 9728.0 9781.5 9792.2 9793.6 9807.2 9050.5 9116.3 9694.4 9742.0 9756.5 8317.0 9612.0 9634.8 9728.0 9737.6 39983.0 40623.0 40711.8 40724.2 40770.4 3340.9 3390.4 3391.4 3414.8 3506.5 29975.0 31351.0 31370.4 31445.0 31507.7 3218.9 3236.2 3325.3 3354.8 3356.7 466612.0 468148.0 470242.0 471058.0 471843.0 52979.5 53060.7 53082.1 53090.5 53136.0 59586.0 59600.7 59680.7 59726.0 59852.7 16163.6 16386.3 16398.2 16406.9 16412.3 12794.4 12864.4 12866.0 12867.2 12880.5 13666.4 15044.5 15070.5 15075.6 15273.8 5694.0 6309.4 6557.5 6588.1 6905.2 912.4 947.6 969.6 996.0 1002.5 28599.0 28793.9 29494.8 29649.6 30344.7 1048.9 1079.8 1120.3 1162.0 1167.6 14793.9 15413.7 15428.7 15475.0 15769.4 575478.0 584163.1 588981.0 589398.0 590127.0 47199.8 55648.9 55659.7 55743.4 55805.7 1252.4 1302.5 1302.8 1410.7 1436.5 25064.5 25769.7 31143.2 32077.8 32408.0 51508.7 52125.2 52154.0 52193.5 52432.5 577959.0 583592.0 583740.0 583891.1 584977.0 25059.0 25790.9 25790.9 26737.5 37982.6 44184.8 46517.1 46685.8 47269.8 47609.0 32700.0 38421.0 38828.8 39033.4 39823.8 32149.7 38578.6 38596.4 38700.4 39665.6 37666.0 38132.0 38255.4 38286.8 38329.4 32536.8 33092.5 34005.3 34372.0 34566.0 22801.5 23947.0 25115.1 25340.7 25777.4 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33566.62 Median:22222.00 stddev:89533.02 (402.9%) stddev-sans-first:89749.47 06:06:12 INFO - PROCESS | 1658 | Values: 359.6 376.4 384.1 386.3 411.5 12444.9 15065.6 19908.3 21505.0 22053.0 20051.7 20319.2 20818.2 21104.7 21715.1 4775.0 5347.3 5618.8 5661.0 5677.5 5280.3 5478.6 5546.8 5576.8 5598.4 5441.4 5538.9 5545.9 5550.7 5555.2 5307.6 5462.3 5501.6 5507.4 5524.9 5231.1 5285.1 5366.5 5367.2 5367.3 11751.6 12778.2 13310.5 13670.5 13683.4 2152.2 2157.3 2218.8 2253.1 2370.9 10091.3 10291.7 10491.8 10594.3 11705.1 1847.4 1862.7 1917.0 1978.3 2028.8 121096.0 125526.4 126141.4 126268.4 126549.4 11167.4 11371.2 11543.2 11567.4 11765.4 13136.4 13649.6 13707.5 13707.6 14473.4 6405.5 7022.5 8267.1 8481.8 8717.1 7536.8 8103.1 8466.7 8504.5 8738.8 4483.6 4564.5 4621.1 4625.9 4632.3 1717.3 1857.8 1908.9 1931.3 1982.4 869.4 917.5 948.6 960.3 1010.5 21645.8 22217.6 22226.4 22227.3 22282.6 933.1 940.1 952.7 955.4 969.7 7592.5 9773.7 11599.2 11703.4 11707.4 472434.0 477471.2 478473.0 589371.0 595416.0 140707.0 140817.3 145015.3 148949.0 153215.0 966.4 990.3 1023.5 1024.2 1026.1 17536.4 19230.0 19381.7 19775.8 19923.4 57482.4 57631.0 59449.7 59820.4 60415.0 81241.6 83158.0 85715.0 87641.4 88489.6 7931.5 7947.6 8066.4 8112.2 8349.8 12880.6 12954.6 13097.9 13182.6 13265.7 11039.5 11325.4 11406.9 11483.7 11578.2 9485.8 10066.0 10080.6 10477.9 11115.0 11395.7 11442.2 11591.7 11660.9 11758.3 7953.1 8005.3 8132.3 8203.6 8219.5 10825.1 11230.2 11485.5 11794.1 11810.3 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5684.60 Median:4913.21 stddev:3216.71 (65.5%) stddev-sans-first:3209.57 06:06:12 INFO - PROCESS | 1658 | Values: 1393.6 1400.3 1585.9 1830.3 2017.6 7914.8 8402.3 8682.9 8954.8 8978.6 8818.2 8914.9 8915.6 8929.3 8929.7 2040.4 2365.4 2375.9 2379.5 2383.7 2362.3 2383.3 2408.2 2410.3 2410.6 2367.8 2385.3 2389.9 2398.0 2403.2 2356.2 2375.8 2383.6 2387.2 2390.2 2346.6 2375.3 2385.6 2387.2 2391.9 8724.3 8868.9 8901.8 8944.2 8978.9 5227.8 5452.3 5459.2 5466.0 5474.8 3652.2 3654.3 3735.6 3735.6 3735.6 1084.7 1096.2 1098.0 1118.5 1123.7 11695.3 11749.5 11800.8 11815.6 11849.4 4353.6 4465.7 4633.7 4638.1 4659.1 9273.0 9280.1 9287.0 9304.1 9318.8 5320.5 5327.2 5329.5 5333.7 5341.9 3851.3 4136.0 4374.4 4529.1 5001.3 3224.5 3759.0 3836.5 3871.8 3893.7 1165.5 1171.9 1173.6 1178.8 1185.6 785.8 866.5 884.7 930.3 946.0 4630.4 5898.8 5934.3 5962.9 6134.0 815.2 955.6 968.7 983.7 1010.7 3415.9 3755.6 3763.7 3839.9 3984.5 10518.9 11033.3 11039.8 11057.8 11069.8 10254.2 10834.4 10961.6 10981.8 10997.0 6972.9 8443.2 8445.2 8453.5 8464.1 5777.9 5830.6 5836.6 6065.8 6192.2 9782.2 10141.3 10149.9 10164.6 10175.7 9088.8 9447.2 10226.8 10310.5 10385.5 5732.8 7065.1 7596.5 7665.9 7764.8 8262.6 8351.9 8393.6 8438.0 8452.5 7522.5 7556.3 7592.8 7612.1 7614.0 7199.5 7387.7 7448.3 7480.0 7569.1 6049.9 7059.5 7083.2 7141.4 7147.7 4865.1 4932.1 4973.0 5042.2 5096.0 4123.2 4896.4 4930.0 4985.0 5052.4 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4191.19 Median:4479.10 stddev:1284.01 (28.7%) stddev-sans-first:1253.23 06:06:12 INFO - PROCESS | 1658 | Values: 258.6 265.5 304.5 307.7 317.6 4971.0 5197.5 5269.3 5293.3 5376.6 4071.7 4466.3 4975.6 5184.8 5324.3 3586.1 3859.0 4051.2 4058.7 4114.5 3358.4 3409.3 4074.2 4088.3 4099.9 3309.7 3948.8 3954.3 3971.6 4031.2 3978.4 3981.9 3981.9 3982.4 3996.5 3295.7 3444.3 3472.4 3475.4 3483.0 4763.2 4904.8 5000.0 5253.1 5256.1 3854.2 4533.0 4588.6 4634.5 4636.5 5388.2 5444.6 5544.9 5562.9 5635.3 3282.7 3641.5 3739.4 3779.5 3801.0 5003.4 5140.9 5752.2 5795.0 5797.6 3586.0 3837.0 3856.5 3857.5 3880.7 3907.6 3917.0 3926.3 3956.6 3965.6 3821.4 4515.0 4565.8 4583.8 4619.1 5360.7 5582.4 5589.3 5596.9 5599.3 1118.5 1235.4 1316.0 1343.5 1347.1 780.9 804.9 805.1 809.9 811.0 3851.8 3996.1 4247.3 4253.3 4273.8 4056.3 4484.9 4677.7 4684.0 4727.5 3927.4 3943.5 4254.7 4278.6 4317.8 2055.7 2270.4 2337.9 2465.1 2504.3 3869.0 3941.8 4727.9 4792.0 4832.0 4410.8 4489.2 4843.5 4924.8 4962.9 4260.7 4375.5 4863.0 4870.9 4873.7 4139.4 4213.2 4410.4 4781.4 4821.8 3959.7 4363.0 4437.0 4473.3 4668.9 4003.6 4387.4 4465.2 4669.5 4755.7 3202.0 3326.9 3618.6 3724.6 3755.5 4899.7 4939.8 5073.8 5352.7 5742.7 5183.9 5325.4 5633.7 5680.5 5704.7 4618.7 5266.7 5541.9 5590.9 5642.3 5468.5 5487.9 5505.0 5506.0 5507.4 4204.1 5177.1 5506.0 5513.6 5624.9 4525.0 4744.6 5435.8 5473.3 5493.9 06:06:12 INFO - PROCESS | 1658 | 06:06:12 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24503.42 Median:4366.16 stddev:39914.32 (914.2%) stddev-sans-first:39986.33 06:06:12 INFO - PROCESS | 1658 | Values: 713.8 725.6 777.1 804.4 818.1 14768.6 15510.1 15594.9 15787.8 15878.9 14483.5 14554.9 14567.0 14572.4 14610.6 710.7 731.6 733.2 884.5 890.3 894.4 896.4 908.5 909.8 910.5 961.7 964.2 965.4 965.6 965.9 742.9 955.2 958.1 959.8 961.7 563.0 565.8 566.0 566.5 696.3 15263.5 15646.7 15652.7 15654.8 15676.7 13953.0 14068.3 14336.9 14503.3 14571.3 12690.1 12754.9 12840.6 12867.0 12893.9 4518.5 4576.5 4623.4 4797.7 4801.5 114230.0 116464.8 116883.0 117043.4 119039.0 11088.2 11211.2 11343.2 11497.4 11674.4 21798.0 21974.8 22753.0 22777.5 22823.5 7681.6 7956.8 8040.3 8121.6 8136.9 4325.4 4438.7 4541.6 4581.3 4584.0 3400.1 3646.2 3650.1 3652.6 3652.7 670.2 676.5 676.9 677.5 677.7 620.0 623.5 626.1 629.3 642.8 7332.8 8705.4 8765.4 8922.4 8983.6 564.8 596.9 611.0 614.3 624.0 3656.3 4236.0 4284.5 4406.9 4513.6 137375.0 138262.0 148611.0 155425.0 158498.0 137797.0 139031.0 139136.9 139288.3 143813.0 69825.6 74770.0 96536.0 96551.5 104229.5 6877.6 8257.7 8517.4 8939.2 9295.3 45753.8 54490.0 55297.0 64340.4 64809.4 91753.0 95968.0 97886.0 98047.0 100823.0 11420.9 11437.7 11592.9 11719.4 11787.8 12563.6 12598.5 12659.4 12800.5 12816.2 11694.2 11941.0 12049.7 12332.1 12353.9 11695.4 11973.8 12366.2 12383.1 12399.8 11685.2 12007.0 12020.7 12198.3 12268.4 9688.2 9781.8 9810.5 9929.7 10061.8 9997.9 10053.4 10056.5 10067.1 10160.7 06:06:12 INFO - PROCESS | 1658 | -------- Summary: end -------- 06:06:12 INFO - PROCESS | 1658 | 06:06:13 INFO - TEST-INFO | 1658: exit 0 06:06:13 INFO - TEST-OK | dromaeo_css | took 1121179ms 06:06:13 INFO - TEST-START | kraken 06:06:13 INFO - operating with platform_type : mac_ 06:06:13 INFO - Initialising browser for kraken test... 06:06:13 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpZJBC65/profile http://localhost:49267/getInfo.html) 06:06:15 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 06:06:15 INFO - PROCESS | 1665 | colorDepth:24 06:06:15 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 06:06:15 INFO - PROCESS | 1665 | __metrics 06:06:15 INFO - PROCESS | 1665 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:06:15 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:06:16 INFO - TEST-INFO | 1665: exit 0 06:06:16 INFO - Browser initialized. 06:06:16 INFO - Running cycle 1/1 for kraken test... 06:06:16 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/tmpZJBC65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:28 INFO - PROCESS | 1666 | RSS: Main: 231702528 06:06:28 INFO - PROCESS | 1666 | 06:06:31 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 06:06:32 INFO - PROCESS | 1666 | RSS: Main: 290590720 06:06:32 INFO - PROCESS | 1666 | 06:06:34 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 06:06:35 INFO - PROCESS | 1666 | RSS: Main: 291512320 06:06:35 INFO - PROCESS | 1666 | 06:06:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 06:06:39 INFO - PROCESS | 1666 | RSS: Main: 383176704 06:06:39 INFO - PROCESS | 1666 | 06:06:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 06:06:42 INFO - PROCESS | 1666 | RSS: Main: 286183424 06:06:42 INFO - PROCESS | 1666 | 06:06:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:44 INFO - PROCESS | 1666 | RSS: Main: 290545664 06:06:44 INFO - PROCESS | 1666 | 06:06:47 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:48 INFO - PROCESS | 1666 | RSS: Main: 329068544 06:06:48 INFO - PROCESS | 1666 | 06:06:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:51 INFO - PROCESS | 1666 | RSS: Main: 330895360 06:06:51 INFO - PROCESS | 1666 | 06:06:54 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 06:06:54 INFO - PROCESS | 1666 | RSS: Main: 327036928 06:06:54 INFO - PROCESS | 1666 | 06:06:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:57 INFO - PROCESS | 1666 | RSS: Main: 302870528 06:06:57 INFO - PROCESS | 1666 | 06:06:58 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:59 INFO - PROCESS | 1666 | RSS: Main: 306888704 06:06:59 INFO - PROCESS | 1666 | 06:07:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:07:02 INFO - PROCESS | 1666 | RSS: Main: 308994048 06:07:02 INFO - PROCESS | 1666 | 06:07:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:07:06 INFO - PROCESS | 1666 | RSS: Main: 323616768 06:07:06 INFO - PROCESS | 1666 | 06:07:09 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:07:09 INFO - PROCESS | 1666 | RSS: Main: 317009920 06:07:09 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 06:07:11 INFO - PROCESS | 1666 | RSS: Main: 361476096 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | __start_tp_report 06:07:11 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 06:07:11 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 06:07:11 INFO - PROCESS | 1666 | |i|pagename|runs| 06:07:11 INFO - PROCESS | 1666 | |0;ai-astar;105;112;110;111;111;112;110;110;110;111 06:07:11 INFO - PROCESS | 1666 | |1;audio-beat-detection;172;128;111;150;114;111;111;112;141;112 06:07:11 INFO - PROCESS | 1666 | |2;audio-dft;183;181;182;190;183;182;179;180;182;184 06:07:11 INFO - PROCESS | 1666 | |3;audio-fft;79;58;59;88;61;59;61;58;82;57 06:07:11 INFO - PROCESS | 1666 | |4;audio-oscillator;91;69;91;69;69;92;128;96;69;90 06:07:11 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;86;84;86;83;86;84;88;84;87;83 06:07:11 INFO - PROCESS | 1666 | |6;imaging-darkroom;93;93;94;94;93;93;92;94;94;93 06:07:11 INFO - PROCESS | 1666 | |7;imaging-desaturate;83;81;81;78;83;96;130;138;83;80 06:07:11 INFO - PROCESS | 1666 | |8;json-parse-financial;57;53;54;52;53;54;54;54;54;54 06:07:11 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;64;69;76;77;70;71;70;69;70;70 06:07:11 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;91;86;88;97;104;106;83;85;85;90 06:07:11 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;141;149;151;146;149;162;155;140;181;134 06:07:11 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;171;169;170;169;170;171;172;172;225;227 06:07:11 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;71;69;67;69;68;68;68;69;68;67 06:07:11 INFO - PROCESS | 1666 | __end_tp_report 06:07:11 INFO - PROCESS | 1666 | __start_cc_report 06:07:11 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2058 06:07:11 INFO - PROCESS | 1666 | __end_cc_report 06:07:11 INFO - PROCESS | 1666 | __startTimestamp1476709631765__endTimestamp 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | ------- Summary: start ------- 06:07:11 INFO - PROCESS | 1666 | Number of tests: 14 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.99 (1.8%) stddev-sans-first:0.83 06:07:11 INFO - PROCESS | 1666 | Values: 105.0 112.0 110.0 111.0 111.0 112.0 110.0 110.0 110.0 111.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:126.20 Median:121.00 stddev:21.43 (17.7%) stddev-sans-first:15.00 06:07:11 INFO - PROCESS | 1666 | Values: 172.0 128.0 111.0 150.0 114.0 111.0 111.0 112.0 141.0 112.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:182.60 Median:182.50 stddev:2.99 (1.6%) stddev-sans-first:3.17 06:07:11 INFO - PROCESS | 1666 | Values: 183.0 181.0 182.0 190.0 183.0 182.0 179.0 180.0 182.0 184.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:66.20 Median:61.00 stddev:11.86 (19.4%) stddev-sans-first:11.64 06:07:11 INFO - PROCESS | 1666 | Values: 79.0 58.0 59.0 88.0 61.0 59.0 61.0 58.0 82.0 57.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:90.50 stddev:18.62 (20.6%) stddev-sans-first:19.68 06:07:11 INFO - PROCESS | 1666 | Values: 91.0 69.0 91.0 69.0 69.0 92.0 128.0 96.0 69.0 90.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.73 (2.0%) stddev-sans-first:1.80 06:07:11 INFO - PROCESS | 1666 | Values: 86.0 84.0 86.0 83.0 86.0 84.0 88.0 84.0 87.0 83.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:07:11 INFO - PROCESS | 1666 | Values: 93.0 93.0 94.0 94.0 93.0 93.0 92.0 94.0 94.0 93.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:82.00 stddev:22.07 (26.9%) stddev-sans-first:23.09 06:07:11 INFO - PROCESS | 1666 | Values: 83.0 81.0 81.0 78.0 83.0 96.0 130.0 138.0 83.0 80.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:0.73 06:07:11 INFO - PROCESS | 1666 | Values: 57.0 53.0 54.0 52.0 53.0 54.0 54.0 54.0 54.0 54.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.00 stddev:3.66 (5.2%) stddev-sans-first:3.00 06:07:11 INFO - PROCESS | 1666 | Values: 64.0 69.0 76.0 77.0 70.0 71.0 70.0 69.0 70.0 70.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:87.00 stddev:8.15 (9.4%) stddev-sans-first:8.65 06:07:11 INFO - PROCESS | 1666 | Values: 91.0 86.0 88.0 97.0 104.0 106.0 83.0 85.0 85.0 90.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:150.00 stddev:13.25 (8.8%) stddev-sans-first:13.57 06:07:11 INFO - PROCESS | 1666 | Values: 141.0 149.0 151.0 146.0 149.0 162.0 155.0 140.0 181.0 134.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:171.50 stddev:23.43 (13.7%) stddev-sans-first:24.53 06:07:11 INFO - PROCESS | 1666 | Values: 171.0 169.0 170.0 169.0 170.0 171.0 172.0 172.0 225.0 227.0 06:07:11 INFO - PROCESS | 1666 | 06:07:11 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.17 (1.7%) stddev-sans-first:0.78 06:07:11 INFO - PROCESS | 1666 | Values: 71.0 69.0 67.0 69.0 68.0 68.0 68.0 69.0 68.0 67.0 06:07:11 INFO - PROCESS | 1666 | -------- Summary: end -------- 06:07:11 INFO - PROCESS | 1666 | 06:07:12 INFO - TEST-INFO | 1666: exit 0 06:07:12 INFO - TEST-OK | kraken | took 59413ms 06:07:12 INFO - SUITE-END | took 1180s 06:07:12 INFO - Completed test suite (00:19:40) 06:07:12 INFO - javascript benchmark 06:07:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.7489188310874, 3384.9323013539715, 3388.2884594235215, 3402.727781777458, 3451.7583769136154, 5703.429657034295, 5837.941620583793, 5864.5015173710235, 5950.523958083354, 5956.136360227764, 5862.179294898718, 5888.470037696607, 5903.911441328383, 5909.320428150764, 5922.082077278029, 5237.9785941741375, 5275.419703832576, 5283.894322113555, 5308.991291654593, 5327.067763141435, 4441.267190913495, 5364.329458817648, 5372.0, 5373.140297552392, 5378.757955891994, 5276.287701160351, 5321.494458026481, 5333.706646134461, 5339.813106541272, 5348.304720386344, 5380.973095134499, 5394.973025134849, 5411.648242864201, 5418.349798024262, 5418.485243901823, 5130.820421285237, 5243.134882744343, 5253.737313134328, 5329.866753331159, 5365.570754339644, 5796.420357964212, 5825.446582574648, 5855.473007429309, 5865.090910908816, 5879.382664820175, 6120.050983828579, 6181.907271390933, 6184.226971628546, 6194.845128871769, 6195.81412557624, 6241.375862413768, 6268.937310626881, 6277.654728989904, 6278.748850045993, 6283.340249273806, 5840.970795145997, 5841.182234487175, 5861.17943487912, 5879.853003674857, 5906.084556893688, 6320.652364120017, 6373.948298530783, 6378.489720822323, 6385.138006369174, 6387.169667943231, 6135.478484328793, 6171.197744293303, 6193.659348735863, 6197.380261973766, 6198.752049917953, 6107.552954153525, 6212.72042758077, 6234.501239900887, 6275.435210831047, 6298.590591611531, 5700.030994730906, 5866.6186697864505, 6239.032949892774, 6279.937200628026, 6287.182666253358, 6202.937970620236, 6266.937330626726, 6272.2473303203, 6282.277538083087, 6284.968575157186, 4911.287863259808, 4945.307656928033, 4998.375203099613, 4999.3000979862845, 5031.77357018935, 4426.11477704454, 4429.734215947054, 4493.303537951622, 4493.707908985905, 4519.322101684774, 5924.170616113747, 5937.0, 5940.762369505258, 5941.257342832146, 5984.760609575568, 6212.192414986023, 6233.252009758858, 6237.875242495124, 6239.563230573907, 6243.37566243372, 5685.204071430003, 5726.3128424588485, 5742.483176514133, 5889.793857214977, 5924.259467566554, 5417.3770016447825, 5446.591505637093, 5457.072297709399, 5457.154141108134, 5459.208414779914, 6268.4671802897265, 6272.40412160844, 6273.278572964167, 6277.0, 6280.5289603279025, 6191.071339299141, 6246.1255424239735, 6256.718447669775, 6259.374062593704, 6263.4362907338555, 6259.0, 6274.780382686584, 6327.3988971047675, 6407.199100112486, 6408.327125651926, 6247.0629405589525, 6259.687015649109, 6265.122882796503, 6271.686415679289, 6274.215723034621, 6152.507799376129, 6251.812445626639, 6254.405831446005, 6255.0617407387435, 6260.718267677874, 5999.70001499932, 6101.126216676282, 6112.1995365628145, 6146.969265153645, 6168.568200225941, 6205.286392064971, 6223.253209614875, 6228.844278892882, 6230.7819226328675, 6239.407256310643, 5969.701514924323, 6119.479844213113, 6128.846778830565, 6130.417610327012, 6145.508359331154, 6111.297200821785, 6131.957816599936, 6134.957077261001, 6137.867325793431, 6138.419052470106, 6105.186826067751, 6118.862843290023, 6119.136988619874, 6119.550973836674, 6133.202683651097], "value": 5771.200776357561, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.75881456308247, 519.997400013, 531.9654222475539, 532.7294402849209, 553.6401339129566, 30096.849515752445, 39555.01112472186, 40984.59015409845, 42910.0, 42984.14031719364, 42058.57941420585, 42532.0, 42570.36144457835, 42615.78692106543, 42662.57337426625, 9617.471039092865, 9824.557894894748, 9847.507624618776, 9849.704508864745, 9861.161801246866, 9661.17879980199, 9672.419654820698, 9687.903120968771, 9780.951095244549, 9784.804303913917, 9728.0, 9781.510924453785, 9792.16766574842, 9793.559289831976, 9807.215422766161, 9050.547472626407, 9116.31627627924, 9694.369865958726, 9741.951290243574, 9756.4633945133, 8317.0, 9611.990740972167, 9634.75913102171, 9728.0, 9737.610495580167, 39983.0, 40623.0, 40711.79644101761, 40724.18551628951, 40770.38844417336, 3340.9331813363597, 3390.4066788311948, 3391.423458012144, 3414.778039427429, 3506.50908872758, 29975.0, 31351.0, 31370.37259254802, 31445.0, 31507.746454228614, 3218.9356212875846, 3236.223306406469, 3325.318309746496, 3354.8490317935753, 3356.6978971892404, 466612.0, 468148.0, 470242.0, 471058.0, 471843.0, 52979.470205298225, 53060.73469632627, 53082.099327087235, 53090.46909530932, 53136.0, 59586.0, 59600.70199648974, 59680.70159649261, 59726.0, 59852.70073649604, 16163.595910102342, 16386.26261818221, 16398.180090995404, 16406.933549319256, 16412.343506259855, 12794.360281985864, 12864.421101050475, 12866.0, 12867.22796632205, 12880.484780608858, 13666.385012674453, 15044.473443429428, 15070.472533461276, 15075.623109422353, 15273.770893436607, 5693.971530142323, 6309.369063093745, 6557.5081868860025, 6588.122385120314, 6905.240423553405, 912.4023764434306, 947.6209516193578, 969.6315400147898, 995.9840962218497, 1002.5238011944268, 28599.0, 28793.85603072013, 29494.8202071919, 29649.555256671167, 30344.696553034628, 1048.8688913885765, 1079.8002369561657, 1120.255030404788, 1161.9948744336089, 1167.6222057971675, 14793.92603036978, 15413.691726165414, 15428.691426171414, 15475.0, 15769.44806931752, 575478.0, 584163.0791846098, 588981.0, 589398.0, 590127.0, 47199.76400117978, 55648.887022259325, 55659.721701392045, 55743.44256557464, 55805.7209713957, 1252.3863306979697, 1302.47900839663, 1302.7655022096114, 1410.7108042851191, 1436.490046033664, 25064.498710026062, 25769.742302576735, 31143.23455374777, 32077.839610801795, 32408.0, 51508.74245628748, 52125.21812172745, 52154.0, 52193.478065218864, 52432.47567524276, 577959.0, 583592.0, 583740.0, 583891.0941577568, 584977.0, 25059.0, 25790.871045644653, 25790.871045644653, 26737.465250695266, 37982.620173797906, 44184.779076104416, 46517.06965860732, 46685.766571166925, 47269.76365118152, 47609.0, 32700.0, 38421.0, 38828.80585597054, 39033.41449878311, 39823.80088099541, 32149.678503215604, 38578.6142138575, 38596.42105368478, 38700.41949370706, 39665.60334396619, 37666.0, 38132.0, 38255.42616860694, 38286.80856595699, 38329.42505862359, 32536.83731581327, 33092.503612445355, 34005.319893602486, 34372.0, 34566.0, 22801.543969120856, 23947.0, 25115.120970765936, 25340.746592534575, 25777.355566110997], "value": 19606.360412500908, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6170078866009, 376.40903781063724, 384.139527458493, 386.2815163795341, 411.51852332770653, 12444.937775311122, 15065.62335941602, 19908.303209387675, 21505.032273547688, 22053.0, 20051.699224511645, 20319.18723251068, 20818.16727330905, 21104.68342974853, 21715.131394744232, 4774.9761251193695, 5347.331583552056, 5618.831435056954, 5661.0, 5677.460641239097, 5280.260763493114, 5478.643888147278, 5546.805861794838, 5576.776928922838, 5598.412166722496, 5441.401445840955, 5538.861528461781, 5545.916811247835, 5550.69471179085, 5555.194496797962, 5307.628466007381, 5462.262594549725, 5501.587380946405, 5507.394186639466, 5524.944750552483, 5231.110711179109, 5285.127953887604, 5366.4633536646415, 5367.2485851980755, 5367.329083864517, 11751.588694395656, 12778.23330600167, 13310.467581296833, 13670.52153174634, 13683.384247708877, 2152.2036846366946, 2157.30966090851, 2218.7617781833465, 2253.143805353955, 2370.9407264818346, 10091.29360944734, 10291.742706432398, 10491.842622360671, 10594.31136976094, 11705.063594912386, 1847.445766270127, 1862.7392165096896, 1916.961660766777, 1978.3193772438426, 2028.7666918304437, 121096.0, 125526.37236813849, 126141.36929315387, 126268.36865815704, 126549.36725316315, 11167.441627918572, 11371.167253917052, 11543.249688770204, 11567.42162891852, 11765.352905590104, 13136.40886160125, 13649.590512284647, 13707.520236791665, 13707.588772336845, 14473.421063157566, 6405.455536279375, 7022.508424410345, 8267.077964077838, 8481.83036339282, 8717.12828717136, 7536.8492630148185, 8103.068147163034, 8466.66133354659, 8504.532250726146, 8738.825223495494, 4483.55164483549, 4564.497905230422, 4621.145088158702, 4625.930611040837, 4632.305154226826, 1717.2959086774613, 1857.8327950484252, 1908.9331873384365, 1931.304730297092, 1982.3557343863301, 869.3566760597113, 917.4999625204147, 948.5541795356172, 960.279790157382, 1010.5200029985698, 21645.783542164376, 22217.555648887253, 22226.44433889166, 22227.333180004625, 22282.554348913254, 933.1182032978905, 940.149165005671, 952.7087354911449, 955.3694561589457, 969.6703120938914, 7592.544447333067, 9773.706788796348, 11599.188056835941, 11703.414829258503, 11707.414629268502, 472434.0, 477471.2252877496, 478473.0, 589371.0, 595416.0, 140707.0, 140817.28558001888, 145015.27492362683, 148949.0, 153215.0, 966.367029595616, 990.277097718655, 1023.518946095334, 1024.1653052761976, 1026.1124127629696, 17536.386226482013, 19230.0, 19381.70927436118, 19775.802241977395, 19923.402297931087, 57482.42517574938, 57631.0, 59449.702751485966, 59820.40179598323, 60415.0, 81241.59379203066, 83158.0, 85715.0, 87641.37075887734, 88489.55755221183, 7931.484453510503, 7947.642356093874, 8066.395020373378, 8112.22933821286, 8349.83300334002, 12880.613581592566, 12954.611361659165, 13097.934510327388, 13182.60452186436, 13265.734685306434, 11039.503222354853, 11325.377104259345, 11406.942965285121, 11483.712907177052, 11578.189526733047, 9485.810283794424, 10066.043725846033, 10080.596776129167, 10477.895221047693, 11115.0, 11395.715107122389, 11442.199046066695, 11591.710207244887, 11660.941695291469, 11758.294502329887, 7953.0515023819535, 8005.318883034395, 8132.308753755997, 8203.630836612247, 8219.506829590244, 10825.074650556047, 11230.21388502797, 11485.540578376771, 11794.056475482112, 11810.291382517076], "value": 9358.425289244717, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.5819254223743, 1400.3278426355348, 1585.9207039648018, 1830.322780571188, 2017.6065667194903, 7914.802129946747, 8402.285805706515, 8682.869756953634, 8954.776130596738, 8978.595963181657, 8818.162274583905, 8914.866277005834, 8915.598798054087, 8929.28565714743, 8929.73210803677, 2040.36748607932, 2365.44412063165, 2375.869327187004, 2379.4527258730504, 2383.749706280837, 2362.2558893948435, 2383.3207535852284, 2408.1932552594903, 2410.313060777679, 2410.6384042393606, 2367.763223677636, 2385.33210701004, 2389.9283021509295, 2397.9520409591796, 2403.170906037414, 2356.2460012795914, 2375.7861792438675, 2383.5709572276983, 2387.248016874679, 2390.151496218835, 2346.62454007358, 2375.2874137758777, 2385.6302273147517, 2387.236084452976, 2391.892364843586, 8724.258438032775, 8868.8669669955, 8901.821963560757, 8944.23973962214, 8978.86531702025, 5227.764750586232, 5452.318460192476, 5459.153831156177, 5466.043442397565, 5474.753636086386, 3652.196516766307, 3654.2958210923725, 3735.6264373562426, 3735.62643735627, 3735.6465426781224, 1084.7233955341417, 1096.199774164864, 1097.9945100274526, 1118.5246270335156, 1123.685368096926, 11695.298282103016, 11749.471273792615, 11800.763984720257, 11815.586454474053, 11849.40752962357, 4353.564643535621, 4465.665075119379, 4633.675642705046, 4638.072385522909, 4659.091477161988, 9272.953635231916, 9280.071992800666, 9287.0, 9304.069593040642, 9318.767030824283, 5320.467953204648, 5327.227552004938, 5329.520343169133, 5333.679979201261, 5341.893162136736, 3851.30676478231, 4135.958640413617, 4374.431323927933, 4529.071540334224, 5001.324821149171, 3224.5324427957817, 3758.962410375861, 3836.5396152461885, 3871.7870517121264, 3893.6885049196, 1165.539611853313, 1171.917965742407, 1173.5716463490764, 1178.8467499225046, 1185.6265276437894, 785.8310463250428, 866.4541338956543, 884.712468447757, 930.2883294279882, 945.9972429225044, 4630.3748993886065, 5898.793542226002, 5934.287885453687, 5962.910556341659, 6133.969330153321, 815.2418251026602, 955.6464108279841, 968.660968660963, 983.7245571240064, 1010.7422607235108, 3415.9316813664086, 3755.5681096673684, 3763.717721170923, 3839.9424008639894, 3984.541777695544, 10518.947405262925, 11033.337999719883, 11039.83440248397, 11057.834132488018, 11069.833952490719, 10254.230932680079, 10834.404107773991, 10961.616343427942, 10981.835272470918, 10997.0, 6972.860542789217, 8443.197896199852, 8445.239928406472, 8453.450525715809, 8464.05326774833, 5777.94222057774, 5830.62100963436, 5836.649801011953, 6065.848353791014, 6192.173308873983, 9782.168515676247, 10141.340812847142, 10149.898501014895, 10164.64423745195, 10175.7456063599, 9088.818223635359, 9447.24422046221, 10226.82391524984, 10310.536025879004, 10385.532651030571, 5732.828015159552, 7065.116860392451, 7596.468247222641, 7665.88501172494, 7764.84470310602, 8262.628181731716, 8351.874721879056, 8393.622286996977, 8437.957810211155, 8452.478553860365, 7522.473426860067, 7556.319931205998, 7592.8481430372185, 7612.1246056704185, 7614.048243969504, 7199.532030418006, 7387.667554959932, 7448.329650331496, 7480.027596412431, 7569.1295501018085, 6049.909251361145, 7059.541129826544, 7083.185433675193, 7141.392981596622, 7147.678354473957, 4865.099956508057, 4932.136876046749, 4972.950270497248, 5042.243663450512, 5096.031753966735, 4123.175364926967, 4896.436909755281, 4929.975350123226, 4984.950150498594, 5052.368453943257], "value": 4561.868438662541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [258.6172464752167, 265.4664125108531, 304.4990989821742, 307.70767770617914, 317.5538368592126, 4971.0, 5197.506236907498, 5269.314989051422, 5293.258943747878, 5376.596755243358, 4071.7149799514045, 4466.263066594016, 4975.626827987898, 5184.807494276319, 5324.307839980797, 3586.0952628370974, 3859.0352411897024, 4051.230266249418, 4058.736182148151, 4114.485689288839, 3358.3619112368574, 3409.318136372723, 4074.1851629674184, 4088.284550203717, 4099.877003689894, 3309.7352211823118, 3948.7828169450668, 3954.268460334847, 3971.60283971602, 4031.21391328691, 3978.3634618460906, 3981.8606348777944, 3981.9004524886964, 3982.4357200305853, 3996.481337091901, 3295.7198638115788, 3444.330643751088, 3472.3576138414473, 3475.4439289713523, 3483.0, 4763.214069678499, 4904.82284251777, 4999.975000124976, 5253.080710875582, 5256.132738098209, 3854.1713531590844, 4533.0, 4588.564086411819, 4634.536546345372, 4636.466806317283, 5388.245645609618, 5444.564434845203, 5544.889102217973, 5562.916556251659, 5635.267415235993, 3282.720968717638, 3641.526601541809, 3739.439084137374, 3779.4897688811934, 3801.004472651852, 5003.374578177728, 5140.897182056376, 5752.194692743019, 5795.043817770021, 5797.565182611321, 3586.0276847733644, 3837.0, 3856.46009558662, 3857.537095548496, 3880.701403806742, 3907.628775266345, 3916.9608303917166, 3926.2540117377607, 3956.6043395660204, 3965.6034396560112, 3821.407681809324, 4514.977425112854, 4565.840195593139, 4583.816647334136, 4619.076184762994, 5360.65155764874, 5582.413846546055, 5589.273394458775, 5596.888062238814, 5599.348192283286, 1118.5078565431184, 1235.3946566182685, 1315.960521184366, 1343.4626149540068, 1347.0871362665039, 780.9336206422518, 804.8511025460308, 805.1264378149773, 809.9028116625925, 810.9797255068553, 3851.826667799956, 3996.1408297215658, 4247.299195632686, 4253.255680255943, 4273.820351620696, 4056.3104272273786, 4484.865454036384, 4677.672562920563, 4683.976580117078, 4727.463574338354, 3927.410888366711, 3943.546492153439, 4254.723442976197, 4278.614924656796, 4317.84887528935, 2055.7357225306628, 2270.3880245025885, 2337.883105844701, 2465.149523414419, 2504.3488692939604, 3868.9613103869165, 3941.763494190358, 4727.858164255078, 4791.952080479151, 4831.95168048315, 4410.794602698651, 4489.19194544985, 4843.467218605951, 4924.808460235161, 4962.8759281018265, 4260.743080791174, 4375.47494300686, 4862.9544647900875, 4870.9269360959615, 4873.658843880965, 4139.379093136054, 4213.199492096492, 4410.390207574276, 4781.374332726889, 4821.769414492369, 3959.7130932446494, 4363.0, 4437.0460351024685, 4473.329000649798, 4668.875661573908, 4003.57962413954, 4387.446168603441, 4465.1962646723905, 4669.463011753692, 4755.671030278888, 3201.982750866939, 3326.8835590754206, 3618.565772107364, 3724.6089160638826, 3755.4930084439343, 4899.657024008286, 4939.802407903788, 5073.807655200951, 5352.742105605257, 5742.712864356849, 5183.937292855031, 5325.440828713085, 5633.746481408264, 5680.460356266148, 5704.743286552032, 4618.720708297146, 5266.6833291677085, 5541.919325731444, 5590.937721832839, 5642.322921249476, 5468.48049435303, 5487.8749856280165, 5504.954058728828, 5505.9724701376235, 5507.394186639386, 4204.096119334357, 5177.107633286508, 5506.0, 5513.558915286687, 5624.915626265692, 4524.963766305242, 4744.644151688706, 5435.83692489226, 5473.31583552056, 5493.890122197614], "value": 3785.2106199426466, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.8037039814054, 725.5827898958099, 777.1024466740913, 804.364552003917, 818.1450384348353, 14768.6307842304, 15510.069395836257, 15594.922025389886, 15787.84212157878, 15878.920605396972, 14483.493077742281, 14554.854451455481, 14567.0, 14572.417103315882, 14610.634734131652, 710.6624353432104, 731.6049333359979, 733.1788396995373, 884.5179377239388, 890.3366991591241, 894.4230971023686, 896.4307664632972, 908.4640062363204, 909.7862002429424, 910.4673765846987, 961.735522731251, 964.2334344196381, 965.3580369054605, 965.5944503308592, 965.8840939087285, 742.9368503677194, 955.2262667239559, 958.075457183821, 959.7840485890689, 961.6826447272454, 562.963407378519, 565.7623798004848, 565.9915101273484, 566.4675205306999, 696.2967402923034, 15263.542093737206, 15646.687066258612, 15652.686946261125, 15654.843451565452, 15676.68646627061, 13953.023288369819, 14068.296585170803, 14336.92831535846, 14503.347349369304, 14571.344289506891, 12690.11169218155, 12754.865095654006, 12840.55058072963, 12867.034972377109, 12893.935530322382, 4518.5481451854885, 4576.519465456146, 4623.375844261015, 4797.664163508556, 4801.5438533339275, 114230.0, 116464.83535164625, 116883.0, 117043.4147829264, 119039.0, 11088.22382433238, 11211.159163062803, 11343.20597558163, 11497.425128743529, 11674.357910314844, 21798.019089141028, 21974.780252197274, 22753.0, 22777.544449110927, 22823.543529129325, 7681.5775132367135, 7956.840863182704, 8040.316573091236, 8121.634526446324, 8136.918630813616, 4325.43769309994, 4438.667099967515, 4541.591256786905, 4581.289900065495, 4584.014436896084, 3400.1159698478573, 3646.1796095878217, 3650.1239702471216, 3652.6164752701116, 3652.6895213907114, 670.2258890980925, 676.5129107042922, 676.9187697476236, 677.478341676906, 677.7390704578772, 619.9783007594802, 623.5136593457111, 626.117174783553, 629.3391938464594, 642.8360768004129, 7332.790089635258, 8705.434146780439, 8765.38642295046, 8922.420042697333, 8983.595738191798, 564.8474911773881, 596.8699031821487, 610.9694515274307, 614.3089024847047, 623.9642193958099, 3656.341858465502, 4235.9621892636505, 4284.479009951485, 4406.889827754268, 4513.593776560059, 137375.0, 138262.0, 148611.0, 155425.0, 158498.0, 137797.0, 139031.0, 139136.91294630588, 139288.30355848157, 143813.0, 69825.60348793097, 74770.0, 96536.0346396527, 96551.51724241333, 104229.47885260677, 6877.552959057645, 8257.710980115668, 8517.403781735218, 8939.240164586083, 9295.349325547148, 45753.771231144965, 54490.0, 55297.0, 64340.356596433434, 64809.35190648222, 91753.0, 95968.0, 97886.0, 98047.0, 100823.0, 11420.94289528547, 11437.656870293904, 11592.88407115918, 11719.414029298672, 11787.823182652095, 12563.623091307276, 12598.496015189894, 12659.430325635185, 12800.48798048105, 12816.166949148275, 11694.181407301407, 11941.0, 12049.698757531132, 12332.075094368138, 12353.876461235273, 11695.415229238673, 11973.820392694292, 12366.19619724715, 12383.071269654632, 12399.75200496003, 11685.182037257311, 12007.0, 12020.699482512657, 12198.268103913793, 12268.44791984345, 9688.224942004763, 9781.804363912825, 9810.509474526103, 9929.702108936743, 10061.798764024825, 9997.850032249667, 10053.399361594178, 10056.508377118947, 10067.14406943676, 10160.717390764457], "value": 7656.676165311281, "unit": "score"}], "name": "dromaeo_css", "value": 7206.061741363688, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 110.0, 111.0, 111.0, 112.0, 110.0, 110.0, 110.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 128.0, 111.0, 150.0, 114.0, 111.0, 111.0, 112.0, 141.0, 112.0], "value": 126.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 182.0, 190.0, 183.0, 182.0, 179.0, 180.0, 182.0, 184.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 88.0, 61.0, 59.0, 61.0, 58.0, 82.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 69.0, 91.0, 69.0, 69.0, 92.0, 128.0, 96.0, 69.0, 90.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 83.0, 86.0, 84.0, 88.0, 84.0, 87.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 92.0, 94.0, 94.0, 93.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 78.0, 83.0, 96.0, 130.0, 138.0, 83.0, 80.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 54.0, 52.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 76.0, 77.0, 70.0, 71.0, 70.0, 69.0, 70.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 88.0, 97.0, 104.0, 106.0, 83.0, 85.0, 85.0, 90.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 149.0, 151.0, 146.0, 149.0, 162.0, 155.0, 140.0, 181.0, 134.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 170.0, 169.0, 170.0, 171.0, 172.0, 172.0, 225.0, 227.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 67.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1460.1, "alertThreshold": 2.0}]} 06:07:13 INFO - Return code: 0 06:07:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:07:13 INFO - # TBPL SUCCESS # 06:07:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:07:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:07:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:07:13 INFO - 2016-10-17 06:07:13.092 screenresolution[1670:9857] starting screenresolution argv=screenresolution get 06:07:13 INFO - 2016-10-17 06:07:13.095 screenresolution[1670:9857] Display 0: 1600x1200x32@60 06:07:13 INFO - 2016-10-17 06:07:13.101 screenresolution[1671:9860] starting screenresolution argv=screenresolution list 06:07:13 INFO - Available Modes on Display 0 06:07:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:07:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:07:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:07:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:07:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:07:13 INFO - Intel Iris: 06:07:13 INFO - Chipset Model: Intel Iris 06:07:13 INFO - Type: GPU 06:07:13 INFO - Bus: Built-In 06:07:13 INFO - VRAM (Dynamic, Max): 1536 MB 06:07:13 INFO - Vendor: Intel (0x8086) 06:07:13 INFO - Device ID: 0x0a2e 06:07:13 INFO - Revision ID: 0x0009 06:07:13 INFO - Displays: 06:07:13 INFO - Display: 06:07:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:07:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:07:13 INFO - Display Serial Number: 1600x1200 60 06:07:13 INFO - Main Display: Yes 06:07:13 INFO - Mirror: Off 06:07:13 INFO - Online: Yes 06:07:13 INFO - Rotation: Supported 06:07:13 INFO - Return code: 0 06:07:13 INFO - Running post-action listener: _resource_record_post_action 06:07:13 INFO - [mozharness: 2016-10-17 13:07:13.335405Z] Finished run-tests step (success) 06:07:13 INFO - Running post-run listener: _resource_record_post_run 06:07:13 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 37114880; Write bytes: 706547200; Read time: 240; Write time: 1951 06:07:13 INFO - TinderboxPrint: CPU usage
53.6% 06:07:13 INFO - TinderboxPrint: I/O read bytes / time
37,114,880 / 240 06:07:13 INFO - TinderboxPrint: I/O write bytes / time
706,547,200 / 1,951 06:07:13 INFO - TinderboxPrint: CPU idle
2,255.2 (46.4%) 06:07:13 INFO - TinderboxPrint: CPU system
971.8 (20.0%) 06:07:13 INFO - TinderboxPrint: CPU user
1,634.8 (33.6%) 06:07:13 INFO - TinderboxPrint: Swap in / out
443,764,736 / 0 06:07:13 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404802048; Write bytes: 397293056; Read time: 29805; Write time: 827 06:07:13 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 29699072; Write bytes: 297158656; Read time: 178; Write time: 1103 06:07:13 INFO - Running post-run listener: _upload_blobber_files 06:07:13 INFO - Blob upload gear active. 06:07:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:07:13 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 06:07:13 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:07:13 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:07:14 INFO - (blobuploader) - INFO - Open directory for files ... 06:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:14 INFO - (blobuploader) - INFO - Done attempting. 06:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:07:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:15 INFO - (blobuploader) - INFO - Done attempting. 06:07:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:07:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:07:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:07:18 INFO - (blobuploader) - INFO - Done attempting. 06:07:18 INFO - (blobuploader) - INFO - Iteration through files over. 06:07:18 INFO - Return code: 0 06:07:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:07:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:07:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5593ed91a9e1a5c954f4f2ef2733e4898226af0c23c803553581b2a71e33b965a342aa58333bf563e344a21c5d393c499b2d638a34a9ce054809b34389ddf887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9576155500714105cf4cdeb376957f3c82bcad0a72361bcee61832ce9aa7f11a5be2b2ff94230998da340d2a1ac06040cadfcdee46f498be3d87a465e92b710d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc93785e3153f9e8d1ff82785871ab0efeb3f00e042758940449d1eecd1928fa250733d0048c1db5e3579de9e465ad573c0c732e366367d411b7768346f2ae6b"} 06:07:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:07:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:07:18 INFO - Contents: 06:07:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5593ed91a9e1a5c954f4f2ef2733e4898226af0c23c803553581b2a71e33b965a342aa58333bf563e344a21c5d393c499b2d638a34a9ce054809b34389ddf887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9576155500714105cf4cdeb376957f3c82bcad0a72361bcee61832ce9aa7f11a5be2b2ff94230998da340d2a1ac06040cadfcdee46f498be3d87a465e92b710d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc93785e3153f9e8d1ff82785871ab0efeb3f00e042758940449d1eecd1928fa250733d0048c1db5e3579de9e465ad573c0c732e366367d411b7768346f2ae6b"} 06:07:18 INFO - Running post-run listener: copy_logs_to_upload_dir 06:07:18 INFO - Copying logs to upload dir... 06:07:18 INFO - mkdir: /builds/slave/test/build/upload/logs 06:07:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.990891 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-17 06:07:18.109838) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:07:18.114033) ========= 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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5593ed91a9e1a5c954f4f2ef2733e4898226af0c23c803553581b2a71e33b965a342aa58333bf563e344a21c5d393c499b2d638a34a9ce054809b34389ddf887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9576155500714105cf4cdeb376957f3c82bcad0a72361bcee61832ce9aa7f11a5be2b2ff94230998da340d2a1ac06040cadfcdee46f498be3d87a465e92b710d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc93785e3153f9e8d1ff82785871ab0efeb3f00e042758940449d1eecd1928fa250733d0048c1db5e3579de9e465ad573c0c732e366367d411b7768346f2ae6b"} build_url:https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011169 build_url: 'https://queue.taskcluster.net/v1/task/ac5aYbRrQv28h5Rt-VQQtg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5593ed91a9e1a5c954f4f2ef2733e4898226af0c23c803553581b2a71e33b965a342aa58333bf563e344a21c5d393c499b2d638a34a9ce054809b34389ddf887", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9576155500714105cf4cdeb376957f3c82bcad0a72361bcee61832ce9aa7f11a5be2b2ff94230998da340d2a1ac06040cadfcdee46f498be3d87a465e92b710d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/fc93785e3153f9e8d1ff82785871ab0efeb3f00e042758940449d1eecd1928fa250733d0048c1db5e3579de9e465ad573c0c732e366367d411b7768346f2ae6b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:07:18.152351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:07:18.152720) ========= 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.x33MUxog4x/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.7oMsdlQ2Dq/Listeners TMPDIR=/var/folders/xt/zmqpr3490qxfv07nrs0f850r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005200 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:07:18.201477) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:07:18.201826) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:07:18.202182) ========= ========= Total master_lag: 0.18 =========