builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0370 starttime: 1475897736.63 results: success (0) buildid: 20161007184222 builduid: e197d1ed64924d3886e1b182cf8b9fde revision: ef962d8857009eff3a2df14c06e4bc72acb13691 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.628873) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.629293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.629562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.757605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.758014) ========= 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.GBqONagfzZ/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.4QLjJ97chF/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-07 20:35:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2016-10-07 20:35:36 (19.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156449 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.936767) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.937044) ========= 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.GBqONagfzZ/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.4QLjJ97chF/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.027663 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:36.985699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 20:35:36.986046) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ef962d8857009eff3a2df14c06e4bc72acb13691 --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 ef962d8857009eff3a2df14c06e4bc72acb13691 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GBqONagfzZ/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.4QLjJ97chF/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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-07 20:35:37,064 truncating revision to first 12 chars 2016-10-07 20:35:37,064 Setting DEBUG logging. 2016-10-07 20:35:37,064 attempt 1/10 2016-10-07 20:35:37,064 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ef962d885700?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 20:35:38,499 unpacking tar archive at: autoland-ef962d885700/testing/mozharness/ program finished with exit code 0 elapsedTime=1.710959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 20:35:38.718872) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:38.719171) ========= script_repo_revision: ef962d8857009eff3a2df14c06e4bc72acb13691 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:38.723315) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:38.723618) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 20:35:38.741904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-07 20:35:38.742400) ========= /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.GBqONagfzZ/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.4QLjJ97chF/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:35:38 INFO - MultiFileLogger online at 20161007 20:35:38 in /builds/slave/test 20:35:38 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 20:35:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:35:38 INFO - {'append_to_log': False, 20:35:38 INFO - 'base_work_dir': '/builds/slave/test', 20:35:38 INFO - 'blob_upload_branch': 'Autoland', 20:35:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:35:38 INFO - 'branch': 'Autoland', 20:35:38 INFO - 'buildbot_json_path': 'buildprops.json', 20:35:38 INFO - 'config_files': ('talos/mac_config.py',), 20:35:38 INFO - 'default_actions': ('clobber', 20:35:38 INFO - 'read-buildbot-config', 20:35:38 INFO - 'download-and-extract', 20:35:38 INFO - 'populate-webroot', 20:35:38 INFO - 'create-virtualenv', 20:35:38 INFO - 'install', 20:35:38 INFO - 'run-tests'), 20:35:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:35:38 INFO - 'download_minidump_stackwalk': True, 20:35:38 INFO - 'download_symbols': 'ondemand', 20:35:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:35:38 INFO - 'tooltool.py': '/tools/tooltool.py', 20:35:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:35:38 INFO - '/tools/misc-python/virtualenv.py')}, 20:35:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:35:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:35:38 INFO - 'installer_path': 'installer.exe', 20:35:38 INFO - 'log_level': 'info', 20:35:38 INFO - 'log_name': 'talos', 20:35:38 INFO - 'log_to_console': True, 20:35:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:35:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:35:38 INFO - 'opt_config_files': (), 20:35:38 INFO - 'pip_index': False, 20:35:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:35:38 INFO - 'cmd': ('bash', 20:35:38 INFO - '-c', 20:35:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:35:38 INFO - 'enabled': True, 20:35:38 INFO - 'halt_on_failure': False, 20:35:38 INFO - 'name': 'check_screen_resolution'},), 20:35:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:35:38 INFO - 'cmd': ('bash', 20:35:38 INFO - '-c', 20:35:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:35:38 INFO - 'enabled': True, 20:35:38 INFO - 'halt_on_failure': False, 20:35:38 INFO - 'name': 'check_screen_resolution'},), 20:35:38 INFO - 'run_cmd_checks_enabled': True, 20:35:38 INFO - 'sps_profile': False, 20:35:38 INFO - 'sps_profile_interval': 0, 20:35:38 INFO - 'suite': 'dromaeojs', 20:35:38 INFO - 'system_bits': '32', 20:35:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:35:38 INFO - 'title': 't-yosemite-r7-0370', 20:35:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:35:38 INFO - 'use_talos_json': True, 20:35:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:35:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:35:38 INFO - 'work_dir': 'build'} 20:35:38 INFO - [mozharness: 2016-10-08 03:35:38.946679Z] Running clobber step. 20:35:38 INFO - Running pre-action listener: _resource_record_pre_action 20:35:38 INFO - Running main action method: clobber 20:35:38 INFO - rmtree: /builds/slave/test/build 20:35:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:35:41 INFO - Running post-action listener: _resource_record_post_action 20:35:41 INFO - [mozharness: 2016-10-08 03:35:41.192187Z] Finished clobber step (success) 20:35:41 INFO - [mozharness: 2016-10-08 03:35:41.192348Z] Running read-buildbot-config step. 20:35:41 INFO - Running pre-action listener: _resource_record_pre_action 20:35:41 INFO - Running main action method: read_buildbot_config 20:35:41 INFO - Using buildbot properties: 20:35:41 INFO - { 20:35:41 INFO - "project": "", 20:35:41 INFO - "product": "firefox", 20:35:41 INFO - "script_repo_revision": "production", 20:35:41 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 20:35:41 INFO - "repository": "", 20:35:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 20:35:41 INFO - "buildid": "20161007184222", 20:35:41 INFO - "pgo_build": "False", 20:35:41 INFO - "basedir": "/builds/slave/test", 20:35:41 INFO - "buildnumber": 235, 20:35:41 INFO - "slavename": "t-yosemite-r7-0370", 20:35:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 20:35:41 INFO - "platform": "yosemite_r7", 20:35:41 INFO - "scheduler": "tests-autoland-macosx64-talos", 20:35:41 INFO - "branch": "autoland", 20:35:41 INFO - "repo_path": "integration/autoland", 20:35:41 INFO - "revision": "ef962d8857009eff3a2df14c06e4bc72acb13691", 20:35:41 INFO - "stage_platform": "macosx64", 20:35:41 INFO - "builduid": "e197d1ed64924d3886e1b182cf8b9fde", 20:35:41 INFO - "slavebuilddir": "test" 20:35:41 INFO - } 20:35:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 20:35:41 INFO - Running post-action listener: _resource_record_post_action 20:35:41 INFO - [mozharness: 2016-10-08 03:35:41.195696Z] Finished read-buildbot-config step (success) 20:35:41 INFO - [mozharness: 2016-10-08 03:35:41.195796Z] Running download-and-extract step. 20:35:41 INFO - Running pre-action listener: _resource_record_pre_action 20:35:41 INFO - Running main action method: download_and_extract 20:35:41 INFO - mkdir: /builds/slave/test/build/tests 20:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:41 INFO - trying https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 20:35:41 INFO - Downloading https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/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 20:35:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/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 20:35:41 INFO - Downloaded 1199 bytes. 20:35:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 20:35:41 INFO - Using the following test package requirements: 20:35:41 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:35:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 20:35:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 20:35:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'jsshell-mac.zip'], 20:35:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 20:35:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 20:35:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 20:35:41 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 20:35:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 20:35:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 20:35:41 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 20:35:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:35:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:35:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:35:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:35:42 INFO - Http code: 200 20:35:42 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 20:35:42 INFO - x-amz-cf-id: XbOji12xnngycBPdK-5UvY9HxaookIbHFmZmEXCJ2kr-ndyhsVKr7Q== 20:35:42 INFO - x-amz-version-id: 7xLzMRFLsH4PZVolizKz7linyNFgYonh 20:35:42 INFO - Expected file size: 16469068 20:35:42 INFO - Obtained file size: 16469068 20:35:49 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 20:35:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 20:35:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:35:49 INFO - Fetch https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 20:35:49 INFO - Http code: 200 20:35:49 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 20:35:49 INFO - x-amz-cf-id: 5rwWKZlx7fkCJaFLqTWdDJLOs04ABd_mfiT2s6k-LqpOhCN3xRQ_0g== 20:35:49 INFO - x-amz-version-id: 7xLzMRFLsH4PZVolizKz7linyNFgYonh 20:35:50 INFO - Expected file size: 16469068 20:35:50 INFO - Obtained file size: 16469068 20:35:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 20:35:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:35:56 INFO - Fetch https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 20:35:57 INFO - Http code: 200 20:35:57 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 20:35:57 INFO - x-amz-cf-id: UcBvQEus9A-2-HLXYqHC6fC-jSYcMBcgflJlJq42QOa3K0exWx3_3Q== 20:35:57 INFO - x-amz-version-id: dZhD.OHR4KEa9DaOOpf82Uyhguj0HlZB 20:35:58 INFO - Expected file size: 14409006 20:35:58 INFO - Obtained file size: 14409006 20:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:35:58 INFO - trying https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 20:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/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 20:36:01 INFO - Downloaded 111741832 bytes. 20:36:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:36:01 INFO - mkdir: /builds/slave/test/properties 20:36:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:36:01 INFO - Writing to file /builds/slave/test/properties/build_url 20:36:01 INFO - Contents: 20:36:01 INFO - build_url:https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 20:36:02 INFO - Running post-action listener: _resource_record_post_action 20:36:02 INFO - Running post-action listener: set_extra_try_arguments 20:36:02 INFO - [mozharness: 2016-10-08 03:36:02.287362Z] Finished download-and-extract step (success) 20:36:02 INFO - [mozharness: 2016-10-08 03:36:02.287469Z] Running populate-webroot step. 20:36:02 INFO - Running pre-action listener: _resource_record_pre_action 20:36:02 INFO - Running main action method: populate_webroot 20:36:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:36:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:36:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:36:02 INFO - '--tppagecycles', 20:36:02 INFO - '7'], 20:36:02 INFO - 'tests': ['tsvgm']}}, 20:36:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:36:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:36:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:36:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:36:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:36:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['damp', 'tps']}, 20:36:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'tests': ['damp', 'tps']}, 20:36:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['dromaeo_dom']}, 20:36:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:36:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['basic_compositor_video']}, 20:36:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:36:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['a11yr', 20:36:02 INFO - 'ts_paint', 20:36:02 INFO - 'tpaint', 20:36:02 INFO - 'sessionrestore', 20:36:02 INFO - 'sessionrestore_no_auto_restore', 20:36:02 INFO - 'tabpaint']}, 20:36:02 INFO - 'other-e10s': {'tests': ['a11yr', 20:36:02 INFO - 'ts_paint', 20:36:02 INFO - 'tpaint', 20:36:02 INFO - 'sessionrestore', 20:36:02 INFO - 'sessionrestore_no_auto_restore', 20:36:02 INFO - 'tabpaint']}, 20:36:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:36:02 INFO - 'ts_paint', 20:36:02 INFO - 'tpaint', 20:36:02 INFO - 'sessionrestore', 20:36:02 INFO - 'sessionrestore_no_auto_restore', 20:36:02 INFO - 'tabpaint']}, 20:36:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:36:02 INFO - 'ts_paint', 20:36:02 INFO - 'tpaint', 20:36:02 INFO - 'sessionrestore', 20:36:02 INFO - 'sessionrestore_no_auto_restore', 20:36:02 INFO - 'tabpaint']}, 20:36:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['a11yr', 20:36:02 INFO - 'ts_paint', 20:36:02 INFO - 'tpaint', 20:36:02 INFO - 'sessionrestore', 20:36:02 INFO - 'sessionrestore_no_auto_restore', 20:36:02 INFO - 'tabpaint']}, 20:36:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['a11yr', 20:36:02 INFO - 'ts_paint', 20:36:02 INFO - 'tpaint', 20:36:02 INFO - 'sessionrestore', 20:36:02 INFO - 'sessionrestore_no_auto_restore', 20:36:02 INFO - 'tabpaint']}, 20:36:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['tsvgx', 20:36:02 INFO - 'tsvgr_opacity', 20:36:02 INFO - 'tart', 20:36:02 INFO - 'tscrollx', 20:36:02 INFO - 'cart']}, 20:36:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:36:02 INFO - 'tsvgr_opacity', 20:36:02 INFO - 'tart', 20:36:02 INFO - 'tscrollx', 20:36:02 INFO - 'cart']}, 20:36:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'talos_options': ['--disable-e10s'], 20:36:02 INFO - 'tests': ['tp5o']}, 20:36:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'tests': ['tp5o']}, 20:36:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'talos_options': ['--disable-e10s', 20:36:02 INFO - '--xperf_path', 20:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:02 INFO - 'tests': ['tp5n']}, 20:36:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:36:02 INFO - 'talos_options': ['--xperf_path', 20:36:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:36:02 INFO - 'tests': ['tp5n']}}, 20:36:02 INFO - 'talos.zip': {'path': '', 20:36:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:36:02 INFO - Running post-action listener: _resource_record_post_action 20:36:02 INFO - [mozharness: 2016-10-08 03:36:02.306583Z] Finished populate-webroot step (success) 20:36:02 INFO - [mozharness: 2016-10-08 03:36:02.306712Z] Running create-virtualenv step. 20:36:02 INFO - Running pre-action listener: _resource_record_pre_action 20:36:02 INFO - Running main action method: create_virtualenv 20:36:02 INFO - Creating virtualenv /builds/slave/test/build/venv 20:36:02 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 20:36:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:36:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:36:02 INFO - Using real prefix '/tools/python27' 20:36:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:36:03 INFO - Installing distribute.............................................................................................................................................................................................done. 20:36:06 INFO - Installing pip.................done. 20:36:06 INFO - Return code: 0 20:36:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:36:06 INFO - Reading from file tmpfile_stdout 20:36:06 INFO - Output received: 20:36:06 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) 20:36:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:06 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:06 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 20:36:06 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 20:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:06 INFO - 'HOME': '/Users/cltbld', 20:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:06 INFO - 'LOGNAME': 'cltbld', 20:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:06 INFO - 'MOZ_NO_REMOTE': '1', 20:36:06 INFO - 'NO_EM_RESTART': '1', 20:36:06 INFO - 'PAGER': '/bin/cat', 20:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:06 INFO - 'PWD': '/builds/slave/test', 20:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:06 INFO - 'SHELL': '/bin/bash', 20:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:06 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:06 INFO - 'USER': 'cltbld', 20:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:06 INFO - 'XPC_FLAGS': '0x0', 20:36:06 INFO - 'XPC_SERVICE_NAME': '0', 20:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:06 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 20:36:06 INFO - Cleaning up... 20:36:06 INFO - Return code: 0 20:36:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:06 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:06 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 20:36:06 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 20:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:06 INFO - 'HOME': '/Users/cltbld', 20:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:06 INFO - 'LOGNAME': 'cltbld', 20:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:06 INFO - 'MOZ_NO_REMOTE': '1', 20:36:06 INFO - 'NO_EM_RESTART': '1', 20:36:06 INFO - 'PAGER': '/bin/cat', 20:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:06 INFO - 'PWD': '/builds/slave/test', 20:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:06 INFO - 'SHELL': '/bin/bash', 20:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:06 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:06 INFO - 'USER': 'cltbld', 20:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:06 INFO - 'XPC_FLAGS': '0x0', 20:36:06 INFO - 'XPC_SERVICE_NAME': '0', 20:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:07 INFO - Downloading/unpacking psutil>=3.1.1 20:36:07 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 20:36:07 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 20:36:07 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 20:36:07 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 20:36:07 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 20:36:07 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 20:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:36:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:11 INFO - Installing collected packages: psutil 20:36:11 INFO - Running setup.py install for psutil 20:36:11 INFO - building 'psutil._psutil_osx' extension 20:36:11 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 20:36:11 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 20:36:11 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 20:36:11 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 20:36:11 INFO - building 'psutil._psutil_posix' extension 20:36:11 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 20:36:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:36:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:36:12 INFO - ^ 20:36:12 INFO - 1 warning generated. 20:36:12 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 20:36:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:36:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:36:12 INFO - Successfully installed psutil 20:36:12 INFO - Cleaning up... 20:36:12 INFO - Return code: 0 20:36:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:36:12 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')]} 20:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:12 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')]} 20:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:12 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:12 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 20:36:12 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 20:36:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:12 INFO - 'HOME': '/Users/cltbld', 20:36:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:12 INFO - 'LOGNAME': 'cltbld', 20:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:12 INFO - 'MOZ_NO_REMOTE': '1', 20:36:12 INFO - 'NO_EM_RESTART': '1', 20:36:12 INFO - 'PAGER': '/bin/cat', 20:36:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:12 INFO - 'PWD': '/builds/slave/test', 20:36:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:12 INFO - 'SHELL': '/bin/bash', 20:36:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:12 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:12 INFO - 'USER': 'cltbld', 20:36:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:12 INFO - 'XPC_FLAGS': '0x0', 20:36:12 INFO - 'XPC_SERVICE_NAME': '0', 20:36:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:36:12 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 20:36:12 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 20:36:12 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 20:36:12 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 20:36:12 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 20:36:12 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 20:36:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:36:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:36:15 INFO - Installing collected packages: mozsystemmonitor 20:36:15 INFO - Running setup.py install for mozsystemmonitor 20:36:15 INFO - Successfully installed mozsystemmonitor 20:36:15 INFO - Cleaning up... 20:36:15 INFO - Return code: 0 20:36:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:36:15 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')]} 20:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:15 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')]} 20:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:15 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:15 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 20:36:15 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 20:36:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:15 INFO - 'HOME': '/Users/cltbld', 20:36:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:15 INFO - 'LOGNAME': 'cltbld', 20:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:15 INFO - 'MOZ_NO_REMOTE': '1', 20:36:15 INFO - 'NO_EM_RESTART': '1', 20:36:15 INFO - 'PAGER': '/bin/cat', 20:36:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:15 INFO - 'PWD': '/builds/slave/test', 20:36:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:15 INFO - 'SHELL': '/bin/bash', 20:36:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:15 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:15 INFO - 'USER': 'cltbld', 20:36:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:15 INFO - 'XPC_FLAGS': '0x0', 20:36:15 INFO - 'XPC_SERVICE_NAME': '0', 20:36:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:15 INFO - Downloading/unpacking jsonschema==2.5.1 20:36:15 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 20:36:15 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 20:36:15 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 20:36:15 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 20:36:15 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 20:36:15 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 20:36:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:36:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:36:18 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 20:36:18 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 20:36:18 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 20:36:18 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 20:36:18 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 20:36:18 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 20:36:18 INFO - Downloading functools32-3.2.3-2.tar.gz 20:36:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:36:18 INFO - warning: no files found matching '*.txt' 20:36:18 INFO - no previously-included directories found matching 'build' 20:36:18 INFO - no previously-included directories found matching 'dist' 20:36:18 INFO - no previously-included directories found matching '.git*' 20:36:18 INFO - Installing collected packages: jsonschema, functools32 20:36:18 INFO - Running setup.py install for functools32 20:36:18 INFO - warning: no files found matching '*.txt' 20:36:18 INFO - no previously-included directories found matching 'build' 20:36:18 INFO - no previously-included directories found matching 'dist' 20:36:18 INFO - no previously-included directories found matching '.git*' 20:36:18 INFO - Successfully installed jsonschema functools32 20:36:18 INFO - Cleaning up... 20:36:18 INFO - Return code: 0 20:36:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:18 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:18 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 20:36:18 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 20:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:18 INFO - 'HOME': '/Users/cltbld', 20:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:18 INFO - 'LOGNAME': 'cltbld', 20:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:18 INFO - 'MOZ_NO_REMOTE': '1', 20:36:18 INFO - 'NO_EM_RESTART': '1', 20:36:18 INFO - 'PAGER': '/bin/cat', 20:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:18 INFO - 'PWD': '/builds/slave/test', 20:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:18 INFO - 'SHELL': '/bin/bash', 20:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:18 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:18 INFO - 'USER': 'cltbld', 20:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:18 INFO - 'XPC_FLAGS': '0x0', 20:36:18 INFO - 'XPC_SERVICE_NAME': '0', 20:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:36:19 INFO - Cleaning up... 20:36:19 INFO - Return code: 0 20:36:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:19 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:19 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 20:36:19 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 20:36:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:19 INFO - 'HOME': '/Users/cltbld', 20:36:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:19 INFO - 'LOGNAME': 'cltbld', 20:36:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:19 INFO - 'MOZ_NO_REMOTE': '1', 20:36:19 INFO - 'NO_EM_RESTART': '1', 20:36:19 INFO - 'PAGER': '/bin/cat', 20:36:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:19 INFO - 'PWD': '/builds/slave/test', 20:36:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:19 INFO - 'SHELL': '/bin/bash', 20:36:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:19 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:19 INFO - 'USER': 'cltbld', 20:36:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:19 INFO - 'XPC_FLAGS': '0x0', 20:36:19 INFO - 'XPC_SERVICE_NAME': '0', 20:36:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:19 INFO - Downloading/unpacking blobuploader==1.2.4 20:36:19 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 20:36:19 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 20:36:19 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 20:36:19 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 20:36:19 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 20:36:19 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 20:36:21 INFO - Downloading blobuploader-1.2.4.tar.gz 20:36:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:36:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:36:22 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 20:36:22 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 20:36:22 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 20:36:22 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 20:36:22 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 20:36:22 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 20:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:36:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:36:22 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 20:36:22 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 20:36:22 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 20:36:22 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 20:36:22 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 20:36:22 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 20:36:23 INFO - Downloading docopt-0.6.1.tar.gz 20:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:36:23 INFO - Installing collected packages: blobuploader, requests, docopt 20:36:23 INFO - Running setup.py install for blobuploader 20:36:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:36:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:36:23 INFO - Running setup.py install for requests 20:36:23 INFO - Running setup.py install for docopt 20:36:23 INFO - Successfully installed blobuploader requests docopt 20:36:23 INFO - Cleaning up... 20:36:24 INFO - Return code: 0 20:36:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:24 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:24 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 20:36:24 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 20:36:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:24 INFO - 'HOME': '/Users/cltbld', 20:36:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:24 INFO - 'LOGNAME': 'cltbld', 20:36:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:24 INFO - 'MOZ_NO_REMOTE': '1', 20:36:24 INFO - 'NO_EM_RESTART': '1', 20:36:24 INFO - 'PAGER': '/bin/cat', 20:36:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:24 INFO - 'PWD': '/builds/slave/test', 20:36:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:24 INFO - 'SHELL': '/bin/bash', 20:36:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:24 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:24 INFO - 'USER': 'cltbld', 20:36:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:24 INFO - 'XPC_FLAGS': '0x0', 20:36:24 INFO - 'XPC_SERVICE_NAME': '0', 20:36:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:36:24 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-QscFHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:36:24 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-0SdRzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:36:24 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-X6NJvM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:36:24 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-48VM6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:36:24 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-2zUr7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:36:24 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-nw1cVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:36:24 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-yOlKYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-hokjX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-XOW5FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-A9ZOvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-FvX736-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Fe277g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-_2sgCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Mx4L9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-0becPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-6OYOKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:36:25 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-hRIjn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:36:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:36:26 INFO - Running setup.py install for manifestparser 20:36:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:36:26 INFO - Running setup.py install for mozcrash 20:36:26 INFO - Running setup.py install for mozdebug 20:36:26 INFO - Running setup.py install for mozdevice 20:36:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:36:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:36:26 INFO - Running setup.py install for mozfile 20:36:26 INFO - Running setup.py install for mozhttpd 20:36:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Running setup.py install for mozinfo 20:36:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Running setup.py install for mozInstall 20:36:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Running setup.py install for mozleak 20:36:27 INFO - Running setup.py install for mozlog 20:36:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Running setup.py install for moznetwork 20:36:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:36:27 INFO - Running setup.py install for mozprocess 20:36:27 INFO - Running setup.py install for mozprofile 20:36:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:36:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:36:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:36:28 INFO - Running setup.py install for mozrunner 20:36:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:36:28 INFO - Running setup.py install for mozscreenshot 20:36:28 INFO - Running setup.py install for moztest 20:36:28 INFO - Running setup.py install for mozversion 20:36:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:36:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:36:28 INFO - Cleaning up... 20:36:28 INFO - Return code: 0 20:36:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36: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')]} 20:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36: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')]} 20:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:28 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:28 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 20:36:28 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 20:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:28 INFO - 'HOME': '/Users/cltbld', 20:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:28 INFO - 'LOGNAME': 'cltbld', 20:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:28 INFO - 'MOZ_NO_REMOTE': '1', 20:36:28 INFO - 'NO_EM_RESTART': '1', 20:36:28 INFO - 'PAGER': '/bin/cat', 20:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:28 INFO - 'PWD': '/builds/slave/test', 20:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:28 INFO - 'SHELL': '/bin/bash', 20:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:28 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:28 INFO - 'USER': 'cltbld', 20:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:28 INFO - 'XPC_FLAGS': '0x0', 20:36:28 INFO - 'XPC_SERVICE_NAME': '0', 20:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:36:28 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-pXBA1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-sUGAMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Xjedc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-LskJlV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-QnHfiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-chTRs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-aleIrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-K1Z2Sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-Hs_IJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:36:29 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)) 20:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:36:29 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-SS3UfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:36:30 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)) 20:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:36:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-zujV28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:36:30 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)) 20:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:36:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-abXbBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:36:30 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)) 20:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:36:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-xDCXz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:36:30 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)) 20:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:36:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-pKemym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:36:30 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)) 20:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-skdyEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:36:30 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)) 20:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:36:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-waQIqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:36:30 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)) 20:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:36:30 INFO - Running setup.py (path:/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/pip-ur0PfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:36:30 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)) 20:36:30 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)) 20:36:30 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)) 20:36:30 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)) 20:36:30 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)) 20:36:30 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)) 20:36:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:36:33 INFO - Downloading blessings-1.6.tar.gz 20:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:36:33 INFO - Installing collected packages: blessings 20:36:33 INFO - Running setup.py install for blessings 20:36:33 INFO - Successfully installed blessings 20:36:33 INFO - Cleaning up... 20:36:33 INFO - Return code: 0 20:36:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:36:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:36:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:36:33 INFO - Reading from file tmpfile_stdout 20:36:33 INFO - Current package versions: 20:36:33 INFO - blessings == 1.6 20:36:33 INFO - blobuploader == 1.2.4 20:36:33 INFO - docopt == 0.6.1 20:36:33 INFO - functools32 == 3.2.3-2 20:36:33 INFO - jsonschema == 2.5.1 20:36:33 INFO - manifestparser == 1.1 20:36:33 INFO - mozInstall == 1.12 20:36:33 INFO - mozcrash == 0.17 20:36:33 INFO - mozdebug == 0.1 20:36:33 INFO - mozdevice == 0.48 20:36:33 INFO - mozfile == 1.2 20:36:33 INFO - mozhttpd == 0.7 20:36:33 INFO - mozinfo == 0.9 20:36:33 INFO - mozleak == 0.1 20:36:33 INFO - mozlog == 3.4 20:36:33 INFO - moznetwork == 0.27 20:36:33 INFO - mozprocess == 0.23 20:36:33 INFO - mozprofile == 0.28 20:36:33 INFO - mozrunner == 6.12 20:36:33 INFO - mozscreenshot == 0.1 20:36:33 INFO - mozsystemmonitor == 0.3 20:36:33 INFO - moztest == 0.7 20:36:33 INFO - mozversion == 1.4 20:36:33 INFO - psutil == 3.1.1 20:36:33 INFO - requests == 1.2.3 20:36:33 INFO - wsgiref == 0.1.2 20:36:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:33 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 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:33 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 20:36:33 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 20:36:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:33 INFO - 'HOME': '/Users/cltbld', 20:36:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:33 INFO - 'LOGNAME': 'cltbld', 20:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:33 INFO - 'MOZ_NO_REMOTE': '1', 20:36:33 INFO - 'NO_EM_RESTART': '1', 20:36:33 INFO - 'PAGER': '/bin/cat', 20:36:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:33 INFO - 'PWD': '/builds/slave/test', 20:36:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:33 INFO - 'SHELL': '/bin/bash', 20:36:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:33 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:33 INFO - 'USER': 'cltbld', 20:36:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:33 INFO - 'XPC_FLAGS': '0x0', 20:36:33 INFO - 'XPC_SERVICE_NAME': '0', 20:36:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 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)) 20:36:34 INFO - Cleaning up... 20:36:34 INFO - Return code: 0 20:36:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:36:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10924f490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1091c5570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e835685a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, '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.GBqONagfzZ/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.4QLjJ97chF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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 20:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:36:34 INFO - 'HOME': '/Users/cltbld', 20:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:36:34 INFO - 'LOGNAME': 'cltbld', 20:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:36:34 INFO - 'MOZ_NO_REMOTE': '1', 20:36:34 INFO - 'NO_EM_RESTART': '1', 20:36:34 INFO - 'PAGER': '/bin/cat', 20:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:36:34 INFO - 'PWD': '/builds/slave/test', 20:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:36:34 INFO - 'SHELL': '/bin/bash', 20:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:36:34 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:36:34 INFO - 'USER': 'cltbld', 20:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:36:34 INFO - 'XPC_FLAGS': '0x0', 20:36:34 INFO - 'XPC_SERVICE_NAME': '0', 20:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:36:34 INFO - Cleaning up... 20:36:34 INFO - Return code: 0 20:36:34 INFO - Running post-action listener: _resource_record_post_action 20:36:34 INFO - Running post-action listener: _start_resource_monitoring 20:36:34 INFO - Starting resource monitoring. 20:36:34 INFO - [mozharness: 2016-10-08 03:36:34.533400Z] Finished create-virtualenv step (success) 20:36:34 INFO - [mozharness: 2016-10-08 03:36:34.534508Z] Running install step. 20:36:34 INFO - Running pre-action listener: _resource_record_pre_action 20:36:34 INFO - Running main action method: install 20:36:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:36:34 INFO - Reading from file tmpfile_stdout 20:36:34 INFO - Detecting whether we're running mozinstall >=1.0... 20:36:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:36:34 INFO - Reading from file tmpfile_stdout 20:36:34 INFO - Output received: 20:36:34 INFO - Usage: mozinstall [options] installer 20:36:34 INFO - Options: 20:36:34 INFO - -h, --help show this help message and exit 20:36:34 INFO - -d DEST, --destination=DEST 20:36:34 INFO - Directory to install application into. [default: 20:36:34 INFO - "/builds/slave/test"] 20:36:34 INFO - --app=APP Application being installed. [default: firefox] 20:36:34 INFO - mkdir: /builds/slave/test/build/application 20:36:34 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'] 20:36:34 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 20:37:09 INFO - Reading from file tmpfile_stdout 20:37:09 INFO - Output received: 20:37:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:37:09 INFO - Running post-action listener: _resource_record_post_action 20:37:09 INFO - [mozharness: 2016-10-08 03:37:09.688023Z] Finished install step (success) 20:37:09 INFO - [mozharness: 2016-10-08 03:37:09.688167Z] Running run-tests step. 20:37:09 INFO - Running pre-action listener: _resource_record_pre_action 20:37:09 INFO - Running main action method: run_tests 20:37:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:37:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:37:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:37:09 INFO - 2016-10-07 20:37:09.702 screenresolution[1658:8364] starting screenresolution argv=screenresolution get 20:37:09 INFO - 2016-10-07 20:37:09.705 screenresolution[1658:8364] Display 0: 1600x1200x32@60 20:37:09 INFO - 2016-10-07 20:37:09.712 screenresolution[1659:8372] starting screenresolution argv=screenresolution list 20:37:09 INFO - Available Modes on Display 0 20:37:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:37:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:37:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:37:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:37:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:37:09 INFO - Intel Iris: 20:37:09 INFO - Chipset Model: Intel Iris 20:37:09 INFO - Type: GPU 20:37:09 INFO - Bus: Built-In 20:37:09 INFO - VRAM (Dynamic, Max): 1536 MB 20:37:09 INFO - Vendor: Intel (0x8086) 20:37:09 INFO - Device ID: 0x0a2e 20:37:09 INFO - Revision ID: 0x0009 20:37:09 INFO - Displays: 20:37:09 INFO - Display: 20:37:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:37:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:37:09 INFO - Display Serial Number: 1600x1200 60 20:37:09 INFO - Main Display: Yes 20:37:09 INFO - Mirror: Off 20:37:09 INFO - Online: Yes 20:37:09 INFO - Rotation: Supported 20:37:09 INFO - Return code: 0 20:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:37:09 INFO - Python 2.7.3 20:37:09 INFO - Return code: 0 20:37:09 INFO - grabbing minidump binary from tooltool 20:37:09 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')]} 20:37:09 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 0x109063d30>, '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 0x108e89db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10905bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:37:09 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 20:37:09 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 20:37:09 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 20:37:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:37:10 INFO - Return code: 0 20:37:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:37:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:37:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:37:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:37:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:37:10 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/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 20:37:10 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/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0370 --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 20:37:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GBqONagfzZ/Render', 20:37:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:37:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:37:10 INFO - 'HOME': '/Users/cltbld', 20:37:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:37:10 INFO - 'LOGNAME': 'cltbld', 20:37:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:37:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:37:10 INFO - 'MOZ_NO_REMOTE': '1', 20:37:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:37:10 INFO - 'NO_EM_RESTART': '1', 20:37:10 INFO - 'PAGER': '/bin/cat', 20:37:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:37:10 INFO - 'PWD': '/builds/slave/test', 20:37:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:37:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:37:10 INFO - 'SHELL': '/bin/bash', 20:37:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4QLjJ97chF/Listeners', 20:37:10 INFO - 'TMPDIR': '/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/', 20:37:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:37:10 INFO - 'USER': 'cltbld', 20:37:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:37:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:37:10 INFO - 'XPC_FLAGS': '0x0', 20:37:10 INFO - 'XPC_SERVICE_NAME': '0', 20:37:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:37:10 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/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0370', '--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 20:37:10 INFO - mozversion application_buildid: 20161007184222 20:37:10 INFO - mozversion application_changeset: ef962d8857009eff3a2df14c06e4bc72acb13691 20:37:10 INFO - mozversion application_display_name: Nightly 20:37:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:37:10 INFO - mozversion application_name: Firefox 20:37:10 INFO - mozversion application_remotingname: firefox 20:37:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:37:10 INFO - mozversion application_vendor: Mozilla 20:37:10 INFO - mozversion application_version: 52.0a1 20:37:10 INFO - mozversion platform_buildid: 20161007184222 20:37:10 INFO - mozversion platform_changeset: ef962d8857009eff3a2df14c06e4bc72acb13691 20:37:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:37:10 INFO - mozversion platform_version: 52.0a1 20:37:10 INFO - using testdate: 1475897830 20:37:10 INFO - actual date: 1475897830 20:37:10 INFO - starting webserver on 'localhost:49267' 20:37:10 INFO - SUITE-START | Running 2 tests 20:37:10 INFO - TEST-START | dromaeo_css 20:37:10 INFO - operating with platform_type : mac_ 20:37:10 INFO - Initialising browser for dromaeo_css test... 20:37:10 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpTBo8ZW/profile http://localhost:49267/getInfo.html) 20:37:12 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 20:37:12 INFO - PROCESS | 1669 | colorDepth:24 20:37:12 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 20:37:12 INFO - PROCESS | 1669 | __metrics 20:37:12 INFO - PROCESS | 1669 | 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" 20:37:12 INFO - PROCESS | 1669 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:37:13 INFO - TEST-INFO | 1669: exit 0 20:37:13 INFO - Browser initialized. 20:37:13 INFO - Running cycle 1/1 for dromaeo_css test... 20:37:13 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpTBo8ZW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:37:25 INFO - PROCESS | 1672 | RSS: Main: 235147264 20:37:25 INFO - PROCESS | 1672 | 20:38:16 INFO - PROCESS | 1672 | 1475897896942 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] 20:40:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 20:40:31 INFO - PROCESS | 1672 | RSS: Main: 405979136 20:40:31 INFO - PROCESS | 1672 | 20:43:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 20:43:35 INFO - PROCESS | 1672 | RSS: Main: 369311744 20:43:35 INFO - PROCESS | 1672 | 20:46:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 20:46:38 INFO - PROCESS | 1672 | RSS: Main: 344940544 20:46:38 INFO - PROCESS | 1672 | 20:49:40 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 20:49:41 INFO - PROCESS | 1672 | RSS: Main: 342392832 20:49:41 INFO - PROCESS | 1672 | 20:52:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 20:52:45 INFO - PROCESS | 1672 | RSS: Main: 330620928 20:52:45 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 20:55:49 INFO - PROCESS | 1672 | RSS: Main: 374554624 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | __start_tp_report 20:55:49 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 20:55:49 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 20:55:49 INFO - PROCESS | 1672 | |i|pagename|runs| 20:55:49 INFO - PROCESS | 1672 | |0;dojo.html;3306.057773534543;3338.582677165354;3341.9164520886975;3348.380549598326;3382.188274814045;5534.833954981357;5747.655140691561;5775.537956963443;5777.017906955823;5801.622894511859;5686.800961966332;5726.599138060337;5785.190073389718;5787.102999035156;5815.214945982291;5208.114620514521;5292.36491621006;5301.125314323132;5308.309919710432;5311.2298716686055;5220.321358223426;5233.293505376782;5268.446813084628;5271.868203294929;5272.367315922094;5115.514026167508;5272.710000949946;5277.8944421111555;5316.318461898058;5356.571474282067;4144.792760362;5258.973705131488;5273.86815329616;5283.07546179419;5335.1197052486295;5125.436202017775;5150.510701483353;5188.9881473112755;5215.556677682402;5231.084560201949;5652.971735141339;5682.51698605619;5695.14572814077;5797.536197104264;5809.88380232393;6276.811695649138;6298.181236439279;6302.1177035215105;6319.3680631936895;6320.5891617044745;6122.062546092375;6181.979973304399;6256.202097368535;6369.5222858285815;6376.043593461018;4777.617790576745;5737.77048918047;5760.135979603051;5789.247397838254;5807.883842323215;6387.073874288202;6392.840178995562;6399.64801935898;6399.872002560016;6424.518161137933;6121.938780612226;6124.724387402489;6139.6009259398;6143.477804386588;6152.415520525543;5159.819406320761;6082.9695851520455;6152.292486364126;6189.690515474208;6191.535634827406;6230.844228894314;6237.96881015592;6249.999999999978;6256.562040657111;6264.1856558648;6227.159333489921;6261.8747625047245;6282.528810339243;6292.968535157295;6294.905576416358;4808.807647694053;4821.349117869043;4907.067657145131;4910.042541704333;4929.285253638202;3977.880663580097;4441.755703436342;4464.754438505914;4481.887952801206;4545.659075569345;5833.7374818133285;5835.183074369592;5837.532997360201;5839.328477225174;5856.267966504187;6136.8772624547255;6333.778317758856;6340.746370145235;6360.427561519393;6362.713677884506;5687.004774164505;5725.198472213893;5771.105478650816;5776.306843178845;5804.738786754606;5410.567154627699;5413.323334583177;5429.592780541475;5456.099743542351;5462.371827239918;6363.777267795697;6364.713587888648;6379.362063793584;6388.2653494847755;6393.552451328363;6137.7851775187655;6198.6280823150755;6299.622022678654;6328.398802113792;6348.079528468438;6320.5891617044745;6333.081703153109;6362.6818659067785;6364.809055728336;6364.93635063662;6215.440610345091;6218.657973811484;6237.4698150657705;6238.189035425366;6238.500919926486;6158.692065396802;6234.719437625227;6253.593516421418;6334.493240540838;6334.524910631629;4995.300657907968;5979.730912108878;6016.398360163948;6024.518038556993;6070.7875224366935;6090.299615544269;6090.604110732788;6117.694115294128;6118.112873633209;6132.5400594956445;5923.614965027259;5926.851828704317;5929.495992840484;5937.139114828239;5938.990371636745;5933.317668468008;6002.45977861977;6011.639301641915;6027.668478233564;6062.969685151546;5852.502537284378;5902.026165682614;5908.7045647718305;5910.763569457174;5926.318473375617 20:55:49 INFO - PROCESS | 1672 | |1;ext.html;449.00097283544096;497.86486810073035;501.5511117549793;532.7309708597157;544.5045009041772;29961.850190749043;38197.618023819756;39288.80355598225;39299;39334.99999999996;39868.60131398685;40106.39840402397;40224.59775402245;40225;40355;9574.138327550536;9764.902350976507;9780.119789218968;9784.853227201598;9800.31397802154;9522;9656.275779316544;9656.758581035496;9663.758406039835;9687.32188746788;9627.566759495805;9656.565454554562;9656.710298691016;9658.661946831862;9692.854607180898;9593.80812383752;9621.711348659552;9651.372660777062;9652.372595781251;9654.613815447374;9411.529423528797;9516.23870090398;9606.471644059575;9611.519424028771;9621.422714637145;32678.856240031724;38206.61793382086;38752;39169.41245881314;39186;3262.706356427909;3342.8829990950444;3359.177001634615;3469.4275444551618;3729.8321575529167;29897.402051959056;30163.547546786816;30166.698333016608;30175.849120754476;31451.52822707661;3141.340318533111;3184.6656101109284;3201.199700074981;3212.3735871505064;3227.160938156073;454553.72723136505;460026;460986;462788;463505;54670.453295467334;55146.72426637841;55193.44806551883;55194.44805551974;55260;33374.49938250928;33538.83230583832;34074.82962585221;56429.71785141048;56699.14951275734;15774.132422716631;16106.114163721108;16227.594310142342;16232.18839058066;16246.75629865553;11820.940895295469;11879.881201187878;11892.762144757056;11901.523939042514;11902.404879755977;17702.203400846993;18333.7249941251;18374.81625183758;18398.81601183971;18430.35493757712;6745.52781305304;7797.493162944391;7839.568823714636;7864.72473463426;7892.368610511146;818.337146911004;902.6395974526566;989.4607438945648;1040.1107053469327;1062.7555662197583;28460.573091403647;29293.56059659107;29433.852830736138;30130.84934575313;30245.848770756445;863.7711006583261;990.9058639429243;1026.9794604107876;1027.4605831938293;1044.9425281609585;14430.206338651265;15054.473093441677;15220.238988050553;15289.455977272117;15328.386864525293;666676;669025;673221;673776;674315;51865;52396.47603523916;52667.419977400736;52850.73574632102;53095.73452132715;1213.2477863724548;1251.8622951475147;1326.562234462625;1347.8921686265076;1373.4574842936984;26859.059932902255;31470;32026;32155.678443216206;32204.516932245566;51573;52243;52261.7386913063;52299.95400092053;52308.476915231884;572299;580145;580351;580354;581976;24108.276751697478;25350.239492815246;25816.741832582185;26693.7330626699;26711.866440667673;44971;46109.07781844277;46156.53843461657;46166;46721.766391167825;37479.43780843235;37818.8109059464;38234;39155.21689566136;39478.2104357917;37221.627783721815;37561;38546.80726596349;38747.0342614008;39273.410898835966;37470.43794343142;37485;37514.249715006095;38324.425133623576;38460.42309365306;23443.76556234484;31268.843655781577;32442;34163.65836341704;34279;24751.752482474945;24971.12601058954;25018.499630006932;25224.747752522973;25476.617850732626 20:55:49 INFO - PROCESS | 1672 | |2;jquery.html;339.09123548888965;354.52316634127106;360.9566851977762;370.6090074970906;387.0941995729991;14794.77807832882;14975.251237438139;15703.293351799182;20383.490412739688;20817;19338.709919351222;19927.701084483746;20573;20697.586048279027;20876.478088047807;5774.942250577504;5999;6146.139540464339;6152;6159.476444502223;5599.32808063031;5945.910811337833;6022.8795424091495;6023.277206735176;6027.39726027396;4127;4354.129174165179;5949.4942929850795;5964.045752679572;6255.937440625581;6371.904421433682;6655.667216639173;6734.326567343251;6740.32596740327;6743;5285.550728188108;5673.375928647845;5679.545636349082;5681.801136960228;5688.260526131577;24713.011479540797;24990;25375.746242537523;25468.745312546824;25667.716614169403;2244.394013616331;2260.062074239189;2378.9286321410386;2807.9157625271273;2910.694377090417;14366.640833979234;15340.769888451681;15438.305276262596;15798.842011579853;16129.435469758502;1855.4804654696707;1913.5981443896799;1919.1076149590367;1938.4087853204767;1956.471752626797;114475;114940.85059149386;117349.82650173474;117715.41142294234;117931;8418.663253469915;10100.494975251355;10179.491025448846;10527.315724477885;10759.677209683721;12954.417051232716;12958.740825183444;12962.481500739865;12967.805482917764;12985.35073246334;7427.700152473296;7866.646000929972;8008.119106898236;8077.919220807834;8563.100874408097;8438.57807109642;8485.0242222144;8486.151384861465;8654.35092368075;8666.6100025499;6247.968760156261;6340.873182536324;6350.364963503613;6367.267764207083;6529.379708927644;1609.6941581099554;1671.2312336325426;1731.2815181699705;1770.7520947067421;1779.1193359287236;797.7965618767178;850.3197442046338;906.3066753933247;946.8437707778277;1018.6485662446444;16938;20539;20938.685919711217;21840.781592184194;21899.78100219009;861.4357595774777;893.6023469555985;915.7619019054961;918.7794929217074;937.6436953957452;9475.808446022816;11038.558457661604;11105.333679979227;11204.607838725606;11469.254498457574;533907;545068;547238;555115;559213;69670.65164674245;94553;95958.52020739851;96900;98078.5096074515;871.6600525794945;960.4765402855321;981.0924894472585;991.8165139449225;1013.1692012549786;18226.544336391697;18898.716519251946;18953.620927581647;19025.619487610446;19039.52401189926;47885.28172077352;47933.28100078571;48674.0265194687;49259.50740492549;49702.005959881324;44110;57812;65074.8417674046;67031.66484167548;68931.65534172498;6550.705218265094;7116.359527642537;7163.462740294394;7169.713211471482;7467.962660186664;11613.76772464563;12713.491460341484;12965.675858103623;13192.736145277233;13218.405171767101;9200.539973001189;10721.463926803784;11163.386013769321;11310.491027903929;11402.258853174517;7771.8834217485655;10787.190960678137;10875.619353322596;11240.156988225752;11264;9845.621612974046;10802.459877005962;11416.828747568627;11468.075640711566;11672.76654466889;7025.227225005143;7112.608806515691;7269;7340;7495.662695178839;10150.593976240867;10856.565737370733;11268.718282043015;11292.7741445169;11355.489002995051 20:55:49 INFO - PROCESS | 1672 | |3;mootools.html;1339.1496399786133;1499.8650121489068;1519.8936074474789;1709.2223038517475;1884.707870280107;7023.789286321406;7773;8261.83476330473;8264.91735082649;8266.049404318504;8370.790730231733;8692.695755648554;8699.782505437368;8801.075887031866;8807.867881981776;2272.0798076778888;2297.0926484038796;2300.4478925058033;2301.42464383904;2306.9192578259763;2273.4202778291515;2307.192482631074;2316.073570571768;2318.918837840676;2324.6280595104786;1922.2407149176067;2290.896909639062;2298.7241531016302;2308.249818808894;2313.2135074074813;2256.176495579102;2275.954480910381;2276.84062115652;2279.6124658807958;2284.828637852151;1929.8166674165932;2236.910523579055;2272.7727227277305;2274.7725227477285;2277.851939623919;8720.651173953034;8756.124387561256;8836.072212417732;8864.911350886474;8883.422577532505;5129.897402051938;5155.84532464023;5339.439358867341;5340.06548853949;5346.652467589594;3461.44616861301;3572.1069732566857;3651.94522082169;3662.597114317423;3667.9816600917093;1058.0847566854693;1060.7719340341787;1068.76656018622;1079.2876701377054;1087.423665457309;11373.658790236388;11455.942720286428;11508.539658413738;11519.48162332697;11543;4386.780660966939;4407.427034485497;4573.748443835554;4579.908401832011;4588.632909367243;9069.77325566853;9073.45559266446;9079.68221112258;9082.909170908339;9083.81832363349;5221.216817477409;5227.320448341768;5233.947660523346;5240.318758561362;5241.449647787003;4141.834326626901;4408.316710909814;4552.430946131733;4565.817367305271;4895.143349913751;3667.889963301105;3723.2181241938956;3775.169462718198;3788.3938569828697;3789.8673546425744;1145.335705290946;1151.6487471321327;1151.7408583068743;1156.67613068341;1163;833.1585099050003;847.2544161138159;862.6894318045498;897.3090720145451;908.3732224764891;4554.407926969473;5489.258950041693;5498.340199176125;5527.917081243784;5618.073017952074;412.85137350553777;418.1323753212097;428.81132301787113;429.47174974781194;439.5736135948125;3324.9501257481156;3464.220550376145;3702.092987218095;3752.699784017272;3761.946654936622;10271;10610.20423468243;10727.731806704895;10732.302400343953;10741.785164296827;10247.692569222787;10307.484625768682;10677.83983240252;10692.732681683021;10704.250702450754;7027.472939529555;8062.83874322522;8088.433809633269;8212.384071194565;8225.465344752572;5476.616636835383;5508.779648814003;5513.5037846594;5560.054790685674;5603.971980140073;8018.719344822904;9831.85252221203;9901.702948911545;10007.999200079934;10046.69859904204;8753.168448997336;9584.952075239578;10101.89898101039;10148.543315550965;10173.542190601293;6981.685824138028;7185.2814718527725;7243.5653860768525;7385.076865391826;7500.474966752275;8248.010238771145;8259.339252859876;8291.751247462586;8346.290565302017;8376.078631350669;7370.96314518424;7372.668229929774;7498.962505187439;7516.624168791648;7648.579328137006;7254.202037775735;7318.451116166202;7350.595717235603;7481.289277518627;7588.8482230353975;6662.133922590032;6913.375356791251;6914.343137401939;6924.238333783381;7022.08712867324;4849.878753031202;4920.434150072644;4929;4985.925211121908;5138.3833939927445;4878.170710979213;4967.801287948586;5044.192929131322;5077.92383114261;5081.339425874613 20:55:49 INFO - PROCESS | 1672 | |4;prototype.html;295.5419100394388;298.64908732239616;309.44763596979396;310.7731356110041;313.85876355639954;4764.523547645238;5185.403678576965;5217.843464696056;5310.176922577007;5352.330958630171;4190.036291652922;4564.657650676196;4910.901781964368;4945.233488809231;5209.348831396075;3429.074149979504;3745.7264530059774;3905.7070719696067;3973.284808734427;4093.3655283431117;2936.883984086055;3433.7081348085444;3563.4832949222346;3968.737819442919;4049.97975010126;3325.8503367348526;3340.615829179639;3974.82113304902;3990.880273591797;4086.8569600064;3297.8515966781433;3956.485656864589;4005.5994400559857;4010.438538604598;4053.5743746906446;2603.9739602603922;3464.4456886897974;3510.859565617372;3519.8416071276856;3564.500969864195;5067;5078.720670363128;5130.640855140142;5143.588512918957;5160.587153027786;3942.940855887164;4184.560621134798;4454.953086024781;4597.264437689953;4610.76946152691;4722.8110875564935;5086.694798312114;5536.197251398565;5616.634918730269;5626.718664066781;3133.545635882807;3520.3839328117733;3549.8757543486113;3810.3903375459795;3833.891359752153;4810.364476078115;5276.393214780311;5408.91886621701;5713.171590119493;5898.8230353089475;3536.381133301662;3625.8578547757897;3819.598942111094;3837;3845.7884816335372;3247.723943464832;3787.4697542344093;3873;3896.2597106549665;3898.9862635714353;3994.141259629194;4283.336082907154;4377.956220437819;4506.369108324837;4527.913300807848;5190.766415511311;5558.415336868376;5599.580031497654;5605.635633683879;5626.859328516738;1171.8925615293465;1244.3653736594401;1310.6068179546098;1319.182107093608;1319.7030668099792;741.4476215219588;792.7938735928585;815.7878951472541;836.6028732017423;850.4982060584285;4235.305877648965;4805.063012712488;4966.279889416014;5172.431032586413;5193.519846843631;5039.571636410946;5074.822381216713;5263.210518422267;5530.419305972895;5819.6508209507565;3932.528096628423;4412.0955204183065;4685.742284174403;5125.205593133071;5149.961522701624;2839.3185635447344;2859.642544681915;2986.7610591152657;2989.671136175019;3026.5018815686376;4756.7145971241835;5861.794837180678;5880.0003999320215;5922.733476993546;5999.610025348338;4768.6661933665;5320.627556071038;5750.763585829067;5804.651720896675;5893.114203454853;4674.906501870011;5120.564751995973;5747.511461525817;5789.478946894799;6003.448534372874;4758.834085648899;5374.596905232045;5438;5588.86027849307;5653.462921022497;4440.911181776411;5123.487651234846;5640.379558248507;5711.543076553782;5717.828465146053;5879.823605291848;5894.793682221101;5932.644041357532;6015.901810567474;6050.394960503914;3658.2683463307976;3788.905277368088;3822.636849499293;3826.617338266151;3831.161042699576;4745.386568566566;4773.355596994361;5537.2557644341905;5696.572757043155;5712.315556466139;5036.823711170092;5242.87278235166;5549.195366671891;5650.971745141248;5654.483754729106;4530.796114174936;5318.361796584435;5601.8432903331695;5672.659640421588;5673.893590749929;4181.393697913724;4239.791659377062;5187.962407518587;5294.299907047356;5523.475269849358;4156.459660244149;4954.925676114934;5199.804045069731;5546.252930326934;5609.102543593006;5437.69495321128;5456.863578410572;5459.426760190282;5484.232207491034;5489.39616642177 20:55:49 INFO - PROCESS | 1672 | |5;yui.html;593.7150167919398;693.7225109956019;726.7202127181034;773.4276635289883;785.7878372839338;12146.757064858708;16075.276612552434;16091.356345746157;16107.194640267984;16490.835091649078;14403.855961440382;14524.491642792504;14553.708925821476;14560.490382836602;14577.05249158804;654.7086546486815;675.618275674245;823.5840900345318;826.5288785392314;846.5386364431399;686.7699320727537;840.5461051032435;841.5203334099566;841.9747407577782;842.4103127810527;894.3918135667743;894.4007514964957;895.8253140637578;896.789254525186;897.6229983406952;695.2074634916199;716.2014353995257;866.384866744612;893.2987604730288;893.5398269890978;653.1509038250256;661.5798967655526;662.6620423583959;662.7084083003463;664.5713514782938;15536.61158471036;15571.610709732235;15576;15581;15581.376744930189;13827.51603693866;13939.16365018092;13960;14142.646433839236;14173.78739318911;12701;12781.680457988532;12844.357782110857;13011.349432528335;13338.333083345793;4451.710638808499;4570.063137056895;4604.3784089147875;4604.815807367701;4618.1918164321105;83420;113333;115609;115743.84256157414;116180;11041.944790275997;11136.443177841076;11227.494762735696;11439.542418303341;11555.133364997659;22369.21707740254;22371.776282237293;22433.32700019002;22464;22570.322890313317;7565.319121279112;7645.655945482466;7757.9224207758325;7893.842123157505;7896.842063158705;4210.85262015828;4257.6168144867115;4269.487661480643;4283.635890949305;4428.800703968329;3518.3491054155065;3645.54430696163;3651.434027725654;3654.543182102237;3657.1771351445714;663.2074670768385;675.4562577125363;677.9661016949192;685.2188505104185;686.7321744519642;561.9747111379997;589.3577689876519;631.2929518938818;635.3741564558998;637.3403527349171;7450.403967682572;8397.874031889527;8660.004099528509;8836.248918841971;9197.908020919838;511.575392424287;514.5420575687641;515.6184423526563;543.2259030880979;615.2862679292;3766.8304926278383;3989.3816458448987;4176.582341765799;4382.452193475816;4552.772361381918;86814;92786.53606731923;144200;150906;158560;93194;124385;142505;143150.2842485781;144022;114041;115469.42265288788;116140.41929790298;117850;124025.9999999982;7236;8325.00099987981;8676.219140277406;8691.869621955802;8748.00551024252;66032.66983665244;67152.66423667851;67199.66400167967;68099.63800724057;68576.62846742937;98474.50762746141;99236.50381748045;100691;101325.49337253561;101548.49225753824;11597.304161750322;11655.77614350481;11965.641030769091;11989.940050299692;12187.817182742088;12041.157119001586;12460.43928023223;12610.810837837256;12681.746365072831;12744.936275318563;11716;11846.466908988943;12017.699557511132;12134.33261170644;12209.572664957039;11714.76570468603;11983.76032479328;12193.024558035513;12328.630141095782;12380.257184568954;10548.261621686408;10568.630097946843;10590.629327973484;10636.574537018432;10913.454327283445;9735.415875047236;10038.799224015333;10127.59489620407;10380.896191037993;10554.261201715806;10041.49792510357;10094.284001446735;10604.363738175734;10687.786244275227;10754.13966882632 20:55:49 INFO - PROCESS | 1672 | __end_tp_report 20:55:49 INFO - PROCESS | 1672 | __start_cc_report 20:55:49 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1869 20:55:49 INFO - PROCESS | 1672 | __end_cc_report 20:55:49 INFO - PROCESS | 1672 | __startTimestamp1475898949637__endTimestamp 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | ------- Summary: start ------- 20:55:49 INFO - PROCESS | 1672 | Number of tests: 6 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5745.38 Median:5926.32 stddev:668.20 (11.3%) stddev-sans-first:642.27 20:55:49 INFO - PROCESS | 1672 | Values: 3306.1 3338.6 3341.9 3348.4 3382.2 5534.8 5747.7 5775.5 5777.0 5801.6 5686.8 5726.6 5785.2 5787.1 5815.2 5208.1 5292.4 5301.1 5308.3 5311.2 5220.3 5233.3 5268.4 5271.9 5272.4 5115.5 5272.7 5277.9 5316.3 5356.6 4144.8 5259.0 5273.9 5283.1 5335.1 5125.4 5150.5 5189.0 5215.6 5231.1 5653.0 5682.5 5695.1 5797.5 5809.9 6276.8 6298.2 6302.1 6319.4 6320.6 6122.1 6182.0 6256.2 6369.5 6376.0 4777.6 5737.8 5760.1 5789.2 5807.9 6387.1 6392.8 6399.6 6399.9 6424.5 6121.9 6124.7 6139.6 6143.5 6152.4 5159.8 6083.0 6152.3 6189.7 6191.5 6230.8 6238.0 6250.0 6256.6 6264.2 6227.2 6261.9 6282.5 6293.0 6294.9 4808.8 4821.3 4907.1 4910.0 4929.3 3977.9 4441.8 4464.8 4481.9 4545.7 5833.7 5835.2 5837.5 5839.3 5856.3 6136.9 6333.8 6340.7 6360.4 6362.7 5687.0 5725.2 5771.1 5776.3 5804.7 5410.6 5413.3 5429.6 5456.1 5462.4 6363.8 6364.7 6379.4 6388.3 6393.6 6137.8 6198.6 6299.6 6328.4 6348.1 6320.6 6333.1 6362.7 6364.8 6364.9 6215.4 6218.7 6237.5 6238.2 6238.5 6158.7 6234.7 6253.6 6334.5 6334.5 4995.3 5979.7 6016.4 6024.5 6070.8 6090.3 6090.6 6117.7 6118.1 6132.5 5923.6 5926.9 5929.5 5937.1 5939.0 5933.3 6002.5 6011.6 6027.7 6063.0 5852.5 5902.0 5908.7 5910.8 5926.3 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:69147.18 Median:39162.31 stddev:154435.61 (394.3%) stddev-sans-first:154782.71 20:55:49 INFO - PROCESS | 1672 | Values: 449.0 497.9 501.6 532.7 544.5 29961.9 38197.6 39288.8 39299.0 39335.0 39868.6 40106.4 40224.6 40225.0 40355.0 9574.1 9764.9 9780.1 9784.9 9800.3 9522.0 9656.3 9656.8 9663.8 9687.3 9627.6 9656.6 9656.7 9658.7 9692.9 9593.8 9621.7 9651.4 9652.4 9654.6 9411.5 9516.2 9606.5 9611.5 9621.4 32678.9 38206.6 38752.0 39169.4 39186.0 3262.7 3342.9 3359.2 3469.4 3729.8 29897.4 30163.5 30166.7 30175.8 31451.5 3141.3 3184.7 3201.2 3212.4 3227.2 454553.7 460026.0 460986.0 462788.0 463505.0 54670.5 55146.7 55193.4 55194.4 55260.0 33374.5 33538.8 34074.8 56429.7 56699.1 15774.1 16106.1 16227.6 16232.2 16246.8 11820.9 11879.9 11892.8 11901.5 11902.4 17702.2 18333.7 18374.8 18398.8 18430.4 6745.5 7797.5 7839.6 7864.7 7892.4 818.3 902.6 989.5 1040.1 1062.8 28460.6 29293.6 29433.9 30130.8 30245.8 863.8 990.9 1027.0 1027.5 1044.9 14430.2 15054.5 15220.2 15289.5 15328.4 666676.0 669025.0 673221.0 673776.0 674315.0 51865.0 52396.5 52667.4 52850.7 53095.7 1213.2 1251.9 1326.6 1347.9 1373.5 26859.1 31470.0 32026.0 32155.7 32204.5 51573.0 52243.0 52261.7 52300.0 52308.5 572299.0 580145.0 580351.0 580354.0 581976.0 24108.3 25350.2 25816.7 26693.7 26711.9 44971.0 46109.1 46156.5 46166.0 46721.8 37479.4 37818.8 38234.0 39155.2 39478.2 37221.6 37561.0 38546.8 38747.0 39273.4 37470.4 37485.0 37514.2 38324.4 38460.4 23443.8 31268.8 32442.0 34163.7 34279.0 24751.8 24971.1 25018.5 25224.7 25476.6 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:31896.02 Median:378.85 stddev:90903.91 (23994.6%) stddev-sans-first:91128.03 20:55:49 INFO - PROCESS | 1672 | Values: 339.1 354.5 361.0 370.6 387.1 14794.8 14975.3 15703.3 20383.5 20817.0 19338.7 19927.7 20573.0 20697.6 20876.5 5774.9 5999.0 6146.1 6152.0 6159.5 5599.3 5945.9 6022.9 6023.3 6027.4 4127.0 4354.1 5949.5 5964.0 6255.9 6371.9 6655.7 6734.3 6740.3 6743.0 5285.6 5673.4 5679.5 5681.8 5688.3 24713.0 24990.0 25375.7 25468.7 25667.7 2244.4 2260.1 2378.9 2807.9 2910.7 14366.6 15340.8 15438.3 15798.8 16129.4 1855.5 1913.6 1919.1 1938.4 1956.5 114475.0 114940.9 117349.8 117715.4 117931.0 8418.7 10100.5 10179.5 10527.3 10759.7 12954.4 12958.7 12962.5 12967.8 12985.4 7427.7 7866.6 8008.1 8077.9 8563.1 8438.6 8485.0 8486.2 8654.4 8666.6 6248.0 6340.9 6350.4 6367.3 6529.4 1609.7 1671.2 1731.3 1770.8 1779.1 797.8 850.3 906.3 946.8 1018.6 16938.0 20539.0 20938.7 21840.8 21899.8 861.4 893.6 915.8 918.8 937.6 9475.8 11038.6 11105.3 11204.6 11469.3 533907.0 545068.0 547238.0 555115.0 559213.0 69670.7 94553.0 95958.5 96900.0 98078.5 871.7 960.5 981.1 991.8 1013.2 18226.5 18898.7 18953.6 19025.6 19039.5 47885.3 47933.3 48674.0 49259.5 49702.0 44110.0 57812.0 65074.8 67031.7 68931.7 6550.7 7116.4 7163.5 7169.7 7468.0 11613.8 12713.5 12965.7 13192.7 13218.4 9200.5 10721.5 11163.4 11310.5 11402.3 7771.9 10787.2 10875.6 11240.2 11264.0 9845.6 10802.5 11416.8 11468.1 11672.8 7025.2 7112.6 7269.0 7340.0 7495.7 10150.6 10856.6 11268.7 11292.8 11355.5 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:5538.91 Median:4864.02 stddev:3153.26 (64.8%) stddev-sans-first:3146.31 20:55:49 INFO - PROCESS | 1672 | Values: 1339.1 1499.9 1519.9 1709.2 1884.7 7023.8 7773.0 8261.8 8264.9 8266.0 8370.8 8692.7 8699.8 8801.1 8807.9 2272.1 2297.1 2300.4 2301.4 2306.9 2273.4 2307.2 2316.1 2318.9 2324.6 1922.2 2290.9 2298.7 2308.2 2313.2 2256.2 2276.0 2276.8 2279.6 2284.8 1929.8 2236.9 2272.8 2274.8 2277.9 8720.7 8756.1 8836.1 8864.9 8883.4 5129.9 5155.8 5339.4 5340.1 5346.7 3461.4 3572.1 3651.9 3662.6 3668.0 1058.1 1060.8 1068.8 1079.3 1087.4 11373.7 11455.9 11508.5 11519.5 11543.0 4386.8 4407.4 4573.7 4579.9 4588.6 9069.8 9073.5 9079.7 9082.9 9083.8 5221.2 5227.3 5233.9 5240.3 5241.4 4141.8 4408.3 4552.4 4565.8 4895.1 3667.9 3723.2 3775.2 3788.4 3789.9 1145.3 1151.6 1151.7 1156.7 1163.0 833.2 847.3 862.7 897.3 908.4 4554.4 5489.3 5498.3 5527.9 5618.1 412.9 418.1 428.8 429.5 439.6 3325.0 3464.2 3702.1 3752.7 3761.9 10271.0 10610.2 10727.7 10732.3 10741.8 10247.7 10307.5 10677.8 10692.7 10704.3 7027.5 8062.8 8088.4 8212.4 8225.5 5476.6 5508.8 5513.5 5560.1 5604.0 8018.7 9831.9 9901.7 10008.0 10046.7 8753.2 9585.0 10101.9 10148.5 10173.5 6981.7 7185.3 7243.6 7385.1 7500.5 8248.0 8259.3 8291.8 8346.3 8376.1 7371.0 7372.7 7499.0 7516.6 7648.6 7254.2 7318.5 7350.6 7481.3 7588.8 6662.1 6913.4 6914.3 6924.2 7022.1 4849.9 4920.4 4929.0 4985.9 5138.4 4878.2 4967.8 5044.2 5077.9 5081.3 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:4395.07 Median:4860.63 stddev:1382.97 (28.5%) stddev-sans-first:1352.18 20:55:49 INFO - PROCESS | 1672 | Values: 295.5 298.6 309.4 310.8 313.9 4764.5 5185.4 5217.8 5310.2 5352.3 4190.0 4564.7 4910.9 4945.2 5209.3 3429.1 3745.7 3905.7 3973.3 4093.4 2936.9 3433.7 3563.5 3968.7 4050.0 3325.9 3340.6 3974.8 3990.9 4086.9 3297.9 3956.5 4005.6 4010.4 4053.6 2604.0 3464.4 3510.9 3519.8 3564.5 5067.0 5078.7 5130.6 5143.6 5160.6 3942.9 4184.6 4455.0 4597.3 4610.8 4722.8 5086.7 5536.2 5616.6 5626.7 3133.5 3520.4 3549.9 3810.4 3833.9 4810.4 5276.4 5408.9 5713.2 5898.8 3536.4 3625.9 3819.6 3837.0 3845.8 3247.7 3787.5 3873.0 3896.3 3899.0 3994.1 4283.3 4378.0 4506.4 4527.9 5190.8 5558.4 5599.6 5605.6 5626.9 1171.9 1244.4 1310.6 1319.2 1319.7 741.4 792.8 815.8 836.6 850.5 4235.3 4805.1 4966.3 5172.4 5193.5 5039.6 5074.8 5263.2 5530.4 5819.7 3932.5 4412.1 4685.7 5125.2 5150.0 2839.3 2859.6 2986.8 2989.7 3026.5 4756.7 5861.8 5880.0 5922.7 5999.6 4768.7 5320.6 5750.8 5804.7 5893.1 4674.9 5120.6 5747.5 5789.5 6003.4 4758.8 5374.6 5438.0 5588.9 5653.5 4440.9 5123.5 5640.4 5711.5 5717.8 5879.8 5894.8 5932.6 6015.9 6050.4 3658.3 3788.9 3822.6 3826.6 3831.2 4745.4 4773.4 5537.3 5696.6 5712.3 5036.8 5242.9 5549.2 5651.0 5654.5 4530.8 5318.4 5601.8 5672.7 5673.9 4181.4 4239.8 5188.0 5294.3 5523.5 4156.5 4954.9 5199.8 5546.3 5609.1 5437.7 5456.9 5459.4 5484.2 5489.4 20:55:49 INFO - PROCESS | 1672 | 20:55:49 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:24549.09 Median:3652.99 stddev:39452.81 (1080.0%) stddev-sans-first:39522.49 20:55:49 INFO - PROCESS | 1672 | Values: 593.7 693.7 726.7 773.4 785.8 12146.8 16075.3 16091.4 16107.2 16490.8 14403.9 14524.5 14553.7 14560.5 14577.1 654.7 675.6 823.6 826.5 846.5 686.8 840.5 841.5 842.0 842.4 894.4 894.4 895.8 896.8 897.6 695.2 716.2 866.4 893.3 893.5 653.2 661.6 662.7 662.7 664.6 15536.6 15571.6 15576.0 15581.0 15581.4 13827.5 13939.2 13960.0 14142.6 14173.8 12701.0 12781.7 12844.4 13011.3 13338.3 4451.7 4570.1 4604.4 4604.8 4618.2 83420.0 113333.0 115609.0 115743.8 116180.0 11041.9 11136.4 11227.5 11439.5 11555.1 22369.2 22371.8 22433.3 22464.0 22570.3 7565.3 7645.7 7757.9 7893.8 7896.8 4210.9 4257.6 4269.5 4283.6 4428.8 3518.3 3645.5 3651.4 3654.5 3657.2 663.2 675.5 678.0 685.2 686.7 562.0 589.4 631.3 635.4 637.3 7450.4 8397.9 8660.0 8836.2 9197.9 511.6 514.5 515.6 543.2 615.3 3766.8 3989.4 4176.6 4382.5 4552.8 86814.0 92786.5 144200.0 150906.0 158560.0 93194.0 124385.0 142505.0 143150.3 144022.0 114041.0 115469.4 116140.4 117850.0 124026.0 7236.0 8325.0 8676.2 8691.9 8748.0 66032.7 67152.7 67199.7 68099.6 68576.6 98474.5 99236.5 100691.0 101325.5 101548.5 11597.3 11655.8 11965.6 11989.9 12187.8 12041.2 12460.4 12610.8 12681.7 12744.9 11716.0 11846.5 12017.7 12134.3 12209.6 11714.8 11983.8 12193.0 12328.6 12380.3 10548.3 10568.6 10590.6 10636.6 10913.5 9735.4 10038.8 10127.6 10380.9 10554.3 10041.5 10094.3 10604.4 10687.8 10754.1 20:55:49 INFO - PROCESS | 1672 | -------- Summary: end -------- 20:55:49 INFO - PROCESS | 1672 | 20:55:50 INFO - TEST-INFO | 1672: exit 0 20:55:50 INFO - TEST-OK | dromaeo_css | took 1119966ms 20:55:50 INFO - TEST-START | kraken 20:55:50 INFO - operating with platform_type : mac_ 20:55:50 INFO - Initialising browser for kraken test... 20:55:50 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpNoyqb8/profile http://localhost:49267/getInfo.html) 20:55:52 INFO - PROCESS | 1679 | __metrics Screen width/height:1600/1200 20:55:52 INFO - PROCESS | 1679 | colorDepth:24 20:55:52 INFO - PROCESS | 1679 | Browser inner width/height: 1024/689 20:55:52 INFO - PROCESS | 1679 | __metrics 20:55:52 INFO - PROCESS | 1679 | 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" 20:55:52 INFO - PROCESS | 1679 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:55:53 INFO - TEST-INFO | 1679: exit 0 20:55:53 INFO - Browser initialized. 20:55:53 INFO - Running cycle 1/1 for kraken test... 20:55:53 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/T/tmpNoyqb8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:56:05 INFO - PROCESS | 1680 | RSS: Main: 234823680 20:56:05 INFO - PROCESS | 1680 | 20:56:08 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 20:56:09 INFO - PROCESS | 1680 | RSS: Main: 293658624 20:56:09 INFO - PROCESS | 1680 | 20:56:11 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 20:56:12 INFO - PROCESS | 1680 | RSS: Main: 293609472 20:56:12 INFO - PROCESS | 1680 | 20:56:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 20:56:16 INFO - PROCESS | 1680 | RSS: Main: 385445888 20:56:16 INFO - PROCESS | 1680 | 20:56:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 20:56:19 INFO - PROCESS | 1680 | RSS: Main: 286699520 20:56:19 INFO - PROCESS | 1680 | 20:56:21 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:56:22 INFO - PROCESS | 1680 | RSS: Main: 288227328 20:56:22 INFO - PROCESS | 1680 | 20:56:24 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 20:56:25 INFO - PROCESS | 1680 | RSS: Main: 326860800 20:56:25 INFO - PROCESS | 1680 | 20:56:28 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 20:56:28 INFO - PROCESS | 1680 | RSS: Main: 328015872 20:56:28 INFO - PROCESS | 1680 | 20:56:31 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 20:56:32 INFO - PROCESS | 1680 | RSS: Main: 325394432 20:56:32 INFO - PROCESS | 1680 | 20:56:33 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:56:34 INFO - PROCESS | 1680 | RSS: Main: 302891008 20:56:34 INFO - PROCESS | 1680 | 20:56:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:56:36 INFO - PROCESS | 1680 | RSS: Main: 304431104 20:56:36 INFO - PROCESS | 1680 | 20:56:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:56:39 INFO - PROCESS | 1680 | RSS: Main: 310870016 20:56:39 INFO - PROCESS | 1680 | 20:56:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:56:43 INFO - PROCESS | 1680 | RSS: Main: 324644864 20:56:43 INFO - PROCESS | 1680 | 20:56:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:56:47 INFO - PROCESS | 1680 | RSS: Main: 318214144 20:56:47 INFO - PROCESS | 1680 | 20:56:48 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 20:56:49 INFO - PROCESS | 1680 | RSS: Main: 361861120 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | __start_tp_report 20:56:49 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 20:56:49 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 20:56:49 INFO - PROCESS | 1680 | |i|pagename|runs| 20:56:49 INFO - PROCESS | 1680 | |0;ai-astar;113;113;112;111;112;113;112;120;151;114 20:56:49 INFO - PROCESS | 1680 | |1;audio-beat-detection;149;114;115;151;113;114;113;113;144;112 20:56:49 INFO - PROCESS | 1680 | |2;audio-dft;186;181;182;184;184;184;181;182;183;183 20:56:49 INFO - PROCESS | 1680 | |3;audio-fft;78;59;74;77;72;82;82;81;74;64 20:56:49 INFO - PROCESS | 1680 | |4;audio-oscillator;90;71;94;71;94;68;74;88;100;124 20:56:49 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;92;89;92;88;92;89;92;90;92;88 20:56:49 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;95;95;103;98;96;95;95;95;95 20:56:49 INFO - PROCESS | 1680 | |7;imaging-desaturate;84;85;85;80;84;84;86;83;84;84 20:56:49 INFO - PROCESS | 1680 | |8;json-parse-financial;56;54;53;53;54;56;54;54;55;54 20:56:49 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;63;75;82;76;73;70;71;71;70;71 20:56:49 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;86;87;86;86;89;89;85;88;91;87 20:56:49 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;147;157;153;155;164;170;142;150;190;160 20:56:49 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;173;175;172;172;171;173;173;171;173;171 20:56:49 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;69;69;68;69;72;81;88;72;66;82 20:56:49 INFO - PROCESS | 1680 | __end_tp_report 20:56:49 INFO - PROCESS | 1680 | __start_cc_report 20:56:49 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,2001 20:56:49 INFO - PROCESS | 1680 | __end_cc_report 20:56:49 INFO - PROCESS | 1680 | __startTimestamp1475899009107__endTimestamp 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | ------- Summary: start ------- 20:56:49 INFO - PROCESS | 1680 | Number of tests: 14 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:117.10 Median:113.00 stddev:12.17 (10.8%) stddev-sans-first:12.82 20:56:49 INFO - PROCESS | 1680 | Values: 113.0 113.0 112.0 111.0 112.0 113.0 112.0 120.0 151.0 114.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:114.50 stddev:16.80 (14.7%) stddev-sans-first:15.15 20:56:49 INFO - PROCESS | 1680 | Values: 149.0 114.0 115.0 151.0 113.0 114.0 113.0 113.0 144.0 112.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:183.00 Median:183.50 stddev:1.56 (0.9%) stddev-sans-first:1.22 20:56:49 INFO - PROCESS | 1680 | Values: 186.0 181.0 182.0 184.0 184.0 184.0 181.0 182.0 183.0 183.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:74.30 Median:77.50 stddev:7.67 (9.9%) stddev-sans-first:8.02 20:56:49 INFO - PROCESS | 1680 | Values: 78.0 59.0 74.0 77.0 72.0 82.0 82.0 81.0 74.0 64.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:81.00 stddev:17.28 (21.3%) stddev-sans-first:18.30 20:56:49 INFO - PROCESS | 1680 | Values: 90.0 71.0 94.0 71.0 94.0 68.0 74.0 88.0 100.0 124.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:90.40 Median:92.00 stddev:1.78 (1.9%) stddev-sans-first:1.79 20:56:49 INFO - PROCESS | 1680 | Values: 92.0 89.0 92.0 88.0 92.0 89.0 92.0 90.0 92.0 88.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:96.20 Median:95.00 stddev:2.57 (2.7%) stddev-sans-first:2.69 20:56:49 INFO - PROCESS | 1680 | Values: 95.0 95.0 95.0 103.0 98.0 96.0 95.0 95.0 95.0 95.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:83.90 Median:84.00 stddev:1.60 (1.9%) stddev-sans-first:1.69 20:56:49 INFO - PROCESS | 1680 | Values: 84.0 85.0 85.0 80.0 84.0 84.0 86.0 83.0 84.0 84.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:0.93 20:56:49 INFO - PROCESS | 1680 | Values: 56.0 54.0 53.0 53.0 54.0 56.0 54.0 54.0 55.0 54.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.00 stddev:4.92 (6.8%) stddev-sans-first:3.93 20:56:49 INFO - PROCESS | 1680 | Values: 63.0 75.0 82.0 76.0 73.0 70.0 71.0 71.0 70.0 71.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:87.40 Median:87.50 stddev:1.84 (2.1%) stddev-sans-first:1.88 20:56:49 INFO - PROCESS | 1680 | Values: 86.0 87.0 86.0 86.0 89.0 89.0 85.0 88.0 91.0 87.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:158.80 Median:158.50 stddev:13.65 (8.6%) stddev-sans-first:13.80 20:56:49 INFO - PROCESS | 1680 | Values: 147.0 157.0 153.0 155.0 164.0 170.0 142.0 150.0 190.0 160.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.00 stddev:1.26 (0.7%) stddev-sans-first:1.32 20:56:49 INFO - PROCESS | 1680 | Values: 173.0 175.0 172.0 172.0 171.0 173.0 173.0 171.0 173.0 171.0 20:56:49 INFO - PROCESS | 1680 | 20:56:49 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:72.00 stddev:7.38 (10.3%) stddev-sans-first:7.64 20:56:49 INFO - PROCESS | 1680 | Values: 69.0 69.0 68.0 69.0 72.0 81.0 88.0 72.0 66.0 82.0 20:56:49 INFO - PROCESS | 1680 | -------- Summary: end -------- 20:56:49 INFO - PROCESS | 1680 | 20:56:50 INFO - TEST-INFO | 1680: exit 0 20:56:50 INFO - TEST-OK | kraken | took 59855ms 20:56:50 INFO - SUITE-END | took 1179s 20:56:50 INFO - Completed test suite (00:19:39) 20:56:50 INFO - javascript benchmark 20:56:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3306.057773534543, 3338.582677165354, 3341.9164520886975, 3348.380549598326, 3382.188274814045, 5534.833954981357, 5747.655140691561, 5775.537956963443, 5777.017906955823, 5801.622894511859, 5686.800961966332, 5726.599138060337, 5785.190073389718, 5787.102999035156, 5815.214945982291, 5208.114620514521, 5292.36491621006, 5301.125314323132, 5308.309919710432, 5311.2298716686055, 5220.321358223426, 5233.293505376782, 5268.446813084628, 5271.868203294929, 5272.367315922094, 5115.514026167508, 5272.710000949946, 5277.8944421111555, 5316.318461898058, 5356.571474282067, 4144.792760362, 5258.973705131488, 5273.86815329616, 5283.07546179419, 5335.1197052486295, 5125.436202017775, 5150.510701483353, 5188.9881473112755, 5215.556677682402, 5231.084560201949, 5652.971735141339, 5682.51698605619, 5695.14572814077, 5797.536197104264, 5809.88380232393, 6276.811695649138, 6298.181236439279, 6302.1177035215105, 6319.3680631936895, 6320.5891617044745, 6122.062546092375, 6181.979973304399, 6256.202097368535, 6369.5222858285815, 6376.043593461018, 4777.617790576745, 5737.77048918047, 5760.135979603051, 5789.247397838254, 5807.883842323215, 6387.073874288202, 6392.840178995562, 6399.64801935898, 6399.872002560016, 6424.518161137933, 6121.938780612226, 6124.724387402489, 6139.6009259398, 6143.477804386588, 6152.415520525543, 5159.819406320761, 6082.9695851520455, 6152.292486364126, 6189.690515474208, 6191.535634827406, 6230.844228894314, 6237.96881015592, 6249.999999999978, 6256.562040657111, 6264.1856558648, 6227.159333489921, 6261.8747625047245, 6282.528810339243, 6292.968535157295, 6294.905576416358, 4808.807647694053, 4821.349117869043, 4907.067657145131, 4910.042541704333, 4929.285253638202, 3977.880663580097, 4441.755703436342, 4464.754438505914, 4481.887952801206, 4545.659075569345, 5833.7374818133285, 5835.183074369592, 5837.532997360201, 5839.328477225174, 5856.267966504187, 6136.8772624547255, 6333.778317758856, 6340.746370145235, 6360.427561519393, 6362.713677884506, 5687.004774164505, 5725.198472213893, 5771.105478650816, 5776.306843178845, 5804.738786754606, 5410.567154627699, 5413.323334583177, 5429.592780541475, 5456.099743542351, 5462.371827239918, 6363.777267795697, 6364.713587888648, 6379.362063793584, 6388.2653494847755, 6393.552451328363, 6137.7851775187655, 6198.6280823150755, 6299.622022678654, 6328.398802113792, 6348.079528468438, 6320.5891617044745, 6333.081703153109, 6362.6818659067785, 6364.809055728336, 6364.93635063662, 6215.440610345091, 6218.657973811484, 6237.4698150657705, 6238.189035425366, 6238.500919926486, 6158.692065396802, 6234.719437625227, 6253.593516421418, 6334.493240540838, 6334.524910631629, 4995.300657907968, 5979.730912108878, 6016.398360163948, 6024.518038556993, 6070.7875224366935, 6090.299615544269, 6090.604110732788, 6117.694115294128, 6118.112873633209, 6132.5400594956445, 5923.614965027259, 5926.851828704317, 5929.495992840484, 5937.139114828239, 5938.990371636745, 5933.317668468008, 6002.45977861977, 6011.639301641915, 6027.668478233564, 6062.969685151546, 5852.502537284378, 5902.026165682614, 5908.7045647718305, 5910.763569457174, 5926.318473375617], "value": 5701.928162438223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.00097283544096, 497.86486810073035, 501.5511117549793, 532.7309708597157, 544.5045009041772, 29961.850190749043, 38197.618023819756, 39288.80355598225, 39299.0, 39334.99999999996, 39868.60131398685, 40106.39840402397, 40224.59775402245, 40225.0, 40355.0, 9574.138327550536, 9764.902350976507, 9780.119789218968, 9784.853227201598, 9800.31397802154, 9522.0, 9656.275779316544, 9656.758581035496, 9663.758406039835, 9687.32188746788, 9627.566759495805, 9656.565454554562, 9656.710298691016, 9658.661946831862, 9692.854607180898, 9593.80812383752, 9621.711348659552, 9651.372660777062, 9652.372595781251, 9654.613815447374, 9411.529423528797, 9516.23870090398, 9606.471644059575, 9611.519424028771, 9621.422714637145, 32678.856240031724, 38206.61793382086, 38752.0, 39169.41245881314, 39186.0, 3262.706356427909, 3342.8829990950444, 3359.177001634615, 3469.4275444551618, 3729.8321575529167, 29897.402051959056, 30163.547546786816, 30166.698333016608, 30175.849120754476, 31451.52822707661, 3141.340318533111, 3184.6656101109284, 3201.199700074981, 3212.3735871505064, 3227.160938156073, 454553.72723136505, 460026.0, 460986.0, 462788.0, 463505.0, 54670.453295467334, 55146.72426637841, 55193.44806551883, 55194.44805551974, 55260.0, 33374.49938250928, 33538.83230583832, 34074.82962585221, 56429.71785141048, 56699.14951275734, 15774.132422716631, 16106.114163721108, 16227.594310142342, 16232.18839058066, 16246.75629865553, 11820.940895295469, 11879.881201187878, 11892.762144757056, 11901.523939042514, 11902.404879755977, 17702.203400846993, 18333.7249941251, 18374.81625183758, 18398.81601183971, 18430.35493757712, 6745.52781305304, 7797.493162944391, 7839.568823714636, 7864.72473463426, 7892.368610511146, 818.337146911004, 902.6395974526566, 989.4607438945648, 1040.1107053469327, 1062.7555662197583, 28460.573091403647, 29293.56059659107, 29433.852830736138, 30130.84934575313, 30245.848770756445, 863.7711006583261, 990.9058639429243, 1026.9794604107876, 1027.4605831938293, 1044.9425281609585, 14430.206338651265, 15054.473093441677, 15220.238988050553, 15289.455977272117, 15328.386864525293, 666676.0, 669025.0, 673221.0, 673776.0, 674315.0, 51865.0, 52396.47603523916, 52667.419977400736, 52850.73574632102, 53095.73452132715, 1213.2477863724548, 1251.8622951475147, 1326.562234462625, 1347.8921686265076, 1373.4574842936984, 26859.059932902255, 31470.0, 32026.0, 32155.678443216206, 32204.516932245566, 51573.0, 52243.0, 52261.7386913063, 52299.95400092053, 52308.476915231884, 572299.0, 580145.0, 580351.0, 580354.0, 581976.0, 24108.276751697478, 25350.239492815246, 25816.741832582185, 26693.7330626699, 26711.866440667673, 44971.0, 46109.07781844277, 46156.53843461657, 46166.0, 46721.766391167825, 37479.43780843235, 37818.8109059464, 38234.0, 39155.21689566136, 39478.2104357917, 37221.627783721815, 37561.0, 38546.80726596349, 38747.0342614008, 39273.410898835966, 37470.43794343142, 37485.0, 37514.249715006095, 38324.425133623576, 38460.42309365306, 23443.76556234484, 31268.843655781577, 32442.0, 34163.65836341704, 34279.0, 24751.752482474945, 24971.12601058954, 25018.499630006932, 25224.747752522973, 25476.617850732626], "value": 19365.105635514272, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.09123548888965, 354.52316634127106, 360.9566851977762, 370.6090074970906, 387.0941995729991, 14794.77807832882, 14975.251237438139, 15703.293351799182, 20383.490412739688, 20817.0, 19338.709919351222, 19927.701084483746, 20573.0, 20697.586048279027, 20876.478088047807, 5774.942250577504, 5999.0, 6146.139540464339, 6152.0, 6159.476444502223, 5599.32808063031, 5945.910811337833, 6022.8795424091495, 6023.277206735176, 6027.39726027396, 4127.0, 4354.129174165179, 5949.4942929850795, 5964.045752679572, 6255.937440625581, 6371.904421433682, 6655.667216639173, 6734.326567343251, 6740.32596740327, 6743.0, 5285.550728188108, 5673.375928647845, 5679.545636349082, 5681.801136960228, 5688.260526131577, 24713.011479540797, 24990.0, 25375.746242537523, 25468.745312546824, 25667.716614169403, 2244.394013616331, 2260.062074239189, 2378.9286321410386, 2807.9157625271273, 2910.694377090417, 14366.640833979234, 15340.769888451681, 15438.305276262596, 15798.842011579853, 16129.435469758502, 1855.4804654696707, 1913.5981443896799, 1919.1076149590367, 1938.4087853204767, 1956.471752626797, 114475.0, 114940.85059149386, 117349.82650173474, 117715.41142294234, 117931.0, 8418.663253469915, 10100.494975251355, 10179.491025448846, 10527.315724477885, 10759.677209683721, 12954.417051232716, 12958.740825183444, 12962.481500739865, 12967.805482917764, 12985.35073246334, 7427.700152473296, 7866.646000929972, 8008.119106898236, 8077.919220807834, 8563.100874408097, 8438.57807109642, 8485.0242222144, 8486.151384861465, 8654.35092368075, 8666.6100025499, 6247.968760156261, 6340.873182536324, 6350.364963503613, 6367.267764207083, 6529.379708927644, 1609.6941581099554, 1671.2312336325426, 1731.2815181699705, 1770.7520947067421, 1779.1193359287236, 797.7965618767178, 850.3197442046338, 906.3066753933247, 946.8437707778277, 1018.6485662446444, 16938.0, 20539.0, 20938.685919711217, 21840.781592184194, 21899.78100219009, 861.4357595774777, 893.6023469555985, 915.7619019054961, 918.7794929217074, 937.6436953957452, 9475.808446022816, 11038.558457661604, 11105.333679979227, 11204.607838725606, 11469.254498457574, 533907.0, 545068.0, 547238.0, 555115.0, 559213.0, 69670.65164674245, 94553.0, 95958.52020739851, 96900.0, 98078.5096074515, 871.6600525794945, 960.4765402855321, 981.0924894472585, 991.8165139449225, 1013.1692012549786, 18226.544336391697, 18898.716519251946, 18953.620927581647, 19025.619487610446, 19039.52401189926, 47885.28172077352, 47933.28100078571, 48674.0265194687, 49259.50740492549, 49702.005959881324, 44110.0, 57812.0, 65074.8417674046, 67031.66484167548, 68931.65534172498, 6550.705218265094, 7116.359527642537, 7163.462740294394, 7169.713211471482, 7467.962660186664, 11613.76772464563, 12713.491460341484, 12965.675858103623, 13192.736145277233, 13218.405171767101, 9200.539973001189, 10721.463926803784, 11163.386013769321, 11310.491027903929, 11402.258853174517, 7771.8834217485655, 10787.190960678137, 10875.619353322596, 11240.156988225752, 11264.0, 9845.621612974046, 10802.459877005962, 11416.828747568627, 11468.075640711566, 11672.76654466889, 7025.227225005143, 7112.608806515691, 7269.0, 7340.0, 7495.662695178839, 10150.593976240867, 10856.565737370733, 11268.718282043015, 11292.7741445169, 11355.489002995051], "value": 9331.91133876933, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.1496399786133, 1499.8650121489068, 1519.8936074474789, 1709.2223038517475, 1884.707870280107, 7023.789286321406, 7773.0, 8261.83476330473, 8264.91735082649, 8266.049404318504, 8370.790730231733, 8692.695755648554, 8699.782505437368, 8801.075887031866, 8807.867881981776, 2272.0798076778888, 2297.0926484038796, 2300.4478925058033, 2301.42464383904, 2306.9192578259763, 2273.4202778291515, 2307.192482631074, 2316.073570571768, 2318.918837840676, 2324.6280595104786, 1922.2407149176067, 2290.896909639062, 2298.7241531016302, 2308.249818808894, 2313.2135074074813, 2256.176495579102, 2275.954480910381, 2276.84062115652, 2279.6124658807958, 2284.828637852151, 1929.8166674165932, 2236.910523579055, 2272.7727227277305, 2274.7725227477285, 2277.851939623919, 8720.651173953034, 8756.124387561256, 8836.072212417732, 8864.911350886474, 8883.422577532505, 5129.897402051938, 5155.84532464023, 5339.439358867341, 5340.06548853949, 5346.652467589594, 3461.44616861301, 3572.1069732566857, 3651.94522082169, 3662.597114317423, 3667.9816600917093, 1058.0847566854693, 1060.7719340341787, 1068.76656018622, 1079.2876701377054, 1087.423665457309, 11373.658790236388, 11455.942720286428, 11508.539658413738, 11519.48162332697, 11543.0, 4386.780660966939, 4407.427034485497, 4573.748443835554, 4579.908401832011, 4588.632909367243, 9069.77325566853, 9073.45559266446, 9079.68221112258, 9082.909170908339, 9083.81832363349, 5221.216817477409, 5227.320448341768, 5233.947660523346, 5240.318758561362, 5241.449647787003, 4141.834326626901, 4408.316710909814, 4552.430946131733, 4565.817367305271, 4895.143349913751, 3667.889963301105, 3723.2181241938956, 3775.169462718198, 3788.3938569828697, 3789.8673546425744, 1145.335705290946, 1151.6487471321327, 1151.7408583068743, 1156.67613068341, 1163.0, 833.1585099050003, 847.2544161138159, 862.6894318045498, 897.3090720145451, 908.3732224764891, 4554.407926969473, 5489.258950041693, 5498.340199176125, 5527.917081243784, 5618.073017952074, 412.85137350553777, 418.1323753212097, 428.81132301787113, 429.47174974781194, 439.5736135948125, 3324.9501257481156, 3464.220550376145, 3702.092987218095, 3752.699784017272, 3761.946654936622, 10271.0, 10610.20423468243, 10727.731806704895, 10732.302400343953, 10741.785164296827, 10247.692569222787, 10307.484625768682, 10677.83983240252, 10692.732681683021, 10704.250702450754, 7027.472939529555, 8062.83874322522, 8088.433809633269, 8212.384071194565, 8225.465344752572, 5476.616636835383, 5508.779648814003, 5513.5037846594, 5560.054790685674, 5603.971980140073, 8018.719344822904, 9831.85252221203, 9901.702948911545, 10007.999200079934, 10046.69859904204, 8753.168448997336, 9584.952075239578, 10101.89898101039, 10148.543315550965, 10173.542190601293, 6981.685824138028, 7185.2814718527725, 7243.5653860768525, 7385.076865391826, 7500.474966752275, 8248.010238771145, 8259.339252859876, 8291.751247462586, 8346.290565302017, 8376.078631350669, 7370.96314518424, 7372.668229929774, 7498.962505187439, 7516.624168791648, 7648.579328137006, 7254.202037775735, 7318.451116166202, 7350.595717235603, 7481.289277518627, 7588.8482230353975, 6662.133922590032, 6913.375356791251, 6914.343137401939, 6924.238333783381, 7022.08712867324, 4849.878753031202, 4920.434150072644, 4929.0, 4985.925211121908, 5138.3833939927445, 4878.170710979213, 4967.801287948586, 5044.192929131322, 5077.92383114261, 5081.339425874613], "value": 4357.872111507681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5419100394388, 298.64908732239616, 309.44763596979396, 310.7731356110041, 313.85876355639954, 4764.523547645238, 5185.403678576965, 5217.843464696056, 5310.176922577007, 5352.330958630171, 4190.036291652922, 4564.657650676196, 4910.901781964368, 4945.233488809231, 5209.348831396075, 3429.074149979504, 3745.7264530059774, 3905.7070719696067, 3973.284808734427, 4093.3655283431117, 2936.883984086055, 3433.7081348085444, 3563.4832949222346, 3968.737819442919, 4049.97975010126, 3325.8503367348526, 3340.615829179639, 3974.82113304902, 3990.880273591797, 4086.8569600064, 3297.8515966781433, 3956.485656864589, 4005.5994400559857, 4010.438538604598, 4053.5743746906446, 2603.9739602603922, 3464.4456886897974, 3510.859565617372, 3519.8416071276856, 3564.500969864195, 5067.0, 5078.720670363128, 5130.640855140142, 5143.588512918957, 5160.587153027786, 3942.940855887164, 4184.560621134798, 4454.953086024781, 4597.264437689953, 4610.76946152691, 4722.8110875564935, 5086.694798312114, 5536.197251398565, 5616.634918730269, 5626.718664066781, 3133.545635882807, 3520.3839328117733, 3549.8757543486113, 3810.3903375459795, 3833.891359752153, 4810.364476078115, 5276.393214780311, 5408.91886621701, 5713.171590119493, 5898.8230353089475, 3536.381133301662, 3625.8578547757897, 3819.598942111094, 3837.0, 3845.7884816335372, 3247.723943464832, 3787.4697542344093, 3873.0, 3896.2597106549665, 3898.9862635714353, 3994.141259629194, 4283.336082907154, 4377.956220437819, 4506.369108324837, 4527.913300807848, 5190.766415511311, 5558.415336868376, 5599.580031497654, 5605.635633683879, 5626.859328516738, 1171.8925615293465, 1244.3653736594401, 1310.6068179546098, 1319.182107093608, 1319.7030668099792, 741.4476215219588, 792.7938735928585, 815.7878951472541, 836.6028732017423, 850.4982060584285, 4235.305877648965, 4805.063012712488, 4966.279889416014, 5172.431032586413, 5193.519846843631, 5039.571636410946, 5074.822381216713, 5263.210518422267, 5530.419305972895, 5819.6508209507565, 3932.528096628423, 4412.0955204183065, 4685.742284174403, 5125.205593133071, 5149.961522701624, 2839.3185635447344, 2859.642544681915, 2986.7610591152657, 2989.671136175019, 3026.5018815686376, 4756.7145971241835, 5861.794837180678, 5880.0003999320215, 5922.733476993546, 5999.610025348338, 4768.6661933665, 5320.627556071038, 5750.763585829067, 5804.651720896675, 5893.114203454853, 4674.906501870011, 5120.564751995973, 5747.511461525817, 5789.478946894799, 6003.448534372874, 4758.834085648899, 5374.596905232045, 5438.0, 5588.86027849307, 5653.462921022497, 4440.911181776411, 5123.487651234846, 5640.379558248507, 5711.543076553782, 5717.828465146053, 5879.823605291848, 5894.793682221101, 5932.644041357532, 6015.901810567474, 6050.394960503914, 3658.2683463307976, 3788.905277368088, 3822.636849499293, 3826.617338266151, 3831.161042699576, 4745.386568566566, 4773.355596994361, 5537.2557644341905, 5696.572757043155, 5712.315556466139, 5036.823711170092, 5242.87278235166, 5549.195366671891, 5650.971745141248, 5654.483754729106, 4530.796114174936, 5318.361796584435, 5601.8432903331695, 5672.659640421588, 5673.893590749929, 4181.393697913724, 4239.791659377062, 5187.962407518587, 5294.299907047356, 5523.475269849358, 4156.459660244149, 4954.925676114934, 5199.804045069731, 5546.252930326934, 5609.102543593006, 5437.69495321128, 5456.863578410572, 5459.426760190282, 5484.232207491034, 5489.39616642177], "value": 3958.7181393615324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.7150167919398, 693.7225109956019, 726.7202127181034, 773.4276635289883, 785.7878372839338, 12146.757064858708, 16075.276612552434, 16091.356345746157, 16107.194640267984, 16490.835091649078, 14403.855961440382, 14524.491642792504, 14553.708925821476, 14560.490382836602, 14577.05249158804, 654.7086546486815, 675.618275674245, 823.5840900345318, 826.5288785392314, 846.5386364431399, 686.7699320727537, 840.5461051032435, 841.5203334099566, 841.9747407577782, 842.4103127810527, 894.3918135667743, 894.4007514964957, 895.8253140637578, 896.789254525186, 897.6229983406952, 695.2074634916199, 716.2014353995257, 866.384866744612, 893.2987604730288, 893.5398269890978, 653.1509038250256, 661.5798967655526, 662.6620423583959, 662.7084083003463, 664.5713514782938, 15536.61158471036, 15571.610709732235, 15576.0, 15581.0, 15581.376744930189, 13827.51603693866, 13939.16365018092, 13960.0, 14142.646433839236, 14173.78739318911, 12701.0, 12781.680457988532, 12844.357782110857, 13011.349432528335, 13338.333083345793, 4451.710638808499, 4570.063137056895, 4604.3784089147875, 4604.815807367701, 4618.1918164321105, 83420.0, 113333.0, 115609.0, 115743.84256157414, 116180.0, 11041.944790275997, 11136.443177841076, 11227.494762735696, 11439.542418303341, 11555.133364997659, 22369.21707740254, 22371.776282237293, 22433.32700019002, 22464.0, 22570.322890313317, 7565.319121279112, 7645.655945482466, 7757.9224207758325, 7893.842123157505, 7896.842063158705, 4210.85262015828, 4257.6168144867115, 4269.487661480643, 4283.635890949305, 4428.800703968329, 3518.3491054155065, 3645.54430696163, 3651.434027725654, 3654.543182102237, 3657.1771351445714, 663.2074670768385, 675.4562577125363, 677.9661016949192, 685.2188505104185, 686.7321744519642, 561.9747111379997, 589.3577689876519, 631.2929518938818, 635.3741564558998, 637.3403527349171, 7450.403967682572, 8397.874031889527, 8660.004099528509, 8836.248918841971, 9197.908020919838, 511.575392424287, 514.5420575687641, 515.6184423526563, 543.2259030880979, 615.2862679292, 3766.8304926278383, 3989.3816458448987, 4176.582341765799, 4382.452193475816, 4552.772361381918, 86814.0, 92786.53606731923, 144200.0, 150906.0, 158560.0, 93194.0, 124385.0, 142505.0, 143150.2842485781, 144022.0, 114041.0, 115469.42265288788, 116140.41929790298, 117850.0, 124025.9999999982, 7236.0, 8325.00099987981, 8676.219140277406, 8691.869621955802, 8748.00551024252, 66032.66983665244, 67152.66423667851, 67199.66400167967, 68099.63800724057, 68576.62846742937, 98474.50762746141, 99236.50381748045, 100691.0, 101325.49337253561, 101548.49225753824, 11597.304161750322, 11655.77614350481, 11965.641030769091, 11989.940050299692, 12187.817182742088, 12041.157119001586, 12460.43928023223, 12610.810837837256, 12681.746365072831, 12744.936275318563, 11716.0, 11846.466908988943, 12017.699557511132, 12134.33261170644, 12209.572664957039, 11714.76570468603, 11983.76032479328, 12193.024558035513, 12328.630141095782, 12380.257184568954, 10548.261621686408, 10568.630097946843, 10590.629327973484, 10636.574537018432, 10913.454327283445, 9735.415875047236, 10038.799224015333, 10127.59489620407, 10380.896191037993, 10554.261201715806, 10041.49792510357, 10094.284001446735, 10604.363738175734, 10687.786244275227, 10754.13966882632], "value": 7565.172372742576, "unit": "score"}], "name": "dromaeo_css", "value": 7157.884046592455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 112.0, 111.0, 112.0, 113.0, 112.0, 120.0, 151.0, 114.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 114.0, 115.0, 151.0, 113.0, 114.0, 113.0, 113.0, 144.0, 112.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 182.0, 184.0, 184.0, 184.0, 181.0, 182.0, 183.0, 183.0], "value": 183.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 74.0, 77.0, 72.0, 82.0, 82.0, 81.0, 74.0, 64.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 94.0, 71.0, 94.0, 68.0, 74.0, 88.0, 100.0, 124.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 92.0, 88.0, 92.0, 89.0, 92.0, 90.0, 92.0, 88.0], "value": 90.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 103.0, 98.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 80.0, 84.0, 84.0, 86.0, 83.0, 84.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 53.0, 53.0, 54.0, 56.0, 54.0, 54.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 75.0, 82.0, 76.0, 73.0, 70.0, 71.0, 71.0, 70.0, 71.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 86.0, 89.0, 89.0, 85.0, 88.0, 91.0, 87.0], "value": 87.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 157.0, 153.0, 155.0, 164.0, 170.0, 142.0, 150.0, 190.0, 160.0], "value": 158.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 172.0, 172.0, 171.0, 173.0, 173.0, 171.0, 173.0, 171.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 69.0, 72.0, 81.0, 88.0, 72.0, 66.0, 82.0], "value": 73.6, "unit": "score"}], "name": "kraken", "value": 1474.8, "alertThreshold": 2.0}]} 20:56:50 INFO - Return code: 0 20:56:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:56:50 INFO - # TBPL SUCCESS # 20:56:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:56:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:56:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:56:50 INFO - 2016-10-07 20:56:50.402 screenresolution[1684:10832] starting screenresolution argv=screenresolution get 20:56:50 INFO - 2016-10-07 20:56:50.405 screenresolution[1684:10832] Display 0: 1600x1200x32@60 20:56:50 INFO - 2016-10-07 20:56:50.411 screenresolution[1685:10835] starting screenresolution argv=screenresolution list 20:56:50 INFO - Available Modes on Display 0 20:56:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:56:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:56:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:56:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:56:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:56:50 INFO - Intel Iris: 20:56:50 INFO - Chipset Model: Intel Iris 20:56:50 INFO - Type: GPU 20:56:50 INFO - Bus: Built-In 20:56:50 INFO - VRAM (Dynamic, Max): 1536 MB 20:56:50 INFO - Vendor: Intel (0x8086) 20:56:50 INFO - Device ID: 0x0a2e 20:56:50 INFO - Revision ID: 0x0009 20:56:50 INFO - Displays: 20:56:50 INFO - Display: 20:56:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:56:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:56:50 INFO - Display Serial Number: 1600x1200 60 20:56:50 INFO - Main Display: Yes 20:56:50 INFO - Mirror: Off 20:56:50 INFO - Online: Yes 20:56:50 INFO - Rotation: Supported 20:56:50 INFO - Return code: 0 20:56:50 INFO - Running post-action listener: _resource_record_post_action 20:56:50 INFO - [mozharness: 2016-10-08 03:56:50.658946Z] Finished run-tests step (success) 20:56:50 INFO - Running post-run listener: _resource_record_post_run 20:56:50 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 32119808; Write bytes: 709090304; Read time: 198; Write time: 1986 20:56:50 INFO - TinderboxPrint: CPU usage
53.4% 20:56:50 INFO - TinderboxPrint: I/O read bytes / time
32,119,808 / 198 20:56:50 INFO - TinderboxPrint: I/O write bytes / time
709,090,304 / 1,986 20:56:50 INFO - TinderboxPrint: CPU idle
2,267.9 (46.6%) 20:56:50 INFO - TinderboxPrint: CPU system
970.6 (20.0%) 20:56:50 INFO - TinderboxPrint: CPU user
1,623.2 (33.4%) 20:56:50 INFO - TinderboxPrint: Swap in / out
436,563,968 / 0 20:56:50 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 408476160; Write bytes: 411737600; Read time: 31074; Write time: 856 20:56:50 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 29203456; Write bytes: 295878144; Read time: 176; Write time: 1123 20:56:51 INFO - Running post-run listener: _upload_blobber_files 20:56:51 INFO - Blob upload gear active. 20:56:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:56:51 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 20:56:51 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'] 20:56:51 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 20:56:51 INFO - (blobuploader) - INFO - Open directory for files ... 20:56:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:56:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:56:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:52 INFO - (blobuploader) - INFO - Done attempting. 20:56:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:56:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:56:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:53 INFO - (blobuploader) - INFO - Done attempting. 20:56:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:56:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:56:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:56:55 INFO - (blobuploader) - INFO - Done attempting. 20:56:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:56:55 INFO - Return code: 0 20:56:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:56:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:56:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a347f5f3b1fa7603e52c4dcebf3433754b9c170c8547ccb90dc2625614d03b7ce4cd0fb20f44797848e308578f8abb9c26c38d9a29e556bc921c17b4ab97069", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b3ff9a4b7557b2531eff8ec388628c3e1732a436b932b49c80c2d8ca171fae27e987e12e7f3210f10d241f1c262df43e89c5834d7a8cb482498bf2d1c026c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd1ccf6006b26f04f27a1758fc98e6706e42933d4be412af76998e8ed482c4fdcc49f6192509a72e19474b3290a9e8c97465069a7efd3c5afa0a70d2ab454119"} 20:56:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:56:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:56:55 INFO - Contents: 20:56:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4a347f5f3b1fa7603e52c4dcebf3433754b9c170c8547ccb90dc2625614d03b7ce4cd0fb20f44797848e308578f8abb9c26c38d9a29e556bc921c17b4ab97069", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b3ff9a4b7557b2531eff8ec388628c3e1732a436b932b49c80c2d8ca171fae27e987e12e7f3210f10d241f1c262df43e89c5834d7a8cb482498bf2d1c026c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd1ccf6006b26f04f27a1758fc98e6706e42933d4be412af76998e8ed482c4fdcc49f6192509a72e19474b3290a9e8c97465069a7efd3c5afa0a70d2ab454119"} 20:56:55 INFO - Running post-run listener: copy_logs_to_upload_dir 20:56:55 INFO - Copying logs to upload dir... 20:56:55 INFO - mkdir: /builds/slave/test/build/upload/logs 20:56:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.823510 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-07 20:56:55.608917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 20:56:55.612970) ========= 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.GBqONagfzZ/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.4QLjJ97chF/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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/4a347f5f3b1fa7603e52c4dcebf3433754b9c170c8547ccb90dc2625614d03b7ce4cd0fb20f44797848e308578f8abb9c26c38d9a29e556bc921c17b4ab97069", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b3ff9a4b7557b2531eff8ec388628c3e1732a436b932b49c80c2d8ca171fae27e987e12e7f3210f10d241f1c262df43e89c5834d7a8cb482498bf2d1c026c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd1ccf6006b26f04f27a1758fc98e6706e42933d4be412af76998e8ed482c4fdcc49f6192509a72e19474b3290a9e8c97465069a7efd3c5afa0a70d2ab454119"} build_url:https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011128 build_url: 'https://queue.taskcluster.net/v1/task/NW5cIOJ5Rr26RrOId_Bipw/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/4a347f5f3b1fa7603e52c4dcebf3433754b9c170c8547ccb90dc2625614d03b7ce4cd0fb20f44797848e308578f8abb9c26c38d9a29e556bc921c17b4ab97069", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b3ff9a4b7557b2531eff8ec388628c3e1732a436b932b49c80c2d8ca171fae27e987e12e7f3210f10d241f1c262df43e89c5834d7a8cb482498bf2d1c026c21b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bd1ccf6006b26f04f27a1758fc98e6706e42933d4be412af76998e8ed482c4fdcc49f6192509a72e19474b3290a9e8c97465069a7efd3c5afa0a70d2ab454119"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 20:56:55.647013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:56:55.647456) ========= 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.GBqONagfzZ/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.4QLjJ97chF/Listeners TMPDIR=/var/folders/q6/xpx_j8b569553pg_p0r3yk4c00000w/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.005184 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 20:56:55.698236) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 20:56:55.698623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 20:56:55.699032) ========= ========= Total master_lag: 0.18 =========