builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0141 starttime: 1475749439.66 results: success (0) buildid: 20161006014600 builduid: 48d258d32a7142e198eacfd2c5187fb1 revision: 47f0358bfff2a6306198bd9a9b95a8319ca45ecd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.657712) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.658477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.658959) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.682971) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.683411) ========= 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.8GmaN08Akq/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.X0h4bzWSAk/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-06 03:23:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.63M=0.002s 2016-10-06 03:23:59 (7.63 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118330 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.823969) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.824330) ========= 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.8GmaN08Akq/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.X0h4bzWSAk/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.021003 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:23:59.874005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 03:23:59.874405) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 47f0358bfff2a6306198bd9a9b95a8319ca45ecd --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 47f0358bfff2a6306198bd9a9b95a8319ca45ecd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8GmaN08Akq/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.X0h4bzWSAk/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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-06 03:23:59,948 truncating revision to first 12 chars 2016-10-06 03:23:59,948 Setting DEBUG logging. 2016-10-06 03:23:59,948 attempt 1/10 2016-10-06 03:23:59,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/47f0358bfff2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 03:24:00,714 unpacking tar archive at: autoland-47f0358bfff2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.029209 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 03:24:00.926051) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:24:00.926426) ========= script_repo_revision: 47f0358bfff2a6306198bd9a9b95a8319ca45ecd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 03:24:00.926879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:24:00.927184) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 03:24:00.945249) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-06 03:24:00.945566) ========= /tools/buildbot/bin/python 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', '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:01 INFO - MultiFileLogger online at 20161006 03:24:01 in /builds/slave/test 03:24:01 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 03:24:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:01 INFO - {'append_to_log': False, 03:24:01 INFO - 'base_work_dir': '/builds/slave/test', 03:24:01 INFO - 'blob_upload_branch': 'Autoland', 03:24:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:01 INFO - 'branch': 'Autoland', 03:24:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:01 INFO - 'config_files': ('talos/mac_config.py',), 03:24:01 INFO - 'default_actions': ('clobber', 03:24:01 INFO - 'read-buildbot-config', 03:24:01 INFO - 'download-and-extract', 03:24:01 INFO - 'populate-webroot', 03:24:01 INFO - 'create-virtualenv', 03:24:01 INFO - 'install', 03:24:01 INFO - 'run-tests'), 03:24:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:01 INFO - 'download_minidump_stackwalk': True, 03:24:01 INFO - 'download_symbols': 'ondemand', 03:24:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:24:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:24:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:24:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:24:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:01 INFO - 'installer_path': 'installer.exe', 03:24:01 INFO - 'log_level': 'info', 03:24:01 INFO - 'log_name': 'talos', 03:24:01 INFO - 'log_to_console': True, 03:24:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:24:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:24:01 INFO - 'opt_config_files': (), 03:24:01 INFO - 'pip_index': False, 03:24:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:01 INFO - 'cmd': ('bash', 03:24:01 INFO - '-c', 03:24:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:01 INFO - 'enabled': True, 03:24:01 INFO - 'halt_on_failure': False, 03:24:01 INFO - 'name': 'check_screen_resolution'},), 03:24:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:24:01 INFO - 'cmd': ('bash', 03:24:01 INFO - '-c', 03:24:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:24:01 INFO - 'enabled': True, 03:24:01 INFO - 'halt_on_failure': False, 03:24:01 INFO - 'name': 'check_screen_resolution'},), 03:24:01 INFO - 'run_cmd_checks_enabled': True, 03:24:01 INFO - 'sps_profile': False, 03:24:01 INFO - 'sps_profile_interval': 0, 03:24:01 INFO - 'suite': 'dromaeojs', 03:24:01 INFO - 'system_bits': '32', 03:24:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:01 INFO - 'title': 't-yosemite-r7-0141', 03:24:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:01 INFO - 'use_talos_json': True, 03:24:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:01 INFO - 'work_dir': 'build'} 03:24:01 INFO - [mozharness: 2016-10-06 10:24:01.144567Z] Running clobber step. 03:24:01 INFO - Running pre-action listener: _resource_record_pre_action 03:24:01 INFO - Running main action method: clobber 03:24:01 INFO - rmtree: /builds/slave/test/build 03:24:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:02 INFO - Running post-action listener: _resource_record_post_action 03:24:02 INFO - [mozharness: 2016-10-06 10:24:02.590331Z] Finished clobber step (success) 03:24:02 INFO - [mozharness: 2016-10-06 10:24:02.590450Z] Running read-buildbot-config step. 03:24:02 INFO - Running pre-action listener: _resource_record_pre_action 03:24:02 INFO - Running main action method: read_buildbot_config 03:24:02 INFO - Using buildbot properties: 03:24:02 INFO - { 03:24:02 INFO - "project": "", 03:24:02 INFO - "product": "firefox", 03:24:02 INFO - "script_repo_revision": "production", 03:24:02 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 03:24:02 INFO - "repository": "", 03:24:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 03:24:02 INFO - "buildid": "20161006014600", 03:24:02 INFO - "pgo_build": "False", 03:24:02 INFO - "basedir": "/builds/slave/test", 03:24:02 INFO - "buildnumber": 230, 03:24:02 INFO - "slavename": "t-yosemite-r7-0141", 03:24:02 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 03:24:02 INFO - "platform": "yosemite_r7", 03:24:02 INFO - "scheduler": "tests-autoland-macosx64-talos", 03:24:02 INFO - "branch": "autoland", 03:24:02 INFO - "repo_path": "integration/autoland", 03:24:02 INFO - "revision": "47f0358bfff2a6306198bd9a9b95a8319ca45ecd", 03:24:02 INFO - "stage_platform": "macosx64", 03:24:02 INFO - "builduid": "48d258d32a7142e198eacfd2c5187fb1", 03:24:02 INFO - "slavebuilddir": "test" 03:24:02 INFO - } 03:24:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 03:24:02 INFO - Running post-action listener: _resource_record_post_action 03:24:02 INFO - [mozharness: 2016-10-06 10:24:02.593908Z] Finished read-buildbot-config step (success) 03:24:02 INFO - [mozharness: 2016-10-06 10:24:02.594022Z] Running download-and-extract step. 03:24:02 INFO - Running pre-action listener: _resource_record_pre_action 03:24:02 INFO - Running main action method: download_and_extract 03:24:02 INFO - mkdir: /builds/slave/test/build/tests 03:24:02 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')]} 03:24:02 INFO - trying https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 03:24:02 INFO - Downloading https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/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 03:24:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/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 03:24:04 INFO - Downloaded 1199 bytes. 03:24:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 03:24:04 INFO - Using the following test package requirements: 03:24:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:24:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 03:24:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 03:24:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'jsshell-mac.zip'], 03:24:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 03:24:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 03:24:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 03:24:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 03:24:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 03:24:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 03:24:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 03:24:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:24:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:24:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:24:04 INFO - Fetch https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:24:04 INFO - Http code: 200 03:24:04 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 03:24:04 INFO - x-amz-cf-id: Of-XRfTtmabGrxXiV3aXgbisYLsSqdSSTU_0gDoSQDi4qXQwxrJ-OA== 03:24:04 INFO - x-amz-version-id: gvYU06Hqe7mYIOEYYPUs0Qba.7HmgPd0 03:24:04 INFO - Expected file size: 16477150 03:24:04 INFO - Obtained file size: 16477150 03:24:11 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 03:24:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 03:24:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:24:11 INFO - Fetch https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 03:24:12 INFO - Http code: 200 03:24:12 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 03:24:12 INFO - x-amz-cf-id: J1uEnER4doL-AxiT6WcTDrRim3p1lnGQkBDBjXfTY3oBtsQqBd7q2A== 03:24:12 INFO - x-amz-version-id: gvYU06Hqe7mYIOEYYPUs0Qba.7HmgPd0 03:24:12 INFO - Expected file size: 16477150 03:24:12 INFO - Obtained file size: 16477150 03:24:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 03:24:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:24:18 INFO - Fetch https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 03:24:19 INFO - Http code: 200 03:24:19 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 03:24:19 INFO - x-amz-cf-id: dRZvGuz9DtpwXXNGzRKsLTWrBPFgUxjlpa5aVG_Zg52ztfO2R4KaUA== 03:24:19 INFO - x-amz-version-id: SKDRuEMmROOniLGyrb2GUdWsWxVoxhsz 03:24:19 INFO - Expected file size: 14409006 03:24:19 INFO - Obtained file size: 14409006 03:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:19 INFO - trying https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:24:19 INFO - Downloading https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 03:24:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/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 03:24:22 INFO - Downloaded 111633422 bytes. 03:24:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:24:22 INFO - mkdir: /builds/slave/test/properties 03:24:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:24:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:24:22 INFO - Contents: 03:24:22 INFO - build_url:https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 03:24:23 INFO - Running post-action listener: _resource_record_post_action 03:24:23 INFO - Running post-action listener: set_extra_try_arguments 03:24:23 INFO - [mozharness: 2016-10-06 10:24:23.809843Z] Finished download-and-extract step (success) 03:24:23 INFO - [mozharness: 2016-10-06 10:24:23.809974Z] Running populate-webroot step. 03:24:23 INFO - Running pre-action listener: _resource_record_pre_action 03:24:23 INFO - Running main action method: populate_webroot 03:24:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:24:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:24:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:24:23 INFO - '--tppagecycles', 03:24:23 INFO - '7'], 03:24:23 INFO - 'tests': ['tsvgm']}}, 03:24:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:24:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:24:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:24:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:24:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:24:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['damp', 'tps']}, 03:24:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'tests': ['damp', 'tps']}, 03:24:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['dromaeo_dom']}, 03:24:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:24:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['basic_compositor_video']}, 03:24:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:24:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['a11yr', 03:24:23 INFO - 'ts_paint', 03:24:23 INFO - 'tpaint', 03:24:23 INFO - 'sessionrestore', 03:24:23 INFO - 'sessionrestore_no_auto_restore', 03:24:23 INFO - 'tabpaint']}, 03:24:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:24:23 INFO - 'ts_paint', 03:24:23 INFO - 'tpaint', 03:24:23 INFO - 'sessionrestore', 03:24:23 INFO - 'sessionrestore_no_auto_restore', 03:24:23 INFO - 'tabpaint']}, 03:24:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:24:23 INFO - 'ts_paint', 03:24:23 INFO - 'tpaint', 03:24:23 INFO - 'sessionrestore', 03:24:23 INFO - 'sessionrestore_no_auto_restore', 03:24:23 INFO - 'tabpaint']}, 03:24:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:24:23 INFO - 'ts_paint', 03:24:23 INFO - 'tpaint', 03:24:23 INFO - 'sessionrestore', 03:24:23 INFO - 'sessionrestore_no_auto_restore', 03:24:23 INFO - 'tabpaint']}, 03:24:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['a11yr', 03:24:23 INFO - 'ts_paint', 03:24:23 INFO - 'tpaint', 03:24:23 INFO - 'sessionrestore', 03:24:23 INFO - 'sessionrestore_no_auto_restore', 03:24:23 INFO - 'tabpaint']}, 03:24:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['a11yr', 03:24:23 INFO - 'ts_paint', 03:24:23 INFO - 'tpaint', 03:24:23 INFO - 'sessionrestore', 03:24:23 INFO - 'sessionrestore_no_auto_restore', 03:24:23 INFO - 'tabpaint']}, 03:24:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['tsvgx', 03:24:23 INFO - 'tsvgr_opacity', 03:24:23 INFO - 'tart', 03:24:23 INFO - 'tscrollx', 03:24:23 INFO - 'cart']}, 03:24:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:24:23 INFO - 'tsvgr_opacity', 03:24:23 INFO - 'tart', 03:24:23 INFO - 'tscrollx', 03:24:23 INFO - 'cart']}, 03:24:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'talos_options': ['--disable-e10s'], 03:24:23 INFO - 'tests': ['tp5o']}, 03:24:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'tests': ['tp5o']}, 03:24:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'talos_options': ['--disable-e10s', 03:24:23 INFO - '--xperf_path', 03:24:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:23 INFO - 'tests': ['tp5n']}, 03:24:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:24:23 INFO - 'talos_options': ['--xperf_path', 03:24:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:24:23 INFO - 'tests': ['tp5n']}}, 03:24:23 INFO - 'talos.zip': {'path': '', 03:24:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:24:23 INFO - Running post-action listener: _resource_record_post_action 03:24:23 INFO - [mozharness: 2016-10-06 10:24:23.828535Z] Finished populate-webroot step (success) 03:24:23 INFO - [mozharness: 2016-10-06 10:24:23.828668Z] Running create-virtualenv step. 03:24:23 INFO - Running pre-action listener: _resource_record_pre_action 03:24:23 INFO - Running main action method: create_virtualenv 03:24:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:24:23 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 03:24:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:24:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:24:23 INFO - Using real prefix '/tools/python27' 03:24:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:24:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:24:27 INFO - Installing pip.................done. 03:24:27 INFO - Return code: 0 03:24:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:24:27 INFO - Reading from file tmpfile_stdout 03:24:27 INFO - Output received: 03:24:27 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) 03:24:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:24:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:27 INFO - 'HOME': '/Users/cltbld', 03:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:27 INFO - 'LOGNAME': 'cltbld', 03:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:27 INFO - 'MOZ_NO_REMOTE': '1', 03:24:27 INFO - 'NO_EM_RESTART': '1', 03:24:27 INFO - 'PAGER': '/bin/cat', 03:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:27 INFO - 'PWD': '/builds/slave/test', 03:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:27 INFO - 'SHELL': '/bin/bash', 03:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:27 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:27 INFO - 'USER': 'cltbld', 03:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:27 INFO - 'XPC_FLAGS': '0x0', 03:24:27 INFO - 'XPC_SERVICE_NAME': '0', 03:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:28 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 03:24:28 INFO - Cleaning up... 03:24:28 INFO - Return code: 0 03:24:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:24:28 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')]} 03:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:28 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')]} 03:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:28 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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:28 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 03:24:28 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 03:24:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:28 INFO - 'HOME': '/Users/cltbld', 03:24:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:28 INFO - 'LOGNAME': 'cltbld', 03:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:28 INFO - 'MOZ_NO_REMOTE': '1', 03:24:28 INFO - 'NO_EM_RESTART': '1', 03:24:28 INFO - 'PAGER': '/bin/cat', 03:24:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:28 INFO - 'PWD': '/builds/slave/test', 03:24:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:28 INFO - 'SHELL': '/bin/bash', 03:24:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:28 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:28 INFO - 'USER': 'cltbld', 03:24:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:28 INFO - 'XPC_FLAGS': '0x0', 03:24:28 INFO - 'XPC_SERVICE_NAME': '0', 03:24:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:28 INFO - Downloading/unpacking psutil>=3.1.1 03:24:28 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 03:24:28 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 03:24:28 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 03:24:28 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 03:24:28 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 03:24:28 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 03:24:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:24:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:31 INFO - Installing collected packages: psutil 03:24:31 INFO - Running setup.py install for psutil 03:24:31 INFO - building 'psutil._psutil_osx' extension 03:24:31 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 03:24:31 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 03:24:32 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 03:24:32 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 03:24:32 INFO - building 'psutil._psutil_posix' extension 03:24:32 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 03:24:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:24:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:24:32 INFO - ^ 03:24:32 INFO - 1 warning generated. 03:24:32 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 03:24:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:24:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:24:32 INFO - Successfully installed psutil 03:24:32 INFO - Cleaning up... 03:24:32 INFO - Return code: 0 03:24:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:32 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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:32 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 03:24:32 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 03:24:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:32 INFO - 'HOME': '/Users/cltbld', 03:24:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:32 INFO - 'LOGNAME': 'cltbld', 03:24:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:32 INFO - 'MOZ_NO_REMOTE': '1', 03:24:32 INFO - 'NO_EM_RESTART': '1', 03:24:32 INFO - 'PAGER': '/bin/cat', 03:24:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:32 INFO - 'PWD': '/builds/slave/test', 03:24:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:32 INFO - 'SHELL': '/bin/bash', 03:24:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:32 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:32 INFO - 'USER': 'cltbld', 03:24:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:32 INFO - 'XPC_FLAGS': '0x0', 03:24:32 INFO - 'XPC_SERVICE_NAME': '0', 03:24:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:24:32 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 03:24:32 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 03:24:32 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 03:24:32 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 03:24:32 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 03:24:32 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 03:24:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:24:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:24:35 INFO - Installing collected packages: mozsystemmonitor 03:24:35 INFO - Running setup.py install for mozsystemmonitor 03:24:35 INFO - Successfully installed mozsystemmonitor 03:24:35 INFO - Cleaning up... 03:24:35 INFO - Return code: 0 03:24:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:24:35 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')]} 03:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:35 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')]} 03:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:35 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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:35 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 03:24:35 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 03:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:35 INFO - 'HOME': '/Users/cltbld', 03:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:35 INFO - 'LOGNAME': 'cltbld', 03:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:35 INFO - 'MOZ_NO_REMOTE': '1', 03:24:35 INFO - 'NO_EM_RESTART': '1', 03:24:35 INFO - 'PAGER': '/bin/cat', 03:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:35 INFO - 'PWD': '/builds/slave/test', 03:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:35 INFO - 'SHELL': '/bin/bash', 03:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:35 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:35 INFO - 'USER': 'cltbld', 03:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:35 INFO - 'XPC_FLAGS': '0x0', 03:24:35 INFO - 'XPC_SERVICE_NAME': '0', 03:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:24:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:24:38 INFO - warning: no files found matching '*.txt' 03:24:38 INFO - no previously-included directories found matching 'build' 03:24:38 INFO - no previously-included directories found matching 'dist' 03:24:38 INFO - no previously-included directories found matching '.git*' 03:24:38 INFO - Installing collected packages: jsonschema, functools32 03:24:38 INFO - Running setup.py install for functools32 03:24:38 INFO - warning: no files found matching '*.txt' 03:24:38 INFO - no previously-included directories found matching 'build' 03:24:38 INFO - no previously-included directories found matching 'dist' 03:24:38 INFO - no previously-included directories found matching '.git*' 03:24:38 INFO - Successfully installed jsonschema functools32 03:24:38 INFO - Cleaning up... 03:24:38 INFO - Return code: 0 03:24:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:24:38 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')]} 03:24:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:38 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')]} 03:24:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24: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', '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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:24: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 functools32==3.2.3-2 03:24:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:38 INFO - 'HOME': '/Users/cltbld', 03:24:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:38 INFO - 'LOGNAME': 'cltbld', 03:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:38 INFO - 'MOZ_NO_REMOTE': '1', 03:24:38 INFO - 'NO_EM_RESTART': '1', 03:24:38 INFO - 'PAGER': '/bin/cat', 03:24:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:38 INFO - 'PWD': '/builds/slave/test', 03:24:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:38 INFO - 'SHELL': '/bin/bash', 03:24:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:38 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:38 INFO - 'USER': 'cltbld', 03:24:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:38 INFO - 'XPC_FLAGS': '0x0', 03:24:38 INFO - 'XPC_SERVICE_NAME': '0', 03:24:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:24:39 INFO - Cleaning up... 03:24:39 INFO - Return code: 0 03:24:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:39 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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:39 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 03:24:39 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 03:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:39 INFO - 'HOME': '/Users/cltbld', 03:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:39 INFO - 'LOGNAME': 'cltbld', 03:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:39 INFO - 'MOZ_NO_REMOTE': '1', 03:24:39 INFO - 'NO_EM_RESTART': '1', 03:24:39 INFO - 'PAGER': '/bin/cat', 03:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:39 INFO - 'PWD': '/builds/slave/test', 03:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:39 INFO - 'SHELL': '/bin/bash', 03:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:39 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:39 INFO - 'USER': 'cltbld', 03:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:39 INFO - 'XPC_FLAGS': '0x0', 03:24:39 INFO - 'XPC_SERVICE_NAME': '0', 03:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:24:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:24:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:24:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24: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 03:24:43 INFO - Downloading docopt-0.6.1.tar.gz 03:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:24:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:24:43 INFO - Running setup.py install for blobuploader 03:24:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:24:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:24:43 INFO - Running setup.py install for requests 03:24:43 INFO - Running setup.py install for docopt 03:24:43 INFO - Successfully installed blobuploader requests docopt 03:24:43 INFO - Cleaning up... 03:24:44 INFO - Return code: 0 03:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:44 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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:44 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 03:24:44 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 03:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:44 INFO - 'HOME': '/Users/cltbld', 03:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:44 INFO - 'LOGNAME': 'cltbld', 03:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:44 INFO - 'MOZ_NO_REMOTE': '1', 03:24:44 INFO - 'NO_EM_RESTART': '1', 03:24:44 INFO - 'PAGER': '/bin/cat', 03:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:44 INFO - 'PWD': '/builds/slave/test', 03:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:44 INFO - 'SHELL': '/bin/bash', 03:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:44 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:44 INFO - 'USER': 'cltbld', 03:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:44 INFO - 'XPC_FLAGS': '0x0', 03:24:44 INFO - 'XPC_SERVICE_NAME': '0', 03:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:44 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Y9K5Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:44 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-l6veF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:44 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-2HQc3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:44 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-f31cC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:44 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-OLSTZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:44 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-yAE8VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:44 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-WGcyQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-RLdKzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-d8p9Xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-NufG0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-Oy8Rl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-mIUnbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-J1Ovj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-mOllVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-5SuR_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-ydiTgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:45 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-zYM97E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:46 INFO - Running setup.py install for manifestparser 03:24:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:46 INFO - Running setup.py install for mozcrash 03:24:46 INFO - Running setup.py install for mozdebug 03:24:46 INFO - Running setup.py install for mozdevice 03:24:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:24:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:46 INFO - Running setup.py install for mozfile 03:24:46 INFO - Running setup.py install for mozhttpd 03:24:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:46 INFO - Running setup.py install for mozinfo 03:24:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:47 INFO - Running setup.py install for mozInstall 03:24:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:24:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:24:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:24:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:24:47 INFO - Running setup.py install for mozleak 03:24:47 INFO - Running setup.py install for mozlog 03:24:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:24:47 INFO - Running setup.py install for moznetwork 03:24:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:24:47 INFO - Running setup.py install for mozprocess 03:24:47 INFO - Running setup.py install for mozprofile 03:24:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:24:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:24:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:24:48 INFO - Running setup.py install for mozrunner 03:24:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:24:48 INFO - Running setup.py install for mozscreenshot 03:24:48 INFO - Running setup.py install for moztest 03:24:48 INFO - Running setup.py install for mozversion 03:24:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:24:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:24:48 INFO - Cleaning up... 03:24:48 INFO - Return code: 0 03:24:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:48 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')]} 03:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:48 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')]} 03:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:48 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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:48 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 03:24:48 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 03:24:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:48 INFO - 'HOME': '/Users/cltbld', 03:24:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:48 INFO - 'LOGNAME': 'cltbld', 03:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:48 INFO - 'MOZ_NO_REMOTE': '1', 03:24:48 INFO - 'NO_EM_RESTART': '1', 03:24:48 INFO - 'PAGER': '/bin/cat', 03:24:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:48 INFO - 'PWD': '/builds/slave/test', 03:24:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:48 INFO - 'SHELL': '/bin/bash', 03:24:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:48 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:48 INFO - 'USER': 'cltbld', 03:24:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:48 INFO - 'XPC_FLAGS': '0x0', 03:24:48 INFO - 'XPC_SERVICE_NAME': '0', 03:24:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:48 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-bmBtyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-6xOx1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-w57F_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-YxkYoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-2JQftA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-H4QP_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-DHzDrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-iGBg4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-lMzIQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:49 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)) 03:24:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:49 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-rSzxxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:50 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)) 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:50 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-vAZ0AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:50 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)) 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:50 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-cJzmci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:50 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)) 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:50 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-W61G2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:50 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)) 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:50 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-jH7OEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:50 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)) 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:50 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-IavdDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:50 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)) 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:50 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-BhD_Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:50 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)) 03:24:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:50 INFO - Running setup.py (path:/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/pip-OEzSqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:50 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)) 03:24:50 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)) 03:24:50 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)) 03:24:50 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)) 03:24:50 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)) 03:24:50 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)) 03:24:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:53 INFO - Downloading blessings-1.6.tar.gz 03:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:53 INFO - Installing collected packages: blessings 03:24:53 INFO - Running setup.py install for blessings 03:24:53 INFO - Successfully installed blessings 03:24:53 INFO - Cleaning up... 03:24:53 INFO - Return code: 0 03:24:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:53 INFO - Reading from file tmpfile_stdout 03:24:53 INFO - Current package versions: 03:24:53 INFO - blessings == 1.6 03:24:53 INFO - blobuploader == 1.2.4 03:24:53 INFO - docopt == 0.6.1 03:24:53 INFO - functools32 == 3.2.3-2 03:24:53 INFO - jsonschema == 2.5.1 03:24:53 INFO - manifestparser == 1.1 03:24:53 INFO - mozInstall == 1.12 03:24:53 INFO - mozcrash == 0.17 03:24:53 INFO - mozdebug == 0.1 03:24:53 INFO - mozdevice == 0.48 03:24:53 INFO - mozfile == 1.2 03:24:53 INFO - mozhttpd == 0.7 03:24:53 INFO - mozinfo == 0.9 03:24:53 INFO - mozleak == 0.1 03:24:53 INFO - mozlog == 3.4 03:24:53 INFO - moznetwork == 0.27 03:24:53 INFO - mozprocess == 0.23 03:24:53 INFO - mozprofile == 0.28 03:24:53 INFO - mozrunner == 6.12 03:24:53 INFO - mozscreenshot == 0.1 03:24:53 INFO - mozsystemmonitor == 0.3 03:24:53 INFO - moztest == 0.7 03:24:53 INFO - mozversion == 1.4 03:24:53 INFO - psutil == 3.1.1 03:24:53 INFO - requests == 1.2.3 03:24:53 INFO - wsgiref == 0.1.2 03:24:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:53 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 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:53 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 03:24:53 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 03:24:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:53 INFO - 'HOME': '/Users/cltbld', 03:24:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:53 INFO - 'LOGNAME': 'cltbld', 03:24:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:53 INFO - 'MOZ_NO_REMOTE': '1', 03:24:53 INFO - 'NO_EM_RESTART': '1', 03:24:53 INFO - 'PAGER': '/bin/cat', 03:24:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:53 INFO - 'PWD': '/builds/slave/test', 03:24:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:53 INFO - 'SHELL': '/bin/bash', 03:24:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:53 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:53 INFO - 'USER': 'cltbld', 03:24:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:53 INFO - 'XPC_FLAGS': '0x0', 03:24:53 INFO - 'XPC_SERVICE_NAME': '0', 03:24:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 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)) 03:24:54 INFO - Cleaning up... 03:24:54 INFO - Return code: 0 03:24:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:24:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10118e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101104570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb12c785e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, '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.8GmaN08Akq/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.X0h4bzWSAk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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 03:24:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:24:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:24:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:54 INFO - 'HOME': '/Users/cltbld', 03:24:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:54 INFO - 'LOGNAME': 'cltbld', 03:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:54 INFO - 'MOZ_NO_REMOTE': '1', 03:24:54 INFO - 'NO_EM_RESTART': '1', 03:24:54 INFO - 'PAGER': '/bin/cat', 03:24:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:54 INFO - 'PWD': '/builds/slave/test', 03:24:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:54 INFO - 'SHELL': '/bin/bash', 03:24:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:24:54 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:24:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:54 INFO - 'USER': 'cltbld', 03:24:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:54 INFO - 'XPC_FLAGS': '0x0', 03:24:54 INFO - 'XPC_SERVICE_NAME': '0', 03:24:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:24:54 INFO - Cleaning up... 03:24:54 INFO - Return code: 0 03:24:54 INFO - Running post-action listener: _resource_record_post_action 03:24:54 INFO - Running post-action listener: _start_resource_monitoring 03:24:54 INFO - Starting resource monitoring. 03:24:54 INFO - [mozharness: 2016-10-06 10:24:54.426866Z] Finished create-virtualenv step (success) 03:24:54 INFO - [mozharness: 2016-10-06 10:24:54.427884Z] Running install step. 03:24:54 INFO - Running pre-action listener: _resource_record_pre_action 03:24:54 INFO - Running main action method: install 03:24:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:54 INFO - Reading from file tmpfile_stdout 03:24:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:54 INFO - Reading from file tmpfile_stdout 03:24:54 INFO - Output received: 03:24:54 INFO - Usage: mozinstall [options] installer 03:24:54 INFO - Options: 03:24:54 INFO - -h, --help show this help message and exit 03:24:54 INFO - -d DEST, --destination=DEST 03:24:54 INFO - Directory to install application into. [default: 03:24:54 INFO - "/builds/slave/test"] 03:24:54 INFO - --app=APP Application being installed. [default: firefox] 03:24:54 INFO - mkdir: /builds/slave/test/build/application 03:24:54 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'] 03:24:54 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 03:25:28 INFO - Reading from file tmpfile_stdout 03:25:28 INFO - Output received: 03:25:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:25:28 INFO - Running post-action listener: _resource_record_post_action 03:25:28 INFO - [mozharness: 2016-10-06 10:25:28.939300Z] Finished install step (success) 03:25:28 INFO - [mozharness: 2016-10-06 10:25:28.939446Z] Running run-tests step. 03:25:28 INFO - Running pre-action listener: _resource_record_pre_action 03:25:28 INFO - Running main action method: run_tests 03:25:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:25:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:25:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:25:28 INFO - 2016-10-06 03:25:28.954 screenresolution[1930:15428] starting screenresolution argv=screenresolution get 03:25:28 INFO - 2016-10-06 03:25:28.956 screenresolution[1930:15428] Display 0: 1600x1200x32@60 03:25:28 INFO - 2016-10-06 03:25:28.963 screenresolution[1931:15431] starting screenresolution argv=screenresolution list 03:25:28 INFO - Available Modes on Display 0 03:25:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:25:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:25:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:25:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:25:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:25:29 INFO - Intel Iris: 03:25:29 INFO - Chipset Model: Intel Iris 03:25:29 INFO - Type: GPU 03:25:29 INFO - Bus: Built-In 03:25:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:25:29 INFO - Vendor: Intel (0x8086) 03:25:29 INFO - Device ID: 0x0a2e 03:25:29 INFO - Revision ID: 0x0009 03:25:29 INFO - Displays: 03:25:29 INFO - Display: 03:25:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:25:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:25:29 INFO - Display Serial Number: 1600x1200 60 03:25:29 INFO - Main Display: Yes 03:25:29 INFO - Mirror: Off 03:25:29 INFO - Online: Yes 03:25:29 INFO - Rotation: Supported 03:25:29 INFO - Return code: 0 03:25:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:29 INFO - Python 2.7.3 03:25:29 INFO - Return code: 0 03:25:29 INFO - grabbing minidump binary from tooltool 03:25: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')]} 03:25:29 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 0x100fa2d30>, '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 0x100dc8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f9ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:29 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 03:25:29 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 03:25:29 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 03:25:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:29 INFO - Return code: 0 03:25:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:25:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:25:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:29 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/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 03:25:29 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/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0141 --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 03:25:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8GmaN08Akq/Render', 03:25:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:25:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:25:29 INFO - 'HOME': '/Users/cltbld', 03:25:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:25:29 INFO - 'LOGNAME': 'cltbld', 03:25:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:25:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:29 INFO - 'MOZ_NO_REMOTE': '1', 03:25:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:29 INFO - 'NO_EM_RESTART': '1', 03:25:29 INFO - 'PAGER': '/bin/cat', 03:25:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:25:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:29 INFO - 'PWD': '/builds/slave/test', 03:25:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:25:29 INFO - 'SHELL': '/bin/bash', 03:25:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.X0h4bzWSAk/Listeners', 03:25:29 INFO - 'TMPDIR': '/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/', 03:25:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:25:29 INFO - 'USER': 'cltbld', 03:25:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:25:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:25:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:29 INFO - 'XPC_FLAGS': '0x0', 03:25:29 INFO - 'XPC_SERVICE_NAME': '0', 03:25:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:25:29 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/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0141', '--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 03:25:29 INFO - mozversion application_buildid: 20161006014600 03:25:29 INFO - mozversion application_changeset: 47f0358bfff2a6306198bd9a9b95a8319ca45ecd 03:25:29 INFO - mozversion application_display_name: Nightly 03:25:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:29 INFO - mozversion application_name: Firefox 03:25:29 INFO - mozversion application_remotingname: firefox 03:25:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:25:29 INFO - mozversion application_vendor: Mozilla 03:25:29 INFO - mozversion application_version: 52.0a1 03:25:29 INFO - mozversion platform_buildid: 20161006014600 03:25:29 INFO - mozversion platform_changeset: 47f0358bfff2a6306198bd9a9b95a8319ca45ecd 03:25:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:25:29 INFO - mozversion platform_version: 52.0a1 03:25:29 INFO - using testdate: 1475749529 03:25:29 INFO - actual date: 1475749529 03:25:29 INFO - starting webserver on 'localhost:53452' 03:25:29 INFO - SUITE-START | Running 2 tests 03:25:29 INFO - TEST-START | dromaeo_css 03:25:29 INFO - operating with platform_type : mac_ 03:25:29 INFO - Initialising browser for dromaeo_css test... 03:25:29 INFO - TEST-INFO | started process 1941 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpesuiHK/profile http://localhost:53452/getInfo.html) 03:25:31 INFO - PROCESS | 1941 | __metrics Screen width/height:1600/1200 03:25:31 INFO - PROCESS | 1941 | colorDepth:24 03:25:31 INFO - PROCESS | 1941 | Browser inner width/height: 1024/689 03:25:31 INFO - PROCESS | 1941 | __metrics 03:25:32 INFO - PROCESS | 1941 | 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" 03:25:32 INFO - PROCESS | 1941 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:25:32 INFO - TEST-INFO | 1941: exit 0 03:25:32 INFO - Browser initialized. 03:25:32 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:32 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpesuiHK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:25:44 INFO - PROCESS | 1943 | RSS: Main: 235704320 03:25:44 INFO - PROCESS | 1943 | 03:26:36 INFO - PROCESS | 1943 | 1475749596006 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] 03:28:48 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53452/tests/dromaeo/cssquery-ext.html) 03:28:51 INFO - PROCESS | 1943 | RSS: Main: 428036096 03:28:51 INFO - PROCESS | 1943 | 03:31:54 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-ext.html (next: http://localhost:53452/tests/dromaeo/cssquery-jquery.html) 03:31:54 INFO - PROCESS | 1943 | RSS: Main: 370712576 03:31:54 INFO - PROCESS | 1943 | 03:34:57 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53452/tests/dromaeo/cssquery-mootools.html) 03:34:57 INFO - PROCESS | 1943 | RSS: Main: 355475456 03:34:57 INFO - PROCESS | 1943 | 03:38:00 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53452/tests/dromaeo/cssquery-prototype.html) 03:38:00 INFO - PROCESS | 1943 | RSS: Main: 343396352 03:38:00 INFO - PROCESS | 1943 | 03:41:03 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53452/tests/dromaeo/cssquery-yui.html) 03:41:04 INFO - PROCESS | 1943 | RSS: Main: 331554816 03:41:04 INFO - PROCESS | 1943 | 03:44:07 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:53452/tests/dromaeo/cssquery-yui.html (next: http://localhost:53452/tests/dromaeo/cssquery-dojo.html) 03:44:08 INFO - PROCESS | 1943 | RSS: Main: 424886272 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | __start_tp_report 03:44:08 INFO - PROCESS | 1943 | _x_x_mozilla_page_load 03:44:08 INFO - PROCESS | 1943 | _x_x_mozilla_page_load_details 03:44:08 INFO - PROCESS | 1943 | |i|pagename|runs| 03:44:08 INFO - PROCESS | 1943 | |0;dojo.html;3335.4830001349783;3336.2493438976226;3339.148517128132;3363.714084302834;3401.0477066421395;4726.62187025038;5592.972035139829;5653.547716182706;5718.971405142968;5726.713664316783;5655.830325090244;5685.147227915814;5807.5644326675565;5809.535237181026;5842.47417732404;5118.129917913945;5184.274201611777;5209.635325527214;5214.296070030536;5235.869103272411;5327;5334.333208348957;5344.652597581165;5344.91982620261;5371.731413429333;5286.127788914824;5322.574194064466;5326.121190003664;5346.010987967219;5403.621746477748;5157.4068982067165;5193.246979187997;5203.8178663746585;5211.114110601206;5248.21276808478;4975.104481193383;4982.003599280122;4987.925181122286;4988.775505102243;5003.949960500385;5457.590680698924;5466.098093814516;5488.1493368527945;5490.423505531901;5498.395176530578;5887.058070708709;5902.586818922677;6117.908231376533;6120.873812997669;6144.556029333103;6216.564840461169;6226.62640241587;6227.09707092469;6255.87488250237;6262.5929314594405;4863.319135321058;5752.453516915886;5753.798617048383;5763.884722305573;5770.509506691894;6109.404666050326;6146.661933593606;6222.502199824004;6227.719752611143;6238.407351301619;6126.855735137944;6179.5056395488255;6181.320054793969;6183.474404675563;6187.566870319034;6241.906371404432;6256.812295631138;6265.843353916098;6269.373062693694;6276.780312689034;6072.908906366408;6078.3921607838865;6219.502439804804;6221.346758590374;6229.2524897012645;6093.021180832706;6148.432149801862;6193.256809182837;6218.502519798405;6247.625142491465;4917;4923.556879880828;4933.235348520985;4936.3829521309835;4966.503349665077;4454.22051141049;4456.019675671347;4474.284114541658;4484.080763443486;4528.637708983273;5514.751836167382;5643.943560564424;5650.576206784508;5693.202951586781;5756.597038207369;6159.722812473449;6169.2288463942;6212.347703491158;6224.408681175281;6267.0286105653695;5726.656400615893;5753.33836608787;5758.452946970031;5761.711914404347;5785.30576330843;5330.706811125426;5371.865703357369;5392.299001129828;5393.110136827458;5398;6150.923588372107;6206.72069756871;6243;6250.343713909974;6270.905936410957;6231.9688401557705;6252.437280644764;6257.7184026718;6275.560710750204;6277.058441233668;6201.503879689524;6303.558750887577;6317.652529110943;6319.52603554726;6328.588641738273;6035.78874739382;6077.848053798691;6141.324454309933;6162.168107305636;6180.196574445473;6151.138840562415;6166.784162554289;6192.783252586138;6208.565400421927;6253.718582663882;6126.877462450637;6130.448259656652;6146.508279337731;6150.04674275488;6157;5951.791687290924;6076.214718874034;6113.602615829956;6117.755289788537;6124.234470691164;5777.133429985536;5828.6211396259105;5832.358440571618;5901.616394934315;5967.850803729768;6102.004547214632;6119.015143218386;6129.786714141161;6133.548895741652;6135.569531795875;4867.245576935581;5742.224799651994;5745.540356771532;5801.622894511843;5831.912521312099 03:44:08 INFO - PROCESS | 1943 | |1;ext.html;479.539641943734;497.8201662060914;526.2238198656979;527.7176461199285;536.1582315764247;40438.39342409863;41714.957126071866;41772.79113604432;43926.34110488345;44048;42591.57408425915;42910;42962;42968.140637187236;43010;9622.08590183935;9799.706008819747;9805.460699661517;9830.361026533288;9844.114029737322;9667.854982175273;9767.853482197772;9772.804543909118;9776.804463910717;9783.804323913517;9740;9808.950955245215;9818.656347027856;9823.607055717763;9824.705258842247;9705.223582113449;9740.318177727562;9754.658586949423;9763;9789.21686265097;9659.565319560566;9747.025297470267;9752.171065459444;9752.658656947044;9756.365836220622;40259.59740402588;40570.1885962282;40633;40674.79662601698;40750;3316.651751566075;3332.9333413331597;3347.364000839857;3361.848716807725;3410.5907291124977;30524.69475305241;30986.070417887273;30995.690043099505;31510.560902953515;31549.842250788828;3198.616166060064;3241.5137729340554;3265.6571060038827;3286.2441638423056;3367.9494807577908;505638;507146;507660;508216;508964.45517772547;47324.7633761829;58054.70972645194;59328.70335648294;59709;59918.10122848161;34125.14687132841;34243.657563424546;34276.657233427846;62078.379216208166;62339.753204935645;16153.273102710406;16330;16341.18294085291;16367.91816040912;16368.345266189219;12425.565105221274;12510.18683785551;12555.932745716535;12564.120511564286;12572.497100116076;18798.53003674919;18837.24651013944;18846.71729924052;18855.905720471583;18881.15034823436;7287.27127287267;7668.431075589629;7914.841703166019;8026.1572534883;8146.796330091795;890.4568213389826;950.2872845365976;1000.2198285337448;1014.6296601740312;1049.2602715085845;29675.109746707203;29800.96396373907;30058;30125.096247112622;30487.542686859713;965.7682156282442;1023.7952409517977;1024.99487502562;1080.2492267873752;1104.6630777612745;14958.027728197632;15494.992825466308;15516.534503964898;15552.222388880511;15954;674351;679577;679802;679855;680615;57506.7124664374;57912.13131803026;57954;57985;58168;1249.194269696059;1288.9548865789652;1361.986380136186;1381.2334154544324;1395.6859706565942;26026.479470410864;30375.088747337617;30892.845535772176;30974;31579.526307105873;49567.75216123896;49941;50089.998200035065;50121.74939125281;50151.74924125502;467594;467758;467812;469303;469887;23260.953257103134;23741.525169496857;26056.609150863133;26349.550774706808;26726.19821405361;46658;46889;47233.763831182;47486;48243.75878120587;36697;36807.35687332926;37064.25871482609;37746.43380349352;38064.809675951445;35899;38290.42564361481;38815.029624259616;39914.2017159661;39947;37611;38200.61799381971;38240.23519529538;38412.03969900663;38451.615483845926;32598.51102233516;33462.996110116736;34408.82795586006;34632.82683586566;34634.13414664654;25012.62481062749;25286.080657498118;25289.62065568981;25782.09762658298;25855.353616159748 03:44:08 INFO - PROCESS | 1943 | |2;jquery.html;300.83454100244865;344.36464722586817;375.498709223187;378.6762318217924;395.61032383102656;19518.512037199078;20537.075831587576;21099.789002109974;21798.237061702843;22009.449763755914;19624.313149039786;20068.555006161972;20174.798252017474;20554.794452055474;21097.367078987616;5105.361829771278;5904.350521442649;6187.628742275478;6200.565960382775;6902.516823822334;6962.443004559648;6972.965135174317;6981.37167654911;7001.299870013009;7004.334588214137;6594.736210551572;6827.590344579341;6854.34883686049;6866.347696968805;6880.965595172017;5852.297724273072;6111.327753947062;6800.659967001655;6833.111695479581;6846.281140480278;6041;6060.15157877893;6063.757449702007;6068.3021452533085;6087.178230938855;12971.02717296197;13090.541831035964;13324.866751332556;13360.799588006188;13534.390952407166;2081.8438617103625;2193.265256139195;2222.6443768997046;2443.64567137764;2684.932876678079;10372.688819335432;10425.530851111718;10453.895461045367;10455.006774356423;10502.422366769824;1788.9642207155914;1816.7184086466618;1848.2884089625456;1894.8389386901993;1918.414883460544;106433.46783266112;112050;112140.439297803;115425;117800.41099794532;11001.22991390611;11233.494492747846;11385.715357115972;11413.600523981788;11556.94221528887;14534.273286335852;14547.636309092357;14560.708785824225;14568;14630.122192668474;8122.9187708123345;8270.421070525126;8279.668813247403;8341.582920853933;8412.453190542596;8098.635561399633;8130.593470326578;8268.338532917352;8298.834023319621;8301.8339633207;4388.410837605764;4463.821447142078;4485.215087359764;4559.430071241095;4565.086982603492;1838.3555938959285;1908.8377487913406;1914.4110388377612;1944.4555524453176;1955.1201959118168;840.7898025493627;866.2636758755008;933.3606479561522;942.3168203052869;1029.4183786160795;19699.40901772949;20566.07452664634;20579.79420205809;20776.68834967477;21047.11885202982;892.5581836990731;913.5614904845711;920.6363486422825;944.8204841080172;1022.1924679503257;8736.519491427905;10436.947815260875;10893.128549716004;10936.671899843017;10966.451677416097;594933;598188;601660;613683;614358;80196.39607207823;98830.01169988351;117719.41140294244;121105;122316;826.3926014379426;982.4891056650501;1030.0163344006455;1030.5980667539666;1034.5034383495963;14231.940132871068;18975.43073707791;19082.236710531422;19117;19213.519662008563;45227.86930326768;50929.745351273006;51665;52741.47258527366;53310.46689533055;60269;73387.26612734018;77273.61363193148;80628.3874322522;83687.5815620918;5363.95402896447;6216.595921265103;6464.2889282177985;7001.089858318386;7163.534370265916;10584.153267738717;12644.431000605178;12973.027022973503;13045.412956417174;13131.868681313064;10824.945875270574;10877.401742904216;11347.659570212907;11382.089432845187;11512.769744605228;10160;10181.981801819758;10501.369917804956;10585.364878107339;11186.720331991766;9334.813303734023;10936.781264374828;11585.710357241136;11609.709757256136;11667.708307292385;7756.88364674519;7790.571518566533;8088.676452941816;8195.016598008038;8261.421700480909;9250.629974800933;10849.294795838561;11024.724381890517;11327.376994265394;11377.54489820431 03:44:08 INFO - PROCESS | 1943 | |3;mootools.html;1523.2155439948424;1541.506717850288;1776.316118294457;1887.4620733091072;1947.357372067218;8477.872831907518;8978.50618215998;9002.774930626738;9005.144511271426;9020.8646870297;7822.256885595873;8130.430869839113;8145.34837213023;8544.95727521363;8793.780155496115;2335.252719129879;2377.0491803278655;2378.95242095158;2379.6787433696404;2380.654805053266;2349.9882500587473;2356.1282325539487;2386.8687222202857;2395.9041638334534;2396.9760302397012;2371.1937941100023;2376.3346263046287;2386.95226095478;2393.652920326552;2399.6040653292184;2343.5430091132234;2362.385779697274;2367.4673198530363;2368.064614477272;2375.168690958168;2324.5002324500315;2349.424391024193;2355.587772139869;2357.0336162173426;2363.1256435118944;8743.956280218557;8955.05971872957;8959.910400895973;8968.148025937526;8975.05761894998;5237;5401.621886467949;5403.459654034605;5422.267993820863;5429.837104886859;3581.94627080594;3600.4239321708665;3652.4521321801676;3666.395044817602;3668.981655091734;1073.7423018475588;1079.1582565598846;1081.9080378167864;1087.9673609791719;1098.8022156011914;11700.414979251003;11849.585264515701;11850.644480665595;11858.229215101077;11876.465559049864;4510.954890451119;4612.146752850734;4787.54518320766;4807.351007613927;4821.63837712173;9917.801643967081;9929.2056635469;9933.652322168833;9935.900640993643;9947.452890091114;5345.946540534623;5350.91973620396;5358.4373640767935;5362.195670649356;5365.973170134124;4404.603585677304;4508.526604706524;4563.018950925501;4852.1508735971065;4897.338859254026;3835.76985380878;3839.9424008639894;3940.527136743609;3964.960350396517;3992.9600703992587;1099.356876227416;1238.195173137468;1269.7143142792982;1284.4990453723055;1284.621036794148;806.9785188103763;854.5214679779343;908.4640062363237;910.4355299714219;949.3591825517748;5469.234307196995;5587.580931430159;5728.513076388554;5881.941180588225;6014.218151640259;900.486722568143;918.3663272342062;945.6595625574788;945.8155659646441;999.7800483893677;3706.2031663192006;3856.5179352580926;3861.38217885137;3972.483577134954;3987.980060099739;10224.182065434747;10690.144788416908;10690.412027338416;10693.83959240612;10708.19688523364;10659;10704.625338113128;10707.785844283071;10727.892721072845;10729.9463502682;7797.259260370256;8147.67409303633;8189.426740128134;8401;8431.915680843113;5153.3558305211845;5576.5817563683695;5881.117832325185;5925.85185370352;5945.851353716192;9220.907790922272;9765.951170244103;9852.852207217042;9892.406455612687;10133.240006999651;9728.951355243178;10097.242706796873;10339.379637221791;10465.476726163814;10495.47522623881;7013.368796808311;7260.89108663381;7266.745663901738;7469.813254668677;7655.46411751172;7660.310572048543;8393.916060839314;8404.36967227448;8477.406581539233;8577.228049475327;7461.962690186514;7553.471257011956;7622.466427350032;7623.542587444771;7726.652300646372;7461.104667439725;7504.099508059068;7564.243575642392;7632.96183519101;7766.534007959541;6832.59004459734;7009.12385951756;7017.543859649107;7030.050943122613;7032.683529241094;4954.752262386938;5046.896158862347;5154.61340399464;5167.121589329748;5238.057149712936;5120.718360490208;5154.407243167084;5186.092433824141;5254.003478678078;5303.098473259478 03:44:08 INFO - PROCESS | 1943 | |4;prototype.html;300.4036986581636;301.81287601686955;309.8234006616229;314.78122704720215;317.3367661587282;4472.753998530079;4874.122657921573;5199.986002729469;5317.78728850846;5427.294451721281;4938.876283198223;5040.344755181831;5097.7960881564695;5176.456472070426;5363.141897296433;4050.696197785178;4053.898652533681;4076.0217547788466;4078.775667338295;4086.346184610463;3573.8213089345427;3716.535433070866;4064.593540645941;4088.6729061674996;4113.753174809521;3714.7213958953052;3990.940135897964;4063.349864021757;4064.5528991811025;4075.735077219986;3863.555691095532;3988.66096381805;4035.2131334389805;4049.068714195722;4066.329055705805;3476.5132881396626;3477.200243943907;3481.7562770605814;3487.5640544931885;3515.771474854126;4901.754912254373;5137.6403651744395;5184.870378240536;5198.532132108128;5268.209768534713;4180.372944058385;4371.606555410029;4541.523140070278;4551.4083169188125;4609.101225261075;5511.173324001392;5523.364813046511;5541.171413433557;5564.972175139139;5568.777248910039;3256.459961230244;3782.9596860863207;3808.9428658570146;3815.828287727059;3859.8349353530116;4664.137134630104;5077.796888124471;5638.40796716343;5788.623739456964;5877.9412205877825;3429.8456569454434;3874.41883717439;3877.418387241936;3892.4550562921213;3909.6481316681065;3547.3614749345365;3854.4004238240814;3931.6264954829244;3970.166265084307;4006.8797936061965;4061.720558024213;4251.511076226274;4291.785410729451;4622.237330840374;4645.372874661877;5520.972395137998;5540.972295138498;5564.805231816867;5573.721313934287;5718.228039214736;1185.2414454748969;1250.9249445033327;1315.316395014383;1332.4869925078915;1335.0988083043906;789.6722860013031;831.4013909984801;854.9615267312986;855.9101294364127;867.418829384314;5157.664751791197;5170.5346518813485;5195.558377537952;5206.349206349207;5270.1040823060175;5055.823046193365;5617.915731264035;5626.43735626434;5704.8859022819315;5707.1724599933605;4593.816247350135;4753.595944344769;4991.201407774739;4991.3511243538105;5202.3497062867145;2613.0723593124167;2680.2629276948996;2928.6632037315553;2930.256497384053;3017.532282496217;4867.878303042452;5308.654937429054;5347.625666203328;5755.568332375088;5797.681127537941;5370.194470829407;5613.221455379613;5671;5687.83862132387;5696.287964004499;5698.686572238484;5715.257016587817;5715.31416230055;5772.94227057724;5775.104858746901;4558.5897269245925;4781.497942716104;5099.954509325506;5287.286216360896;5600.479784097254;5076.847694569169;5645.463680950304;5692.943070569241;5695.373508914099;5721.22763426932;5748.712564371681;5989.880202396015;5995.400459954144;6000.459958603747;6009.879802404015;3411.6247212807066;3743.0455233915177;3805.687037972006;3869.922601547897;3881.854852818482;5698.116791897262;5711.942880571141;5724.74238659253;5730.484256416942;5755;5221.389305347327;5585.346960193875;5586.357568879631;5593.916091258553;5634.366033850138;5120.846374608767;5129.512186589426;5475.808346707846;5522.889542209214;5533.253010843485;4439.48945871216;5028.446870844277;5029.874253143701;5256.868578285421;5482.259894914136;4475.6349313459705;4641.605463535638;5050.267711181931;5171.6469006601155;5443.795262918525;4815.879603009953;5490.984167928946;5512.5667326494595;5524.088525393265;5549.667019978814 03:44:08 INFO - PROCESS | 1943 | |5;yui.html;719.3597698048736;733.4828945593357;765.9348955338796;771.0323543952343;797.0435477427089;15189.620259493518;15528;15546.689066218698;15586.298616562239;15586.532404027883;11677.941610291959;13849.16904985699;13907.930460347685;13976.09155404898;14323.498677546288;690.0511796280102;713.4435140590322;713.8215446138465;716.3194964783451;719.2483854372193;693.109354479494;864.749222725412;887.3211992825494;893.4817805672727;896.5651658945407;926.9582868770888;944.4474982135459;946.186279799372;946.2051876423802;947.7251597036851;940.3464592108487;940.8588711693233;944.7118628818208;945.9830682016859;951.9952400238024;549.7690969792696;561.668615516847;564.9378568357478;700.982475438113;708.5748550869489;12327.321997290146;12378.81431778524;13744.65638359039;14304.642383940381;14383.065100768417;13906.443742250298;14387.352569134415;14442.061266017676;14468.98717089804;14480.493182738554;11607.651770446815;11780.410979450993;11889.227200231957;12019.57931472403;12338.81491777624;3835.827387767557;3876.9418458723144;3905.394663827083;4030.1939612077704;4041.515018197835;110728;111978.44010779976;112349.87650123476;113555;113888;10930;10996;11050.668479945614;11104.666859994213;11385.08919286455;22031.66952495714;22368.776312236994;22368.888155559118;22402.775972240393;23027.07891684314;7790.220977902164;7888.368930485547;7973.880391794128;7985.480943738638;8000.35997120229;4261.850835220753;4271.9960809209815;4276.17282532132;4323.54602766705;4381.759003254851;3488.110531814371;3625.836837342326;3629.4374371972385;3632.4551317302617;3866.8066596670055;731.7329174851141;732.1141418883211;733.5525329548971;752.3943225703252;754.087554059594;612.5038718637918;650.4276236911583;666.2571233075183;667.172705844749;687.1101923009714;8723.956380218058;9216.447013179231;9252.028537003653;9274.489903055262;9325.766855828522;602.9366916473795;640.8878446271884;664.8603793203481;667.4560233409755;669.1568623534382;4101.671866250693;4498.707584007029;4509.751963641966;4577.61090307321;4629.930551041737;99156.50421747845;105820.41269380966;130917;134249;139796;113021;120825.39587302183;126704.09943850849;126993;130388;104613.47693261485;118756;122865;123148;126511.36744316219;9564.18704410105;9703.641490191238;9752.024797520191;9818.950905245429;9941.552630131517;65944.6702766483;66754;66860.66569667315;67571;67664.95507702067;83378;94616.80747887872;101217;102892;103145.48427257816;11438;13005.284709341076;13582.388792504558;14303.785443218569;14556.344964476835;14606.415743370146;14671.92664036673;14795;15125.697486049998;15180.772288415903;13407.396667150197;13439.328033598085;13878.791818122534;14032;14187.574372768833;13354;13778.448862045807;13798.310084495935;13903.930480347939;14210.147391156564;13177.882008863571;13564.253966031964;13760.518381856988;13809.171449713049;14217.64455888611;11057.673079230544;11269.549218031187;11290.379029153475;11486;11518.136139789716;8300.501969881827;10043.4476103815;10576.735581610214;10734.491513564166;11864.22882512634 03:44:08 INFO - PROCESS | 1943 | __end_tp_report 03:44:08 INFO - PROCESS | 1943 | __start_cc_report 03:44:08 INFO - PROCESS | 1943 | _x_x_mozilla_cycle_collect,2256 03:44:08 INFO - PROCESS | 1943 | __end_cc_report 03:44:08 INFO - PROCESS | 1943 | __startTimestamp1475750648160__endTimestamp 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | ------- Summary: start ------- 03:44:08 INFO - PROCESS | 1943 | Number of tests: 6 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | [#0] dojo.html Cycles:165 Average:5704.99 Median:5842.47 stddev:637.58 (10.9%) stddev-sans-first:611.84 03:44:08 INFO - PROCESS | 1943 | Values: 3335.5 3336.2 3339.1 3363.7 3401.0 4726.6 5593.0 5653.5 5719.0 5726.7 5655.8 5685.1 5807.6 5809.5 5842.5 5118.1 5184.3 5209.6 5214.3 5235.9 5327.0 5334.3 5344.7 5344.9 5371.7 5286.1 5322.6 5326.1 5346.0 5403.6 5157.4 5193.2 5203.8 5211.1 5248.2 4975.1 4982.0 4987.9 4988.8 5003.9 5457.6 5466.1 5488.1 5490.4 5498.4 5887.1 5902.6 6117.9 6120.9 6144.6 6216.6 6226.6 6227.1 6255.9 6262.6 4863.3 5752.5 5753.8 5763.9 5770.5 6109.4 6146.7 6222.5 6227.7 6238.4 6126.9 6179.5 6181.3 6183.5 6187.6 6241.9 6256.8 6265.8 6269.4 6276.8 6072.9 6078.4 6219.5 6221.3 6229.3 6093.0 6148.4 6193.3 6218.5 6247.6 4917.0 4923.6 4933.2 4936.4 4966.5 4454.2 4456.0 4474.3 4484.1 4528.6 5514.8 5643.9 5650.6 5693.2 5756.6 6159.7 6169.2 6212.3 6224.4 6267.0 5726.7 5753.3 5758.5 5761.7 5785.3 5330.7 5371.9 5392.3 5393.1 5398.0 6150.9 6206.7 6243.0 6250.3 6270.9 6232.0 6252.4 6257.7 6275.6 6277.1 6201.5 6303.6 6317.7 6319.5 6328.6 6035.8 6077.8 6141.3 6162.2 6180.2 6151.1 6166.8 6192.8 6208.6 6253.7 6126.9 6130.4 6146.5 6150.0 6157.0 5951.8 6076.2 6113.6 6117.8 6124.2 5777.1 5828.6 5832.4 5901.6 5967.9 6102.0 6119.0 6129.8 6133.5 6135.6 4867.2 5742.2 5745.5 5801.6 5831.9 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | [#1] ext.html Cycles:180 Average:68283.61 Median:40349.00 stddev:149490.12 (370.5%) stddev-sans-first:149822.79 03:44:08 INFO - PROCESS | 1943 | Values: 479.5 497.8 526.2 527.7 536.2 40438.4 41715.0 41772.8 43926.3 44048.0 42591.6 42910.0 42962.0 42968.1 43010.0 9622.1 9799.7 9805.5 9830.4 9844.1 9667.9 9767.9 9772.8 9776.8 9783.8 9740.0 9809.0 9818.7 9823.6 9824.7 9705.2 9740.3 9754.7 9763.0 9789.2 9659.6 9747.0 9752.2 9752.7 9756.4 40259.6 40570.2 40633.0 40674.8 40750.0 3316.7 3332.9 3347.4 3361.8 3410.6 30524.7 30986.1 30995.7 31510.6 31549.8 3198.6 3241.5 3265.7 3286.2 3367.9 505638.0 507146.0 507660.0 508216.0 508964.5 47324.8 58054.7 59328.7 59709.0 59918.1 34125.1 34243.7 34276.7 62078.4 62339.8 16153.3 16330.0 16341.2 16367.9 16368.3 12425.6 12510.2 12555.9 12564.1 12572.5 18798.5 18837.2 18846.7 18855.9 18881.2 7287.3 7668.4 7914.8 8026.2 8146.8 890.5 950.3 1000.2 1014.6 1049.3 29675.1 29801.0 30058.0 30125.1 30487.5 965.8 1023.8 1025.0 1080.2 1104.7 14958.0 15495.0 15516.5 15552.2 15954.0 674351.0 679577.0 679802.0 679855.0 680615.0 57506.7 57912.1 57954.0 57985.0 58168.0 1249.2 1289.0 1362.0 1381.2 1395.7 26026.5 30375.1 30892.8 30974.0 31579.5 49567.8 49941.0 50090.0 50121.7 50151.7 467594.0 467758.0 467812.0 469303.0 469887.0 23261.0 23741.5 26056.6 26349.6 26726.2 46658.0 46889.0 47233.8 47486.0 48243.8 36697.0 36807.4 37064.3 37746.4 38064.8 35899.0 38290.4 38815.0 39914.2 39947.0 37611.0 38200.6 38240.2 38412.0 38451.6 32598.5 33463.0 34408.8 34632.8 34634.1 25012.6 25286.1 25289.6 25782.1 25855.4 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | [#2] jquery.html Cycles:180 Average:34007.15 Median:12101.36 stddev:100327.05 (829.1%) stddev-sans-first:100576.57 03:44:08 INFO - PROCESS | 1943 | Values: 300.8 344.4 375.5 378.7 395.6 19518.5 20537.1 21099.8 21798.2 22009.4 19624.3 20068.6 20174.8 20554.8 21097.4 5105.4 5904.4 6187.6 6200.6 6902.5 6962.4 6973.0 6981.4 7001.3 7004.3 6594.7 6827.6 6854.3 6866.3 6881.0 5852.3 6111.3 6800.7 6833.1 6846.3 6041.0 6060.2 6063.8 6068.3 6087.2 12971.0 13090.5 13324.9 13360.8 13534.4 2081.8 2193.3 2222.6 2443.6 2684.9 10372.7 10425.5 10453.9 10455.0 10502.4 1789.0 1816.7 1848.3 1894.8 1918.4 106433.5 112050.0 112140.4 115425.0 117800.4 11001.2 11233.5 11385.7 11413.6 11556.9 14534.3 14547.6 14560.7 14568.0 14630.1 8122.9 8270.4 8279.7 8341.6 8412.5 8098.6 8130.6 8268.3 8298.8 8301.8 4388.4 4463.8 4485.2 4559.4 4565.1 1838.4 1908.8 1914.4 1944.5 1955.1 840.8 866.3 933.4 942.3 1029.4 19699.4 20566.1 20579.8 20776.7 21047.1 892.6 913.6 920.6 944.8 1022.2 8736.5 10436.9 10893.1 10936.7 10966.5 594933.0 598188.0 601660.0 613683.0 614358.0 80196.4 98830.0 117719.4 121105.0 122316.0 826.4 982.5 1030.0 1030.6 1034.5 14231.9 18975.4 19082.2 19117.0 19213.5 45227.9 50929.7 51665.0 52741.5 53310.5 60269.0 73387.3 77273.6 80628.4 83687.6 5364.0 6216.6 6464.3 7001.1 7163.5 10584.2 12644.4 12973.0 13045.4 13131.9 10824.9 10877.4 11347.7 11382.1 11512.8 10160.0 10182.0 10501.4 10585.4 11186.7 9334.8 10936.8 11585.7 11609.7 11667.7 7756.9 7790.6 8088.7 8195.0 8261.4 9250.6 10849.3 11024.7 11327.4 11377.5 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | [#3] mootools.html Cycles:180 Average:5726.66 Median:5160.87 stddev:3198.01 (62.0%) stddev-sans-first:3191.38 03:44:08 INFO - PROCESS | 1943 | Values: 1523.2 1541.5 1776.3 1887.5 1947.4 8477.9 8978.5 9002.8 9005.1 9020.9 7822.3 8130.4 8145.3 8545.0 8793.8 2335.3 2377.0 2379.0 2379.7 2380.7 2350.0 2356.1 2386.9 2395.9 2397.0 2371.2 2376.3 2387.0 2393.7 2399.6 2343.5 2362.4 2367.5 2368.1 2375.2 2324.5 2349.4 2355.6 2357.0 2363.1 8744.0 8955.1 8959.9 8968.1 8975.1 5237.0 5401.6 5403.5 5422.3 5429.8 3581.9 3600.4 3652.5 3666.4 3669.0 1073.7 1079.2 1081.9 1088.0 1098.8 11700.4 11849.6 11850.6 11858.2 11876.5 4511.0 4612.1 4787.5 4807.4 4821.6 9917.8 9929.2 9933.7 9935.9 9947.5 5345.9 5350.9 5358.4 5362.2 5366.0 4404.6 4508.5 4563.0 4852.2 4897.3 3835.8 3839.9 3940.5 3965.0 3993.0 1099.4 1238.2 1269.7 1284.5 1284.6 807.0 854.5 908.5 910.4 949.4 5469.2 5587.6 5728.5 5881.9 6014.2 900.5 918.4 945.7 945.8 999.8 3706.2 3856.5 3861.4 3972.5 3988.0 10224.2 10690.1 10690.4 10693.8 10708.2 10659.0 10704.6 10707.8 10727.9 10729.9 7797.3 8147.7 8189.4 8401.0 8431.9 5153.4 5576.6 5881.1 5925.9 5945.9 9220.9 9766.0 9852.9 9892.4 10133.2 9729.0 10097.2 10339.4 10465.5 10495.5 7013.4 7260.9 7266.7 7469.8 7655.5 7660.3 8393.9 8404.4 8477.4 8577.2 7462.0 7553.5 7622.5 7623.5 7726.7 7461.1 7504.1 7564.2 7633.0 7766.5 6832.6 7009.1 7017.5 7030.1 7032.7 4954.8 5046.9 5154.6 5167.1 5238.1 5120.7 5154.4 5186.1 5254.0 5303.1 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | [#4] prototype.html Cycles:180 Average:4485.54 Median:5066.34 stddev:1372.58 (27.1%) stddev-sans-first:1340.01 03:44:08 INFO - PROCESS | 1943 | Values: 300.4 301.8 309.8 314.8 317.3 4472.8 4874.1 5200.0 5317.8 5427.3 4938.9 5040.3 5097.8 5176.5 5363.1 4050.7 4053.9 4076.0 4078.8 4086.3 3573.8 3716.5 4064.6 4088.7 4113.8 3714.7 3990.9 4063.3 4064.6 4075.7 3863.6 3988.7 4035.2 4049.1 4066.3 3476.5 3477.2 3481.8 3487.6 3515.8 4901.8 5137.6 5184.9 5198.5 5268.2 4180.4 4371.6 4541.5 4551.4 4609.1 5511.2 5523.4 5541.2 5565.0 5568.8 3256.5 3783.0 3808.9 3815.8 3859.8 4664.1 5077.8 5638.4 5788.6 5877.9 3429.8 3874.4 3877.4 3892.5 3909.6 3547.4 3854.4 3931.6 3970.2 4006.9 4061.7 4251.5 4291.8 4622.2 4645.4 5521.0 5541.0 5564.8 5573.7 5718.2 1185.2 1250.9 1315.3 1332.5 1335.1 789.7 831.4 855.0 855.9 867.4 5157.7 5170.5 5195.6 5206.3 5270.1 5055.8 5617.9 5626.4 5704.9 5707.2 4593.8 4753.6 4991.2 4991.4 5202.3 2613.1 2680.3 2928.7 2930.3 3017.5 4867.9 5308.7 5347.6 5755.6 5797.7 5370.2 5613.2 5671.0 5687.8 5696.3 5698.7 5715.3 5715.3 5772.9 5775.1 4558.6 4781.5 5100.0 5287.3 5600.5 5076.8 5645.5 5692.9 5695.4 5721.2 5748.7 5989.9 5995.4 6000.5 6009.9 3411.6 3743.0 3805.7 3869.9 3881.9 5698.1 5711.9 5724.7 5730.5 5755.0 5221.4 5585.3 5586.4 5593.9 5634.4 5120.8 5129.5 5475.8 5522.9 5533.3 4439.5 5028.4 5029.9 5256.9 5482.3 4475.6 4641.6 5050.3 5171.6 5443.8 4815.9 5491.0 5512.6 5524.1 5549.7 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - PROCESS | 1943 | [#5] yui.html Cycles:180 Average:24576.87 Median:13257.59 stddev:38365.06 (289.4%) stddev-sans-first:38430.86 03:44:08 INFO - PROCESS | 1943 | Values: 719.4 733.5 765.9 771.0 797.0 15189.6 15528.0 15546.7 15586.3 15586.5 11677.9 13849.2 13907.9 13976.1 14323.5 690.1 713.4 713.8 716.3 719.2 693.1 864.7 887.3 893.5 896.6 927.0 944.4 946.2 946.2 947.7 940.3 940.9 944.7 946.0 952.0 549.8 561.7 564.9 701.0 708.6 12327.3 12378.8 13744.7 14304.6 14383.1 13906.4 14387.4 14442.1 14469.0 14480.5 11607.7 11780.4 11889.2 12019.6 12338.8 3835.8 3876.9 3905.4 4030.2 4041.5 110728.0 111978.4 112349.9 113555.0 113888.0 10930.0 10996.0 11050.7 11104.7 11385.1 22031.7 22368.8 22368.9 22402.8 23027.1 7790.2 7888.4 7973.9 7985.5 8000.4 4261.9 4272.0 4276.2 4323.5 4381.8 3488.1 3625.8 3629.4 3632.5 3866.8 731.7 732.1 733.6 752.4 754.1 612.5 650.4 666.3 667.2 687.1 8724.0 9216.4 9252.0 9274.5 9325.8 602.9 640.9 664.9 667.5 669.2 4101.7 4498.7 4509.8 4577.6 4629.9 99156.5 105820.4 130917.0 134249.0 139796.0 113021.0 120825.4 126704.1 126993.0 130388.0 104613.5 118756.0 122865.0 123148.0 126511.4 9564.2 9703.6 9752.0 9819.0 9941.6 65944.7 66754.0 66860.7 67571.0 67665.0 83378.0 94616.8 101217.0 102892.0 103145.5 11438.0 13005.3 13582.4 14303.8 14556.3 14606.4 14671.9 14795.0 15125.7 15180.8 13407.4 13439.3 13878.8 14032.0 14187.6 13354.0 13778.4 13798.3 13903.9 14210.1 13177.9 13564.3 13760.5 13809.2 14217.6 11057.7 11269.5 11290.4 11486.0 11518.1 8300.5 10043.4 10576.7 10734.5 11864.2 03:44:08 INFO - PROCESS | 1943 | -------- Summary: end -------- 03:44:08 INFO - PROCESS | 1943 | 03:44:08 INFO - TEST-INFO | 1943: exit 0 03:44:08 INFO - TEST-OK | dromaeo_css | took 1119236ms 03:44:08 INFO - TEST-START | kraken 03:44:08 INFO - operating with platform_type : mac_ 03:44:08 INFO - Initialising browser for kraken test... 03:44:08 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpCQgcq_/profile http://localhost:53452/getInfo.html) 03:44:10 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 03:44:10 INFO - PROCESS | 1970 | colorDepth:24 03:44:10 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 03:44:10 INFO - PROCESS | 1970 | __metrics 03:44:11 INFO - PROCESS | 1970 | 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" 03:44:11 INFO - PROCESS | 1970 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:44:11 INFO - TEST-INFO | 1970: exit 0 03:44:11 INFO - Browser initialized. 03:44:11 INFO - Running cycle 1/1 for kraken test... 03:44:11 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/T/tmpCQgcq_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:23 INFO - PROCESS | 1971 | RSS: Main: 235839488 03:44:23 INFO - PROCESS | 1971 | 03:44:26 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:27 INFO - PROCESS | 1971 | RSS: Main: 294584320 03:44:27 INFO - PROCESS | 1971 | 03:44:30 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-dft) 03:44:30 INFO - PROCESS | 1971 | RSS: Main: 295288832 03:44:30 INFO - PROCESS | 1971 | 03:44:34 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-fft) 03:44:35 INFO - PROCESS | 1971 | RSS: Main: 383516672 03:44:35 INFO - PROCESS | 1971 | 03:44:37 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53452/tests/kraken/driver.html?testName=audio-oscillator) 03:44:37 INFO - PROCESS | 1971 | RSS: Main: 285757440 03:44:37 INFO - PROCESS | 1971 | 03:44:39 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:40 INFO - PROCESS | 1971 | RSS: Main: 290234368 03:44:40 INFO - PROCESS | 1971 | 03:44:43 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53452/tests/kraken/driver.html?testName=imaging-darkroom) 03:44:43 INFO - PROCESS | 1971 | RSS: Main: 327921664 03:44:43 INFO - PROCESS | 1971 | 03:44:46 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53452/tests/kraken/driver.html?testName=imaging-desaturate) 03:44:47 INFO - PROCESS | 1971 | RSS: Main: 328036352 03:44:47 INFO - PROCESS | 1971 | 03:44:49 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53452/tests/kraken/driver.html?testName=json-parse-financial) 03:44:50 INFO - PROCESS | 1971 | RSS: Main: 326615040 03:44:50 INFO - PROCESS | 1971 | 03:44:52 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:52 INFO - PROCESS | 1971 | RSS: Main: 301498368 03:44:52 INFO - PROCESS | 1971 | 03:44:54 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:55 INFO - PROCESS | 1971 | RSS: Main: 305369088 03:44:55 INFO - PROCESS | 1971 | 03:44:57 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:58 INFO - PROCESS | 1971 | RSS: Main: 312811520 03:44:58 INFO - PROCESS | 1971 | 03:45:01 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:01 INFO - PROCESS | 1971 | RSS: Main: 320450560 03:45:01 INFO - PROCESS | 1971 | 03:45:04 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:05 INFO - PROCESS | 1971 | RSS: Main: 319889408 03:45:05 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:53452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53452/tests/kraken/driver.html?testName=ai-astar) 03:45:07 INFO - PROCESS | 1971 | RSS: Main: 363724800 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | __start_tp_report 03:45:07 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 03:45:07 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 03:45:07 INFO - PROCESS | 1971 | |i|pagename|runs| 03:45:07 INFO - PROCESS | 1971 | |0;ai-astar;113;113;114;112;113;114;113;113;113;113 03:45:07 INFO - PROCESS | 1971 | |1;audio-beat-detection;151;114;123;170;139;143;140;113;145;108 03:45:07 INFO - PROCESS | 1971 | |2;audio-dft;185;184;210;264;184;183;183;184;183;182 03:45:07 INFO - PROCESS | 1971 | |3;audio-fft;81;59;58;89;61;59;59;58;83;58 03:45:07 INFO - PROCESS | 1971 | |4;audio-oscillator;88;69;91;70;68;69;92;67;68;90 03:45:07 INFO - PROCESS | 1971 | |5;imaging-gaussian-blur;87;84;87;85;90;129;88;85;87;83 03:45:07 INFO - PROCESS | 1971 | |6;imaging-darkroom;93;92;93;94;93;93;94;93;94;92 03:45:07 INFO - PROCESS | 1971 | |7;imaging-desaturate;85;86;86;84;86;83;84;86;83;85 03:45:07 INFO - PROCESS | 1971 | |8;json-parse-financial;57;55;55;53;54;54;54;54;53;55 03:45:07 INFO - PROCESS | 1971 | |9;json-stringify-tinderbox;63;72;67;75;71;68;68;71;70;72 03:45:07 INFO - PROCESS | 1971 | |10;stanford-crypto-aes;86;87;89;87;89;90;87;88;92;86 03:45:07 INFO - PROCESS | 1971 | |11;stanford-crypto-ccm;147;147;147;142;154;158;159;152;255;144 03:45:07 INFO - PROCESS | 1971 | |12;stanford-crypto-pbkdf2;174;173;175;170;173;177;171;168;169;172 03:45:07 INFO - PROCESS | 1971 | |13;stanford-crypto-sha256-iterative;67;68;69;67;69;68;69;67;68;68 03:45:07 INFO - PROCESS | 1971 | __end_tp_report 03:45:07 INFO - PROCESS | 1971 | __start_cc_report 03:45:07 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,1894 03:45:07 INFO - PROCESS | 1971 | __end_cc_report 03:45:07 INFO - PROCESS | 1971 | __startTimestamp1475750707427__endTimestamp 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | ------- Summary: start ------- 03:45:07 INFO - PROCESS | 1971 | Number of tests: 14 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:45:07 INFO - PROCESS | 1971 | Values: 113.0 113.0 114.0 112.0 113.0 114.0 113.0 113.0 113.0 113.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:141.50 stddev:19.67 (13.9%) stddev-sans-first:19.95 03:45:07 INFO - PROCESS | 1971 | Values: 151.0 114.0 123.0 170.0 139.0 143.0 140.0 113.0 145.0 108.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#2] audio-dft Cycles:10 Average:194.20 Median:184.00 stddev:25.91 (14.1%) stddev-sans-first:27.27 03:45:07 INFO - PROCESS | 1971 | Values: 185.0 184.0 210.0 264.0 184.0 183.0 183.0 184.0 183.0 182.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#3] audio-fft Cycles:10 Average:66.50 Median:60.00 stddev:12.49 (20.8%) stddev-sans-first:12.10 03:45:07 INFO - PROCESS | 1971 | Values: 81.0 59.0 58.0 89.0 61.0 59.0 59.0 58.0 83.0 58.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.00 stddev:11.30 (14.3%) stddev-sans-first:11.29 03:45:07 INFO - PROCESS | 1971 | Values: 88.0 69.0 91.0 70.0 68.0 69.0 92.0 67.0 68.0 90.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:87.00 stddev:13.68 (15.7%) stddev-sans-first:14.45 03:45:07 INFO - PROCESS | 1971 | Values: 87.0 84.0 87.0 85.0 90.0 129.0 88.0 85.0 87.0 83.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 03:45:07 INFO - PROCESS | 1971 | Values: 93.0 92.0 93.0 94.0 93.0 93.0 94.0 93.0 94.0 92.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:1.23 (1.4%) stddev-sans-first:1.30 03:45:07 INFO - PROCESS | 1971 | Values: 85.0 86.0 86.0 84.0 86.0 83.0 84.0 86.0 83.0 85.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.17 (2.2%) stddev-sans-first:0.78 03:45:07 INFO - PROCESS | 1971 | Values: 57.0 55.0 55.0 53.0 54.0 54.0 54.0 54.0 53.0 55.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:71.00 stddev:3.33 (4.7%) stddev-sans-first:2.51 03:45:07 INFO - PROCESS | 1971 | Values: 63.0 72.0 67.0 75.0 71.0 68.0 68.0 71.0 70.0 72.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.50 stddev:1.91 (2.2%) stddev-sans-first:1.87 03:45:07 INFO - PROCESS | 1971 | Values: 86.0 87.0 89.0 87.0 89.0 90.0 87.0 88.0 92.0 86.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#11] stanford-crypto-ccm Cycles:10 Average:160.50 Median:153.00 stddev:33.69 (22.0%) stddev-sans-first:35.38 03:45:07 INFO - PROCESS | 1971 | Values: 147.0 147.0 147.0 142.0 154.0 158.0 159.0 152.0 255.0 144.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:173.00 stddev:2.78 (1.6%) stddev-sans-first:2.87 03:45:07 INFO - PROCESS | 1971 | Values: 174.0 173.0 175.0 170.0 173.0 177.0 171.0 168.0 169.0 172.0 03:45:07 INFO - PROCESS | 1971 | 03:45:07 INFO - PROCESS | 1971 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 03:45:07 INFO - PROCESS | 1971 | Values: 67.0 68.0 69.0 67.0 69.0 68.0 69.0 67.0 68.0 68.0 03:45:07 INFO - PROCESS | 1971 | -------- Summary: end -------- 03:45:07 INFO - PROCESS | 1971 | 03:45:08 INFO - TEST-INFO | 1971: exit 0 03:45:08 INFO - TEST-OK | kraken | took 59543ms 03:45:08 INFO - SUITE-END | took 1178s 03:45:08 INFO - Completed test suite (00:19:39) 03:45:08 INFO - javascript benchmark 03:45:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3335.4830001349783, 3336.2493438976226, 3339.148517128132, 3363.714084302834, 3401.0477066421395, 4726.62187025038, 5592.972035139829, 5653.547716182706, 5718.971405142968, 5726.713664316783, 5655.830325090244, 5685.147227915814, 5807.5644326675565, 5809.535237181026, 5842.47417732404, 5118.129917913945, 5184.274201611777, 5209.635325527214, 5214.296070030536, 5235.869103272411, 5327.0, 5334.333208348957, 5344.652597581165, 5344.91982620261, 5371.731413429333, 5286.127788914824, 5322.574194064466, 5326.121190003664, 5346.010987967219, 5403.621746477748, 5157.4068982067165, 5193.246979187997, 5203.8178663746585, 5211.114110601206, 5248.21276808478, 4975.104481193383, 4982.003599280122, 4987.925181122286, 4988.775505102243, 5003.949960500385, 5457.590680698924, 5466.098093814516, 5488.1493368527945, 5490.423505531901, 5498.395176530578, 5887.058070708709, 5902.586818922677, 6117.908231376533, 6120.873812997669, 6144.556029333103, 6216.564840461169, 6226.62640241587, 6227.09707092469, 6255.87488250237, 6262.5929314594405, 4863.319135321058, 5752.453516915886, 5753.798617048383, 5763.884722305573, 5770.509506691894, 6109.404666050326, 6146.661933593606, 6222.502199824004, 6227.719752611143, 6238.407351301619, 6126.855735137944, 6179.5056395488255, 6181.320054793969, 6183.474404675563, 6187.566870319034, 6241.906371404432, 6256.812295631138, 6265.843353916098, 6269.373062693694, 6276.780312689034, 6072.908906366408, 6078.3921607838865, 6219.502439804804, 6221.346758590374, 6229.2524897012645, 6093.021180832706, 6148.432149801862, 6193.256809182837, 6218.502519798405, 6247.625142491465, 4917.0, 4923.556879880828, 4933.235348520985, 4936.3829521309835, 4966.503349665077, 4454.22051141049, 4456.019675671347, 4474.284114541658, 4484.080763443486, 4528.637708983273, 5514.751836167382, 5643.943560564424, 5650.576206784508, 5693.202951586781, 5756.597038207369, 6159.722812473449, 6169.2288463942, 6212.347703491158, 6224.408681175281, 6267.0286105653695, 5726.656400615893, 5753.33836608787, 5758.452946970031, 5761.711914404347, 5785.30576330843, 5330.706811125426, 5371.865703357369, 5392.299001129828, 5393.110136827458, 5398.0, 6150.923588372107, 6206.72069756871, 6243.0, 6250.343713909974, 6270.905936410957, 6231.9688401557705, 6252.437280644764, 6257.7184026718, 6275.560710750204, 6277.058441233668, 6201.503879689524, 6303.558750887577, 6317.652529110943, 6319.52603554726, 6328.588641738273, 6035.78874739382, 6077.848053798691, 6141.324454309933, 6162.168107305636, 6180.196574445473, 6151.138840562415, 6166.784162554289, 6192.783252586138, 6208.565400421927, 6253.718582663882, 6126.877462450637, 6130.448259656652, 6146.508279337731, 6150.04674275488, 6157.0, 5951.791687290924, 6076.214718874034, 6113.602615829956, 6117.755289788537, 6124.234470691164, 5777.133429985536, 5828.6211396259105, 5832.358440571618, 5901.616394934315, 5967.850803729768, 6102.004547214632, 6119.015143218386, 6129.786714141161, 6133.548895741652, 6135.569531795875, 4867.245576935581, 5742.224799651994, 5745.540356771532, 5801.622894511843, 5831.912521312099], "value": 5664.515207899517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.539641943734, 497.8201662060914, 526.2238198656979, 527.7176461199285, 536.1582315764247, 40438.39342409863, 41714.957126071866, 41772.79113604432, 43926.34110488345, 44048.0, 42591.57408425915, 42910.0, 42962.0, 42968.140637187236, 43010.0, 9622.08590183935, 9799.706008819747, 9805.460699661517, 9830.361026533288, 9844.114029737322, 9667.854982175273, 9767.853482197772, 9772.804543909118, 9776.804463910717, 9783.804323913517, 9740.0, 9808.950955245215, 9818.656347027856, 9823.607055717763, 9824.705258842247, 9705.223582113449, 9740.318177727562, 9754.658586949423, 9763.0, 9789.21686265097, 9659.565319560566, 9747.025297470267, 9752.171065459444, 9752.658656947044, 9756.365836220622, 40259.59740402588, 40570.1885962282, 40633.0, 40674.79662601698, 40750.0, 3316.651751566075, 3332.9333413331597, 3347.364000839857, 3361.848716807725, 3410.5907291124977, 30524.69475305241, 30986.070417887273, 30995.690043099505, 31510.560902953515, 31549.842250788828, 3198.616166060064, 3241.5137729340554, 3265.6571060038827, 3286.2441638423056, 3367.9494807577908, 505638.0, 507146.0, 507660.0, 508216.0, 508964.45517772547, 47324.7633761829, 58054.70972645194, 59328.70335648294, 59709.0, 59918.10122848161, 34125.14687132841, 34243.657563424546, 34276.657233427846, 62078.379216208166, 62339.753204935645, 16153.273102710406, 16330.0, 16341.18294085291, 16367.91816040912, 16368.345266189219, 12425.565105221274, 12510.18683785551, 12555.932745716535, 12564.120511564286, 12572.497100116076, 18798.53003674919, 18837.24651013944, 18846.71729924052, 18855.905720471583, 18881.15034823436, 7287.27127287267, 7668.431075589629, 7914.841703166019, 8026.1572534883, 8146.796330091795, 890.4568213389826, 950.2872845365976, 1000.2198285337448, 1014.6296601740312, 1049.2602715085845, 29675.109746707203, 29800.96396373907, 30058.0, 30125.096247112622, 30487.542686859713, 965.7682156282442, 1023.7952409517977, 1024.99487502562, 1080.2492267873752, 1104.6630777612745, 14958.027728197632, 15494.992825466308, 15516.534503964898, 15552.222388880511, 15954.0, 674351.0, 679577.0, 679802.0, 679855.0, 680615.0, 57506.7124664374, 57912.13131803026, 57954.0, 57985.0, 58168.0, 1249.194269696059, 1288.9548865789652, 1361.986380136186, 1381.2334154544324, 1395.6859706565942, 26026.479470410864, 30375.088747337617, 30892.845535772176, 30974.0, 31579.526307105873, 49567.75216123896, 49941.0, 50089.998200035065, 50121.74939125281, 50151.74924125502, 467594.0, 467758.0, 467812.0, 469303.0, 469887.0, 23260.953257103134, 23741.525169496857, 26056.609150863133, 26349.550774706808, 26726.19821405361, 46658.0, 46889.0, 47233.763831182, 47486.0, 48243.75878120587, 36697.0, 36807.35687332926, 37064.25871482609, 37746.43380349352, 38064.809675951445, 35899.0, 38290.42564361481, 38815.029624259616, 39914.2017159661, 39947.0, 37611.0, 38200.61799381971, 38240.23519529538, 38412.03969900663, 38451.615483845926, 32598.51102233516, 33462.996110116736, 34408.82795586006, 34632.82683586566, 34634.13414664654, 25012.62481062749, 25286.080657498118, 25289.62065568981, 25782.09762658298, 25855.353616159748], "value": 19765.66460672831, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.83454100244865, 344.36464722586817, 375.498709223187, 378.6762318217924, 395.61032383102656, 19518.512037199078, 20537.075831587576, 21099.789002109974, 21798.237061702843, 22009.449763755914, 19624.313149039786, 20068.555006161972, 20174.798252017474, 20554.794452055474, 21097.367078987616, 5105.361829771278, 5904.350521442649, 6187.628742275478, 6200.565960382775, 6902.516823822334, 6962.443004559648, 6972.965135174317, 6981.37167654911, 7001.299870013009, 7004.334588214137, 6594.736210551572, 6827.590344579341, 6854.34883686049, 6866.347696968805, 6880.965595172017, 5852.297724273072, 6111.327753947062, 6800.659967001655, 6833.111695479581, 6846.281140480278, 6041.0, 6060.15157877893, 6063.757449702007, 6068.3021452533085, 6087.178230938855, 12971.02717296197, 13090.541831035964, 13324.866751332556, 13360.799588006188, 13534.390952407166, 2081.8438617103625, 2193.265256139195, 2222.6443768997046, 2443.64567137764, 2684.932876678079, 10372.688819335432, 10425.530851111718, 10453.895461045367, 10455.006774356423, 10502.422366769824, 1788.9642207155914, 1816.7184086466618, 1848.2884089625456, 1894.8389386901993, 1918.414883460544, 106433.46783266112, 112050.0, 112140.439297803, 115425.0, 117800.41099794532, 11001.22991390611, 11233.494492747846, 11385.715357115972, 11413.600523981788, 11556.94221528887, 14534.273286335852, 14547.636309092357, 14560.708785824225, 14568.0, 14630.122192668474, 8122.9187708123345, 8270.421070525126, 8279.668813247403, 8341.582920853933, 8412.453190542596, 8098.635561399633, 8130.593470326578, 8268.338532917352, 8298.834023319621, 8301.8339633207, 4388.410837605764, 4463.821447142078, 4485.215087359764, 4559.430071241095, 4565.086982603492, 1838.3555938959285, 1908.8377487913406, 1914.4110388377612, 1944.4555524453176, 1955.1201959118168, 840.7898025493627, 866.2636758755008, 933.3606479561522, 942.3168203052869, 1029.4183786160795, 19699.40901772949, 20566.07452664634, 20579.79420205809, 20776.68834967477, 21047.11885202982, 892.5581836990731, 913.5614904845711, 920.6363486422825, 944.8204841080172, 1022.1924679503257, 8736.519491427905, 10436.947815260875, 10893.128549716004, 10936.671899843017, 10966.451677416097, 594933.0, 598188.0, 601660.0, 613683.0, 614358.0, 80196.39607207823, 98830.01169988351, 117719.41140294244, 121105.0, 122316.0, 826.3926014379426, 982.4891056650501, 1030.0163344006455, 1030.5980667539666, 1034.5034383495963, 14231.940132871068, 18975.43073707791, 19082.236710531422, 19117.0, 19213.519662008563, 45227.86930326768, 50929.745351273006, 51665.0, 52741.47258527366, 53310.46689533055, 60269.0, 73387.26612734018, 77273.61363193148, 80628.3874322522, 83687.5815620918, 5363.95402896447, 6216.595921265103, 6464.2889282177985, 7001.089858318386, 7163.534370265916, 10584.153267738717, 12644.431000605178, 12973.027022973503, 13045.412956417174, 13131.868681313064, 10824.945875270574, 10877.401742904216, 11347.659570212907, 11382.089432845187, 11512.769744605228, 10160.0, 10181.981801819758, 10501.369917804956, 10585.364878107339, 11186.720331991766, 9334.813303734023, 10936.781264374828, 11585.710357241136, 11609.709757256136, 11667.708307292385, 7756.88364674519, 7790.571518566533, 8088.676452941816, 8195.016598008038, 8261.421700480909, 9250.629974800933, 10849.294795838561, 11024.724381890517, 11327.376994265394, 11377.54489820431], "value": 9333.255195448195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1523.2155439948424, 1541.506717850288, 1776.316118294457, 1887.4620733091072, 1947.357372067218, 8477.872831907518, 8978.50618215998, 9002.774930626738, 9005.144511271426, 9020.8646870297, 7822.256885595873, 8130.430869839113, 8145.34837213023, 8544.95727521363, 8793.780155496115, 2335.252719129879, 2377.0491803278655, 2378.95242095158, 2379.6787433696404, 2380.654805053266, 2349.9882500587473, 2356.1282325539487, 2386.8687222202857, 2395.9041638334534, 2396.9760302397012, 2371.1937941100023, 2376.3346263046287, 2386.95226095478, 2393.652920326552, 2399.6040653292184, 2343.5430091132234, 2362.385779697274, 2367.4673198530363, 2368.064614477272, 2375.168690958168, 2324.5002324500315, 2349.424391024193, 2355.587772139869, 2357.0336162173426, 2363.1256435118944, 8743.956280218557, 8955.05971872957, 8959.910400895973, 8968.148025937526, 8975.05761894998, 5237.0, 5401.621886467949, 5403.459654034605, 5422.267993820863, 5429.837104886859, 3581.94627080594, 3600.4239321708665, 3652.4521321801676, 3666.395044817602, 3668.981655091734, 1073.7423018475588, 1079.1582565598846, 1081.9080378167864, 1087.9673609791719, 1098.8022156011914, 11700.414979251003, 11849.585264515701, 11850.644480665595, 11858.229215101077, 11876.465559049864, 4510.954890451119, 4612.146752850734, 4787.54518320766, 4807.351007613927, 4821.63837712173, 9917.801643967081, 9929.2056635469, 9933.652322168833, 9935.900640993643, 9947.452890091114, 5345.946540534623, 5350.91973620396, 5358.4373640767935, 5362.195670649356, 5365.973170134124, 4404.603585677304, 4508.526604706524, 4563.018950925501, 4852.1508735971065, 4897.338859254026, 3835.76985380878, 3839.9424008639894, 3940.527136743609, 3964.960350396517, 3992.9600703992587, 1099.356876227416, 1238.195173137468, 1269.7143142792982, 1284.4990453723055, 1284.621036794148, 806.9785188103763, 854.5214679779343, 908.4640062363237, 910.4355299714219, 949.3591825517748, 5469.234307196995, 5587.580931430159, 5728.513076388554, 5881.941180588225, 6014.218151640259, 900.486722568143, 918.3663272342062, 945.6595625574788, 945.8155659646441, 999.7800483893677, 3706.2031663192006, 3856.5179352580926, 3861.38217885137, 3972.483577134954, 3987.980060099739, 10224.182065434747, 10690.144788416908, 10690.412027338416, 10693.83959240612, 10708.19688523364, 10659.0, 10704.625338113128, 10707.785844283071, 10727.892721072845, 10729.9463502682, 7797.259260370256, 8147.67409303633, 8189.426740128134, 8401.0, 8431.915680843113, 5153.3558305211845, 5576.5817563683695, 5881.117832325185, 5925.85185370352, 5945.851353716192, 9220.907790922272, 9765.951170244103, 9852.852207217042, 9892.406455612687, 10133.240006999651, 9728.951355243178, 10097.242706796873, 10339.379637221791, 10465.476726163814, 10495.47522623881, 7013.368796808311, 7260.89108663381, 7266.745663901738, 7469.813254668677, 7655.46411751172, 7660.310572048543, 8393.916060839314, 8404.36967227448, 8477.406581539233, 8577.228049475327, 7461.962690186514, 7553.471257011956, 7622.466427350032, 7623.542587444771, 7726.652300646372, 7461.104667439725, 7504.099508059068, 7564.243575642392, 7632.96183519101, 7766.534007959541, 6832.59004459734, 7009.12385951756, 7017.543859649107, 7030.050943122613, 7032.683529241094, 4954.752262386938, 5046.896158862347, 5154.61340399464, 5167.121589329748, 5238.057149712936, 5120.718360490208, 5154.407243167084, 5186.092433824141, 5254.003478678078, 5303.098473259478], "value": 4608.3505681636525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.4036986581636, 301.81287601686955, 309.8234006616229, 314.78122704720215, 317.3367661587282, 4472.753998530079, 4874.122657921573, 5199.986002729469, 5317.78728850846, 5427.294451721281, 4938.876283198223, 5040.344755181831, 5097.7960881564695, 5176.456472070426, 5363.141897296433, 4050.696197785178, 4053.898652533681, 4076.0217547788466, 4078.775667338295, 4086.346184610463, 3573.8213089345427, 3716.535433070866, 4064.593540645941, 4088.6729061674996, 4113.753174809521, 3714.7213958953052, 3990.940135897964, 4063.349864021757, 4064.5528991811025, 4075.735077219986, 3863.555691095532, 3988.66096381805, 4035.2131334389805, 4049.068714195722, 4066.329055705805, 3476.5132881396626, 3477.200243943907, 3481.7562770605814, 3487.5640544931885, 3515.771474854126, 4901.754912254373, 5137.6403651744395, 5184.870378240536, 5198.532132108128, 5268.209768534713, 4180.372944058385, 4371.606555410029, 4541.523140070278, 4551.4083169188125, 4609.101225261075, 5511.173324001392, 5523.364813046511, 5541.171413433557, 5564.972175139139, 5568.777248910039, 3256.459961230244, 3782.9596860863207, 3808.9428658570146, 3815.828287727059, 3859.8349353530116, 4664.137134630104, 5077.796888124471, 5638.40796716343, 5788.623739456964, 5877.9412205877825, 3429.8456569454434, 3874.41883717439, 3877.418387241936, 3892.4550562921213, 3909.6481316681065, 3547.3614749345365, 3854.4004238240814, 3931.6264954829244, 3970.166265084307, 4006.8797936061965, 4061.720558024213, 4251.511076226274, 4291.785410729451, 4622.237330840374, 4645.372874661877, 5520.972395137998, 5540.972295138498, 5564.805231816867, 5573.721313934287, 5718.228039214736, 1185.2414454748969, 1250.9249445033327, 1315.316395014383, 1332.4869925078915, 1335.0988083043906, 789.6722860013031, 831.4013909984801, 854.9615267312986, 855.9101294364127, 867.418829384314, 5157.664751791197, 5170.5346518813485, 5195.558377537952, 5206.349206349207, 5270.1040823060175, 5055.823046193365, 5617.915731264035, 5626.43735626434, 5704.8859022819315, 5707.1724599933605, 4593.816247350135, 4753.595944344769, 4991.201407774739, 4991.3511243538105, 5202.3497062867145, 2613.0723593124167, 2680.2629276948996, 2928.6632037315553, 2930.256497384053, 3017.532282496217, 4867.878303042452, 5308.654937429054, 5347.625666203328, 5755.568332375088, 5797.681127537941, 5370.194470829407, 5613.221455379613, 5671.0, 5687.83862132387, 5696.287964004499, 5698.686572238484, 5715.257016587817, 5715.31416230055, 5772.94227057724, 5775.104858746901, 4558.5897269245925, 4781.497942716104, 5099.954509325506, 5287.286216360896, 5600.479784097254, 5076.847694569169, 5645.463680950304, 5692.943070569241, 5695.373508914099, 5721.22763426932, 5748.712564371681, 5989.880202396015, 5995.400459954144, 6000.459958603747, 6009.879802404015, 3411.6247212807066, 3743.0455233915177, 3805.687037972006, 3869.922601547897, 3881.854852818482, 5698.116791897262, 5711.942880571141, 5724.74238659253, 5730.484256416942, 5755.0, 5221.389305347327, 5585.346960193875, 5586.357568879631, 5593.916091258553, 5634.366033850138, 5120.846374608767, 5129.512186589426, 5475.808346707846, 5522.889542209214, 5533.253010843485, 4439.48945871216, 5028.446870844277, 5029.874253143701, 5256.868578285421, 5482.259894914136, 4475.6349313459705, 4641.605463535638, 5050.267711181931, 5171.6469006601155, 5443.795262918525, 4815.879603009953, 5490.984167928946, 5512.5667326494595, 5524.088525393265, 5549.667019978814], "value": 4043.2762358361765, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.3597698048736, 733.4828945593357, 765.9348955338796, 771.0323543952343, 797.0435477427089, 15189.620259493518, 15528.0, 15546.689066218698, 15586.298616562239, 15586.532404027883, 11677.941610291959, 13849.16904985699, 13907.930460347685, 13976.09155404898, 14323.498677546288, 690.0511796280102, 713.4435140590322, 713.8215446138465, 716.3194964783451, 719.2483854372193, 693.109354479494, 864.749222725412, 887.3211992825494, 893.4817805672727, 896.5651658945407, 926.9582868770888, 944.4474982135459, 946.186279799372, 946.2051876423802, 947.7251597036851, 940.3464592108487, 940.8588711693233, 944.7118628818208, 945.9830682016859, 951.9952400238024, 549.7690969792696, 561.668615516847, 564.9378568357478, 700.982475438113, 708.5748550869489, 12327.321997290146, 12378.81431778524, 13744.65638359039, 14304.642383940381, 14383.065100768417, 13906.443742250298, 14387.352569134415, 14442.061266017676, 14468.98717089804, 14480.493182738554, 11607.651770446815, 11780.410979450993, 11889.227200231957, 12019.57931472403, 12338.81491777624, 3835.827387767557, 3876.9418458723144, 3905.394663827083, 4030.1939612077704, 4041.515018197835, 110728.0, 111978.44010779976, 112349.87650123476, 113555.0, 113888.0, 10930.0, 10996.0, 11050.668479945614, 11104.666859994213, 11385.08919286455, 22031.66952495714, 22368.776312236994, 22368.888155559118, 22402.775972240393, 23027.07891684314, 7790.220977902164, 7888.368930485547, 7973.880391794128, 7985.480943738638, 8000.35997120229, 4261.850835220753, 4271.9960809209815, 4276.17282532132, 4323.54602766705, 4381.759003254851, 3488.110531814371, 3625.836837342326, 3629.4374371972385, 3632.4551317302617, 3866.8066596670055, 731.7329174851141, 732.1141418883211, 733.5525329548971, 752.3943225703252, 754.087554059594, 612.5038718637918, 650.4276236911583, 666.2571233075183, 667.172705844749, 687.1101923009714, 8723.956380218058, 9216.447013179231, 9252.028537003653, 9274.489903055262, 9325.766855828522, 602.9366916473795, 640.8878446271884, 664.8603793203481, 667.4560233409755, 669.1568623534382, 4101.671866250693, 4498.707584007029, 4509.751963641966, 4577.61090307321, 4629.930551041737, 99156.50421747845, 105820.41269380966, 130917.0, 134249.0, 139796.0, 113021.0, 120825.39587302183, 126704.09943850849, 126993.0, 130388.0, 104613.47693261485, 118756.0, 122865.0, 123148.0, 126511.36744316219, 9564.18704410105, 9703.641490191238, 9752.024797520191, 9818.950905245429, 9941.552630131517, 65944.6702766483, 66754.0, 66860.66569667315, 67571.0, 67664.95507702067, 83378.0, 94616.80747887872, 101217.0, 102892.0, 103145.48427257816, 11438.0, 13005.284709341076, 13582.388792504558, 14303.785443218569, 14556.344964476835, 14606.415743370146, 14671.92664036673, 14795.0, 15125.697486049998, 15180.772288415903, 13407.396667150197, 13439.328033598085, 13878.791818122534, 14032.0, 14187.574372768833, 13354.0, 13778.448862045807, 13798.310084495935, 13903.930480347939, 14210.147391156564, 13177.882008863571, 13564.253966031964, 13760.518381856988, 13809.171449713049, 14217.64455888611, 11057.673079230544, 11269.549218031187, 11290.379029153475, 11486.0, 11518.136139789716, 8300.501969881827, 10043.4476103815, 10576.735581610214, 10734.491513564166, 11864.22882512634], "value": 7828.931478835111, "unit": "score"}], "name": "dromaeo_css", "value": 7308.962758101565, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 112.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 123.0, 170.0, 139.0, 143.0, 140.0, 113.0, 145.0, 108.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 210.0, 264.0, 184.0, 183.0, 183.0, 184.0, 183.0, 182.0], "value": 194.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 89.0, 61.0, 59.0, 59.0, 58.0, 83.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 91.0, 70.0, 68.0, 69.0, 92.0, 67.0, 68.0, 90.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 90.0, 129.0, 88.0, 85.0, 87.0, 83.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 94.0, 93.0, 93.0, 94.0, 93.0, 94.0, 92.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 84.0, 86.0, 83.0, 84.0, 86.0, 83.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 53.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 67.0, 75.0, 71.0, 68.0, 68.0, 71.0, 70.0, 72.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 89.0, 87.0, 89.0, 90.0, 87.0, 88.0, 92.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 142.0, 154.0, 158.0, 159.0, 152.0, 255.0, 144.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 175.0, 170.0, 173.0, 177.0, 171.0, 168.0, 169.0, 172.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 69.0, 68.0, 69.0, 67.0, 68.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1466.9, "alertThreshold": 2.0}]} 03:45:08 INFO - Return code: 0 03:45:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:08 INFO - # TBPL SUCCESS # 03:45:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:45:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:45:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:45:08 INFO - 2016-10-06 03:45:08.734 screenresolution[1975:17468] starting screenresolution argv=screenresolution get 03:45:08 INFO - 2016-10-06 03:45:08.736 screenresolution[1975:17468] Display 0: 1600x1200x32@60 03:45:08 INFO - 2016-10-06 03:45:08.743 screenresolution[1976:17471] starting screenresolution argv=screenresolution list 03:45:08 INFO - Available Modes on Display 0 03:45:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:45:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:45:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:45:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:45:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:45:08 INFO - Intel Iris: 03:45:08 INFO - Chipset Model: Intel Iris 03:45:08 INFO - Type: GPU 03:45:08 INFO - Bus: Built-In 03:45:08 INFO - VRAM (Dynamic, Max): 1536 MB 03:45:08 INFO - Vendor: Intel (0x8086) 03:45:08 INFO - Device ID: 0x0a2e 03:45:08 INFO - Revision ID: 0x0009 03:45:08 INFO - Displays: 03:45:08 INFO - Display: 03:45:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:45:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:45:08 INFO - Display Serial Number: 1600x1200 60 03:45:08 INFO - Main Display: Yes 03:45:08 INFO - Mirror: Off 03:45:08 INFO - Online: Yes 03:45:08 INFO - Rotation: Supported 03:45:08 INFO - Return code: 0 03:45:08 INFO - Running post-action listener: _resource_record_post_action 03:45:08 INFO - [mozharness: 2016-10-06 10:45:08.975625Z] Finished run-tests step (success) 03:45:08 INFO - Running post-run listener: _resource_record_post_run 03:45:09 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 729088; Write bytes: 707403776; Read time: 10; Write time: 1977 03:45:09 INFO - TinderboxPrint: CPU usage
53.5% 03:45:09 INFO - TinderboxPrint: I/O read bytes / time
729,088 / 10 03:45:09 INFO - TinderboxPrint: I/O write bytes / time
707,403,776 / 1,977 03:45:09 INFO - TinderboxPrint: CPU idle
2,257.3 (46.5%) 03:45:09 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 03:45:09 INFO - TinderboxPrint: CPU user
1,628.4 (33.5%) 03:45:09 INFO - TinderboxPrint: Swap in / out
408,547,328 / 0 03:45:09 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 397871616; Write bytes: 392930816; Read time: 29510; Write time: 683 03:45:09 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 729088; Write bytes: 295496192; Read time: 10; Write time: 1218 03:45:09 INFO - Running post-run listener: _upload_blobber_files 03:45:09 INFO - Blob upload gear active. 03:45:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:09 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 03:45:09 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'] 03:45:09 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 03:45:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:45:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:10 INFO - (blobuploader) - INFO - Done attempting. 03:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:11 INFO - (blobuploader) - INFO - Done attempting. 03:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:14 INFO - (blobuploader) - INFO - Done attempting. 03:45:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:14 INFO - Return code: 0 03:45:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/29061016ce00a7fc71a41357eb4d94ce9bd4117e93d7ec56ccd0ea6a63c3252a6b58eb516ed002df2615b8650e5d9138f028afb9427d54f5161faf3600245350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b79c6496b53289b3f4da00f7d041ba2125e01893ad6ba2f7998d148a2fac2cf5f78a984771733dcc050d4c65ad0ac3c96c86887d714198de2506df6cc0188ac8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bf99da2ffc61659aebf66374314b4895bdebfe4f806d4a2c6f94e4bd9508ba373f354e50562ce27a30a159f4fec4e9c4c035d9deda626c4f40a0b04e8836df6a"} 03:45:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:14 INFO - Contents: 03:45:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/29061016ce00a7fc71a41357eb4d94ce9bd4117e93d7ec56ccd0ea6a63c3252a6b58eb516ed002df2615b8650e5d9138f028afb9427d54f5161faf3600245350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b79c6496b53289b3f4da00f7d041ba2125e01893ad6ba2f7998d148a2fac2cf5f78a984771733dcc050d4c65ad0ac3c96c86887d714198de2506df6cc0188ac8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bf99da2ffc61659aebf66374314b4895bdebfe4f806d4a2c6f94e4bd9508ba373f354e50562ce27a30a159f4fec4e9c4c035d9deda626c4f40a0b04e8836df6a"} 03:45:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:14 INFO - Copying logs to upload dir... 03:45:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.793214 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-06 03:45:14.783863) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 03:45:14.787220) ========= 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.8GmaN08Akq/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.X0h4bzWSAk/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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/29061016ce00a7fc71a41357eb4d94ce9bd4117e93d7ec56ccd0ea6a63c3252a6b58eb516ed002df2615b8650e5d9138f028afb9427d54f5161faf3600245350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b79c6496b53289b3f4da00f7d041ba2125e01893ad6ba2f7998d148a2fac2cf5f78a984771733dcc050d4c65ad0ac3c96c86887d714198de2506df6cc0188ac8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bf99da2ffc61659aebf66374314b4895bdebfe4f806d4a2c6f94e4bd9508ba373f354e50562ce27a30a159f4fec4e9c4c035d9deda626c4f40a0b04e8836df6a"} build_url:https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011033 build_url: 'https://queue.taskcluster.net/v1/task/DwOdF3ieQxWPndCttG5obw/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/29061016ce00a7fc71a41357eb4d94ce9bd4117e93d7ec56ccd0ea6a63c3252a6b58eb516ed002df2615b8650e5d9138f028afb9427d54f5161faf3600245350", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b79c6496b53289b3f4da00f7d041ba2125e01893ad6ba2f7998d148a2fac2cf5f78a984771733dcc050d4c65ad0ac3c96c86887d714198de2506df6cc0188ac8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bf99da2ffc61659aebf66374314b4895bdebfe4f806d4a2c6f94e4bd9508ba373f354e50562ce27a30a159f4fec4e9c4c035d9deda626c4f40a0b04e8836df6a"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 03:45:14.824312) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:45:14.825078) ========= 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.8GmaN08Akq/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.X0h4bzWSAk/Listeners TMPDIR=/var/folders/h0/9zkb9vkd5vjd65kp5941w0xh00000w/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.005265 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 03:45:14.878387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 03:45:14.879020) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 03:45:14.879722) ========= ========= Total master_lag: 0.19 =========