builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0294 starttime: 1485353211.26 results: success (0) buildid: 20170125032347 builduid: a05964a10add4257b90463c97a8afbb1 revision: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.264070) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.264550) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.264831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.291178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.291553) ========= 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.prwZwMrLlK/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.TxPjXB1H8v/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-25 06:06:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-01-25 06:06:51 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093964 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.409521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.409841) ========= 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.prwZwMrLlK/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.TxPjXB1H8v/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.025776 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:51.458276) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 06:06:51.458655) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d3b5028a47eca5e20b75063c06e61d7ac9a7f295 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d3b5028a47eca5e20b75063c06e61d7ac9a7f295 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.prwZwMrLlK/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.TxPjXB1H8v/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-25 06:06:51,565 truncating revision to first 12 chars 2017-01-25 06:06:51,565 Setting DEBUG logging. 2017-01-25 06:06:51,566 attempt 1/10 2017-01-25 06:06:51,566 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d3b5028a47ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 06:06:52,712 unpacking tar archive at: mozilla-beta-d3b5028a47ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.421443 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 06:06:52.903569) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:52.903910) ========= script_repo_revision: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:52.904401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:52.904722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:52.925101) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-25 06:06:52.925561) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.prwZwMrLlK/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.TxPjXB1H8v/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:06:53 INFO - MultiFileLogger online at 20170125 06:06:53 in /builds/slave/test 06:06:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:06:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:06:53 INFO - {'append_to_log': False, 06:06:53 INFO - 'base_work_dir': '/builds/slave/test', 06:06:53 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:06:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:06:53 INFO - 'branch': 'Mozilla-Beta', 06:06:53 INFO - 'buildbot_json_path': 'buildprops.json', 06:06:53 INFO - 'config_files': ('talos/mac_config.py',), 06:06:53 INFO - 'default_actions': ('clobber', 06:06:53 INFO - 'read-buildbot-config', 06:06:53 INFO - 'download-and-extract', 06:06:53 INFO - 'populate-webroot', 06:06:53 INFO - 'create-virtualenv', 06:06:53 INFO - 'install', 06:06:53 INFO - 'run-tests'), 06:06:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:06:53 INFO - 'download_minidump_stackwalk': True, 06:06:53 INFO - 'download_symbols': 'ondemand', 06:06:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:06:53 INFO - 'tooltool.py': '/tools/tooltool.py', 06:06:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:06:53 INFO - '/tools/misc-python/virtualenv.py')}, 06:06:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:06:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:06:53 INFO - 'installer_path': 'installer.exe', 06:06:53 INFO - 'log_level': 'info', 06:06:53 INFO - 'log_name': 'talos', 06:06:53 INFO - 'log_to_console': True, 06:06:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:06:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:06:53 INFO - 'opt_config_files': (), 06:06:53 INFO - 'pip_index': False, 06:06:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:06:53 INFO - 'cmd': ('bash', 06:06:53 INFO - '-c', 06:06:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:06:53 INFO - 'enabled': True, 06:06:53 INFO - 'halt_on_failure': False, 06:06:53 INFO - 'name': 'check_screen_resolution'},), 06:06:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:06:53 INFO - 'cmd': ('bash', 06:06:53 INFO - '-c', 06:06:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:06:53 INFO - 'enabled': True, 06:06:53 INFO - 'halt_on_failure': False, 06:06:53 INFO - 'name': 'check_screen_resolution'},), 06:06:53 INFO - 'run_cmd_checks_enabled': True, 06:06:53 INFO - 'sps_profile': False, 06:06:53 INFO - 'sps_profile_interval': 0, 06:06:53 INFO - 'suite': 'dromaeojs', 06:06:53 INFO - 'system_bits': '32', 06:06:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:06:53 INFO - 'title': 't-yosemite-r7-0294', 06:06:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:06:53 INFO - 'use_talos_json': True, 06:06:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:06:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:06:53 INFO - 'work_dir': 'build'} 06:06:53 INFO - [mozharness: 2017-01-25 14:06:53.140965Z] Running clobber step. 06:06:53 INFO - Running pre-action listener: _resource_record_pre_action 06:06:53 INFO - Running main action method: clobber 06:06:53 INFO - rmtree: /builds/slave/test/build 06:06:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:06:55 INFO - Running post-action listener: _resource_record_post_action 06:06:55 INFO - [mozharness: 2017-01-25 14:06:55.441699Z] Finished clobber step (success) 06:06:55 INFO - [mozharness: 2017-01-25 14:06:55.441894Z] Running read-buildbot-config step. 06:06:55 INFO - Running pre-action listener: _resource_record_pre_action 06:06:55 INFO - Running main action method: read_buildbot_config 06:06:55 INFO - Using buildbot properties: 06:06:55 INFO - { 06:06:55 INFO - "project": "", 06:06:55 INFO - "product": "firefox", 06:06:55 INFO - "script_repo_revision": "production", 06:06:55 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:06:55 INFO - "repository": "", 06:06:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:06:55 INFO - "buildid": "20170125032347", 06:06:55 INFO - "pgo_build": "False", 06:06:55 INFO - "basedir": "/builds/slave/test", 06:06:55 INFO - "buildnumber": 20, 06:06:55 INFO - "slavename": "t-yosemite-r7-0294", 06:06:55 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:06:55 INFO - "platform": "yosemite_r7", 06:06:55 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:06:55 INFO - "branch": "mozilla-beta", 06:06:55 INFO - "repo_path": "releases/mozilla-beta", 06:06:55 INFO - "revision": "d3b5028a47eca5e20b75063c06e61d7ac9a7f295", 06:06:55 INFO - "stage_platform": "macosx64", 06:06:55 INFO - "builduid": "a05964a10add4257b90463c97a8afbb1", 06:06:55 INFO - "slavebuilddir": "test" 06:06:55 INFO - } 06:06:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 06:06:55 INFO - Running post-action listener: _resource_record_post_action 06:06:55 INFO - [mozharness: 2017-01-25 14:06:55.445430Z] Finished read-buildbot-config step (success) 06:06:55 INFO - [mozharness: 2017-01-25 14:06:55.445574Z] Running download-and-extract step. 06:06:55 INFO - Running pre-action listener: _resource_record_pre_action 06:06:55 INFO - Running main action method: download_and_extract 06:06:55 INFO - mkdir: /builds/slave/test/build/tests 06:06:55 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')]} 06:06:55 INFO - trying https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 06:06:55 INFO - Downloading https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 06:06:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 06:06:56 INFO - Downloaded 1165 bytes. 06:06:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 06:06:56 INFO - Using the following test package requirements: 06:06:56 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 06:06:56 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:06:56 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 06:06:56 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:06:56 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 06:06:56 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:06:56 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:06:56 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 06:06:56 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 06:06:56 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:06:56 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 06:06:56 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:06:56 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 06:06:56 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:06:56 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 06:06:56 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 06:06:56 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 06:06:56 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 06:06:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 06:06:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 06:06:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 06:06:57 INFO - Http code: 200 06:06:57 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 06:06:57 INFO - x-amz-cf-id: p8_QdiAaOHyAAp4cGUWnyRtJrABITWFTjSvIfhXThl9DQk8rsmGxvw== 06:06:57 INFO - x-amz-version-id: bU6dVKRRShmbi1N6LzPthQNB5pH9ui7E 06:06:57 INFO - Expected file size: 16086224 06:06:57 INFO - Obtained file size: 16086224 06:07:03 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:07:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 06:07:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 06:07:03 INFO - Fetch https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 06:07:04 INFO - Http code: 200 06:07:04 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 06:07:04 INFO - x-amz-cf-id: -bXJmbwcibqGfrp__jgTtzm-lGxfpE6HhTGu3nBoeQ_EcQkp2yPU3g== 06:07:04 INFO - x-amz-version-id: bU6dVKRRShmbi1N6LzPthQNB5pH9ui7E 06:07:04 INFO - Expected file size: 16086224 06:07:04 INFO - Obtained file size: 16086224 06:07:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 06:07:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 06:07:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 06:07:11 INFO - Http code: 200 06:07:11 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 06:07:11 INFO - x-amz-cf-id: rxF-IbJOHxpRaahzIMdohuF8KHRINWJ_3O_ulP1kTK2VgQib_i1vLw== 06:07:11 INFO - x-amz-version-id: e0gssD67rqM33UAEBzjihGDINyQ6OaZs 06:07:11 INFO - Expected file size: 14402992 06:07:11 INFO - Obtained file size: 14402992 06:07: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')]} 06:07:12 INFO - trying https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:07:12 INFO - Downloading https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 06:07:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 06:07:14 INFO - Downloaded 82123880 bytes. 06:07:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:07:14 INFO - mkdir: /builds/slave/test/properties 06:07:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:07:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:07:14 INFO - Contents: 06:07:14 INFO - build_url:https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 06:07:14 INFO - Running post-action listener: _resource_record_post_action 06:07:14 INFO - Running post-action listener: set_extra_try_arguments 06:07:14 INFO - [mozharness: 2017-01-25 14:07:14.929539Z] Finished download-and-extract step (success) 06:07:14 INFO - [mozharness: 2017-01-25 14:07:14.929643Z] Running populate-webroot step. 06:07:14 INFO - Running pre-action listener: _resource_record_pre_action 06:07:14 INFO - Running main action method: populate_webroot 06:07:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:07:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:07:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:07:14 INFO - '--tppagecycles', 06:07:14 INFO - '7'], 06:07:14 INFO - 'tests': ['tsvgm']}}, 06:07:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:07:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:07:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:07:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:07:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:07:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['damp', 'tps']}, 06:07:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'tests': ['damp', 'tps']}, 06:07:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['dromaeo_dom']}, 06:07:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:07:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['basic_compositor_video']}, 06:07:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:07:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['a11yr', 06:07:14 INFO - 'ts_paint', 06:07:14 INFO - 'tpaint', 06:07:14 INFO - 'sessionrestore', 06:07:14 INFO - 'sessionrestore_no_auto_restore', 06:07:14 INFO - 'tabpaint']}, 06:07:14 INFO - 'other-e10s': {'tests': ['a11yr', 06:07:14 INFO - 'ts_paint', 06:07:14 INFO - 'tpaint', 06:07:14 INFO - 'sessionrestore', 06:07:14 INFO - 'sessionrestore_no_auto_restore', 06:07:14 INFO - 'tabpaint']}, 06:07:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:07:14 INFO - 'ts_paint', 06:07:14 INFO - 'tpaint', 06:07:14 INFO - 'sessionrestore', 06:07:14 INFO - 'sessionrestore_no_auto_restore', 06:07:14 INFO - 'tabpaint']}, 06:07:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:07:14 INFO - 'ts_paint', 06:07:14 INFO - 'tpaint', 06:07:14 INFO - 'sessionrestore', 06:07:14 INFO - 'sessionrestore_no_auto_restore', 06:07:14 INFO - 'tabpaint']}, 06:07:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['a11yr', 06:07:14 INFO - 'ts_paint', 06:07:14 INFO - 'tpaint', 06:07:14 INFO - 'sessionrestore', 06:07:14 INFO - 'sessionrestore_no_auto_restore', 06:07:14 INFO - 'tabpaint']}, 06:07:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['a11yr', 06:07:14 INFO - 'ts_paint', 06:07:14 INFO - 'tpaint', 06:07:14 INFO - 'sessionrestore', 06:07:14 INFO - 'sessionrestore_no_auto_restore', 06:07:14 INFO - 'tabpaint']}, 06:07:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['tsvgx', 06:07:14 INFO - 'tsvgr_opacity', 06:07:14 INFO - 'tart', 06:07:14 INFO - 'tscrollx', 06:07:14 INFO - 'cart']}, 06:07:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:07:14 INFO - 'tsvgr_opacity', 06:07:14 INFO - 'tart', 06:07:14 INFO - 'tscrollx', 06:07:14 INFO - 'cart']}, 06:07:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'talos_options': ['--disable-e10s'], 06:07:14 INFO - 'tests': ['tp5o']}, 06:07:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'tests': ['tp5o']}, 06:07:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'talos_options': ['--disable-e10s', 06:07:14 INFO - '--xperf_path', 06:07:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:14 INFO - 'tests': ['tp5n']}, 06:07:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:07:14 INFO - 'talos_options': ['--xperf_path', 06:07:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:07:14 INFO - 'tests': ['tp5n']}}, 06:07:14 INFO - 'talos.zip': {'path': '', 06:07:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:07:14 INFO - Running post-action listener: _resource_record_post_action 06:07:14 INFO - [mozharness: 2017-01-25 14:07:14.948122Z] Finished populate-webroot step (success) 06:07:14 INFO - [mozharness: 2017-01-25 14:07:14.948255Z] Running create-virtualenv step. 06:07:14 INFO - Running pre-action listener: _resource_record_pre_action 06:07:14 INFO - Running main action method: create_virtualenv 06:07:14 INFO - Creating virtualenv /builds/slave/test/build/venv 06:07:14 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 06:07:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:07:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:07:15 INFO - Using real prefix '/tools/python27' 06:07:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:07:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:07:18 INFO - Installing pip.................done. 06:07:18 INFO - Return code: 0 06:07:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:07:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:07:18 INFO - Reading from file tmpfile_stdout 06:07:18 INFO - Output received: 06:07:18 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) 06:07:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07: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', 'pip>=1.5'] in /builds/slave/test/build 06:07: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 pip>=1.5 06:07:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:18 INFO - 'HOME': '/Users/cltbld', 06:07:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:18 INFO - 'LOGNAME': 'cltbld', 06:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:18 INFO - 'MOZ_NO_REMOTE': '1', 06:07:18 INFO - 'NO_EM_RESTART': '1', 06:07:18 INFO - 'PAGER': '/bin/cat', 06:07:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:18 INFO - 'PWD': '/builds/slave/test', 06:07:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:18 INFO - 'SHELL': '/bin/bash', 06:07:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:18 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:18 INFO - 'USER': 'cltbld', 06:07:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:18 INFO - 'XPC_FLAGS': '0x0', 06:07:18 INFO - 'XPC_SERVICE_NAME': '0', 06:07:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:19 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 06:07:19 INFO - Cleaning up... 06:07:19 INFO - Return code: 0 06:07:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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', '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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07: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', 'psutil>=3.1.1'] in /builds/slave/test/build 06:07: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 psutil>=3.1.1 06:07:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:19 INFO - 'HOME': '/Users/cltbld', 06:07:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:19 INFO - 'LOGNAME': 'cltbld', 06:07:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:19 INFO - 'MOZ_NO_REMOTE': '1', 06:07:19 INFO - 'NO_EM_RESTART': '1', 06:07:19 INFO - 'PAGER': '/bin/cat', 06:07:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:19 INFO - 'PWD': '/builds/slave/test', 06:07:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:19 INFO - 'SHELL': '/bin/bash', 06:07:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:19 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:19 INFO - 'USER': 'cltbld', 06:07:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:19 INFO - 'XPC_FLAGS': '0x0', 06:07:19 INFO - 'XPC_SERVICE_NAME': '0', 06:07:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:19 INFO - Downloading/unpacking psutil>=3.1.1 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:07:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:23 INFO - Installing collected packages: psutil 06:07:23 INFO - Running setup.py install for psutil 06:07:23 INFO - building 'psutil._psutil_osx' extension 06:07:23 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 06:07:23 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 06:07:23 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 06:07:23 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 06:07:23 INFO - building 'psutil._psutil_posix' extension 06:07:23 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 06:07:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:07:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:07:23 INFO - ^ 06:07:24 INFO - 1 warning generated. 06:07:24 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 06:07:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:07:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:07:24 INFO - Successfully installed psutil 06:07:24 INFO - Cleaning up... 06:07:24 INFO - Return code: 0 06:07:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:07:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:24 INFO - 'HOME': '/Users/cltbld', 06:07:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:24 INFO - 'LOGNAME': 'cltbld', 06:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:24 INFO - 'MOZ_NO_REMOTE': '1', 06:07:24 INFO - 'NO_EM_RESTART': '1', 06:07:24 INFO - 'PAGER': '/bin/cat', 06:07:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:24 INFO - 'PWD': '/builds/slave/test', 06:07:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:24 INFO - 'SHELL': '/bin/bash', 06:07:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:24 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:24 INFO - 'USER': 'cltbld', 06:07:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:24 INFO - 'XPC_FLAGS': '0x0', 06:07:24 INFO - 'XPC_SERVICE_NAME': '0', 06:07:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:07:24 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 06:07:24 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 06:07:24 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 06:07:24 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 06:07:24 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 06:07:24 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 06:07:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:07:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:07:27 INFO - Installing collected packages: mozsystemmonitor 06:07:27 INFO - Running setup.py install for mozsystemmonitor 06:07:27 INFO - Successfully installed mozsystemmonitor 06:07:27 INFO - Cleaning up... 06:07:27 INFO - Return code: 0 06:07:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:07:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:07:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:27 INFO - 'HOME': '/Users/cltbld', 06:07:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:27 INFO - 'LOGNAME': 'cltbld', 06:07:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:27 INFO - 'MOZ_NO_REMOTE': '1', 06:07:27 INFO - 'NO_EM_RESTART': '1', 06:07:27 INFO - 'PAGER': '/bin/cat', 06:07:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:27 INFO - 'PWD': '/builds/slave/test', 06:07:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:27 INFO - 'SHELL': '/bin/bash', 06:07:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:27 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:27 INFO - 'USER': 'cltbld', 06:07:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:27 INFO - 'XPC_FLAGS': '0x0', 06:07:27 INFO - 'XPC_SERVICE_NAME': '0', 06:07:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:27 INFO - Downloading/unpacking jsonschema==2.5.1 06:07:27 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 06:07:27 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 06:07:27 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 06:07:27 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 06:07:27 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 06:07:27 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 06:07:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:07:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07: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 06:07:30 INFO - Downloading functools32-3.2.3-2.tar.gz 06:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:07:30 INFO - warning: no files found matching '*.txt' 06:07:30 INFO - no previously-included directories found matching 'build' 06:07:30 INFO - no previously-included directories found matching 'dist' 06:07:30 INFO - no previously-included directories found matching '.git*' 06:07:30 INFO - Installing collected packages: jsonschema, functools32 06:07:30 INFO - Running setup.py install for functools32 06:07:31 INFO - warning: no files found matching '*.txt' 06:07:31 INFO - no previously-included directories found matching 'build' 06:07:31 INFO - no previously-included directories found matching 'dist' 06:07:31 INFO - no previously-included directories found matching '.git*' 06:07:31 INFO - Successfully installed jsonschema functools32 06:07:31 INFO - Cleaning up... 06:07:31 INFO - Return code: 0 06:07:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:31 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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:31 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 06:07:31 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 06:07:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:31 INFO - 'HOME': '/Users/cltbld', 06:07:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:31 INFO - 'LOGNAME': 'cltbld', 06:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:31 INFO - 'MOZ_NO_REMOTE': '1', 06:07:31 INFO - 'NO_EM_RESTART': '1', 06:07:31 INFO - 'PAGER': '/bin/cat', 06:07:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:31 INFO - 'PWD': '/builds/slave/test', 06:07:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:31 INFO - 'SHELL': '/bin/bash', 06:07:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:31 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:31 INFO - 'USER': 'cltbld', 06:07:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:31 INFO - 'XPC_FLAGS': '0x0', 06:07:31 INFO - 'XPC_SERVICE_NAME': '0', 06:07:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:07:31 INFO - Cleaning up... 06:07:31 INFO - Return code: 0 06:07:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:31 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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:31 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 06:07:31 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 06:07:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:31 INFO - 'HOME': '/Users/cltbld', 06:07:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:31 INFO - 'LOGNAME': 'cltbld', 06:07:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:31 INFO - 'MOZ_NO_REMOTE': '1', 06:07:31 INFO - 'NO_EM_RESTART': '1', 06:07:31 INFO - 'PAGER': '/bin/cat', 06:07:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:31 INFO - 'PWD': '/builds/slave/test', 06:07:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:31 INFO - 'SHELL': '/bin/bash', 06:07:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:31 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:31 INFO - 'USER': 'cltbld', 06:07:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:31 INFO - 'XPC_FLAGS': '0x0', 06:07:31 INFO - 'XPC_SERVICE_NAME': '0', 06:07:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:31 INFO - Downloading/unpacking blobuploader==1.2.4 06:07:31 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 06:07:31 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 06:07:31 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 06:07:31 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 06:07:31 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 06:07:31 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 06:07:34 INFO - Downloading blobuploader-1.2.4.tar.gz 06:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:07:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:07:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:07:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:07:35 INFO - Downloading docopt-0.6.1.tar.gz 06:07:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:07:35 INFO - Installing collected packages: blobuploader, requests, docopt 06:07:35 INFO - Running setup.py install for blobuploader 06:07:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:07:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:07:35 INFO - Running setup.py install for requests 06:07:36 INFO - Running setup.py install for docopt 06:07:36 INFO - Successfully installed blobuploader requests docopt 06:07:36 INFO - Cleaning up... 06:07:36 INFO - Return code: 0 06:07:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:36 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')]} 06:07:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:36 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')]} 06:07:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:36 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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:36 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 06:07:36 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 06:07:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:36 INFO - 'HOME': '/Users/cltbld', 06:07:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:36 INFO - 'LOGNAME': 'cltbld', 06:07:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:36 INFO - 'MOZ_NO_REMOTE': '1', 06:07:36 INFO - 'NO_EM_RESTART': '1', 06:07:36 INFO - 'PAGER': '/bin/cat', 06:07:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:36 INFO - 'PWD': '/builds/slave/test', 06:07:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:36 INFO - 'SHELL': '/bin/bash', 06:07:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:36 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:36 INFO - 'USER': 'cltbld', 06:07:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:36 INFO - 'XPC_FLAGS': '0x0', 06:07:36 INFO - 'XPC_SERVICE_NAME': '0', 06:07:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:36 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-y9W_bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-e2SLFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-X3iUOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-InsFjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-PUXHC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-VXKCjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-AVBf4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-TNNiOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-bexORz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-rhDJRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:37 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-RRVYWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:38 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-t1tE5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:38 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-NVBPjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:38 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-t2AMCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:38 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-onbX2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:38 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-zkLGRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:38 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-CdjKIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:07:38 INFO - Running setup.py install for manifestparser 06:07:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:07:38 INFO - Running setup.py install for mozcrash 06:07:39 INFO - Running setup.py install for mozdebug 06:07:39 INFO - Running setup.py install for mozdevice 06:07:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Running setup.py install for mozfile 06:07:39 INFO - Running setup.py install for mozhttpd 06:07:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Running setup.py install for mozinfo 06:07:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Running setup.py install for mozInstall 06:07:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:07:39 INFO - Running setup.py install for mozleak 06:07:40 INFO - Running setup.py install for mozlog 06:07:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:07:40 INFO - Running setup.py install for moznetwork 06:07:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:07:40 INFO - Running setup.py install for mozprocess 06:07:40 INFO - Running setup.py install for mozprofile 06:07:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:07:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:07:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:07:40 INFO - Running setup.py install for mozrunner 06:07:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:07:40 INFO - Running setup.py install for mozscreenshot 06:07:41 INFO - Running setup.py install for moztest 06:07:41 INFO - Running setup.py install for mozversion 06:07:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:07:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:07:41 INFO - Cleaning up... 06:07:41 INFO - Return code: 0 06:07:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07: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')]} 06:07:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07: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')]} 06:07:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:41 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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:41 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 06:07:41 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 06:07:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:41 INFO - 'HOME': '/Users/cltbld', 06:07:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:41 INFO - 'LOGNAME': 'cltbld', 06:07:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:41 INFO - 'MOZ_NO_REMOTE': '1', 06:07:41 INFO - 'NO_EM_RESTART': '1', 06:07:41 INFO - 'PAGER': '/bin/cat', 06:07:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:41 INFO - 'PWD': '/builds/slave/test', 06:07:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:41 INFO - 'SHELL': '/bin/bash', 06:07:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:41 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:41 INFO - 'USER': 'cltbld', 06:07:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:41 INFO - 'XPC_FLAGS': '0x0', 06:07:41 INFO - 'XPC_SERVICE_NAME': '0', 06:07:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:07:41 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-VFJRot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:07:41 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)) 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:07:41 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-VfrUAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:07:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:07:41 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-LLI11u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:07:41 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)) 06:07:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:07:41 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-fe5sYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-Zhn1jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-V3WBIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-wlFt9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-4LsPjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-TmwWdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-ghbLHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-ccniJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-3k8oWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:07:42 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)) 06:07:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:07:42 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-DM_pFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:07:43 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)) 06:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:07:43 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-DYq5WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:43 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-h50ewE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:07:43 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)) 06:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:07:43 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-8Sd3Xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:07:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:07:43 INFO - Running setup.py (path:/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/pip-_tCitF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:07:43 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)) 06:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:07:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:07:43 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)) 06:07:43 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)) 06:07:43 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)) 06:07:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:07:43 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 06:07:43 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 06:07:43 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 06:07:43 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 06:07:43 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 06:07:43 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 06:07:46 INFO - Downloading blessings-1.6.tar.gz 06:07:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:07:46 INFO - Installing collected packages: blessings 06:07:46 INFO - Running setup.py install for blessings 06:07:46 INFO - Successfully installed blessings 06:07:46 INFO - Cleaning up... 06:07:46 INFO - Return code: 0 06:07:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:07:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:46 INFO - Reading from file tmpfile_stdout 06:07:46 INFO - Current package versions: 06:07:46 INFO - blessings == 1.6 06:07:46 INFO - blobuploader == 1.2.4 06:07:46 INFO - docopt == 0.6.1 06:07:46 INFO - functools32 == 3.2.3-2 06:07:46 INFO - jsonschema == 2.5.1 06:07:46 INFO - manifestparser == 1.1 06:07:46 INFO - mozInstall == 1.12 06:07:46 INFO - mozcrash == 1.0 06:07:46 INFO - mozdebug == 0.1 06:07:46 INFO - mozdevice == 0.48 06:07:46 INFO - mozfile == 1.2 06:07:46 INFO - mozhttpd == 0.7 06:07:46 INFO - mozinfo == 0.9 06:07:46 INFO - mozleak == 0.1 06:07:46 INFO - mozlog == 3.4 06:07:46 INFO - moznetwork == 0.27 06:07:46 INFO - mozprocess == 0.23 06:07:46 INFO - mozprofile == 0.28 06:07:46 INFO - mozrunner == 6.13 06:07:46 INFO - mozscreenshot == 0.1 06:07:46 INFO - mozsystemmonitor == 0.3 06:07:46 INFO - moztest == 0.8 06:07:46 INFO - mozversion == 1.4 06:07:46 INFO - psutil == 3.1.1 06:07:46 INFO - requests == 1.2.3 06:07:46 INFO - wsgiref == 0.1.2 06:07:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:07:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:47 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 06:07:47 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 06:07:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:47 INFO - 'HOME': '/Users/cltbld', 06:07:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:47 INFO - 'LOGNAME': 'cltbld', 06:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:47 INFO - 'MOZ_NO_REMOTE': '1', 06:07:47 INFO - 'NO_EM_RESTART': '1', 06:07:47 INFO - 'PAGER': '/bin/cat', 06:07:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:47 INFO - 'PWD': '/builds/slave/test', 06:07:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:47 INFO - 'SHELL': '/bin/bash', 06:07:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:47 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:47 INFO - 'USER': 'cltbld', 06:07:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:47 INFO - 'XPC_FLAGS': '0x0', 06:07:47 INFO - 'XPC_SERVICE_NAME': '0', 06:07:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 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)) 06:07:47 INFO - Cleaning up... 06:07:47 INFO - Return code: 0 06:07:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:07:48 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 0x10aaf4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa6a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa4d957fbc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, '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.prwZwMrLlK/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.TxPjXB1H8v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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 06:07:48 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 06:07:48 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 06:07:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:07:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:07:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:07:48 INFO - 'HOME': '/Users/cltbld', 06:07:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:07:48 INFO - 'LOGNAME': 'cltbld', 06:07:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:07:48 INFO - 'MOZ_NO_REMOTE': '1', 06:07:48 INFO - 'NO_EM_RESTART': '1', 06:07:48 INFO - 'PAGER': '/bin/cat', 06:07:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:07:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:07:48 INFO - 'PWD': '/builds/slave/test', 06:07:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:07:48 INFO - 'SHELL': '/bin/bash', 06:07:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:07:48 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:07:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:07:48 INFO - 'USER': 'cltbld', 06:07:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:07:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:07:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:07:48 INFO - 'XPC_FLAGS': '0x0', 06:07:48 INFO - 'XPC_SERVICE_NAME': '0', 06:07:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:07:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:07:48 INFO - Cleaning up... 06:07:48 INFO - Return code: 0 06:07:48 INFO - Running post-action listener: _resource_record_post_action 06:07:48 INFO - Running post-action listener: _start_resource_monitoring 06:07:48 INFO - Starting resource monitoring. 06:07:48 INFO - [mozharness: 2017-01-25 14:07:48.522792Z] Finished create-virtualenv step (success) 06:07:48 INFO - [mozharness: 2017-01-25 14:07:48.523588Z] Running install step. 06:07:48 INFO - Running pre-action listener: _resource_record_pre_action 06:07:48 INFO - Running main action method: install 06:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:07:48 INFO - Reading from file tmpfile_stdout 06:07:48 INFO - Detecting whether we're running mozinstall >=1.0... 06:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:07:48 INFO - Reading from file tmpfile_stdout 06:07:48 INFO - Output received: 06:07:48 INFO - Usage: mozinstall [options] installer 06:07:48 INFO - Options: 06:07:48 INFO - -h, --help show this help message and exit 06:07:48 INFO - -d DEST, --destination=DEST 06:07:48 INFO - Directory to install application into. [default: 06:07:48 INFO - "/builds/slave/test"] 06:07:48 INFO - --app=APP Application being installed. [default: firefox] 06:07:48 INFO - mkdir: /builds/slave/test/build/application 06:07:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:07:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:08:10 INFO - Reading from file tmpfile_stdout 06:08:10 INFO - Output received: 06:08:10 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:08:10 INFO - Running post-action listener: _resource_record_post_action 06:08:10 INFO - [mozharness: 2017-01-25 14:08:10.817319Z] Finished install step (success) 06:08:10 INFO - [mozharness: 2017-01-25 14:08:10.817456Z] Running run-tests step. 06:08:10 INFO - Running pre-action listener: _resource_record_pre_action 06:08:10 INFO - Running main action method: run_tests 06:08:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:08:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:08:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:08:10 INFO - 2017-01-25 06:08:10.832 screenresolution[1624:7452] starting screenresolution argv=screenresolution get 06:08:10 INFO - 2017-01-25 06:08:10.834 screenresolution[1624:7452] Display 0: 1600x1200x32@60 06:08:10 INFO - 2017-01-25 06:08:10.840 screenresolution[1625:7455] starting screenresolution argv=screenresolution list 06:08:10 INFO - Available Modes on Display 0 06:08:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:08:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:08:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:08:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:08:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:08:11 INFO - Intel Iris: 06:08:11 INFO - Chipset Model: Intel Iris 06:08:11 INFO - Type: GPU 06:08:11 INFO - Bus: Built-In 06:08:11 INFO - VRAM (Dynamic, Max): 1536 MB 06:08:11 INFO - Vendor: Intel (0x8086) 06:08:11 INFO - Device ID: 0x0a2e 06:08:11 INFO - Revision ID: 0x0009 06:08:11 INFO - Displays: 06:08:11 INFO - Display: 06:08:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:08:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:08:11 INFO - Display Serial Number: 1600x1200 60 06:08:11 INFO - Main Display: Yes 06:08:11 INFO - Mirror: Off 06:08:11 INFO - Online: Yes 06:08:11 INFO - Rotation: Supported 06:08:11 INFO - Return code: 0 06:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:08:11 INFO - Python 2.7.3 06:08:11 INFO - Return code: 0 06:08:11 INFO - grabbing minidump binary from tooltool 06:08:11 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')]} 06:08:11 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 0x10a908d30>, '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 0x10a76edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a900b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:08:11 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 06:08:11 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 06:08:11 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 06:08:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:08:11 INFO - Return code: 0 06:08:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:08:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:08:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:08:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:08:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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 06:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0294 --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 06:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.prwZwMrLlK/Render', 06:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:08:11 INFO - 'HOME': '/Users/cltbld', 06:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:08:11 INFO - 'LOGNAME': 'cltbld', 06:08:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:08:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:08:11 INFO - 'MOZ_NO_REMOTE': '1', 06:08:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:08:11 INFO - 'NO_EM_RESTART': '1', 06:08:11 INFO - 'PAGER': '/bin/cat', 06:08:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:08:11 INFO - 'PWD': '/builds/slave/test', 06:08:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:08:11 INFO - 'SHELL': '/bin/bash', 06:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TxPjXB1H8v/Listeners', 06:08:11 INFO - 'TMPDIR': '/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/', 06:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:08:11 INFO - 'USER': 'cltbld', 06:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:08:11 INFO - 'XPC_FLAGS': '0x0', 06:08:11 INFO - 'XPC_SERVICE_NAME': '0', 06:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:08:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0294', '--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 06:08:11 INFO - mozversion application_buildid: 20170125032347 06:08:11 INFO - mozversion application_changeset: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 06:08:11 INFO - mozversion application_display_name: Firefox 06:08:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:08:11 INFO - mozversion application_name: Firefox 06:08:11 INFO - mozversion application_remotingname: firefox 06:08:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:08:11 INFO - mozversion application_vendor: Mozilla 06:08:11 INFO - mozversion application_version: 52.0 06:08:11 INFO - mozversion platform_buildid: 20170125032347 06:08:11 INFO - mozversion platform_changeset: d3b5028a47eca5e20b75063c06e61d7ac9a7f295 06:08:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:08:11 INFO - mozversion platform_version: 52.0 06:08:11 INFO - using testdate: 1485353291 06:08:11 INFO - actual date: 1485353291 06:08:11 INFO - starting webserver on 'localhost:49241' 06:08:11 INFO - SUITE-START | Running 2 tests 06:08:11 INFO - TEST-START | dromaeo_css 06:08:11 INFO - operating with platform_type : mac_ 06:08:11 INFO - Initialising browser for dromaeo_css test... 06:08:11 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpZhj3SU/profile http://localhost:49241/getInfo.html) 06:08:14 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 06:08:14 INFO - PROCESS | 1635 | colorDepth:24 06:08:14 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 06:08:14 INFO - PROCESS | 1635 | __metrics 06:08:14 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:08:14 INFO - PROCESS | 1635 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:08:15 INFO - TEST-INFO | 1635: exit 0 06:08:15 INFO - Browser initialized. 06:08:15 INFO - Running cycle 1/1 for dromaeo_css test... 06:08:15 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpZhj3SU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:27 INFO - PROCESS | 1638 | RSS: Main: 172097536 06:08:27 INFO - PROCESS | 1638 | 06:11:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 06:11:33 INFO - PROCESS | 1638 | RSS: Main: 318201856 06:11:33 INFO - PROCESS | 1638 | 06:14:36 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:14:36 INFO - PROCESS | 1638 | RSS: Main: 298897408 06:14:36 INFO - PROCESS | 1638 | 06:17:39 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:17:39 INFO - PROCESS | 1638 | RSS: Main: 268500992 06:17:39 INFO - PROCESS | 1638 | 06:20:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 06:20:42 INFO - PROCESS | 1638 | RSS: Main: 272789504 06:20:42 INFO - PROCESS | 1638 | 06:23:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 06:23:46 INFO - PROCESS | 1638 | RSS: Main: 260780032 06:23:46 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 06:26:49 INFO - PROCESS | 1638 | RSS: Main: 413204480 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | __start_tp_report 06:26:49 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 06:26:49 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 06:26:49 INFO - PROCESS | 1638 | |i|pagename|runs| 06:26:49 INFO - PROCESS | 1638 | |0;dojo.html;3455.447128459446;3461.4115600347936;3471.2363280078375;3477.704395126414;3538.168530395357;5469.5624350052;5736.799212027579;5744.540436765059;5747.080467125261;5788.5658575606785;5747.856303592413;5792.6524408535415;5818.44724751148;5819.505342045921;5819.505342045931;5269.6311258211845;5308.5414991936395;5311.442298558653;5357.839264822042;5406.702631355274;5270.0250453666;5281.207818827187;5286.365636123671;5293.39126000511;5383.407825139231;4500.437445319335;5381.623286369956;5382.165764306539;5397.325334333208;5432.592555558349;5355.116405793039;5378.865528361783;5383.4212053427445;5393.352797664305;5416.8104116356135;5107.668001579923;5217.895642087175;5232.136697444917;5308.018016666891;5325.281087053237;5670.631408958446;5719.19931209631;5746.051901436258;5746.080627099685;5775.480206781368;6135.263768347782;6141.744875216143;6159.907601385983;6162.84592885177;6164.537659675542;6201.565890387675;6255.374462553754;6263.4989200864275;6273.749050037993;6278.968605156991;5777.45114214149;5779.508741756956;5818.7672493100645;5824.854378640483;5825.533957283407;6282.308946015934;6285.2457705075685;6302.432781049728;6311.495080393557;6327.525435592349;5955.255593050869;5966.284045914431;5975.731092100779;6081.756729730761;6135.662538560422;6282.654454005074;6299.779507717208;6305.684715764193;6307.779227727099;6320.146780184617;6220.409061139185;6226.968865155645;6244;6251.781187658501;6253.906191407133;6068.059450785136;6105.877882442326;6106.15732346443;6262.5929314594405;6264.718087686065;4914.72968986702;4926.039422312615;4942.777575009133;4946.035523073038;4946.109700253989;4394.714343567658;4461.263891457873;4471.5081341052455;4473;4498.370228168059;5941.108833674897;5960.821175364746;5972.193753843262;6004.369541198199;6006.279246490361;6252.218472690914;6253.187085678833;6265.65538895356;6287.937120628735;6288.276848162428;5924.4667979882015;5940.316863560746;5949.434803693643;5967.104934259895;5990.221271234712;5352.090144675414;5385.434529374437;5397.298351214396;5408.1887716842;5456.61803673739;6232.750689972441;6326.905096423558;6329.240491141092;6335.176427064452;6394.424501794861;6258.749650013949;6260.186175797117;6287.96856015717;6294;6316.14732011191;6202.255729312331;6229.0967809668255;6346.2067241594805;6348.904766428415;6353.205849268841;6131.407250743203;6143.109249158758;6195.535334849814;6242.28213755424;6268.686565671789;5335.906139241524;5991.820245392645;6281.026440901667;6307.590006649553;6331.240251169889;5986.521078313637;6068.757249709962;6167.475764560063;6172.537059720449;6186.072089186478;6082;6095.908561371494;6119.228375855631;6119.441623354662;6169.753209871555;6046.002409602366;6047.879042419039;6049.334573197033;6050.183225264533;6059.21230240066;5998.970005149947;6109.08363745424;6143.631382117087;6168.1056246844855;6173.074038894202;5857.736401861841;5966.313873904556;6007.939920600738;6012.398760123952;6075.544334174866 06:26:49 INFO - PROCESS | 1638 | |1;ext.html;529.1692043491718;529.7457220534144;530.0353356890458;549.4121290219467;558.0290294886893;31556.368872622563;33152.005439836816;33162.33675326492;33257.16857078571;41717.37423938643;35781.46327805078;43159;43574.56425435745;43640.563594364045;43733;9702.61189552417;9863.753406164831;9876.111149996499;9884.357516761387;9887.752806179868;9651.903480965171;9767;9770.853437198448;9771.951140244324;9779.559919803625;9726.70819875405;9796.902030979705;9804.117629413351;9808.411495310304;9814.754631134243;9715.562799674031;9757.219422446187;9773.267004974656;9774.26692998021;9783.657571985017;9738.853917191247;9810.558524866326;9815.165710914582;9830.361026533252;9849.803003939953;41326.79336603328;41656;41713.58286417127;41738.33046678129;41834.79082604598;3513.5608048993877;3589.623089575583;3606.2607165531003;3719.497867787868;3834.2331533693373;31214.53178202306;31520.527192092137;31659.100309465033;31766.841165794252;31854.681453185403;3119.266972261517;3211.309568442796;3240.756943229267;3244.237604163043;3270.3459308138467;518872;521801;522696;523145.38427308;523658;64170;64525.67737161378;64611.353886460536;64613;64743.67628161829;35813.74651887172;36342.454863177074;36468;37496;37564.62435375666;15956.601084972737;16142.596435088983;16145.112018838841;16170.514884553482;16186.514404567883;12168.330741809286;12264.754704905852;12266.141370104186;12284.631461056182;12296.569620063256;19418.320358787376;19646.312379066665;19692.803071969385;19702.01489925498;19715.11281992314;7764.805879853049;7834.921650783419;7844.249407924833;7850.882236766453;7877.212278772192;842.4692443760392;945.3382632157517;1028.984565231522;1092.5684354679856;1106.397013627575;24020.51958960811;28753;29902.70097298999;30323.393532129234;30408;859.5916939453834;900.9504477253682;949.8480243161061;960.8030353777459;1060.4803646213454;15287.617809554627;16153.353865845469;16157.676846463004;16170.353185872433;16338.428155014517;695736;698627;698694;699811;699851;59551;60195;60205.698971505735;60269.397306027255;60307;1263.210493441599;1305.6278960496213;1394.1774353131498;1401.6355747505722;1444.949426770037;29660.406791864472;31088.465588397965;32068.5189722159;32228.516572251905;32393.916728995264;52446.47553524416;53096.20355694745;53263.46736532585;53490;53550.99999999844;605684;617622;618406;618753;619998.900005497;37424.6257537432;38359.61640383561;41450.37824432576;43530.56469435265;44328.778356108014;47213;47860.28209576929;47951.5204847947;48632.756836215594;48712.5128748708;39218.215635687695;39467.605323947544;39505.80247098746;39784.20431591294;41275.793621032906;38994.4150837732;39183.80408098055;39505.80247098746;40210.597894021856;40855.59144408637;37660;37996.05009874775;38421.4236786454;38863.80568097141;38916.805415973875;33310.83344583261;35036;35731.642683572834;35864.46203307005;35911.64088359083;25809.611876139956;25920.8703956479;26028.787553057446;26450.470990579695;26457.867710661325 06:26:49 INFO - PROCESS | 1638 | |2;jquery.html;371.76207227374476;383.98656047038344;388.71429499318;392.9744566603169;410.18373436860657;19607.509812254684;21531.892340538314;21577.784222157774;21815.127394904204;22085.006174722115;20528.692069618966;20788;21131.683024754642;21284;21336.03987820548;5926.585139040269;5993.850153746159;6104.328523862371;6157.415045570664;6175.289841668198;4402.97798511007;4624.1445332613575;4627.62978961684;6109.908351374733;6225.750969961219;6547.476201903836;6827.146606674166;6867.519273650846;6945.027696122547;6945.131858517685;5816.9418305817035;6599.373059559334;6926.688299026506;6933.2720064393525;6940;5120.206368012927;5988.131720900445;6031.336552979169;6096.177016102858;6097.420745029215;26787.86606066957;26816.329591760168;26900.86549567259;27005.459890802074;27053;2022.706707527415;2125.330520885916;2148.1622167354744;2448.326710154704;3104.410162069222;10107.747306317327;10482.79034419315;12332.828381303761;15847;16341.346346146258;1876.1576212038772;1923.951901202467;1962.3033822992918;2039.4187656517822;2039.5920815836744;101573.49213253887;103467;104881;123624.76375236313;129059;11563.132765042656;11587.08813045838;11607.419629018685;11672.066234701204;11705.824412633818;15042.849571504365;15058.698826023417;15058.924705376403;15058.924705376403;15100.848991509944;7249.347558719635;8394.538300393415;8658.090900455487;8682.565871706389;8779.341549383822;8470.957645211734;8476.618552165044;8484.109168537338;8611.311095112376;8617.224449799423;4417.712848664826;4553.2942393929;4568.634509239253;4604.907901842012;4694.342792009122;1705.8485522272665;1783.7324401339904;1812.8005919348861;1841.9040670800853;1851.5000949743494;825.9463134896213;873.6112429968603;878.2183856367838;936.8969413364524;948.6442584030989;18733.531661708294;20107.396778096387;22289.10843566239;22321.21875734374;22330.106795728312;946.6071580294101;968.7142293023575;978.554757585297;992.5533509920565;1030.057497389895;8205.671773129128;11340.092792576574;11349.319040857576;11361.318320900607;11365.488553015135;549851;555267;571785;589626;591174;112744.87255127344;119136;122004;129397;131139;979.5151400057017;986.5067466266867;1035.53918506264;1041.4896700616796;1045.5974449836867;19116.713249300992;19603.509912252306;20215.79784202139;20223;20233.898830505754;55620.721896390256;55652.72173639106;56166.719166403906;57167.42832571621;57225.85548289094;76018.61990690012;76798;79092.20907791078;82858.58570707108;86139;7484.550926944401;7635.465517413728;7986.161453047346;8209.548474833942;8217.83564328722;12846.486140554272;13352.465901364225;13448.663783405493;13473.191608503521;13828.239446830119;11581.594644187413;11620.825687614863;11759;11873.465694043962;12024.278543287432;11172.217944744116;11361.375124367909;11554.884451155382;11618.419079045845;11985.400729963641;11589.826152607886;11716.179867409199;11775.23460975034;12032.338221397908;12083.818742718691;7568.470207085671;7665.118511371264;7684.807879803049;7794.817451113698;7869.921300786918;11256.212065155689;11619.30284182918;11638.70903227426;11973.820392693942;11986 06:26:49 INFO - PROCESS | 1638 | |3;mootools.html;1376.256821316488;1508.3966413434625;1509.6075020494668;1532.9422698338146;1920.2031157069816;7561.281678240565;7936.087349954757;8150.836983260331;8358.498490090598;8372.288355489776;8240.299574536157;8316.251537361637;8320.959880014998;8321.12628174042;8323.45897516661;2324.395657129142;2357.363511851799;2358.25714899806;2359.079958816063;2365.680633114525;2348.802110923433;2390.2590197038885;2400.231925783741;2403.5433267679173;2404.4950560382254;2301.9079236830507;2319.026009076192;2343.8828058597087;2346.7770561796688;2348.906043758256;2320.6751054852334;2329.091654254842;2351.5061837014246;2355.4111472131967;2357.634566642173;2348.3659411958674;2369.9289021329387;2383.845050071757;2388.295452841416;2390.6414037894283;8178.83642327156;8231.547264900428;8372.28835548979;8375;8376.120507346703;5059.544640982329;5245.423003469616;5246.081935661244;5253;5258.211268309746;3186.3308705171944;3396.6603339666085;3496.6153723090692;3498.4227602445567;3582.7850328980085;1075.2258373970728;1097.7969075721016;1105.9612913547987;1108.2076315434422;1122.8764835868049;10654.147668186526;10723.46382680863;10790.892091079068;10791.1906607004;10810.621628242974;4245.490541135084;4400.361947517592;4473.507914129443;4493.123840851068;4496.078303947683;8535.871961920577;8551.401401901807;8556.957215214008;8557.914420855712;8558;4382.956170438319;5067.265246539231;5071.4928507149725;5076.314697515862;5079.949200508022;4365.75988320639;4488;4640.559146881041;4697.037107393045;4759;3650.908727281839;3675.5038069860225;3746.194568167857;3765.5669597996034;3787.6401741834484;1149.9592868454063;1152.4929031226234;1154.2958795134962;1165.6677846813618;1166.9066474682006;921.8340698674169;924.5469719837231;929.6420877962033;931.3992474853682;962.2782912815388;5584;5618.85952851182;5918.141869428909;5958.493528050078;5963.105534169909;908.5911339897073;958.5159494455255;967.4098799732158;970.427447805798;975.4634950777045;3332.583427071616;3725.1990821973404;3850.9807450962567;3895.35726605107;4002.1795531915886;9782.5597848097;10050.346727462691;10138;10180.032896874785;10201.693949181536;9896.406215627085;10118.544665489924;10120.645777397756;10124.493775311352;10140.391576505433;7654.693812247559;7724.420668449889;7888.408369372205;7904.0119985001875;7918.604069796487;5515.779368825202;5563.415841336601;5574.777008919597;5705.144228365778;5739.62692424991;9275.39709918853;9420.481873497023;9421.905780942103;9441.433513989183;9447;8065.959670201846;9198.816023679356;9358.204552613104;9509;9583.993680663709;6343.968280158754;6528.6735663215695;6679.56582822115;6696.732130714911;6824.488163387667;7705.845883082419;8000.5599692017495;8006.159353267823;8018.198180181935;8019.599020048858;7095.9645201773665;7168.856622867618;7207.48642785021;7237.203907570058;7310;6964.582125072512;6997.7200911962955;7055.3650171484815;7077.186123595852;7121.181064177686;6624.735010599522;6627.966860165669;6730.226024007302;6738.056672065817;6753.696083676148;4068.2066996936496;4616.792244348945;4634.281686338623;4642.442906851199;4722.1028004679;4880.92678609814;4889.095517329305;4890.315355850255;5050.292958985671;5166.560842328294 06:26:49 INFO - PROCESS | 1638 | |4;prototype.html;261.2580272027442;308.361691299011;314.55176373667524;317.38110684165883;320.5240218275861;4353.259945809212;4776.498467660889;5319.271236848031;5326.360836699597;5348.652337598059;4803.25549539821;4952.900941981158;5155.896882062366;5163.251328557357;5173.534381905628;4030.6170913763217;4052.2503336882623;4083.693218170187;4103.405006274089;4125.608067233608;3873.825677844504;4093.3450647896193;4104.8768536943935;4128.21563902859;4159.417681524589;3826.693864490834;4036.6568841648495;4052.5744796796207;4085.1412607263774;4105.466289382376;3802.174956021125;3986.9202615947665;4036.858709945167;4062.918741625151;4072.287349713803;3431.1079119428878;3481.9129521761906;3491.354099491602;3496.2483066140903;3526.188976535386;4203.696853975277;4805.543473370024;5050.696958182521;5072.2391641253735;5094.217024041593;4487.573680500347;4558.521355257683;4584.197765391076;4594.724316541018;4646.790894409726;4747.45404278509;5107.284980102789;5346.716787970898;5467.20725494805;5491.121420572689;3096.690330966908;3659.670629643318;3845.8653947111716;3845.8653947111998;3875.5543112541854;5086.084504789136;5259.815906443295;5410.648307860016;5860.765569377178;6018.458338749533;3357.942248191812;3836.9232615348096;3876.383441177194;3905.882823515299;3914.667253283446;3958.7228893977144;3964.980175099106;3966.424868394067;3969.503812023497;3975.8012099394914;4430.025394413224;4537.6143027842345;4586.587207151306;4605.148047611203;4610.3084537319;4654.348391225231;4997.800087996439;5329.307190065267;5335.906139241446;5594.244776955059;1106.7659559590998;1205.9939700301443;1239.7086684629105;1269.3018839638162;1288.8131220972907;747.3460721868365;828.7803732010901;832.4048305461624;865.2126564825978;870.8824308718368;3889.091463079587;4020.6582440492302;4506.1213063452315;4699.859004229878;4883;4784.258439941815;5258;5309.991101690666;5351.491608297206;5415.241866138744;3894.4353068804867;4426.092651006536;4821.300911367832;4890.877728056827;4963.49343581489;2511.5855883779336;2575.7037940637065;2603.5053339865367;2797.622021281935;2806.424682939992;4801.399825021872;4891.9755401222765;5101.9489805101475;5526.917096243559;5636.632614302003;5209.515288142861;5482.972585137049;5501.339839219319;5563.052931474032;5564;4795.496472870368;5629.0149223885655;5649.661020338793;5656.85857853557;5672.17864814904;4407.779611019372;4732.929006064981;5085.4914508548845;5411.2965314508865;5413.593980451561;5046.369203849519;5597.160425936142;5748.626339287933;5773.884522309614;5807.245058142415;5974.103884417372;6071.453569178795;6080.543959202989;6085.208922840003;6086.6348019119;3232.6444091149483;3456.2223499712363;3752.249550089938;3919.1965647042857;3958.51555666625;4635.397398338195;5340.798320377884;5830.329512106162;5871.794487192928;5883.2057672213705;4447.642030267128;4684.758538987103;5581.302337207849;5612.045952188057;5683.431656834449;5216.66091704038;5426.565874730091;5597.3003374578175;5640;5640.661560306395;4843.515648435269;5052.772625231947;5160.845174644766;5477.808276710296;5544.811733253476;5263.210518422267;5466.508014278734;5701.291886353949;5710.488049849396;5732.512736417451;4796.760161991956;5097.974510127574;5533.170024496197;5563.7774489019985;5630.042892708331 06:26:49 INFO - PROCESS | 1638 | |5;yui.html;672.1665135232311;721.4985585018414;779.7621725373758;793.8452001859636;816.9877451838222;14572.417103315867;15683.529494115195;15705.979111357754;15722.091413088587;15722.371105155795;12390.946769524578;12655.240685558872;13816;14090.154590724564;14294.857051429482;693.8820400531896;703.3915662951562;703.4126504368858;706.1737766812842;806.6491076381764;708.174976152784;710.4174576846988;817.4073796497521;846.4159729786459;847.9491230526157;740.4927624577155;874.9737507874773;891.4873947480193;891.5675897189858;891.9732408027769;885.5926273914007;885.9601317940708;887.4409122252972;887.8934527856634;887.9467231966103;655.7082098466185;656.3108735827362;656.7044829826549;656.9441597464221;657.2080642825384;14502.347394367172;14632.122072675673;14677.55967320982;14688;15324.233788310652;14243.501477448342;14532.346044428026;14634.41462341505;14708.485203017843;14823.555293341216;10784;11303.434828258636;11305.886941130566;11814.704632384173;12077.27536347822;4646.4191976003;4662.487126416091;4893.608511319086;4901.436334821506;4914.950850491485;88077.11922880753;90740;91177.3774829165;91277.54361228218;93201.53399233028;10579.523921423555;10971.561137554409;11365.431728413547;11376.54493820238;11439.714007149722;17478.388256411217;20924.790752092587;20973.47566310824;20998.370048898556;21014.2645007424;7678.078630564256;7854.725084622125;7910.129885712567;8033.19668033192;8048.114707382183;4248.171606536757;4377.102693947733;4398.406215160976;4460.107978404332;4561.749103799323;3427.8971630851115;3532.523109380252;3536.5402497675136;3557.270759494349;3561.3233485637647;631.0817760159049;645.9224893012869;655.7180412422608;664.5481072870398;668.9732410703517;559.8740283436194;574.5862978655362;602.2712517853358;656.4846595422571;693.5561240805888;7629.3133617974645;8221.958890205511;8992.235659968845;9062.864057039149;9273.629054837731;665.6288046623873;671.758167059858;674.7537148940602;677.9186497620317;691.8235849858355;3767.51022367096;4133.689973251958;4609.7695115244105;4621.584057434847;4640.303954406866;70482.64758676276;95245.52377238208;104474;119928.8007119935;120752;78238;101150;104993;105020;107795;69996;87407.56296218478;89717.65423518652;90278.54860725654;92338;8545.957270213608;8700.825388572463;9512.667056652985;9666.613335466502;9720.125188733047;50381;53283.73358133184;54485.1827222584;54602.18096728473;54607.6348091285;45240.09519809651;54703.45296547143;54780.23516237383;69132;76947.84578231219;12155.513779448724;12504.374781260718;12532.686682833002;12842.972562194815;13360.599182024554;11208.55165793359;14504.347304371118;14576.416943322572;14843.480478183212;15581.29884155193;12622;13202.735945281232;13659.590212293648;14001.719965600427;14341.498047568284;13290.867091328962;13774.862251377357;13803.447862085806;13957.93021034929;14151.858481415054;12290.754184916073;12573.245605263714;12942.67643308887;13248;13393.062485625913;10756.300840445347;10992.340459572451;11578.536858525564;11592.362420066976;12123.393830308272;9935.304528682922;10787.568497260336;11174.49714762854;11628.418579070843;11693.415329233334 06:26:49 INFO - PROCESS | 1638 | __end_tp_report 06:26:49 INFO - PROCESS | 1638 | __start_cc_report 06:26:49 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1612 06:26:49 INFO - PROCESS | 1638 | __end_cc_report 06:26:49 INFO - PROCESS | 1638 | __startTimestamp1485354409735__endTimestamp 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | ------- Summary: start ------- 06:26:49 INFO - PROCESS | 1638 | Number of tests: 6 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5786.60 Median:6004.37 stddev:619.43 (10.3%) stddev-sans-first:593.72 06:26:49 INFO - PROCESS | 1638 | Values: 3455.4 3461.4 3471.2 3477.7 3538.2 5469.6 5736.8 5744.5 5747.1 5788.6 5747.9 5792.7 5818.4 5819.5 5819.5 5269.6 5308.5 5311.4 5357.8 5406.7 5270.0 5281.2 5286.4 5293.4 5383.4 4500.4 5381.6 5382.2 5397.3 5432.6 5355.1 5378.9 5383.4 5393.4 5416.8 5107.7 5217.9 5232.1 5308.0 5325.3 5670.6 5719.2 5746.1 5746.1 5775.5 6135.3 6141.7 6159.9 6162.8 6164.5 6201.6 6255.4 6263.5 6273.7 6279.0 5777.5 5779.5 5818.8 5824.9 5825.5 6282.3 6285.2 6302.4 6311.5 6327.5 5955.3 5966.3 5975.7 6081.8 6135.7 6282.7 6299.8 6305.7 6307.8 6320.1 6220.4 6227.0 6244.0 6251.8 6253.9 6068.1 6105.9 6106.2 6262.6 6264.7 4914.7 4926.0 4942.8 4946.0 4946.1 4394.7 4461.3 4471.5 4473.0 4498.4 5941.1 5960.8 5972.2 6004.4 6006.3 6252.2 6253.2 6265.7 6287.9 6288.3 5924.5 5940.3 5949.4 5967.1 5990.2 5352.1 5385.4 5397.3 5408.2 5456.6 6232.8 6326.9 6329.2 6335.2 6394.4 6258.7 6260.2 6288.0 6294.0 6316.1 6202.3 6229.1 6346.2 6348.9 6353.2 6131.4 6143.1 6195.5 6242.3 6268.7 5335.9 5991.8 6281.0 6307.6 6331.2 5986.5 6068.8 6167.5 6172.5 6186.1 6082.0 6095.9 6119.2 6119.4 6169.8 6046.0 6047.9 6049.3 6050.2 6059.2 5999.0 6109.1 6143.6 6168.1 6173.1 5857.7 5966.3 6007.9 6012.4 6075.5 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:73919.36 Median:41301.29 stddev:165033.79 (399.6%) stddev-sans-first:165404.77 06:26:49 INFO - PROCESS | 1638 | Values: 529.2 529.7 530.0 549.4 558.0 31556.4 33152.0 33162.3 33257.2 41717.4 35781.5 43159.0 43574.6 43640.6 43733.0 9702.6 9863.8 9876.1 9884.4 9887.8 9651.9 9767.0 9770.9 9772.0 9779.6 9726.7 9796.9 9804.1 9808.4 9814.8 9715.6 9757.2 9773.3 9774.3 9783.7 9738.9 9810.6 9815.2 9830.4 9849.8 41326.8 41656.0 41713.6 41738.3 41834.8 3513.6 3589.6 3606.3 3719.5 3834.2 31214.5 31520.5 31659.1 31766.8 31854.7 3119.3 3211.3 3240.8 3244.2 3270.3 518872.0 521801.0 522696.0 523145.4 523658.0 64170.0 64525.7 64611.4 64613.0 64743.7 35813.7 36342.5 36468.0 37496.0 37564.6 15956.6 16142.6 16145.1 16170.5 16186.5 12168.3 12264.8 12266.1 12284.6 12296.6 19418.3 19646.3 19692.8 19702.0 19715.1 7764.8 7834.9 7844.2 7850.9 7877.2 842.5 945.3 1029.0 1092.6 1106.4 24020.5 28753.0 29902.7 30323.4 30408.0 859.6 901.0 949.8 960.8 1060.5 15287.6 16153.4 16157.7 16170.4 16338.4 695736.0 698627.0 698694.0 699811.0 699851.0 59551.0 60195.0 60205.7 60269.4 60307.0 1263.2 1305.6 1394.2 1401.6 1444.9 29660.4 31088.5 32068.5 32228.5 32393.9 52446.5 53096.2 53263.5 53490.0 53551.0 605684.0 617622.0 618406.0 618753.0 619998.9 37424.6 38359.6 41450.4 43530.6 44328.8 47213.0 47860.3 47951.5 48632.8 48712.5 39218.2 39467.6 39505.8 39784.2 41275.8 38994.4 39183.8 39505.8 40210.6 40855.6 37660.0 37996.1 38421.4 38863.8 38916.8 33310.8 35036.0 35731.6 35864.5 35911.6 25809.6 25920.9 26028.8 26450.5 26457.9 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:34487.59 Median:12389.22 stddev:95430.76 (770.3%) stddev-sans-first:95664.09 06:26:49 INFO - PROCESS | 1638 | Values: 371.8 384.0 388.7 393.0 410.2 19607.5 21531.9 21577.8 21815.1 22085.0 20528.7 20788.0 21131.7 21284.0 21336.0 5926.6 5993.9 6104.3 6157.4 6175.3 4403.0 4624.1 4627.6 6109.9 6225.8 6547.5 6827.1 6867.5 6945.0 6945.1 5816.9 6599.4 6926.7 6933.3 6940.0 5120.2 5988.1 6031.3 6096.2 6097.4 26787.9 26816.3 26900.9 27005.5 27053.0 2022.7 2125.3 2148.2 2448.3 3104.4 10107.7 10482.8 12332.8 15847.0 16341.3 1876.2 1924.0 1962.3 2039.4 2039.6 101573.5 103467.0 104881.0 123624.8 129059.0 11563.1 11587.1 11607.4 11672.1 11705.8 15042.8 15058.7 15058.9 15058.9 15100.8 7249.3 8394.5 8658.1 8682.6 8779.3 8471.0 8476.6 8484.1 8611.3 8617.2 4417.7 4553.3 4568.6 4604.9 4694.3 1705.8 1783.7 1812.8 1841.9 1851.5 825.9 873.6 878.2 936.9 948.6 18733.5 20107.4 22289.1 22321.2 22330.1 946.6 968.7 978.6 992.6 1030.1 8205.7 11340.1 11349.3 11361.3 11365.5 549851.0 555267.0 571785.0 589626.0 591174.0 112744.9 119136.0 122004.0 129397.0 131139.0 979.5 986.5 1035.5 1041.5 1045.6 19116.7 19603.5 20215.8 20223.0 20233.9 55620.7 55652.7 56166.7 57167.4 57225.9 76018.6 76798.0 79092.2 82858.6 86139.0 7484.6 7635.5 7986.2 8209.5 8217.8 12846.5 13352.5 13448.7 13473.2 13828.2 11581.6 11620.8 11759.0 11873.5 12024.3 11172.2 11361.4 11554.9 11618.4 11985.4 11589.8 11716.2 11775.2 12032.3 12083.8 7568.5 7665.1 7684.8 7794.8 7869.9 11256.2 11619.3 11638.7 11973.8 11986.0 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5404.02 Median:5073.90 stddev:2933.78 (57.8%) stddev-sans-first:2926.39 06:26:49 INFO - PROCESS | 1638 | Values: 1376.3 1508.4 1509.6 1532.9 1920.2 7561.3 7936.1 8150.8 8358.5 8372.3 8240.3 8316.3 8321.0 8321.1 8323.5 2324.4 2357.4 2358.3 2359.1 2365.7 2348.8 2390.3 2400.2 2403.5 2404.5 2301.9 2319.0 2343.9 2346.8 2348.9 2320.7 2329.1 2351.5 2355.4 2357.6 2348.4 2369.9 2383.8 2388.3 2390.6 8178.8 8231.5 8372.3 8375.0 8376.1 5059.5 5245.4 5246.1 5253.0 5258.2 3186.3 3396.7 3496.6 3498.4 3582.8 1075.2 1097.8 1106.0 1108.2 1122.9 10654.1 10723.5 10790.9 10791.2 10810.6 4245.5 4400.4 4473.5 4493.1 4496.1 8535.9 8551.4 8557.0 8557.9 8558.0 4383.0 5067.3 5071.5 5076.3 5079.9 4365.8 4488.0 4640.6 4697.0 4759.0 3650.9 3675.5 3746.2 3765.6 3787.6 1150.0 1152.5 1154.3 1165.7 1166.9 921.8 924.5 929.6 931.4 962.3 5584.0 5618.9 5918.1 5958.5 5963.1 908.6 958.5 967.4 970.4 975.5 3332.6 3725.2 3851.0 3895.4 4002.2 9782.6 10050.3 10138.0 10180.0 10201.7 9896.4 10118.5 10120.6 10124.5 10140.4 7654.7 7724.4 7888.4 7904.0 7918.6 5515.8 5563.4 5574.8 5705.1 5739.6 9275.4 9420.5 9421.9 9441.4 9447.0 8066.0 9198.8 9358.2 9509.0 9584.0 6344.0 6528.7 6679.6 6696.7 6824.5 7705.8 8000.6 8006.2 8018.2 8019.6 7096.0 7168.9 7207.5 7237.2 7310.0 6964.6 6997.7 7055.4 7077.2 7121.2 6624.7 6628.0 6730.2 6738.1 6753.7 4068.2 4616.8 4634.3 4642.4 4722.1 4880.9 4889.1 4890.3 5050.3 5166.6 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4419.03 Median:4804.40 stddev:1357.31 (28.3%) stddev-sans-first:1324.75 06:26:49 INFO - PROCESS | 1638 | Values: 261.3 308.4 314.6 317.4 320.5 4353.3 4776.5 5319.3 5326.4 5348.7 4803.3 4952.9 5155.9 5163.3 5173.5 4030.6 4052.3 4083.7 4103.4 4125.6 3873.8 4093.3 4104.9 4128.2 4159.4 3826.7 4036.7 4052.6 4085.1 4105.5 3802.2 3986.9 4036.9 4062.9 4072.3 3431.1 3481.9 3491.4 3496.2 3526.2 4203.7 4805.5 5050.7 5072.2 5094.2 4487.6 4558.5 4584.2 4594.7 4646.8 4747.5 5107.3 5346.7 5467.2 5491.1 3096.7 3659.7 3845.9 3845.9 3875.6 5086.1 5259.8 5410.6 5860.8 6018.5 3357.9 3836.9 3876.4 3905.9 3914.7 3958.7 3965.0 3966.4 3969.5 3975.8 4430.0 4537.6 4586.6 4605.1 4610.3 4654.3 4997.8 5329.3 5335.9 5594.2 1106.8 1206.0 1239.7 1269.3 1288.8 747.3 828.8 832.4 865.2 870.9 3889.1 4020.7 4506.1 4699.9 4883.0 4784.3 5258.0 5310.0 5351.5 5415.2 3894.4 4426.1 4821.3 4890.9 4963.5 2511.6 2575.7 2603.5 2797.6 2806.4 4801.4 4892.0 5101.9 5526.9 5636.6 5209.5 5483.0 5501.3 5563.1 5564.0 4795.5 5629.0 5649.7 5656.9 5672.2 4407.8 4732.9 5085.5 5411.3 5413.6 5046.4 5597.2 5748.6 5773.9 5807.2 5974.1 6071.5 6080.5 6085.2 6086.6 3232.6 3456.2 3752.2 3919.2 3958.5 4635.4 5340.8 5830.3 5871.8 5883.2 4447.6 4684.8 5581.3 5612.0 5683.4 5216.7 5426.6 5597.3 5640.0 5640.7 4843.5 5052.8 5160.8 5477.8 5544.8 5263.2 5466.5 5701.3 5710.5 5732.5 4796.8 5098.0 5533.2 5563.8 5630.0 06:26:49 INFO - PROCESS | 1638 | 06:26:49 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20340.46 Median:4630.94 stddev:29522.29 (637.5%) stddev-sans-first:29568.17 06:26:49 INFO - PROCESS | 1638 | Values: 672.2 721.5 779.8 793.8 817.0 14572.4 15683.5 15706.0 15722.1 15722.4 12390.9 12655.2 13816.0 14090.2 14294.9 693.9 703.4 703.4 706.2 806.6 708.2 710.4 817.4 846.4 847.9 740.5 875.0 891.5 891.6 892.0 885.6 886.0 887.4 887.9 887.9 655.7 656.3 656.7 656.9 657.2 14502.3 14632.1 14677.6 14688.0 15324.2 14243.5 14532.3 14634.4 14708.5 14823.6 10784.0 11303.4 11305.9 11814.7 12077.3 4646.4 4662.5 4893.6 4901.4 4915.0 88077.1 90740.0 91177.4 91277.5 93201.5 10579.5 10971.6 11365.4 11376.5 11439.7 17478.4 20924.8 20973.5 20998.4 21014.3 7678.1 7854.7 7910.1 8033.2 8048.1 4248.2 4377.1 4398.4 4460.1 4561.7 3427.9 3532.5 3536.5 3557.3 3561.3 631.1 645.9 655.7 664.5 669.0 559.9 574.6 602.3 656.5 693.6 7629.3 8222.0 8992.2 9062.9 9273.6 665.6 671.8 674.8 677.9 691.8 3767.5 4133.7 4609.8 4621.6 4640.3 70482.6 95245.5 104474.0 119928.8 120752.0 78238.0 101150.0 104993.0 105020.0 107795.0 69996.0 87407.6 89717.7 90278.5 92338.0 8546.0 8700.8 9512.7 9666.6 9720.1 50381.0 53283.7 54485.2 54602.2 54607.6 45240.1 54703.5 54780.2 69132.0 76947.8 12155.5 12504.4 12532.7 12843.0 13360.6 11208.6 14504.3 14576.4 14843.5 15581.3 12622.0 13202.7 13659.6 14001.7 14341.5 13290.9 13774.9 13803.4 13957.9 14151.9 12290.8 12573.2 12942.7 13248.0 13393.1 10756.3 10992.3 11578.5 11592.4 12123.4 9935.3 10787.6 11174.5 11628.4 11693.4 06:26:49 INFO - PROCESS | 1638 | -------- Summary: end -------- 06:26:49 INFO - PROCESS | 1638 | 06:26:50 INFO - TEST-INFO | 1638: exit 0 06:26:50 INFO - TEST-OK | dromaeo_css | took 1118889ms 06:26:50 INFO - TEST-START | kraken 06:26:50 INFO - operating with platform_type : mac_ 06:26:50 INFO - Initialising browser for kraken test... 06:26:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpWyy1fN/profile http://localhost:49241/getInfo.html) 06:26:52 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 06:26:52 INFO - PROCESS | 1648 | colorDepth:24 06:26:52 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 06:26:52 INFO - PROCESS | 1648 | __metrics 06:26:52 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:26:52 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:26:53 INFO - TEST-INFO | 1648: exit 0 06:26:53 INFO - Browser initialized. 06:26:53 INFO - Running cycle 1/1 for kraken test... 06:26:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/T/tmpWyy1fN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:05 INFO - PROCESS | 1650 | RSS: Main: 168013824 06:27:05 INFO - PROCESS | 1650 | 06:27:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:27:09 INFO - PROCESS | 1650 | RSS: Main: 218058752 06:27:09 INFO - PROCESS | 1650 | 06:27:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:27:12 INFO - PROCESS | 1650 | RSS: Main: 231923712 06:27:12 INFO - PROCESS | 1650 | 06:27:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:27:16 INFO - PROCESS | 1650 | RSS: Main: 327716864 06:27:16 INFO - PROCESS | 1650 | 06:27:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:27:19 INFO - PROCESS | 1650 | RSS: Main: 232722432 06:27:19 INFO - PROCESS | 1650 | 06:27:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:27:21 INFO - PROCESS | 1650 | RSS: Main: 233582592 06:27:21 INFO - PROCESS | 1650 | 06:27:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:27:24 INFO - PROCESS | 1650 | RSS: Main: 272908288 06:27:24 INFO - PROCESS | 1650 | 06:27:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:27:28 INFO - PROCESS | 1650 | RSS: Main: 271208448 06:27:28 INFO - PROCESS | 1650 | 06:27:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:27:31 INFO - PROCESS | 1650 | RSS: Main: 268484608 06:27:31 INFO - PROCESS | 1650 | 06:27:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:27:34 INFO - PROCESS | 1650 | RSS: Main: 249290752 06:27:34 INFO - PROCESS | 1650 | 06:27:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:27:36 INFO - PROCESS | 1650 | RSS: Main: 248287232 06:27:36 INFO - PROCESS | 1650 | 06:27:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:27:39 INFO - PROCESS | 1650 | RSS: Main: 249757696 06:27:39 INFO - PROCESS | 1650 | 06:27:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:27:42 INFO - PROCESS | 1650 | RSS: Main: 271663104 06:27:42 INFO - PROCESS | 1650 | 06:27:45 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:27:46 INFO - PROCESS | 1650 | RSS: Main: 265748480 06:27:46 INFO - PROCESS | 1650 | 06:27:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:27:48 INFO - PROCESS | 1650 | RSS: Main: 309780480 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | __start_tp_report 06:27:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 06:27:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 06:27:48 INFO - PROCESS | 1650 | |i|pagename|runs| 06:27:48 INFO - PROCESS | 1650 | |0;ai-astar;102;112;112;112;113;114;112;112;112;112 06:27:48 INFO - PROCESS | 1650 | |1;audio-beat-detection;143;112;109;138;107;105;110;108;135;111 06:27:48 INFO - PROCESS | 1650 | |2;audio-dft;182;183;182;184;181;182;181;183;181;179 06:27:48 INFO - PROCESS | 1650 | |3;audio-fft;84;58;59;86;63;58;59;57;81;59 06:27:48 INFO - PROCESS | 1650 | |4;audio-oscillator;89;70;94;69;68;68;89;67;68;91 06:27:48 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;91;88;92;88;89;87;91;88;89;87 06:27:48 INFO - PROCESS | 1650 | |6;imaging-darkroom;118;148;103;96;96;96;97;96;96;96 06:27:48 INFO - PROCESS | 1650 | |7;imaging-desaturate;83;82;80;89;84;84;86;84;84;84 06:27:48 INFO - PROCESS | 1650 | |8;json-parse-financial;55;55;53;54;56;56;56;56;55;56 06:27:48 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;62;70;67;78;74;71;69;68;68;68 06:27:48 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;81;82;82;82;82;80;80;91;72;92 06:27:48 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;121;135;136;136;141;140;139;140;183;136 06:27:48 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;162;160;158;160;163;163;163;164;161;161 06:27:48 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;66;66;65;66;67;65;65;65;64;66 06:27:48 INFO - PROCESS | 1650 | __end_tp_report 06:27:48 INFO - PROCESS | 1650 | __start_cc_report 06:27:48 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1870 06:27:48 INFO - PROCESS | 1650 | __end_cc_report 06:27:48 INFO - PROCESS | 1650 | __startTimestamp1485354468062__endTimestamp 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | ------- Summary: start ------- 06:27:48 INFO - PROCESS | 1650 | Number of tests: 14 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:3.33 (3.0%) stddev-sans-first:0.71 06:27:48 INFO - PROCESS | 1650 | Values: 102.0 112.0 112.0 112.0 113.0 114.0 112.0 112.0 112.0 112.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:111.50 stddev:14.66 (13.1%) stddev-sans-first:12.39 06:27:48 INFO - PROCESS | 1650 | Values: 143.0 112.0 109.0 138.0 107.0 105.0 110.0 108.0 135.0 111.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:181.80 Median:182.00 stddev:1.40 (0.8%) stddev-sans-first:1.48 06:27:48 INFO - PROCESS | 1650 | Values: 182.0 183.0 182.0 184.0 181.0 182.0 181.0 183.0 181.0 179.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.40 Median:61.00 stddev:12.08 (19.8%) stddev-sans-first:11.00 06:27:48 INFO - PROCESS | 1650 | Values: 84.0 58.0 59.0 86.0 63.0 58.0 59.0 57.0 81.0 59.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:79.50 stddev:11.68 (14.7%) stddev-sans-first:11.60 06:27:48 INFO - PROCESS | 1650 | Values: 89.0 70.0 94.0 69.0 68.0 68.0 89.0 67.0 68.0 91.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:89.00 stddev:1.76 (2.0%) stddev-sans-first:1.72 06:27:48 INFO - PROCESS | 1650 | Values: 91.0 88.0 92.0 88.0 89.0 87.0 91.0 88.0 89.0 87.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:96.00 stddev:16.88 (17.6%) stddev-sans-first:17.15 06:27:48 INFO - PROCESS | 1650 | Values: 118.0 148.0 103.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:2.36 (2.8%) stddev-sans-first:2.47 06:27:48 INFO - PROCESS | 1650 | Values: 83.0 82.0 80.0 89.0 84.0 84.0 86.0 84.0 84.0 84.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:56.00 stddev:1.03 (1.8%) stddev-sans-first:1.09 06:27:48 INFO - PROCESS | 1650 | Values: 55.0 55.0 53.0 54.0 56.0 56.0 56.0 56.0 55.0 56.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:69.50 stddev:4.28 (6.2%) stddev-sans-first:3.57 06:27:48 INFO - PROCESS | 1650 | Values: 62.0 70.0 67.0 78.0 74.0 71.0 69.0 68.0 68.0 68.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:5.66 (6.9%) stddev-sans-first:5.98 06:27:48 INFO - PROCESS | 1650 | Values: 81.0 82.0 82.0 82.0 82.0 80.0 80.0 91.0 72.0 92.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:139.50 stddev:15.92 (11.4%) stddev-sans-first:15.20 06:27:48 INFO - PROCESS | 1650 | Values: 121.0 135.0 136.0 136.0 141.0 140.0 139.0 140.0 183.0 136.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.50 Median:162.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 06:27:48 INFO - PROCESS | 1650 | Values: 162.0 160.0 158.0 160.0 163.0 163.0 163.0 164.0 161.0 161.0 06:27:48 INFO - PROCESS | 1650 | 06:27:48 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 06:27:48 INFO - PROCESS | 1650 | Values: 66.0 66.0 65.0 66.0 67.0 65.0 65.0 65.0 64.0 66.0 06:27:48 INFO - PROCESS | 1650 | -------- Summary: end -------- 06:27:48 INFO - PROCESS | 1650 | 06:27:49 INFO - TEST-INFO | 1650: exit 0 06:27:49 INFO - TEST-OK | kraken | took 58847ms 06:27:49 INFO - SUITE-END | took 1177s 06:27:49 INFO - Completed test suite (00:19:37) 06:27:49 INFO - javascript benchmark 06:27:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3455.447128459446, 3461.4115600347936, 3471.2363280078375, 3477.704395126414, 3538.168530395357, 5469.5624350052, 5736.799212027579, 5744.540436765059, 5747.080467125261, 5788.5658575606785, 5747.856303592413, 5792.6524408535415, 5818.44724751148, 5819.505342045921, 5819.505342045931, 5269.6311258211845, 5308.5414991936395, 5311.442298558653, 5357.839264822042, 5406.702631355274, 5270.0250453666, 5281.207818827187, 5286.365636123671, 5293.39126000511, 5383.407825139231, 4500.437445319335, 5381.623286369956, 5382.165764306539, 5397.325334333208, 5432.592555558349, 5355.116405793039, 5378.865528361783, 5383.4212053427445, 5393.352797664305, 5416.8104116356135, 5107.668001579923, 5217.895642087175, 5232.136697444917, 5308.018016666891, 5325.281087053237, 5670.631408958446, 5719.19931209631, 5746.051901436258, 5746.080627099685, 5775.480206781368, 6135.263768347782, 6141.744875216143, 6159.907601385983, 6162.84592885177, 6164.537659675542, 6201.565890387675, 6255.374462553754, 6263.4989200864275, 6273.749050037993, 6278.968605156991, 5777.45114214149, 5779.508741756956, 5818.7672493100645, 5824.854378640483, 5825.533957283407, 6282.308946015934, 6285.2457705075685, 6302.432781049728, 6311.495080393557, 6327.525435592349, 5955.255593050869, 5966.284045914431, 5975.731092100779, 6081.756729730761, 6135.662538560422, 6282.654454005074, 6299.779507717208, 6305.684715764193, 6307.779227727099, 6320.146780184617, 6220.409061139185, 6226.968865155645, 6244.0, 6251.781187658501, 6253.906191407133, 6068.059450785136, 6105.877882442326, 6106.15732346443, 6262.5929314594405, 6264.718087686065, 4914.72968986702, 4926.039422312615, 4942.777575009133, 4946.035523073038, 4946.109700253989, 4394.714343567658, 4461.263891457873, 4471.5081341052455, 4473.0, 4498.370228168059, 5941.108833674897, 5960.821175364746, 5972.193753843262, 6004.369541198199, 6006.279246490361, 6252.218472690914, 6253.187085678833, 6265.65538895356, 6287.937120628735, 6288.276848162428, 5924.4667979882015, 5940.316863560746, 5949.434803693643, 5967.104934259895, 5990.221271234712, 5352.090144675414, 5385.434529374437, 5397.298351214396, 5408.1887716842, 5456.61803673739, 6232.750689972441, 6326.905096423558, 6329.240491141092, 6335.176427064452, 6394.424501794861, 6258.749650013949, 6260.186175797117, 6287.96856015717, 6294.0, 6316.14732011191, 6202.255729312331, 6229.0967809668255, 6346.2067241594805, 6348.904766428415, 6353.205849268841, 6131.407250743203, 6143.109249158758, 6195.535334849814, 6242.28213755424, 6268.686565671789, 5335.906139241524, 5991.820245392645, 6281.026440901667, 6307.590006649553, 6331.240251169889, 5986.521078313637, 6068.757249709962, 6167.475764560063, 6172.537059720449, 6186.072089186478, 6082.0, 6095.908561371494, 6119.228375855631, 6119.441623354662, 6169.753209871555, 6046.002409602366, 6047.879042419039, 6049.334573197033, 6050.183225264533, 6059.21230240066, 5998.970005149947, 6109.08363745424, 6143.631382117087, 6168.1056246844855, 6173.074038894202, 5857.736401861841, 5966.313873904556, 6007.939920600738, 6012.398760123952, 6075.544334174866], "value": 5748.450145897276, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.1692043491718, 529.7457220534144, 530.0353356890458, 549.4121290219467, 558.0290294886893, 31556.368872622563, 33152.005439836816, 33162.33675326492, 33257.16857078571, 41717.37423938643, 35781.46327805078, 43159.0, 43574.56425435745, 43640.563594364045, 43733.0, 9702.61189552417, 9863.753406164831, 9876.111149996499, 9884.357516761387, 9887.752806179868, 9651.903480965171, 9767.0, 9770.853437198448, 9771.951140244324, 9779.559919803625, 9726.70819875405, 9796.902030979705, 9804.117629413351, 9808.411495310304, 9814.754631134243, 9715.562799674031, 9757.219422446187, 9773.267004974656, 9774.26692998021, 9783.657571985017, 9738.853917191247, 9810.558524866326, 9815.165710914582, 9830.361026533252, 9849.803003939953, 41326.79336603328, 41656.0, 41713.58286417127, 41738.33046678129, 41834.79082604598, 3513.5608048993877, 3589.623089575583, 3606.2607165531003, 3719.497867787868, 3834.2331533693373, 31214.53178202306, 31520.527192092137, 31659.100309465033, 31766.841165794252, 31854.681453185403, 3119.266972261517, 3211.309568442796, 3240.756943229267, 3244.237604163043, 3270.3459308138467, 518872.0, 521801.0, 522696.0, 523145.38427308, 523658.0, 64170.0, 64525.67737161378, 64611.353886460536, 64613.0, 64743.67628161829, 35813.74651887172, 36342.454863177074, 36468.0, 37496.0, 37564.62435375666, 15956.601084972737, 16142.596435088983, 16145.112018838841, 16170.514884553482, 16186.514404567883, 12168.330741809286, 12264.754704905852, 12266.141370104186, 12284.631461056182, 12296.569620063256, 19418.320358787376, 19646.312379066665, 19692.803071969385, 19702.01489925498, 19715.11281992314, 7764.805879853049, 7834.921650783419, 7844.249407924833, 7850.882236766453, 7877.212278772192, 842.4692443760392, 945.3382632157517, 1028.984565231522, 1092.5684354679856, 1106.397013627575, 24020.51958960811, 28753.0, 29902.70097298999, 30323.393532129234, 30408.0, 859.5916939453834, 900.9504477253682, 949.8480243161061, 960.8030353777459, 1060.4803646213454, 15287.617809554627, 16153.353865845469, 16157.676846463004, 16170.353185872433, 16338.428155014517, 695736.0, 698627.0, 698694.0, 699811.0, 699851.0, 59551.0, 60195.0, 60205.698971505735, 60269.397306027255, 60307.0, 1263.210493441599, 1305.6278960496213, 1394.1774353131498, 1401.6355747505722, 1444.949426770037, 29660.406791864472, 31088.465588397965, 32068.5189722159, 32228.516572251905, 32393.916728995264, 52446.47553524416, 53096.20355694745, 53263.46736532585, 53490.0, 53550.99999999844, 605684.0, 617622.0, 618406.0, 618753.0, 619998.900005497, 37424.6257537432, 38359.61640383561, 41450.37824432576, 43530.56469435265, 44328.778356108014, 47213.0, 47860.28209576929, 47951.5204847947, 48632.756836215594, 48712.5128748708, 39218.215635687695, 39467.605323947544, 39505.80247098746, 39784.20431591294, 41275.793621032906, 38994.4150837732, 39183.80408098055, 39505.80247098746, 40210.597894021856, 40855.59144408637, 37660.0, 37996.05009874775, 38421.4236786454, 38863.80568097141, 38916.805415973875, 33310.83344583261, 35036.0, 35731.642683572834, 35864.46203307005, 35911.64088359083, 25809.611876139956, 25920.8703956479, 26028.787553057446, 26450.470990579695, 26457.867710661325], "value": 20296.08648637402, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.76207227374476, 383.98656047038344, 388.71429499318, 392.9744566603169, 410.18373436860657, 19607.509812254684, 21531.892340538314, 21577.784222157774, 21815.127394904204, 22085.006174722115, 20528.692069618966, 20788.0, 21131.683024754642, 21284.0, 21336.03987820548, 5926.585139040269, 5993.850153746159, 6104.328523862371, 6157.415045570664, 6175.289841668198, 4402.97798511007, 4624.1445332613575, 4627.62978961684, 6109.908351374733, 6225.750969961219, 6547.476201903836, 6827.146606674166, 6867.519273650846, 6945.027696122547, 6945.131858517685, 5816.9418305817035, 6599.373059559334, 6926.688299026506, 6933.2720064393525, 6940.0, 5120.206368012927, 5988.131720900445, 6031.336552979169, 6096.177016102858, 6097.420745029215, 26787.86606066957, 26816.329591760168, 26900.86549567259, 27005.459890802074, 27053.0, 2022.706707527415, 2125.330520885916, 2148.1622167354744, 2448.326710154704, 3104.410162069222, 10107.747306317327, 10482.79034419315, 12332.828381303761, 15847.0, 16341.346346146258, 1876.1576212038772, 1923.951901202467, 1962.3033822992918, 2039.4187656517822, 2039.5920815836744, 101573.49213253887, 103467.0, 104881.0, 123624.76375236313, 129059.0, 11563.132765042656, 11587.08813045838, 11607.419629018685, 11672.066234701204, 11705.824412633818, 15042.849571504365, 15058.698826023417, 15058.924705376403, 15058.924705376403, 15100.848991509944, 7249.347558719635, 8394.538300393415, 8658.090900455487, 8682.565871706389, 8779.341549383822, 8470.957645211734, 8476.618552165044, 8484.109168537338, 8611.311095112376, 8617.224449799423, 4417.712848664826, 4553.2942393929, 4568.634509239253, 4604.907901842012, 4694.342792009122, 1705.8485522272665, 1783.7324401339904, 1812.8005919348861, 1841.9040670800853, 1851.5000949743494, 825.9463134896213, 873.6112429968603, 878.2183856367838, 936.8969413364524, 948.6442584030989, 18733.531661708294, 20107.396778096387, 22289.10843566239, 22321.21875734374, 22330.106795728312, 946.6071580294101, 968.7142293023575, 978.554757585297, 992.5533509920565, 1030.057497389895, 8205.671773129128, 11340.092792576574, 11349.319040857576, 11361.318320900607, 11365.488553015135, 549851.0, 555267.0, 571785.0, 589626.0, 591174.0, 112744.87255127344, 119136.0, 122004.0, 129397.0, 131139.0, 979.5151400057017, 986.5067466266867, 1035.53918506264, 1041.4896700616796, 1045.5974449836867, 19116.713249300992, 19603.509912252306, 20215.79784202139, 20223.0, 20233.898830505754, 55620.721896390256, 55652.72173639106, 56166.719166403906, 57167.42832571621, 57225.85548289094, 76018.61990690012, 76798.0, 79092.20907791078, 82858.58570707108, 86139.0, 7484.550926944401, 7635.465517413728, 7986.161453047346, 8209.548474833942, 8217.83564328722, 12846.486140554272, 13352.465901364225, 13448.663783405493, 13473.191608503521, 13828.239446830119, 11581.594644187413, 11620.825687614863, 11759.0, 11873.465694043962, 12024.278543287432, 11172.217944744116, 11361.375124367909, 11554.884451155382, 11618.419079045845, 11985.400729963641, 11589.826152607886, 11716.179867409199, 11775.23460975034, 12032.338221397908, 12083.818742718691, 7568.470207085671, 7665.118511371264, 7684.807879803049, 7794.817451113698, 7869.921300786918, 11256.212065155689, 11619.30284182918, 11638.70903227426, 11973.820392693942, 11986.0], "value": 9833.65373747077, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1376.256821316488, 1508.3966413434625, 1509.6075020494668, 1532.9422698338146, 1920.2031157069816, 7561.281678240565, 7936.087349954757, 8150.836983260331, 8358.498490090598, 8372.288355489776, 8240.299574536157, 8316.251537361637, 8320.959880014998, 8321.12628174042, 8323.45897516661, 2324.395657129142, 2357.363511851799, 2358.25714899806, 2359.079958816063, 2365.680633114525, 2348.802110923433, 2390.2590197038885, 2400.231925783741, 2403.5433267679173, 2404.4950560382254, 2301.9079236830507, 2319.026009076192, 2343.8828058597087, 2346.7770561796688, 2348.906043758256, 2320.6751054852334, 2329.091654254842, 2351.5061837014246, 2355.4111472131967, 2357.634566642173, 2348.3659411958674, 2369.9289021329387, 2383.845050071757, 2388.295452841416, 2390.6414037894283, 8178.83642327156, 8231.547264900428, 8372.28835548979, 8375.0, 8376.120507346703, 5059.544640982329, 5245.423003469616, 5246.081935661244, 5253.0, 5258.211268309746, 3186.3308705171944, 3396.6603339666085, 3496.6153723090692, 3498.4227602445567, 3582.7850328980085, 1075.2258373970728, 1097.7969075721016, 1105.9612913547987, 1108.2076315434422, 1122.8764835868049, 10654.147668186526, 10723.46382680863, 10790.892091079068, 10791.1906607004, 10810.621628242974, 4245.490541135084, 4400.361947517592, 4473.507914129443, 4493.123840851068, 4496.078303947683, 8535.871961920577, 8551.401401901807, 8556.957215214008, 8557.914420855712, 8558.0, 4382.956170438319, 5067.265246539231, 5071.4928507149725, 5076.314697515862, 5079.949200508022, 4365.75988320639, 4488.0, 4640.559146881041, 4697.037107393045, 4759.0, 3650.908727281839, 3675.5038069860225, 3746.194568167857, 3765.5669597996034, 3787.6401741834484, 1149.9592868454063, 1152.4929031226234, 1154.2958795134962, 1165.6677846813618, 1166.9066474682006, 921.8340698674169, 924.5469719837231, 929.6420877962033, 931.3992474853682, 962.2782912815388, 5584.0, 5618.85952851182, 5918.141869428909, 5958.493528050078, 5963.105534169909, 908.5911339897073, 958.5159494455255, 967.4098799732158, 970.427447805798, 975.4634950777045, 3332.583427071616, 3725.1990821973404, 3850.9807450962567, 3895.35726605107, 4002.1795531915886, 9782.5597848097, 10050.346727462691, 10138.0, 10180.032896874785, 10201.693949181536, 9896.406215627085, 10118.544665489924, 10120.645777397756, 10124.493775311352, 10140.391576505433, 7654.693812247559, 7724.420668449889, 7888.408369372205, 7904.0119985001875, 7918.604069796487, 5515.779368825202, 5563.415841336601, 5574.777008919597, 5705.144228365778, 5739.62692424991, 9275.39709918853, 9420.481873497023, 9421.905780942103, 9441.433513989183, 9447.0, 8065.959670201846, 9198.816023679356, 9358.204552613104, 9509.0, 9583.993680663709, 6343.968280158754, 6528.6735663215695, 6679.56582822115, 6696.732130714911, 6824.488163387667, 7705.845883082419, 8000.5599692017495, 8006.159353267823, 8018.198180181935, 8019.599020048858, 7095.9645201773665, 7168.856622867618, 7207.48642785021, 7237.203907570058, 7310.0, 6964.582125072512, 6997.7200911962955, 7055.3650171484815, 7077.186123595852, 7121.181064177686, 6624.735010599522, 6627.966860165669, 6730.226024007302, 6738.056672065817, 6753.696083676148, 4068.2066996936496, 4616.792244348945, 4634.281686338623, 4642.442906851199, 4722.1028004679, 4880.92678609814, 4889.095517329305, 4890.315355850255, 5050.292958985671, 5166.560842328294], "value": 4404.287264949174, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.2580272027442, 308.361691299011, 314.55176373667524, 317.38110684165883, 320.5240218275861, 4353.259945809212, 4776.498467660889, 5319.271236848031, 5326.360836699597, 5348.652337598059, 4803.25549539821, 4952.900941981158, 5155.896882062366, 5163.251328557357, 5173.534381905628, 4030.6170913763217, 4052.2503336882623, 4083.693218170187, 4103.405006274089, 4125.608067233608, 3873.825677844504, 4093.3450647896193, 4104.8768536943935, 4128.21563902859, 4159.417681524589, 3826.693864490834, 4036.6568841648495, 4052.5744796796207, 4085.1412607263774, 4105.466289382376, 3802.174956021125, 3986.9202615947665, 4036.858709945167, 4062.918741625151, 4072.287349713803, 3431.1079119428878, 3481.9129521761906, 3491.354099491602, 3496.2483066140903, 3526.188976535386, 4203.696853975277, 4805.543473370024, 5050.696958182521, 5072.2391641253735, 5094.217024041593, 4487.573680500347, 4558.521355257683, 4584.197765391076, 4594.724316541018, 4646.790894409726, 4747.45404278509, 5107.284980102789, 5346.716787970898, 5467.20725494805, 5491.121420572689, 3096.690330966908, 3659.670629643318, 3845.8653947111716, 3845.8653947111998, 3875.5543112541854, 5086.084504789136, 5259.815906443295, 5410.648307860016, 5860.765569377178, 6018.458338749533, 3357.942248191812, 3836.9232615348096, 3876.383441177194, 3905.882823515299, 3914.667253283446, 3958.7228893977144, 3964.980175099106, 3966.424868394067, 3969.503812023497, 3975.8012099394914, 4430.025394413224, 4537.6143027842345, 4586.587207151306, 4605.148047611203, 4610.3084537319, 4654.348391225231, 4997.800087996439, 5329.307190065267, 5335.906139241446, 5594.244776955059, 1106.7659559590998, 1205.9939700301443, 1239.7086684629105, 1269.3018839638162, 1288.8131220972907, 747.3460721868365, 828.7803732010901, 832.4048305461624, 865.2126564825978, 870.8824308718368, 3889.091463079587, 4020.6582440492302, 4506.1213063452315, 4699.859004229878, 4883.0, 4784.258439941815, 5258.0, 5309.991101690666, 5351.491608297206, 5415.241866138744, 3894.4353068804867, 4426.092651006536, 4821.300911367832, 4890.877728056827, 4963.49343581489, 2511.5855883779336, 2575.7037940637065, 2603.5053339865367, 2797.622021281935, 2806.424682939992, 4801.399825021872, 4891.9755401222765, 5101.9489805101475, 5526.917096243559, 5636.632614302003, 5209.515288142861, 5482.972585137049, 5501.339839219319, 5563.052931474032, 5564.0, 4795.496472870368, 5629.0149223885655, 5649.661020338793, 5656.85857853557, 5672.17864814904, 4407.779611019372, 4732.929006064981, 5085.4914508548845, 5411.2965314508865, 5413.593980451561, 5046.369203849519, 5597.160425936142, 5748.626339287933, 5773.884522309614, 5807.245058142415, 5974.103884417372, 6071.453569178795, 6080.543959202989, 6085.208922840003, 6086.6348019119, 3232.6444091149483, 3456.2223499712363, 3752.249550089938, 3919.1965647042857, 3958.51555666625, 4635.397398338195, 5340.798320377884, 5830.329512106162, 5871.794487192928, 5883.2057672213705, 4447.642030267128, 4684.758538987103, 5581.302337207849, 5612.045952188057, 5683.431656834449, 5216.66091704038, 5426.565874730091, 5597.3003374578175, 5640.0, 5640.661560306395, 4843.515648435269, 5052.772625231947, 5160.845174644766, 5477.808276710296, 5544.811733253476, 5263.210518422267, 5466.508014278734, 5701.291886353949, 5710.488049849396, 5732.512736417451, 4796.760161991956, 5097.974510127574, 5533.170024496197, 5563.7774489019985, 5630.042892708331], "value": 3982.4015480297994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.1665135232311, 721.4985585018414, 779.7621725373758, 793.8452001859636, 816.9877451838222, 14572.417103315867, 15683.529494115195, 15705.979111357754, 15722.091413088587, 15722.371105155795, 12390.946769524578, 12655.240685558872, 13816.0, 14090.154590724564, 14294.857051429482, 693.8820400531896, 703.3915662951562, 703.4126504368858, 706.1737766812842, 806.6491076381764, 708.174976152784, 710.4174576846988, 817.4073796497521, 846.4159729786459, 847.9491230526157, 740.4927624577155, 874.9737507874773, 891.4873947480193, 891.5675897189858, 891.9732408027769, 885.5926273914007, 885.9601317940708, 887.4409122252972, 887.8934527856634, 887.9467231966103, 655.7082098466185, 656.3108735827362, 656.7044829826549, 656.9441597464221, 657.2080642825384, 14502.347394367172, 14632.122072675673, 14677.55967320982, 14688.0, 15324.233788310652, 14243.501477448342, 14532.346044428026, 14634.41462341505, 14708.485203017843, 14823.555293341216, 10784.0, 11303.434828258636, 11305.886941130566, 11814.704632384173, 12077.27536347822, 4646.4191976003, 4662.487126416091, 4893.608511319086, 4901.436334821506, 4914.950850491485, 88077.11922880753, 90740.0, 91177.3774829165, 91277.54361228218, 93201.53399233028, 10579.523921423555, 10971.561137554409, 11365.431728413547, 11376.54493820238, 11439.714007149722, 17478.388256411217, 20924.790752092587, 20973.47566310824, 20998.370048898556, 21014.2645007424, 7678.078630564256, 7854.725084622125, 7910.129885712567, 8033.19668033192, 8048.114707382183, 4248.171606536757, 4377.102693947733, 4398.406215160976, 4460.107978404332, 4561.749103799323, 3427.8971630851115, 3532.523109380252, 3536.5402497675136, 3557.270759494349, 3561.3233485637647, 631.0817760159049, 645.9224893012869, 655.7180412422608, 664.5481072870398, 668.9732410703517, 559.8740283436194, 574.5862978655362, 602.2712517853358, 656.4846595422571, 693.5561240805888, 7629.3133617974645, 8221.958890205511, 8992.235659968845, 9062.864057039149, 9273.629054837731, 665.6288046623873, 671.758167059858, 674.7537148940602, 677.9186497620317, 691.8235849858355, 3767.51022367096, 4133.689973251958, 4609.7695115244105, 4621.584057434847, 4640.303954406866, 70482.64758676276, 95245.52377238208, 104474.0, 119928.8007119935, 120752.0, 78238.0, 101150.0, 104993.0, 105020.0, 107795.0, 69996.0, 87407.56296218478, 89717.65423518652, 90278.54860725654, 92338.0, 8545.957270213608, 8700.825388572463, 9512.667056652985, 9666.613335466502, 9720.125188733047, 50381.0, 53283.73358133184, 54485.1827222584, 54602.18096728473, 54607.6348091285, 45240.09519809651, 54703.45296547143, 54780.23516237383, 69132.0, 76947.84578231219, 12155.513779448724, 12504.374781260718, 12532.686682833002, 12842.972562194815, 13360.599182024554, 11208.55165793359, 14504.347304371118, 14576.416943322572, 14843.480478183212, 15581.29884155193, 12622.0, 13202.735945281232, 13659.590212293648, 14001.719965600427, 14341.498047568284, 13290.867091328962, 13774.862251377357, 13803.447862085806, 13957.93021034929, 14151.858481415054, 12290.754184916073, 12573.245605263714, 12942.67643308887, 13248.0, 13393.062485625913, 10756.300840445347, 10992.340459572451, 11578.536858525564, 11592.362420066976, 12123.393830308272, 9935.304528682922, 10787.568497260336, 11174.49714762854, 11628.418579070843, 11693.415329233334], "value": 7399.829762032297, "unit": "score"}], "name": "dromaeo_css", "value": 7280.5075483898445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 112.0, 113.0, 114.0, 112.0, 112.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 112.0, 109.0, 138.0, 107.0, 105.0, 110.0, 108.0, 135.0, 111.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 183.0, 182.0, 184.0, 181.0, 182.0, 181.0, 183.0, 181.0, 179.0], "value": 181.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 59.0, 86.0, 63.0, 58.0, 59.0, 57.0, 81.0, 59.0], "value": 66.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 94.0, 69.0, 68.0, 68.0, 89.0, 67.0, 68.0, 91.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 92.0, 88.0, 89.0, 87.0, 91.0, 88.0, 89.0, 87.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 148.0, 103.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 104.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 80.0, 89.0, 84.0, 84.0, 86.0, 84.0, 84.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 70.0, 67.0, 78.0, 74.0, 71.0, 69.0, 68.0, 68.0, 68.0], "value": 69.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 82.0, 82.0, 80.0, 80.0, 91.0, 72.0, 92.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 135.0, 136.0, 136.0, 141.0, 140.0, 139.0, 140.0, 183.0, 136.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 158.0, 160.0, 163.0, 163.0, 163.0, 164.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 65.0, 65.0, 64.0, 66.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1406.6000000000001, "alertThreshold": 2.0}]} 06:27:49 INFO - Return code: 0 06:27:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:27:49 INFO - # TBPL SUCCESS # 06:27:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:27:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:27:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:27:49 INFO - 2017-01-25 06:27:49.369 screenresolution[1654:9851] starting screenresolution argv=screenresolution get 06:27:49 INFO - 2017-01-25 06:27:49.372 screenresolution[1654:9851] Display 0: 1600x1200x32@60 06:27:49 INFO - 2017-01-25 06:27:49.379 screenresolution[1655:9854] starting screenresolution argv=screenresolution list 06:27:49 INFO - Available Modes on Display 0 06:27:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:27:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:27:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:27:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:27:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:27:49 INFO - Intel Iris: 06:27:49 INFO - Chipset Model: Intel Iris 06:27:49 INFO - Type: GPU 06:27:49 INFO - Bus: Built-In 06:27:49 INFO - VRAM (Dynamic, Max): 1536 MB 06:27:49 INFO - Vendor: Intel (0x8086) 06:27:49 INFO - Device ID: 0x0a2e 06:27:49 INFO - Revision ID: 0x0009 06:27:49 INFO - Displays: 06:27:49 INFO - Display: 06:27:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:27:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:27:49 INFO - Display Serial Number: 1600x1200 60 06:27:49 INFO - Main Display: Yes 06:27:49 INFO - Mirror: Off 06:27:49 INFO - Online: Yes 06:27:49 INFO - Rotation: Supported 06:27:49 INFO - Return code: 0 06:27:49 INFO - Running post-action listener: _resource_record_post_action 06:27:49 INFO - [mozharness: 2017-01-25 14:27:49.624098Z] Finished run-tests step (success) 06:27:49 INFO - Running post-run listener: _resource_record_post_run 06:27:49 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 38032384; Write bytes: 494986752; Read time: 241; Write time: 1567 06:27:49 INFO - TinderboxPrint: CPU usage
53.4% 06:27:49 INFO - TinderboxPrint: I/O read bytes / time
38,032,384 / 241 06:27:49 INFO - TinderboxPrint: I/O write bytes / time
494,986,752 / 1,567 06:27:49 INFO - TinderboxPrint: CPU idle
2,237.6 (46.6%) 06:27:49 INFO - TinderboxPrint: CPU system
960.2 (20.0%) 06:27:49 INFO - TinderboxPrint: CPU user
1,603.8 (33.4%) 06:27:49 INFO - TinderboxPrint: Swap in / out
229,437,440 / 0 06:27:49 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 188543488; Write bytes: 186150912; Read time: 17628; Write time: 416 06:27:49 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 35951616; Write bytes: 301651456; Read time: 222; Write time: 1122 06:27:50 INFO - Running post-run listener: _upload_blobber_files 06:27:50 INFO - Blob upload gear active. 06:27:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:27:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:27:50 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:27:50 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:27:50 INFO - (blobuploader) - INFO - Open directory for files ... 06:27:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:27:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:27:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:51 INFO - (blobuploader) - INFO - Done attempting. 06:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:52 INFO - (blobuploader) - INFO - Done attempting. 06:27:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:27:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:27:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:27:55 INFO - (blobuploader) - INFO - Done attempting. 06:27:55 INFO - (blobuploader) - INFO - Iteration through files over. 06:27:55 INFO - Return code: 0 06:27:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:27:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:27:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/656b4cee945cf43498f734a570e0ef28ef2a94b1c6285084d86eb29d6c7d6ed8ec183a1849c610c4b718b206e1e47bcd1b23d247b20444f65ac8287300abcb12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/580f58642854af0a4c42fd07539bdfa00cee857c34b5923dd63fe90814c12f8650d7a1c32a648802193f77c8949b85dba397c4c5fc4ff3b7dc139a85310483ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3460e2daf364e25a0828daec4d7ffdd1f8d2928069df26fb682bdbbf5bfad894f84aa0ea244c4897fe05db872ebfa40acd85c1fafb5a4a1a76ba129690f388d5"} 06:27:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:27:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:27:55 INFO - Contents: 06:27:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/656b4cee945cf43498f734a570e0ef28ef2a94b1c6285084d86eb29d6c7d6ed8ec183a1849c610c4b718b206e1e47bcd1b23d247b20444f65ac8287300abcb12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/580f58642854af0a4c42fd07539bdfa00cee857c34b5923dd63fe90814c12f8650d7a1c32a648802193f77c8949b85dba397c4c5fc4ff3b7dc139a85310483ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3460e2daf364e25a0828daec4d7ffdd1f8d2928069df26fb682bdbbf5bfad894f84aa0ea244c4897fe05db872ebfa40acd85c1fafb5a4a1a76ba129690f388d5"} 06:27:55 INFO - Running post-run listener: copy_logs_to_upload_dir 06:27:55 INFO - Copying logs to upload dir... 06:27:55 INFO - mkdir: /builds/slave/test/build/upload/logs 06:27:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.310491 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-01-25 06:27:55.548169) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 06:27:55.551754) ========= 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.prwZwMrLlK/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.TxPjXB1H8v/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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/Mozilla-Beta/sha512/656b4cee945cf43498f734a570e0ef28ef2a94b1c6285084d86eb29d6c7d6ed8ec183a1849c610c4b718b206e1e47bcd1b23d247b20444f65ac8287300abcb12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/580f58642854af0a4c42fd07539bdfa00cee857c34b5923dd63fe90814c12f8650d7a1c32a648802193f77c8949b85dba397c4c5fc4ff3b7dc139a85310483ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3460e2daf364e25a0828daec4d7ffdd1f8d2928069df26fb682bdbbf5bfad894f84aa0ea244c4897fe05db872ebfa40acd85c1fafb5a4a1a76ba129690f388d5"} build_url:https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/ASutUjWPTOmzoiqHCZkshw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/656b4cee945cf43498f734a570e0ef28ef2a94b1c6285084d86eb29d6c7d6ed8ec183a1849c610c4b718b206e1e47bcd1b23d247b20444f65ac8287300abcb12", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/580f58642854af0a4c42fd07539bdfa00cee857c34b5923dd63fe90814c12f8650d7a1c32a648802193f77c8949b85dba397c4c5fc4ff3b7dc139a85310483ad", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3460e2daf364e25a0828daec4d7ffdd1f8d2928069df26fb682bdbbf5bfad894f84aa0ea244c4897fe05db872ebfa40acd85c1fafb5a4a1a76ba129690f388d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 06:27:55.586370) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:27:55.586704) ========= 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.prwZwMrLlK/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.TxPjXB1H8v/Listeners TMPDIR=/var/folders/07/z5h29ykn58v73zfg5g95jh1r00000w/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.004401 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:27:55.636545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 06:27:55.636854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 06:27:55.637207) ========= ========= Total master_lag: 0.45 =========