builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1479747798.9 results: success (0) buildid: 20161121061609 builduid: 0d832ffe026f486d9c7038b146bfd613 revision: bb1124d7df770a08acb6255289276cf5575db0b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:18.900928) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:18.901452) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:18.901750) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:18.919170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:18.919473) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 09:03:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (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% 30.1M=0s 2016-11-21 09:03:19 (30.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096262 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.029340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.029662) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013459 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.079044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.079353) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bb1124d7df770a08acb6255289276cf5575db0b1 --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-aurora --rev bb1124d7df770a08acb6255289276cf5575db0b1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 09:03:19,369 truncating revision to first 12 chars 2016-11-21 09:03:19,369 Setting DEBUG logging. 2016-11-21 09:03:19,369 attempt 1/10 2016-11-21 09:03:19,369 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bb1124d7df77?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 09:03:19,813 unpacking tar archive at: mozilla-aurora-bb1124d7df77/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793487 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.885534) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.885810) ========= script_repo_revision: bb1124d7df770a08acb6255289276cf5575db0b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.886153) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.886433) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 09:03:19.896655) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-21 09:03:19.896963) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:03:20 INFO - MultiFileLogger online at 20161121 09:03:20 in /builds/slave/test 09:03:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:03:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:03:20 INFO - {'append_to_log': False, 09:03:20 INFO - 'base_work_dir': '/builds/slave/test', 09:03:20 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:03:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:03:20 INFO - 'branch': 'Mozilla-Aurora', 09:03:20 INFO - 'buildbot_json_path': 'buildprops.json', 09:03:20 INFO - 'config_files': ('talos/linux_config.py',), 09:03:20 INFO - 'default_actions': ('clobber', 09:03:20 INFO - 'read-buildbot-config', 09:03:20 INFO - 'download-and-extract', 09:03:20 INFO - 'populate-webroot', 09:03:20 INFO - 'create-virtualenv', 09:03:20 INFO - 'install', 09:03:20 INFO - 'run-tests'), 09:03:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:03:20 INFO - 'download_minidump_stackwalk': True, 09:03:20 INFO - 'download_symbols': 'ondemand', 09:03:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:03:20 INFO - 'tooltool.py': '/tools/tooltool.py', 09:03:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:03:20 INFO - '/tools/misc-python/virtualenv.py')}, 09:03:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:03:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:03:20 INFO - 'installer_path': 'installer.exe', 09:03:20 INFO - 'log_level': 'info', 09:03:20 INFO - 'log_name': 'talos', 09:03:20 INFO - 'log_to_console': True, 09:03:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:03:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:03:20 INFO - 'opt_config_files': (), 09:03:20 INFO - 'pip_index': False, 09:03:20 INFO - 'sps_profile': False, 09:03:20 INFO - 'sps_profile_interval': 0, 09:03:20 INFO - 'suite': 'dromaeojs', 09:03:20 INFO - 'system_bits': '32', 09:03:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:03:20 INFO - 'title': 'talos-linux64-ix-011', 09:03:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:03:20 INFO - 'use_talos_json': True, 09:03:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:03:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:03:20 INFO - 'work_dir': 'build'} 09:03:20 INFO - [mozharness: 2016-11-21 17:03:20.286305Z] Running clobber step. 09:03:20 INFO - Running pre-action listener: _resource_record_pre_action 09:03:20 INFO - Running main action method: clobber 09:03:20 INFO - rmtree: /builds/slave/test/build 09:03:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:03:20 INFO - Running post-action listener: _resource_record_post_action 09:03:20 INFO - [mozharness: 2016-11-21 17:03:20.749570Z] Finished clobber step (success) 09:03:20 INFO - [mozharness: 2016-11-21 17:03:20.749669Z] Running read-buildbot-config step. 09:03:20 INFO - Running pre-action listener: _resource_record_pre_action 09:03:20 INFO - Running main action method: read_buildbot_config 09:03:20 INFO - Using buildbot properties: 09:03:20 INFO - { 09:03:20 INFO - "project": "", 09:03:20 INFO - "product": "firefox", 09:03:20 INFO - "script_repo_revision": "production", 09:03:20 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:03:20 INFO - "repository": "", 09:03:20 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:03:20 INFO - "buildid": "20161121061609", 09:03:20 INFO - "pgo_build": "True", 09:03:20 INFO - "basedir": "/builds/slave/test", 09:03:20 INFO - "buildnumber": 917, 09:03:20 INFO - "slavename": "talos-linux64-ix-011", 09:03:20 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:03:20 INFO - "platform": "ubuntu64_hw", 09:03:20 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:03:20 INFO - "branch": "mozilla-aurora", 09:03:20 INFO - "repo_path": "releases/mozilla-aurora", 09:03:20 INFO - "revision": "bb1124d7df770a08acb6255289276cf5575db0b1", 09:03:20 INFO - "stage_platform": "linux64-pgo", 09:03:20 INFO - "builduid": "0d832ffe026f486d9c7038b146bfd613", 09:03:20 INFO - "slavebuilddir": "test" 09:03:20 INFO - } 09:03:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:03:20 INFO - Running post-action listener: _resource_record_post_action 09:03:20 INFO - [mozharness: 2016-11-21 17:03:20.752105Z] Finished read-buildbot-config step (success) 09:03:20 INFO - [mozharness: 2016-11-21 17:03:20.752193Z] Running download-and-extract step. 09:03:20 INFO - Running pre-action listener: _resource_record_pre_action 09:03:20 INFO - Running main action method: download_and_extract 09:03:20 INFO - mkdir: /builds/slave/test/build/tests 09:03:20 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')]} 09:03:20 INFO - trying https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:03:20 INFO - Downloading https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:03:21 INFO - Downloaded 1361 bytes. 09:03:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:03:21 INFO - Using the following test package requirements: 09:03:21 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:03:21 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:03:21 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:03:21 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'jsshell-linux-x86_64.zip'], 09:03:21 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:03:21 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:03:21 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:03:21 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:03:21 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:03:21 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:03:21 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:03:21 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:03:21 INFO - Http code: 200 09:03:21 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 09:03:21 INFO - x-amz-cf-id: dIa0y7xhcIXBem8ekpeFaYQZV9NMFwPTMYZX5ZyWZR17AQB_7J925A== 09:03:21 INFO - x-amz-version-id: xJWbmiKvKgqyC0kmgqNjF72eofkGuLM_ 09:03:22 INFO - Expected file size: 21947271 09:03:22 INFO - Obtained file size: 21947271 09:03:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:03:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:03:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:03:26 INFO - Fetch https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:03:26 INFO - Http code: 200 09:03:26 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:03:26 INFO - x-amz-cf-id: D0lrDT_uOqhdv3WnaHq33ewMTOLUcpL6dr1_nE5HwJULQaza_WfVOw== 09:03:26 INFO - x-amz-version-id: xJWbmiKvKgqyC0kmgqNjF72eofkGuLM_ 09:03:26 INFO - Expected file size: 21947271 09:03:26 INFO - Obtained file size: 21947271 09:03:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:03:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:03:31 INFO - Fetch https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:03:32 INFO - Http code: 200 09:03:32 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 09:03:32 INFO - x-amz-cf-id: AJh3o0gVuKEVFgulssD3EJe-jGpzQztz0HPcLasP4EyWR4Y-m-M_vA== 09:03:32 INFO - x-amz-version-id: 6ENkfoccwkudeZej0PRzg5gtmkj3Z6Wg 09:03:32 INFO - Expected file size: 14409038 09:03:32 INFO - Obtained file size: 14409038 09:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:32 INFO - trying https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:32 INFO - Downloading https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:03:35 INFO - Downloaded 63942042 bytes. 09:03:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:35 INFO - mkdir: /builds/slave/test/properties 09:03:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:35 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:35 INFO - Contents: 09:03:35 INFO - build_url:https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:03:35 INFO - Running post-action listener: _resource_record_post_action 09:03:35 INFO - Running post-action listener: set_extra_try_arguments 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.922955Z] Finished download-and-extract step (success) 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.923181Z] Running populate-webroot step. 09:03:35 INFO - Running pre-action listener: _resource_record_pre_action 09:03:35 INFO - Running main action method: populate_webroot 09:03:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:35 INFO - '--tppagecycles', 09:03:35 INFO - '7'], 09:03:35 INFO - 'tests': ['tsvgm']}}, 09:03:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:03:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['damp', 'tps']}, 09:03:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'tests': ['damp', 'tps']}, 09:03:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['dromaeo_dom']}, 09:03:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['basic_compositor_video']}, 09:03:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:03:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['a11yr', 09:03:35 INFO - 'ts_paint', 09:03:35 INFO - 'tpaint', 09:03:35 INFO - 'sessionrestore', 09:03:35 INFO - 'sessionrestore_no_auto_restore', 09:03:35 INFO - 'tabpaint']}, 09:03:35 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:35 INFO - 'ts_paint', 09:03:35 INFO - 'tpaint', 09:03:35 INFO - 'sessionrestore', 09:03:35 INFO - 'sessionrestore_no_auto_restore', 09:03:35 INFO - 'tabpaint']}, 09:03:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:35 INFO - 'ts_paint', 09:03:35 INFO - 'tpaint', 09:03:35 INFO - 'sessionrestore', 09:03:35 INFO - 'sessionrestore_no_auto_restore', 09:03:35 INFO - 'tabpaint']}, 09:03:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:35 INFO - 'ts_paint', 09:03:35 INFO - 'tpaint', 09:03:35 INFO - 'sessionrestore', 09:03:35 INFO - 'sessionrestore_no_auto_restore', 09:03:35 INFO - 'tabpaint']}, 09:03:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['a11yr', 09:03:35 INFO - 'ts_paint', 09:03:35 INFO - 'tpaint', 09:03:35 INFO - 'sessionrestore', 09:03:35 INFO - 'sessionrestore_no_auto_restore', 09:03:35 INFO - 'tabpaint']}, 09:03:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['a11yr', 09:03:35 INFO - 'ts_paint', 09:03:35 INFO - 'tpaint', 09:03:35 INFO - 'sessionrestore', 09:03:35 INFO - 'sessionrestore_no_auto_restore', 09:03:35 INFO - 'tabpaint']}, 09:03:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['tsvgx', 09:03:35 INFO - 'tsvgr_opacity', 09:03:35 INFO - 'tart', 09:03:35 INFO - 'tscrollx', 09:03:35 INFO - 'cart']}, 09:03:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:35 INFO - 'tsvgr_opacity', 09:03:35 INFO - 'tart', 09:03:35 INFO - 'tscrollx', 09:03:35 INFO - 'cart']}, 09:03:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'talos_options': ['--disable-e10s'], 09:03:35 INFO - 'tests': ['tp5o']}, 09:03:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'tests': ['tp5o']}, 09:03:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'talos_options': ['--disable-e10s', 09:03:35 INFO - '--xperf_path', 09:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:35 INFO - 'tests': ['tp5n']}, 09:03:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:03:35 INFO - 'talos_options': ['--xperf_path', 09:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:35 INFO - 'tests': ['tp5n']}}, 09:03:35 INFO - 'talos.zip': {'path': '', 09:03:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:35 INFO - Running post-action listener: _resource_record_post_action 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.941624Z] Finished populate-webroot step (success) 09:03:35 INFO - [mozharness: 2016-11-21 17:03:35.941712Z] Running create-virtualenv step. 09:03:35 INFO - Running pre-action listener: _resource_record_pre_action 09:03:35 INFO - Running main action method: create_virtualenv 09:03:35 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:35 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 09:03:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:36 INFO - Using real prefix '/usr' 09:03:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:36 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:38 INFO - Installing pip.................done. 09:03:38 INFO - Return code: 0 09:03:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:38 INFO - Reading from file tmpfile_stdout 09:03:38 INFO - Output received: 09:03:38 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:03:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:38 INFO - Using env: {'DISPLAY': ':0', 09:03:38 INFO - 'HOME': '/home/cltbld', 09:03:38 INFO - 'LANG': 'en_US.UTF-8', 09:03:38 INFO - 'LANGUAGE': 'en_US:en', 09:03:38 INFO - 'LOGNAME': 'cltbld', 09:03:38 INFO - 'MAIL': '/var/mail/cltbld', 09:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:38 INFO - 'MOZ_NO_REMOTE': '1', 09:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:38 INFO - 'NO_EM_RESTART': '1', 09:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:38 INFO - 'PWD': '/builds/slave/test', 09:03:38 INFO - 'SHELL': '/bin/bash', 09:03:38 INFO - 'SHLVL': '1', 09:03:38 INFO - 'TERM': 'linux', 09:03:38 INFO - 'TMOUT': '86400', 09:03:38 INFO - 'USER': 'cltbld', 09:03:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:38 INFO - '_': '/tools/buildbot/bin/python'} 09:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:38 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 09:03:38 INFO - Cleaning up... 09:03:38 INFO - Return code: 0 09:03:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:03:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:03:38 INFO - Using env: {'DISPLAY': ':0', 09:03:38 INFO - 'HOME': '/home/cltbld', 09:03:38 INFO - 'LANG': 'en_US.UTF-8', 09:03:38 INFO - 'LANGUAGE': 'en_US:en', 09:03:38 INFO - 'LOGNAME': 'cltbld', 09:03:38 INFO - 'MAIL': '/var/mail/cltbld', 09:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:38 INFO - 'MOZ_NO_REMOTE': '1', 09:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:38 INFO - 'NO_EM_RESTART': '1', 09:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:38 INFO - 'PWD': '/builds/slave/test', 09:03:38 INFO - 'SHELL': '/bin/bash', 09:03:38 INFO - 'SHLVL': '1', 09:03:38 INFO - 'TERM': 'linux', 09:03:38 INFO - 'TMOUT': '86400', 09:03:38 INFO - 'USER': 'cltbld', 09:03:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:38 INFO - '_': '/tools/buildbot/bin/python'} 09:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:39 INFO - Downloading/unpacking psutil>=3.1.1 09:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:41 INFO - Installing collected packages: psutil 09:03:41 INFO - Running setup.py install for psutil 09:03:41 INFO - building 'psutil._psutil_linux' extension 09:03:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:03:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:03:41 INFO - building 'psutil._psutil_posix' extension 09:03:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:03:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:03:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:41 INFO - Successfully installed psutil 09:03:41 INFO - Cleaning up... 09:03:41 INFO - Return code: 0 09:03:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:03:41 INFO - Using env: {'DISPLAY': ':0', 09:03:41 INFO - 'HOME': '/home/cltbld', 09:03:41 INFO - 'LANG': 'en_US.UTF-8', 09:03:41 INFO - 'LANGUAGE': 'en_US:en', 09:03:41 INFO - 'LOGNAME': 'cltbld', 09:03:41 INFO - 'MAIL': '/var/mail/cltbld', 09:03:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:41 INFO - 'MOZ_NO_REMOTE': '1', 09:03:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:41 INFO - 'NO_EM_RESTART': '1', 09:03:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:41 INFO - 'PWD': '/builds/slave/test', 09:03:41 INFO - 'SHELL': '/bin/bash', 09:03:41 INFO - 'SHLVL': '1', 09:03:41 INFO - 'TERM': 'linux', 09:03:41 INFO - 'TMOUT': '86400', 09:03:41 INFO - 'USER': 'cltbld', 09:03:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:41 INFO - '_': '/tools/buildbot/bin/python'} 09:03:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:43 INFO - Installing collected packages: mozsystemmonitor 09:03:43 INFO - Running setup.py install for mozsystemmonitor 09:03:44 INFO - Successfully installed mozsystemmonitor 09:03:44 INFO - Cleaning up... 09:03:44 INFO - Return code: 0 09:03:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:44 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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:44 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 09:03:44 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 09:03:44 INFO - Using env: {'DISPLAY': ':0', 09:03:44 INFO - 'HOME': '/home/cltbld', 09:03:44 INFO - 'LANG': 'en_US.UTF-8', 09:03:44 INFO - 'LANGUAGE': 'en_US:en', 09:03:44 INFO - 'LOGNAME': 'cltbld', 09:03:44 INFO - 'MAIL': '/var/mail/cltbld', 09:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:44 INFO - 'MOZ_NO_REMOTE': '1', 09:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:44 INFO - 'NO_EM_RESTART': '1', 09:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:44 INFO - 'PWD': '/builds/slave/test', 09:03:44 INFO - 'SHELL': '/bin/bash', 09:03:44 INFO - 'SHLVL': '1', 09:03:44 INFO - 'TERM': 'linux', 09:03:44 INFO - 'TMOUT': '86400', 09:03:44 INFO - 'USER': 'cltbld', 09:03:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:44 INFO - '_': '/tools/buildbot/bin/python'} 09:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:44 INFO - Downloading/unpacking jsonschema==2.5.1 09:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03:46 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 09:03:46 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 09:03:46 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 09:03:46 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 09:03:46 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 09:03:46 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 09:03:46 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:46 INFO - warning: no files found matching '*.txt' 09:03:46 INFO - no previously-included directories found matching 'build' 09:03:46 INFO - no previously-included directories found matching 'dist' 09:03:46 INFO - no previously-included directories found matching '.git*' 09:03:46 INFO - Installing collected packages: jsonschema, functools32 09:03:46 INFO - Running setup.py install for functools32 09:03:46 INFO - warning: no files found matching '*.txt' 09:03:46 INFO - no previously-included directories found matching 'build' 09:03:46 INFO - no previously-included directories found matching 'dist' 09:03:46 INFO - no previously-included directories found matching '.git*' 09:03:46 INFO - Successfully installed jsonschema functools32 09:03:46 INFO - Cleaning up... 09:03:46 INFO - Return code: 0 09:03:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:46 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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:46 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 09:03:46 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 09:03:46 INFO - Using env: {'DISPLAY': ':0', 09:03:46 INFO - 'HOME': '/home/cltbld', 09:03:46 INFO - 'LANG': 'en_US.UTF-8', 09:03:46 INFO - 'LANGUAGE': 'en_US:en', 09:03:46 INFO - 'LOGNAME': 'cltbld', 09:03:46 INFO - 'MAIL': '/var/mail/cltbld', 09:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:46 INFO - 'MOZ_NO_REMOTE': '1', 09:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:46 INFO - 'NO_EM_RESTART': '1', 09:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:46 INFO - 'PWD': '/builds/slave/test', 09:03:46 INFO - 'SHELL': '/bin/bash', 09:03:46 INFO - 'SHLVL': '1', 09:03:46 INFO - 'TERM': 'linux', 09:03:46 INFO - 'TMOUT': '86400', 09:03:46 INFO - 'USER': 'cltbld', 09:03:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:46 INFO - '_': '/tools/buildbot/bin/python'} 09:03:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:03:46 INFO - Cleaning up... 09:03:46 INFO - Return code: 0 09:03:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03: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')]} 09:03:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:46 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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:46 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 09:03:46 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 09:03:46 INFO - Using env: {'DISPLAY': ':0', 09:03:46 INFO - 'HOME': '/home/cltbld', 09:03:46 INFO - 'LANG': 'en_US.UTF-8', 09:03:46 INFO - 'LANGUAGE': 'en_US:en', 09:03:46 INFO - 'LOGNAME': 'cltbld', 09:03:46 INFO - 'MAIL': '/var/mail/cltbld', 09:03:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:46 INFO - 'MOZ_NO_REMOTE': '1', 09:03:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:46 INFO - 'NO_EM_RESTART': '1', 09:03:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:46 INFO - 'PWD': '/builds/slave/test', 09:03:46 INFO - 'SHELL': '/bin/bash', 09:03:46 INFO - 'SHLVL': '1', 09:03:46 INFO - 'TERM': 'linux', 09:03:46 INFO - 'TMOUT': '86400', 09:03:46 INFO - 'USER': 'cltbld', 09:03:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:46 INFO - '_': '/tools/buildbot/bin/python'} 09:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:47 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:47 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 09:03:47 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 09:03:47 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 09:03:47 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 09:03:47 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 09:03:47 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 09:03:49 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:03:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:03:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:49 INFO - Downloading docopt-0.6.1.tar.gz 09:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:49 INFO - Running setup.py install for blobuploader 09:03:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:03:49 INFO - Running setup.py install for requests 09:03:50 INFO - Running setup.py install for docopt 09:03:50 INFO - Successfully installed blobuploader requests docopt 09:03:50 INFO - Cleaning up... 09:03:50 INFO - Return code: 0 09:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:50 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')]} 09:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:50 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')]} 09:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:50 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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:50 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 09:03:50 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 09:03:50 INFO - Using env: {'DISPLAY': ':0', 09:03:50 INFO - 'HOME': '/home/cltbld', 09:03:50 INFO - 'LANG': 'en_US.UTF-8', 09:03:50 INFO - 'LANGUAGE': 'en_US:en', 09:03:50 INFO - 'LOGNAME': 'cltbld', 09:03:50 INFO - 'MAIL': '/var/mail/cltbld', 09:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:50 INFO - 'MOZ_NO_REMOTE': '1', 09:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:50 INFO - 'NO_EM_RESTART': '1', 09:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:50 INFO - 'PWD': '/builds/slave/test', 09:03:50 INFO - 'SHELL': '/bin/bash', 09:03:50 INFO - 'SHLVL': '1', 09:03:50 INFO - 'TERM': 'linux', 09:03:50 INFO - 'TMOUT': '86400', 09:03:50 INFO - 'USER': 'cltbld', 09:03:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:50 INFO - '_': '/tools/buildbot/bin/python'} 09:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:50 INFO - Running setup.py (path:/tmp/pip-n8lqd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:50 INFO - Running setup.py (path:/tmp/pip-WFm1_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:50 INFO - Running setup.py (path:/tmp/pip-ajBKOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:50 INFO - Running setup.py (path:/tmp/pip-Cid2EP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:51 INFO - Running setup.py (path:/tmp/pip-H5bKmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:51 INFO - Running setup.py (path:/tmp/pip-pvxKZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:51 INFO - Running setup.py (path:/tmp/pip-w4Hapa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:51 INFO - Running setup.py (path:/tmp/pip-ZK5E2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:51 INFO - Running setup.py (path:/tmp/pip-2DPazk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:51 INFO - Running setup.py (path:/tmp/pip-xoCQia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:51 INFO - Running setup.py (path:/tmp/pip-uVpVpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:51 INFO - Running setup.py (path:/tmp/pip-jrE9FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:51 INFO - Running setup.py (path:/tmp/pip-T48qZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:51 INFO - Running setup.py (path:/tmp/pip-nYt2sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:51 INFO - Running setup.py (path:/tmp/pip-mxiKeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:51 INFO - Running setup.py (path:/tmp/pip-_2KIms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:51 INFO - Running setup.py (path:/tmp/pip-hXTJQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:51 INFO - Running setup.py install for manifestparser 09:03:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Running setup.py install for mozcrash 09:03:52 INFO - Running setup.py install for mozdebug 09:03:52 INFO - Running setup.py install for mozdevice 09:03:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Running setup.py install for mozfile 09:03:52 INFO - Running setup.py install for mozhttpd 09:03:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Running setup.py install for mozinfo 09:03:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Running setup.py install for mozInstall 09:03:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:52 INFO - Running setup.py install for mozleak 09:03:52 INFO - Running setup.py install for mozlog 09:03:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:53 INFO - Running setup.py install for moznetwork 09:03:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:53 INFO - Running setup.py install for mozprocess 09:03:53 INFO - Running setup.py install for mozprofile 09:03:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:53 INFO - Running setup.py install for mozrunner 09:03:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:53 INFO - Running setup.py install for mozscreenshot 09:03:53 INFO - Running setup.py install for moztest 09:03:53 INFO - Running setup.py install for mozversion 09:03:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:53 INFO - Cleaning up... 09:03:53 INFO - Return code: 0 09:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:53 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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:53 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 09:03:53 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 09:03:53 INFO - Using env: {'DISPLAY': ':0', 09:03:53 INFO - 'HOME': '/home/cltbld', 09:03:53 INFO - 'LANG': 'en_US.UTF-8', 09:03:53 INFO - 'LANGUAGE': 'en_US:en', 09:03:53 INFO - 'LOGNAME': 'cltbld', 09:03:53 INFO - 'MAIL': '/var/mail/cltbld', 09:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:53 INFO - 'MOZ_NO_REMOTE': '1', 09:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:53 INFO - 'NO_EM_RESTART': '1', 09:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:53 INFO - 'PWD': '/builds/slave/test', 09:03:53 INFO - 'SHELL': '/bin/bash', 09:03:53 INFO - 'SHLVL': '1', 09:03:53 INFO - 'TERM': 'linux', 09:03:53 INFO - 'TMOUT': '86400', 09:03:53 INFO - 'USER': 'cltbld', 09:03:53 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:53 INFO - '_': '/tools/buildbot/bin/python'} 09:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:54 INFO - Running setup.py (path:/tmp/pip-LPN8Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:54 INFO - Running setup.py (path:/tmp/pip-M7d_N4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:54 INFO - Running setup.py (path:/tmp/pip-cXwrpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:54 INFO - Running setup.py (path:/tmp/pip-R8XGdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:54 INFO - Running setup.py (path:/tmp/pip-PBH3pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:54 INFO - Running setup.py (path:/tmp/pip-oz5qN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:54 INFO - Running setup.py (path:/tmp/pip-ik9OK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:54 INFO - Running setup.py (path:/tmp/pip-tQ95Zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:54 INFO - Running setup.py (path:/tmp/pip-2TqRiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:54 INFO - Running setup.py (path:/tmp/pip-8jDGdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:54 INFO - Running setup.py (path:/tmp/pip-W43WLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:54 INFO - Running setup.py (path:/tmp/pip-bJ6LTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:54 INFO - Running setup.py (path:/tmp/pip-DDrW7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:54 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)) 09:03:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:54 INFO - Running setup.py (path:/tmp/pip-201GGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:55 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)) 09:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:55 INFO - Running setup.py (path:/tmp/pip-24735I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:55 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)) 09:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:55 INFO - Running setup.py (path:/tmp/pip-Dv8ey6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:03:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:55 INFO - Running setup.py (path:/tmp/pip-RrvPSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:55 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)) 09:03:55 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)) 09:03:55 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)) 09:03:55 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)) 09:03:55 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)) 09:03:55 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)) 09:03:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:55 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 09:03:55 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 09:03:55 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 09:03:55 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 09:03:55 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 09:03:55 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 09:03:57 INFO - Downloading blessings-1.6.tar.gz 09:03:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:57 INFO - Installing collected packages: blessings 09:03:57 INFO - Running setup.py install for blessings 09:03:57 INFO - Successfully installed blessings 09:03:57 INFO - Cleaning up... 09:03:57 INFO - Return code: 0 09:03:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:57 INFO - Reading from file tmpfile_stdout 09:03:57 INFO - Current package versions: 09:03:57 INFO - argparse == 1.2.1 09:03:57 INFO - blessings == 1.6 09:03:57 INFO - blobuploader == 1.2.4 09:03:57 INFO - docopt == 0.6.1 09:03:57 INFO - functools32 == 3.2.3-2 09:03:57 INFO - jsonschema == 2.5.1 09:03:57 INFO - manifestparser == 1.1 09:03:57 INFO - mozInstall == 1.12 09:03:57 INFO - mozcrash == 1.0 09:03:57 INFO - mozdebug == 0.1 09:03:57 INFO - mozdevice == 0.48 09:03:57 INFO - mozfile == 1.2 09:03:57 INFO - mozhttpd == 0.7 09:03:57 INFO - mozinfo == 0.9 09:03:57 INFO - mozleak == 0.1 09:03:57 INFO - mozlog == 3.4 09:03:57 INFO - moznetwork == 0.27 09:03:57 INFO - mozprocess == 0.23 09:03:57 INFO - mozprofile == 0.28 09:03:57 INFO - mozrunner == 6.13 09:03:57 INFO - mozscreenshot == 0.1 09:03:57 INFO - mozsystemmonitor == 0.3 09:03:57 INFO - moztest == 0.7 09:03:57 INFO - mozversion == 1.4 09:03:57 INFO - psutil == 3.1.1 09:03:57 INFO - requests == 1.2.3 09:03:57 INFO - wsgiref == 0.1.2 09:03:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:57 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')]} 09:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 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')]} 09:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:57 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 09:03:57 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 09:03:57 INFO - Using env: {'DISPLAY': ':0', 09:03:57 INFO - 'HOME': '/home/cltbld', 09:03:57 INFO - 'LANG': 'en_US.UTF-8', 09:03:57 INFO - 'LANGUAGE': 'en_US:en', 09:03:57 INFO - 'LOGNAME': 'cltbld', 09:03:57 INFO - 'MAIL': '/var/mail/cltbld', 09:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:57 INFO - 'MOZ_NO_REMOTE': '1', 09:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:57 INFO - 'NO_EM_RESTART': '1', 09:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:57 INFO - 'PWD': '/builds/slave/test', 09:03:57 INFO - 'SHELL': '/bin/bash', 09:03:57 INFO - 'SHLVL': '1', 09:03:57 INFO - 'TERM': 'linux', 09:03:57 INFO - 'TMOUT': '86400', 09:03:57 INFO - 'USER': 'cltbld', 09:03:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:57 INFO - '_': '/tools/buildbot/bin/python'} 09:03:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 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)) 09:03:57 INFO - Cleaning up... 09:03:57 INFO - Return code: 0 09:03:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03:57 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')]} 09:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 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')]} 09:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:03:57 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 0x7f3cc51aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1940ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:03:57 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 09:03:57 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 09:03:57 INFO - Using env: {'DISPLAY': ':0', 09:03:57 INFO - 'HOME': '/home/cltbld', 09:03:57 INFO - 'LANG': 'en_US.UTF-8', 09:03:57 INFO - 'LANGUAGE': 'en_US:en', 09:03:57 INFO - 'LOGNAME': 'cltbld', 09:03:57 INFO - 'MAIL': '/var/mail/cltbld', 09:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:57 INFO - 'MOZ_NO_REMOTE': '1', 09:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:57 INFO - 'NO_EM_RESTART': '1', 09:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:57 INFO - 'PWD': '/builds/slave/test', 09:03:57 INFO - 'SHELL': '/bin/bash', 09:03:57 INFO - 'SHLVL': '1', 09:03:57 INFO - 'TERM': 'linux', 09:03:57 INFO - 'TMOUT': '86400', 09:03:57 INFO - 'USER': 'cltbld', 09:03:57 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:57 INFO - '_': '/tools/buildbot/bin/python'} 09:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:58 INFO - Cleaning up... 09:03:58 INFO - Return code: 0 09:03:58 INFO - Running post-action listener: _resource_record_post_action 09:03:58 INFO - Running post-action listener: _start_resource_monitoring 09:03:58 INFO - Starting resource monitoring. 09:03:58 INFO - [mozharness: 2016-11-21 17:03:58.133571Z] Finished create-virtualenv step (success) 09:03:58 INFO - [mozharness: 2016-11-21 17:03:58.134027Z] Running install step. 09:03:58 INFO - Running pre-action listener: _resource_record_pre_action 09:03:58 INFO - Running main action method: install 09:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:58 INFO - Reading from file tmpfile_stdout 09:03:58 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:58 INFO - Reading from file tmpfile_stdout 09:03:58 INFO - Output received: 09:03:58 INFO - Usage: mozinstall [options] installer 09:03:58 INFO - Options: 09:03:58 INFO - -h, --help show this help message and exit 09:03:58 INFO - -d DEST, --destination=DEST 09:03:58 INFO - Directory to install application into. [default: 09:03:58 INFO - "/builds/slave/test"] 09:03:58 INFO - --app=APP Application being installed. [default: firefox] 09:03:58 INFO - mkdir: /builds/slave/test/build/application 09:03:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:04:14 INFO - Reading from file tmpfile_stdout 09:04:14 INFO - Output received: 09:04:14 INFO - /builds/slave/test/build/application/firefox/firefox 09:04:14 INFO - Running post-action listener: _resource_record_post_action 09:04:14 INFO - [mozharness: 2016-11-21 17:04:14.345504Z] Finished install step (success) 09:04:14 INFO - [mozharness: 2016-11-21 17:04:14.345745Z] Running run-tests step. 09:04:14 INFO - Running pre-action listener: _resource_record_pre_action 09:04:14 INFO - Running main action method: run_tests 09:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:14 INFO - Python 2.7.3 09:04:14 INFO - Return code: 0 09:04:14 INFO - grabbing minidump binary from tooltool 09:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/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 0x193df60>, '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 0x193ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:04:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:04:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:04:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:14 INFO - Return code: 0 09:04:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:04:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:04:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 09:04:14 INFO - Using env: {'DISPLAY': ':0', 09:04:14 INFO - 'HOME': '/home/cltbld', 09:04:14 INFO - 'LANG': 'en_US.UTF-8', 09:04:14 INFO - 'LANGUAGE': 'en_US:en', 09:04:14 INFO - 'LOGNAME': 'cltbld', 09:04:14 INFO - 'MAIL': '/var/mail/cltbld', 09:04:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:14 INFO - 'MOZ_NO_REMOTE': '1', 09:04:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:14 INFO - 'NO_EM_RESTART': '1', 09:04:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:14 INFO - 'PWD': '/builds/slave/test', 09:04:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:14 INFO - 'SHELL': '/bin/bash', 09:04:14 INFO - 'SHLVL': '1', 09:04:14 INFO - 'TERM': 'linux', 09:04:14 INFO - 'TMOUT': '86400', 09:04:14 INFO - 'USER': 'cltbld', 09:04:14 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889', 09:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:14 INFO - '_': '/tools/buildbot/bin/python'} 09:04:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 09:04:14 INFO - mozversion application_buildid: 20161121061609 09:04:14 INFO - mozversion application_changeset: bb1124d7df770a08acb6255289276cf5575db0b1 09:04:14 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:04:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:14 INFO - mozversion application_name: Firefox 09:04:14 INFO - mozversion application_remotingname: firefox-dev 09:04:14 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:04:14 INFO - mozversion application_vendor: Mozilla 09:04:14 INFO - mozversion application_version: 52.0a2 09:04:14 INFO - mozversion platform_buildid: 20161121061609 09:04:14 INFO - mozversion platform_changeset: bb1124d7df770a08acb6255289276cf5575db0b1 09:04:14 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:04:14 INFO - mozversion platform_version: 52.0a2 09:04:14 INFO - using testdate: 1479747854 09:04:14 INFO - actual date: 1479747854 09:04:14 INFO - starting webserver on 'localhost:55605' 09:04:14 INFO - SUITE-START | Running 2 tests 09:04:14 INFO - TEST-START | dromaeo_css 09:04:14 INFO - operating with platform_type : linux_ 09:04:14 INFO - Initialising browser for dromaeo_css test... 09:04:14 INFO - TEST-INFO | started process 15871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL9pohZ/profile http://localhost:55605/getInfo.html) 09:04:18 ERROR - PROCESS | 15871 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:04:19 INFO - PROCESS | 15871 | __metrics Screen width/height:1600/1200 09:04:19 INFO - PROCESS | 15871 | colorDepth:24 09:04:19 INFO - PROCESS | 15871 | Browser inner width/height: 1024/697 09:04:19 INFO - PROCESS | 15871 | __metrics 09:04:20 INFO - PROCESS | 15871 | 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" 09:04:20 INFO - PROCESS | 15871 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:21 INFO - PROCESS | 15871 | console.error: PushService: 09:04:21 INFO - PROCESS | 15871 | stateChangeProcessEnqueue: Error transitioning state 09:04:21 INFO - PROCESS | 15871 | UnknownError 09:04:21 INFO - TEST-INFO | 15871: exit 0 09:04:21 INFO - Browser initialized. 09:04:21 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:21 INFO - TEST-INFO | started process 15961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL9pohZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:33 INFO - PROCESS | 15961 | RSS: Main: 148144128 09:04:33 INFO - PROCESS | 15961 | 09:05:24 INFO - PROCESS | 15961 | 1479747924922 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:07:35 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:55605/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55605/tests/dromaeo/cssquery-ext.html) 09:07:36 INFO - PROCESS | 15961 | RSS: Main: 254787584 09:07:36 INFO - PROCESS | 15961 | 09:10:38 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:55605/tests/dromaeo/cssquery-ext.html (next: http://localhost:55605/tests/dromaeo/cssquery-jquery.html) 09:10:39 INFO - PROCESS | 15961 | RSS: Main: 233029632 09:10:39 INFO - PROCESS | 15961 | 09:13:41 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:55605/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55605/tests/dromaeo/cssquery-mootools.html) 09:13:41 INFO - PROCESS | 15961 | RSS: Main: 174223360 09:13:41 INFO - PROCESS | 15961 | 09:16:43 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:55605/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55605/tests/dromaeo/cssquery-prototype.html) 09:16:44 INFO - PROCESS | 15961 | RSS: Main: 214560768 09:16:44 INFO - PROCESS | 15961 | 09:19:47 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:55605/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55605/tests/dromaeo/cssquery-yui.html) 09:19:47 INFO - PROCESS | 15961 | RSS: Main: 173764608 09:19:47 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | Cycle 1(1): loaded http://localhost:55605/tests/dromaeo/cssquery-yui.html (next: http://localhost:55605/tests/dromaeo/cssquery-dojo.html) 09:22:50 INFO - PROCESS | 15961 | RSS: Main: 265396224 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | __start_tp_report 09:22:50 INFO - PROCESS | 15961 | _x_x_mozilla_page_load 09:22:50 INFO - PROCESS | 15961 | _x_x_mozilla_page_load_details 09:22:50 INFO - PROCESS | 15961 | |i|pagename|runs| 09:22:50 INFO - PROCESS | 15961 | |0;dojo.html;3189.4099591575555;3234.4824828027504;3242.4001559711464;3243.5134729790516;3264.9347013059723;5455.727213639317;5557.138643510252;5572.916406253909;5576.247206627104;5609.439056094394;5588.972055139729;5613.635113717616;5627.521660658849;5633.070543360341;5641.379448260688;5081.237814327853;5084.211947148179;5100.234964755279;5132.640715149941;5196.662216955905;5018.473060328668;5130.6152038597065;5176.197689358156;5185.896282074375;5187.533122019017;5031.798728050873;5033.949660503385;5040.470750571192;5045.520675535819;5067.037262920052;5109.948900511003;5113.872153196163;5171.922421163686;5193.143131383317;5201.24581935621;4919.704817710949;4931.112399768041;5063.11395505785;5080.288759573663;5129.1280482317725;5419.783208671648;5440.265564148829;5448.346198456171;5458.4541545845495;5517.69652669103;5847.883042339172;5910.34986151523;5955.583109182359;5958.374370691058;5964.135200395962;5836.970815145897;5899.852503687399;6003.549733769984;6009.308929473079;6019.969900150515;5546.722663866791;5582.49757521825;5587.8882422352135;5596.804111856106;5621.100623900156;6121.693915304217;6124.785632502841;6132.018876979661;6132.908006379818;6137.754489820357;5724.255846739898;5779.075347944308;5896.086106653475;5898.734556944948;5900.616459930091;5878.764849405976;5919.200907877382;5937.406259374028;5953.047512398082;6019.578629495893;5951.226340575698;5951.4941229995065;5957.374475680078;5957.672328021914;5986.461218490357;5790.7973220937065;5910.7931222407005;5954.434328738763;5972.581919265696;5972.641641501524;4522.005158865044;4560.361549383089;4569.314602809605;4571.2000399929875;4593.724376537419;4134.937975930364;4140.068484590943;4145.523264824524;4181.1010632714115;4196.727212731163;5714.7428365723645;5720.856978575569;5721.342045664718;5722.484976352148;5739.942600573941;5761.625494342854;5877.324107727581;5982.371850955674;5994.460498555151;5997.340292567814;5681.573881958787;5686.97156514223;5692.117721753135;5694.08894576874;5694.572907031989;5144.125498665236;5168.9224661630105;5183.326167598264;5186.988537235278;5188.610854185876;6170.81487555374;6200.627962322275;6200.844978875474;6206.565540412128;6206.658633775186;6039.063945088518;6062.120992455981;6068.21113255274;6076.513878889767;6079.878402431838;6291.307956124914;6309.337519560564;6317.873642527032;6334.271558770801;6337.7781777637565;5736.19693242938;5767.9711601443405;5796.797112101056;5949.018411961978;5960.284765827955;5899.144624029577;5973.372795856372;5992.580519363777;6004.549658775697;6008.87982240344;5785.884282314414;5792.304923409218;5808.82573522795;5809.448102430262;5810.389909059488;5591.8881622368135;5649.350324712711;5767.279090113736;5793.768249269982;5799.043157878903;5658.688772117408;5679.034564124191;5720.570957178312;5782.5373970081455;5821.621594596338;5789.247397838422;5827.883442331215;5833.270841144857;5836.883262334814;5839.153322768259;5656;5682.232898558642;5699.430056994267;5702.315722113373;5705.657660540381 09:22:50 INFO - PROCESS | 15961 | |1;ext.html;574.8131857146428;621.0435928669849;649.259843778093;659.1266571792377;688.0298778722002;33727.15682107949;44103.558964410346;44452.3332150018;44569.108617827624;47833.521664783344;45619;45975.54024459754;46009.30986035212;46082.30876536846;46218.30672539906;8260.710875119372;8727.5636218189;8870.60082296295;8885.555722213896;8888.288936885034;8191.754247372588;10429.269951103426;10635.946820265888;10637.840432393521;10932.07077398422;10708.089812365959;10775.622853200139;10789.082927951094;10801.027907488324;10804;10547.630832920811;10577.682669519927;10599.311044782104;10620.522076506575;10622.46887655614;10474.738131546772;10603.416812075333;10659;10663.680089597325;10668.14654827612;42724.359134613005;43001.35497967533;43121;43144.56855431437;43178;3660.103274697716;3681.2821499807283;3748.250349930025;3763.209725957552;3929.7445666031617;31853.362932741446;31903.361932761447;31917.361652767046;31936.840315798272;32166;4276.615104640598;4371.956280437187;4417.204903117437;4548.522405147478;4659.767011649404;359376;360812;361025;361452;361796;64259.67870160619;64834;64926;64927;65006.674966624865;39323.41014884779;39651;39911.401328980086;42192;42199.7890010548;17225.65548689019;17318.220680069426;17347.479575612753;17354;17361.826381736275;13025.544105956245;13161.078724489194;14095.436182552789;14230.075045122241;14282.3572939218;19645;20499.590008199753;20510.077046532642;20539.178432862816;20659.17363305481;7218.6390680465765;7221.53060051095;7236.963815180996;7389.453062530016;7602;1030.2324768047852;1071.603506702525;1077;1136.4431428599926;1208.4803534480081;33514.49728254078;33849.492257616155;33871.153221169174;33960.32079358399;33966.15084622855;1108.7837871615118;1128.1257025805066;1137.8008848451489;1191.2733232728028;1202.4528839378063;14893.329800158803;18015.459536213933;18635.627287454176;18725;18781.0609469526;572331;574746;576700;577095;580014;59549.404505954386;60192;60206.397936020076;60386.69806651027;60434;1311.731095125497;1341.704824938512;1367.9452821887014;1381.4267079162034;1401.9088759230822;32152.35695286128;34490;34651.48022779711;35032.29935401227;35045.29909401849;51252.74373628108;51529.22706159336;51693.48306516887;51839.74080129575;51875.481245188574;382608;385034.14965851104;385726;386675;387106;31325.373492530478;31655;31759.52360714545;31816.840915795274;32066.839665801523;49493.752531237114;49866;50411;50715.74642126766;51003.48996509987;42412;43100.353494696974;43193.3520997179;43970;44620.55379446294;41834.37248441337;42080.737577872715;43266.56733432625;43308;44468.332975004756;43479.347809782244;43679.78160109179;44249;44768.55231447774;44845;36493.635063649024;38743.926129752486;38818.80590597029;38926.653322499726;39309.01727456722;29312.650441294496;29396.853015734785;29596.704032959395;29790.8510457455;29805.254868628457 09:22:50 INFO - PROCESS | 15961 | |2;jquery.html;390.6503679207108;401.67865707434044;423.6335569732183;423.9957600423996;433.64007873465005;16776.245068971893;19280.3251886184;19784.90107549462;19936.302229421974;20228.08973596188;19097.61804763904;19228.519287017833;19669.606607867834;19730.112144953477;19830.603387932268;4729.834455794048;5630.690312032836;5759.1937128802;5775.3358363788075;5872.823815285548;5632.9436705632825;5692.601517893729;5724.742386592592;5730.971345143268;5738.770449182028;5488.17677348397;5679.346875109374;5697.43025697429;5705.629134106291;5710.628809127415;5670.853003176863;5672.574556908248;5744.195812586241;5748.655080695151;5751.654900705971;4994.775235114428;5094.4141423736;5122.078025955327;5125.589952803767;5126.051680439131;23036.53926921469;23192.4201894954;23225.419364515852;23276.418089547897;23291.53416931669;2376.346504711201;2428.3929017745563;2456.4227406559444;2919.459899918522;3077.7845550811453;13896.652583685387;14505.129692218501;14972.850271497255;15223;15276.312565934559;1760.7534945107695;1910.5414700471927;1913.9425817225367;1922.7692676878723;1951.5121219695077;80690.59654701689;87078.56460717655;87662;88585.55707221423;90749.09250907472;11517.654470365902;11700.122490813223;11822.586209482626;11836.644900652995;11846.88153118475;16523.421680241136;16534.338626455046;16538.83461165373;16552.586185345222;16556.337746490248;8528.275096616733;8686.91313086861;8722.86915696265;8846.203841654282;8856.557172141367;8648.351373647001;8675.826483470422;8714.21572058505;8872.112788721077;8876.644934202559;4583.449986001635;4845.9757701211265;4865.197242455026;5087.745612719349;5112.642115051911;1942.7377304064053;2024.7570291565107;2067.2041264113122;2113.915443382278;2154.181411063817;762.3558093411169;891.7280229530055;951.509972364233;993.2153598657125;1024.2011231239644;19360.612787744165;19725.50686232827;19853.404397868086;19921.800781991995;20151.19395224204;986.9062439068277;1013.4476710192963;1025.7589466475372;1035.1873779083535;1058.9947050264852;10360.896391035993;11182.776344473064;11239.269447485887;11247.493862776195;11277.774444511228;498004;501547;506449;522840;534574;58553;60852;94625.5268723652;98900;101114;1038.8285932821152;1041.9114375278034;1074.731317170723;1089.553283153903;1090.432974853072;17641.911790440965;18015.2793888243;18193.636127277117;18317.90841045786;18422.35521756732;41419.378709319986;41668.374974374805;42088.78955605203;42656;43058.56941430671;58043.70978145082;58616.413835861094;59108.70445647744;59252;59805.10292345531;8488.193621605938;8734.30125589964;8757.518336491554;8975.596098175467;9059.728208153765;13031.934840325737;13325.600231992668;13634.659133521742;13737.24445155526;14187.858121418654;12334.136610437183;12434.37828108609;12679.492820287085;12689.36553172356;13013.674658133623;12190.967174706904;12292.446839892405;12349.444275007825;12671.366431678194;12816.102872798814;12587.87412125867;12598.433070512032;12666.493340266286;12959.35203239853;12997.48010079624;8050;8125.699888017889;8150.2664760171865;8388.119247478928;8898.4660920345;11071.833922491009;12387.566435174725;12446.439910204244;12471;12758.808617870554 09:22:50 INFO - PROCESS | 15961 | |3;mootools.html;1504.2854644044078;1523.6495606010617;1661.509854592895;1762.55936015996;1786.7386283713347;8150.103488616248;8708.869366959501;8717.302615790737;8723.21491065804;8723.302135829133;7629.465937384385;7828.334591559725;8095.190480951902;8245.422820402575;8546.529940853266;2416.891239894209;2450.375154335642;2453.1168779239547;2456.9754302457013;2459.5080983803223;2443.1481115285796;2467.087177744237;2483.50329934013;2491.352248415416;2495.388629785696;2440.2069327468553;2448.4490989527394;2452.8160387970975;2457.213691618683;2459.9016039358494;2381.1903952656094;2401.903923843053;2405.987970060156;2407.2898494943947;2441.4750828571764;2412.6381042843536;2435.257246539805;2454.312792418108;2457.9553689681816;2458.1150785717127;8428.578571071423;8513.787155321166;8514.74455766328;8586.356023298278;8696.260817830493;5337.4662533746705;5468.589855760833;5495.697736624484;5496.148097044965;5499.532539734128;3466.272082862602;3489.1974845785358;3576.624454432273;3590.4793804898404;3610.6930910872607;1142.8400323388803;1187.139323990109;1198.4786617821276;1207.4325067218392;1228.1280290993404;11589.826152607717;11595.130365222642;11611.6516504505;11643.06855451562;11653.825192622118;4519.706219095814;4664.720116793003;4737.0052289019695;4775.379200703886;4900.995295964319;9629.470379129076;9631.614735410505;9634.807303854024;9639.036096390304;9650.08324209199;5389.703566303812;5393.13709806437;5402.054640437987;5402.216678581583;5406.864828379322;4398.318260669601;4525.502194758574;4992.076465853756;5012.323336349619;5085.720285384339;3984.063745019918;4072.857449989236;4116.094459218967;4156.854510092193;4164.708470407103;1387.0775934003975;1403.4105675616265;1403.9087459315317;1423;1438.3239877257672;945.5650400815564;1006.2654262388497;1023.959041638341;1037.4242295526055;1040.458961340099;5930.673812940329;5987;6018.97677394844;6160.845978850564;6206.379362063757;940.6472572785206;995.0646392391129;1002.7693630464888;1043.5512729526224;1061.9893801062044;3793.1275806564645;3870.2453021661067;3878.553966293856;3885.592012838668;3928.862489812843;10313.174946004452;10742.086922611665;10784.514696838662;10791.78416431667;10797.892021079846;10653.360798351969;10656.467176641137;10659.253852230424;10669.093127084285;10675.57297708083;7739.5743234122665;7961.1242763295995;8184.713535026364;8196.754097377208;8205.138460461685;5860.238169037998;5927.614705044159;5988.760449581968;6115.205023346936;6149.600275982047;9903.851442228517;9920.156786672926;9931.602735890772;10020.048095430922;10123.088921996761;9371.437713737198;9742.07450292221;9806.901930980599;10097;10100.747481313027;6695.799126026227;6862.107925969792;6868.450523958171;7689.3848492121615;7863.449558531077;7971.92028079735;8180.059293181361;8342.749717508485;8535.786605334917;8542.35932305092;7304.233055529306;7377.077865266841;7566.546007239584;7622.656980436004;7848.568328741974;7285.453590980592;7454.701811927679;7472.439567032386;7488.812779680552;7525.661345239368;6918.377346038881;7041.718331266897;7047.577145371089;7047.929520704933;7048.224695283618;5068.59451243907;5076.162433198481;5102.311187989574;5123.692578445305;5176.689398636094;5262.552683021833;5278.445763194963;5310.522053015247;5378.946210537844;5621.831345059655 09:22:50 INFO - PROCESS | 15961 | |4;prototype.html;350.45679197244266;357.7299139149942;361.3658030157074;367.36996051771206;367.8105775525603;5226.5034821691925;5302.867428314294;5303.302943058223;5334.199870019499;5350.357957045155;4997;5081.314022606947;5135.666181698196;5156.561692256163;5270.947290527093;4140.875773726778;4144.41978123063;4146.606072423115;4155.542890282074;4159;4181.3309870420735;4194.685398595102;4196.475440569929;4196.97901510492;4200.7444230721285;3906.6484016438517;3976.383660532622;4167.1457351242925;4171;4178.310578754502;4161.417401563784;4175.54069052404;4192.496900371944;4203.495580530356;4206.684498662597;3721.0883333583447;3733.290674771785;3735.1595890924323;3744.475773391727;3747.156889699823;5020.3724534433195;5061.797528098871;5076.23856421536;5102.413222479426;5146.356705411824;4716.457607375161;4736.123817093849;4747.629183279875;4751.83368582098;4761.8095276188915;5437.238786569884;5443.891122177574;5445.101558242885;5446.836594902159;5447.319085114361;3964.226975739732;4070.877873663765;4074.7351422157467;4077.3883917412327;4085.142120154771;5647.181158731961;5671.376148623648;5671.489565939044;5672.376038635747;5681.318241811009;4174.457320548309;4188.623023927861;4190.434291370687;4196.790160491963;4215.494140703136;4042.2723909696538;4188.183304255702;4235.23765722173;4241.172971270573;4242.703010789215;4705.294205869079;4716.410448693913;4723.905521889543;4732.397181550134;4737.170995075848;5447.264619276347;5460.5085542300585;5463.672179669233;5478.91781623276;5482.491205628401;1352.3914238592672;1377.882879955215;1389.9027068105338;1390.3048475762118;1397.7134687389062;986.3687240166299;993.7657566104432;996.9930370325878;1010.3634710132569;1013.7566983923953;5123.410807757155;5134.15286477727;5135.382354558302;5139.537441630271;5169.327987361694;5343.946560534423;5382.811601593926;5383.5962302826665;5385.5960802939935;5428.67427954324;4962.330085438492;5090.949090509048;5095.414027386824;5109.489051094935;5141.640085194001;2834.588984597263;2851.5009873272093;2851.5294976328673;2860.4994126027864;2867.354845159864;5643.858903527363;5672.517835983905;5673.886522269531;5685.488306052475;5685.60200785941;5314.686699912352;5342.866428339323;5442.455754424605;5471.835844924659;5486.533644640251;5575.804846830341;5635.8591035224445;5636.971815140898;5644.334921198174;5652.943470565242;5374.516293533601;5379.919301210563;5388.218708287198;5392.487713667196;5413.783448662167;5248.186531087687;5554.305711786027;5572.832815015556;5594.440555944373;5623.718814059363;5901.881962360643;5923.674197919156;5924.585279030599;5935.258092738408;5961.314448838439;4002.6597739192493;4095.262852686426;4116.8147433364975;4117.135401565585;4119.814608342692;5428.185772134211;5522.30971128609;5546.251256080377;5629.915551266652;5660.235868157911;5551.167324901297;5553.750081246273;5557.609857986544;5559.527440167631;5561.6663000220115;5322.813701520428;5554.805581804779;5555.500004999408;5556;5563.833085007294;5466.207399926909;5485.890282194254;5500.339959204921;5512.200730894078;5515.503604675599;5572.192032155233;5591.580631452576;5602.411746766531;5605.719714014364;5609.411011843697;5199.740012999259;5368.865778355416;5430.15832545956;5441;5474.288342515448 09:22:50 INFO - PROCESS | 15961 | |5;yui.html;760.5018712743155;763.8777795552709;777.3237283563298;795.8937077462326;810.2990912860375;14378.065425747332;14468.421263149461;14743.557693269193;15094.396224151034;15114.244287785621;13574.592762217124;13633.113847599923;13811.654708632264;13869.653258668513;13907.096038757474;723.9927600724004;842.7471758472465;853.6158728572136;855.2772906893696;856.4219152072358;744.036472767767;828.8425199212161;840.7183593496155;853.9146085391474;864.5201912938317;905.1491597897955;908.5684299957534;909.0364213933219;909.7816524034217;910.2490445382585;746.1978373248779;905.7282815155427;910.2990697163181;910.3172620534632;910.8406028944908;563.0990415335472;636.805774238857;646.7768619826153;650.7624716978316;655.0501772429996;14294.71410571793;14302.71394572113;14337.42650293987;15250.771238431322;15271.236438178157;14214;14307.28463576817;14438;14532.128072315694;14532.782008269884;11610.129240307011;11774.823377649342;11784.351860647661;11876.406179691066;11938.701532461671;3842.3468010438014;3876.5348158221195;3948.881533553998;4495.842645507424;4657.836975705868;64454.677726611066;65006.674966624865;65457.67271163662;66122.99999999952;66411.335886641;11206.663800086011;11272.492737826817;11288.548458061585;11362.602308919148;11614.6515604532;21376.893115534323;21424.143034278455;21497.785022149892;21506.70959742389;21744.456388590414;8130.268275855202;8239.299659528888;8313.958430207811;8342.332613390914;8478.448900821428;4344.076214646157;4344.5296834629025;4355.5208927018;4413.514513403523;4492.05666809967;3165.683431656816;3254.2677897473354;3275.967240327614;3280.7539434542505;3313.552670389515;617.8671585609115;624.4286477872787;630.4011189370117;631.0408179567032;638.6998110887876;759.1156302907161;786.897703298579;787.8266781308217;792.9405294602927;817.9182081791893;9721;9833;9857.211423086135;10349.9482502587;10375.84436233457;725.6516871901517;740.1968863782856;769.8960640313486;787.5038725602833;807.0839597057264;4723.244280915106;4907.975460122748;4986.052649996489;4987.80048798044;4994.300797888299;71454.64272678707;72876.63561682157;74282;79903;92914;46921.76539117283;64727.67636161883;69915.65042174756;72178.63910680413;72723.27276727164;57865.999999999156;67159.32840671531;68093.97859032119;69533.30466695268;69898;9792.412455252708;9867.309288349747;10010.64962726301;10025.244855178393;10110.79778404413;44199.116017678825;45024.54975450334;45186.32220516629;46958.29562556496;47348.76325618487;38064.23871522609;41678.583214168684;58905;59297.70351148216;61694.69152654208;12792.61622151337;12833.42249598789;12968.870311297143;13118.409671564612;13416.195028298333;14489.710205796036;14549.41802327895;14863.108213507225;15385;15891.920540397225;12912.289824059766;13368.866311337151;14162.716745664822;14473.710525789214;15026.098434093989;13461.932690336485;13603.183808971493;13632.454701812214;13647.38586763618;14079.718405631626;13380.732385352434;13521;13661.795073073714;13886.375113120135;14797.926010370309;10452.529636166542;10534.894651053391;11251.606193783178;11631.243969141979;11806.704832379259;11153.888461115284;11283.492242848928;11438.94280528592;11480.712982175179;11551.826722599335 09:22:50 INFO - PROCESS | 15961 | __end_tp_report 09:22:50 INFO - PROCESS | 15961 | __start_cc_report 09:22:50 INFO - PROCESS | 15961 | _x_x_mozilla_cycle_collect,1037 09:22:50 INFO - PROCESS | 15961 | __end_cc_report 09:22:50 INFO - PROCESS | 15961 | __startTimestamp1479748970562__endTimestamp 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | ------- Summary: start ------- 09:22:50 INFO - PROCESS | 15961 | Number of tests: 6 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | [#0] dojo.html Cycles:165 Average:5545.85 Median:5721.34 stddev:621.49 (10.9%) stddev-sans-first:595.27 09:22:50 INFO - PROCESS | 15961 | Values: 3189.4 3234.5 3242.4 3243.5 3264.9 5455.7 5557.1 5572.9 5576.2 5609.4 5589.0 5613.6 5627.5 5633.1 5641.4 5081.2 5084.2 5100.2 5132.6 5196.7 5018.5 5130.6 5176.2 5185.9 5187.5 5031.8 5033.9 5040.5 5045.5 5067.0 5109.9 5113.9 5171.9 5193.1 5201.2 4919.7 4931.1 5063.1 5080.3 5129.1 5419.8 5440.3 5448.3 5458.5 5517.7 5847.9 5910.3 5955.6 5958.4 5964.1 5837.0 5899.9 6003.5 6009.3 6020.0 5546.7 5582.5 5587.9 5596.8 5621.1 6121.7 6124.8 6132.0 6132.9 6137.8 5724.3 5779.1 5896.1 5898.7 5900.6 5878.8 5919.2 5937.4 5953.0 6019.6 5951.2 5951.5 5957.4 5957.7 5986.5 5790.8 5910.8 5954.4 5972.6 5972.6 4522.0 4560.4 4569.3 4571.2 4593.7 4134.9 4140.1 4145.5 4181.1 4196.7 5714.7 5720.9 5721.3 5722.5 5739.9 5761.6 5877.3 5982.4 5994.5 5997.3 5681.6 5687.0 5692.1 5694.1 5694.6 5144.1 5168.9 5183.3 5187.0 5188.6 6170.8 6200.6 6200.8 6206.6 6206.7 6039.1 6062.1 6068.2 6076.5 6079.9 6291.3 6309.3 6317.9 6334.3 6337.8 5736.2 5768.0 5796.8 5949.0 5960.3 5899.1 5973.4 5992.6 6004.5 6008.9 5785.9 5792.3 5808.8 5809.4 5810.4 5591.9 5649.4 5767.3 5793.8 5799.0 5658.7 5679.0 5720.6 5782.5 5821.6 5789.2 5827.9 5833.3 5836.9 5839.2 5656.0 5682.2 5699.4 5702.3 5705.7 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | [#1] ext.html Cycles:180 Average:60900.18 Median:383821.07 stddev:119590.34 (31.2%) stddev-sans-first:119840.05 09:22:50 INFO - PROCESS | 15961 | Values: 574.8 621.0 649.3 659.1 688.0 33727.2 44103.6 44452.3 44569.1 47833.5 45619.0 45975.5 46009.3 46082.3 46218.3 8260.7 8727.6 8870.6 8885.6 8888.3 8191.8 10429.3 10635.9 10637.8 10932.1 10708.1 10775.6 10789.1 10801.0 10804.0 10547.6 10577.7 10599.3 10620.5 10622.5 10474.7 10603.4 10659.0 10663.7 10668.1 42724.4 43001.4 43121.0 43144.6 43178.0 3660.1 3681.3 3748.3 3763.2 3929.7 31853.4 31903.4 31917.4 31936.8 32166.0 4276.6 4372.0 4417.2 4548.5 4659.8 359376.0 360812.0 361025.0 361452.0 361796.0 64259.7 64834.0 64926.0 64927.0 65006.7 39323.4 39651.0 39911.4 42192.0 42199.8 17225.7 17318.2 17347.5 17354.0 17361.8 13025.5 13161.1 14095.4 14230.1 14282.4 19645.0 20499.6 20510.1 20539.2 20659.2 7218.6 7221.5 7237.0 7389.5 7602.0 1030.2 1071.6 1077.0 1136.4 1208.5 33514.5 33849.5 33871.2 33960.3 33966.2 1108.8 1128.1 1137.8 1191.3 1202.5 14893.3 18015.5 18635.6 18725.0 18781.1 572331.0 574746.0 576700.0 577095.0 580014.0 59549.4 60192.0 60206.4 60386.7 60434.0 1311.7 1341.7 1367.9 1381.4 1401.9 32152.4 34490.0 34651.5 35032.3 35045.3 51252.7 51529.2 51693.5 51839.7 51875.5 382608.0 385034.1 385726.0 386675.0 387106.0 31325.4 31655.0 31759.5 31816.8 32066.8 49493.8 49866.0 50411.0 50715.7 51003.5 42412.0 43100.4 43193.4 43970.0 44620.6 41834.4 42080.7 43266.6 43308.0 44468.3 43479.3 43679.8 44249.0 44768.6 44845.0 36493.6 38743.9 38818.8 38926.7 39309.0 29312.7 29396.9 29596.7 29790.9 29805.3 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | [#2] jquery.html Cycles:180 Average:29957.88 Median:12833.94 stddev:84371.63 (657.4%) stddev-sans-first:84579.11 09:22:50 INFO - PROCESS | 15961 | Values: 390.7 401.7 423.6 424.0 433.6 16776.2 19280.3 19784.9 19936.3 20228.1 19097.6 19228.5 19669.6 19730.1 19830.6 4729.8 5630.7 5759.2 5775.3 5872.8 5632.9 5692.6 5724.7 5731.0 5738.8 5488.2 5679.3 5697.4 5705.6 5710.6 5670.9 5672.6 5744.2 5748.7 5751.7 4994.8 5094.4 5122.1 5125.6 5126.1 23036.5 23192.4 23225.4 23276.4 23291.5 2376.3 2428.4 2456.4 2919.5 3077.8 13896.7 14505.1 14972.9 15223.0 15276.3 1760.8 1910.5 1913.9 1922.8 1951.5 80690.6 87078.6 87662.0 88585.6 90749.1 11517.7 11700.1 11822.6 11836.6 11846.9 16523.4 16534.3 16538.8 16552.6 16556.3 8528.3 8686.9 8722.9 8846.2 8856.6 8648.4 8675.8 8714.2 8872.1 8876.6 4583.4 4846.0 4865.2 5087.7 5112.6 1942.7 2024.8 2067.2 2113.9 2154.2 762.4 891.7 951.5 993.2 1024.2 19360.6 19725.5 19853.4 19921.8 20151.2 986.9 1013.4 1025.8 1035.2 1059.0 10360.9 11182.8 11239.3 11247.5 11277.8 498004.0 501547.0 506449.0 522840.0 534574.0 58553.0 60852.0 94625.5 98900.0 101114.0 1038.8 1041.9 1074.7 1089.6 1090.4 17641.9 18015.3 18193.6 18317.9 18422.4 41419.4 41668.4 42088.8 42656.0 43058.6 58043.7 58616.4 59108.7 59252.0 59805.1 8488.2 8734.3 8757.5 8975.6 9059.7 13031.9 13325.6 13634.7 13737.2 14187.9 12334.1 12434.4 12679.5 12689.4 13013.7 12191.0 12292.4 12349.4 12671.4 12816.1 12587.9 12598.4 12666.5 12959.4 12997.5 8050.0 8125.7 8150.3 8388.1 8898.5 11071.8 12387.6 12446.4 12471.0 12758.8 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | [#3] mootools.html Cycles:180 Average:5726.42 Median:5072.38 stddev:3110.35 (61.3%) stddev-sans-first:3102.89 09:22:50 INFO - PROCESS | 15961 | Values: 1504.3 1523.6 1661.5 1762.6 1786.7 8150.1 8708.9 8717.3 8723.2 8723.3 7629.5 7828.3 8095.2 8245.4 8546.5 2416.9 2450.4 2453.1 2457.0 2459.5 2443.1 2467.1 2483.5 2491.4 2495.4 2440.2 2448.4 2452.8 2457.2 2459.9 2381.2 2401.9 2406.0 2407.3 2441.5 2412.6 2435.3 2454.3 2458.0 2458.1 8428.6 8513.8 8514.7 8586.4 8696.3 5337.5 5468.6 5495.7 5496.1 5499.5 3466.3 3489.2 3576.6 3590.5 3610.7 1142.8 1187.1 1198.5 1207.4 1228.1 11589.8 11595.1 11611.7 11643.1 11653.8 4519.7 4664.7 4737.0 4775.4 4901.0 9629.5 9631.6 9634.8 9639.0 9650.1 5389.7 5393.1 5402.1 5402.2 5406.9 4398.3 4525.5 4992.1 5012.3 5085.7 3984.1 4072.9 4116.1 4156.9 4164.7 1387.1 1403.4 1403.9 1423.0 1438.3 945.6 1006.3 1024.0 1037.4 1040.5 5930.7 5987.0 6019.0 6160.8 6206.4 940.6 995.1 1002.8 1043.6 1062.0 3793.1 3870.2 3878.6 3885.6 3928.9 10313.2 10742.1 10784.5 10791.8 10797.9 10653.4 10656.5 10659.3 10669.1 10675.6 7739.6 7961.1 8184.7 8196.8 8205.1 5860.2 5927.6 5988.8 6115.2 6149.6 9903.9 9920.2 9931.6 10020.0 10123.1 9371.4 9742.1 9806.9 10097.0 10100.7 6695.8 6862.1 6868.5 7689.4 7863.4 7971.9 8180.1 8342.7 8535.8 8542.4 7304.2 7377.1 7566.5 7622.7 7848.6 7285.5 7454.7 7472.4 7488.8 7525.7 6918.4 7041.7 7047.6 7047.9 7048.2 5068.6 5076.2 5102.3 5123.7 5176.7 5262.6 5278.4 5310.5 5378.9 5621.8 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | [#4] prototype.html Cycles:180 Average:4619.04 Median:5184.53 stddev:1324.66 (25.6%) stddev-sans-first:1289.05 09:22:50 INFO - PROCESS | 15961 | Values: 350.5 357.7 361.4 367.4 367.8 5226.5 5302.9 5303.3 5334.2 5350.4 4997.0 5081.3 5135.7 5156.6 5270.9 4140.9 4144.4 4146.6 4155.5 4159.0 4181.3 4194.7 4196.5 4197.0 4200.7 3906.6 3976.4 4167.1 4171.0 4178.3 4161.4 4175.5 4192.5 4203.5 4206.7 3721.1 3733.3 3735.2 3744.5 3747.2 5020.4 5061.8 5076.2 5102.4 5146.4 4716.5 4736.1 4747.6 4751.8 4761.8 5437.2 5443.9 5445.1 5446.8 5447.3 3964.2 4070.9 4074.7 4077.4 4085.1 5647.2 5671.4 5671.5 5672.4 5681.3 4174.5 4188.6 4190.4 4196.8 4215.5 4042.3 4188.2 4235.2 4241.2 4242.7 4705.3 4716.4 4723.9 4732.4 4737.2 5447.3 5460.5 5463.7 5478.9 5482.5 1352.4 1377.9 1389.9 1390.3 1397.7 986.4 993.8 997.0 1010.4 1013.8 5123.4 5134.2 5135.4 5139.5 5169.3 5343.9 5382.8 5383.6 5385.6 5428.7 4962.3 5090.9 5095.4 5109.5 5141.6 2834.6 2851.5 2851.5 2860.5 2867.4 5643.9 5672.5 5673.9 5685.5 5685.6 5314.7 5342.9 5442.5 5471.8 5486.5 5575.8 5635.9 5637.0 5644.3 5652.9 5374.5 5379.9 5388.2 5392.5 5413.8 5248.2 5554.3 5572.8 5594.4 5623.7 5901.9 5923.7 5924.6 5935.3 5961.3 4002.7 4095.3 4116.8 4117.1 4119.8 5428.2 5522.3 5546.3 5629.9 5660.2 5551.2 5553.8 5557.6 5559.5 5561.7 5322.8 5554.8 5555.5 5556.0 5563.8 5466.2 5485.9 5500.3 5512.2 5515.5 5572.2 5591.6 5602.4 5605.7 5609.4 5199.7 5368.9 5430.2 5441.0 5474.3 09:22:50 INFO - PROCESS | 15961 | 09:22:50 INFO - PROCESS | 15961 | [#5] yui.html Cycles:180 Average:17213.34 Median:4493.95 stddev:21555.87 (479.7%) stddev-sans-first:21580.93 09:22:50 INFO - PROCESS | 15961 | Values: 760.5 763.9 777.3 795.9 810.3 14378.1 14468.4 14743.6 15094.4 15114.2 13574.6 13633.1 13811.7 13869.7 13907.1 724.0 842.7 853.6 855.3 856.4 744.0 828.8 840.7 853.9 864.5 905.1 908.6 909.0 909.8 910.2 746.2 905.7 910.3 910.3 910.8 563.1 636.8 646.8 650.8 655.1 14294.7 14302.7 14337.4 15250.8 15271.2 14214.0 14307.3 14438.0 14532.1 14532.8 11610.1 11774.8 11784.4 11876.4 11938.7 3842.3 3876.5 3948.9 4495.8 4657.8 64454.7 65006.7 65457.7 66123.0 66411.3 11206.7 11272.5 11288.5 11362.6 11614.7 21376.9 21424.1 21497.8 21506.7 21744.5 8130.3 8239.3 8314.0 8342.3 8478.4 4344.1 4344.5 4355.5 4413.5 4492.1 3165.7 3254.3 3276.0 3280.8 3313.6 617.9 624.4 630.4 631.0 638.7 759.1 786.9 787.8 792.9 817.9 9721.0 9833.0 9857.2 10349.9 10375.8 725.7 740.2 769.9 787.5 807.1 4723.2 4908.0 4986.1 4987.8 4994.3 71454.6 72876.6 74282.0 79903.0 92914.0 46921.8 64727.7 69915.7 72178.6 72723.3 57866.0 67159.3 68094.0 69533.3 69898.0 9792.4 9867.3 10010.6 10025.2 10110.8 44199.1 45024.5 45186.3 46958.3 47348.8 38064.2 41678.6 58905.0 59297.7 61694.7 12792.6 12833.4 12968.9 13118.4 13416.2 14489.7 14549.4 14863.1 15385.0 15891.9 12912.3 13368.9 14162.7 14473.7 15026.1 13461.9 13603.2 13632.5 13647.4 14079.7 13380.7 13521.0 13661.8 13886.4 14797.9 10452.5 10534.9 11251.6 11631.2 11806.7 11153.9 11283.5 11438.9 11480.7 11551.8 09:22:50 INFO - PROCESS | 15961 | -------- Summary: end -------- 09:22:50 INFO - PROCESS | 15961 | 09:22:51 INFO - TEST-INFO | 15961: exit 0 09:22:51 INFO - TEST-OK | dromaeo_css | took 1116800ms 09:22:51 INFO - TEST-START | kraken 09:22:51 INFO - operating with platform_type : linux_ 09:22:51 INFO - Initialising browser for kraken test... 09:22:51 INFO - TEST-INFO | started process 16280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCcXkR/profile http://localhost:55605/getInfo.html) 09:22:55 ERROR - PROCESS | 16280 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 09:22:56 INFO - PROCESS | 16280 | __metrics Screen width/height:1600/1200 09:22:56 INFO - PROCESS | 16280 | colorDepth:24 09:22:56 INFO - PROCESS | 16280 | Browser inner width/height: 1024/697 09:22:56 INFO - PROCESS | 16280 | __metrics 09:22:56 INFO - PROCESS | 16280 | 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" 09:22:56 INFO - PROCESS | 16280 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:22:57 INFO - PROCESS | 16280 | console.error: PushService: 09:22:57 INFO - PROCESS | 16280 | stateChangeProcessEnqueue: Error transitioning state 09:22:57 INFO - PROCESS | 16280 | UnknownError 09:22:58 INFO - TEST-INFO | 16280: exit 0 09:22:58 INFO - Browser initialized. 09:22:58 INFO - Running cycle 1/1 for kraken test... 09:22:58 INFO - TEST-INFO | started process 16374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTCcXkR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:10 INFO - PROCESS | 16374 | RSS: Main: 144384000 09:23:10 INFO - PROCESS | 16374 | 09:23:12 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55605/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:13 INFO - PROCESS | 16374 | RSS: Main: 185962496 09:23:13 INFO - PROCESS | 16374 | 09:23:16 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55605/tests/kraken/driver.html?testName=audio-dft) 09:23:16 INFO - PROCESS | 16374 | RSS: Main: 176099328 09:23:16 INFO - PROCESS | 16374 | 09:23:19 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55605/tests/kraken/driver.html?testName=audio-fft) 09:23:20 INFO - PROCESS | 16374 | RSS: Main: 266858496 09:23:20 INFO - PROCESS | 16374 | 09:23:22 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55605/tests/kraken/driver.html?testName=audio-oscillator) 09:23:22 INFO - PROCESS | 16374 | RSS: Main: 173289472 09:23:22 INFO - PROCESS | 16374 | 09:23:24 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55605/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:23:25 INFO - PROCESS | 16374 | RSS: Main: 176218112 09:23:25 INFO - PROCESS | 16374 | 09:23:28 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55605/tests/kraken/driver.html?testName=imaging-darkroom) 09:23:28 INFO - PROCESS | 16374 | RSS: Main: 214466560 09:23:28 INFO - PROCESS | 16374 | 09:23:32 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55605/tests/kraken/driver.html?testName=imaging-desaturate) 09:23:32 INFO - PROCESS | 16374 | RSS: Main: 212819968 09:23:32 INFO - PROCESS | 16374 | 09:23:35 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55605/tests/kraken/driver.html?testName=json-parse-financial) 09:23:36 INFO - PROCESS | 16374 | RSS: Main: 211873792 09:23:36 INFO - PROCESS | 16374 | 09:23:37 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55605/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:23:38 INFO - PROCESS | 16374 | RSS: Main: 173969408 09:23:38 INFO - PROCESS | 16374 | 09:23:39 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:23:40 INFO - PROCESS | 16374 | RSS: Main: 180592640 09:23:40 INFO - PROCESS | 16374 | 09:23:42 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:23:43 INFO - PROCESS | 16374 | RSS: Main: 190590976 09:23:43 INFO - PROCESS | 16374 | 09:23:45 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:23:46 INFO - PROCESS | 16374 | RSS: Main: 198770688 09:23:46 INFO - PROCESS | 16374 | 09:23:48 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:23:49 INFO - PROCESS | 16374 | RSS: Main: 194949120 09:23:49 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | Cycle 1(1): loaded http://localhost:55605/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55605/tests/kraken/driver.html?testName=ai-astar) 09:23:51 INFO - PROCESS | 16374 | RSS: Main: 246861824 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | __start_tp_report 09:23:51 INFO - PROCESS | 16374 | _x_x_mozilla_page_load 09:23:51 INFO - PROCESS | 16374 | _x_x_mozilla_page_load_details 09:23:51 INFO - PROCESS | 16374 | |i|pagename|runs| 09:23:51 INFO - PROCESS | 16374 | |0;ai-astar;102;111;111;111;112;110;111;111;112;109 09:23:51 INFO - PROCESS | 16374 | |1;audio-beat-detection;141;122;119;161;124;128;129;119;149;125 09:23:51 INFO - PROCESS | 16374 | |2;audio-dft;163;160;160;159;170;162;159;162;160;160 09:23:51 INFO - PROCESS | 16374 | |3;audio-fft;75;75;76;106;75;76;76;77;100;75 09:23:51 INFO - PROCESS | 16374 | |4;audio-oscillator;82;81;124;82;82;83;104;83;82;117 09:23:51 INFO - PROCESS | 16374 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;116;117;117 09:23:51 INFO - PROCESS | 16374 | |6;imaging-darkroom;147;146;145;146;145;147;145;145;146;157 09:23:51 INFO - PROCESS | 16374 | |7;imaging-desaturate;85;84;85;84;84;84;88;84;86;85 09:23:51 INFO - PROCESS | 16374 | |8;json-parse-financial;59;52;52;53;52;53;55;53;52;53 09:23:51 INFO - PROCESS | 16374 | |9;json-stringify-tinderbox;61;61;60;60;60;60;61;61;61;60 09:23:51 INFO - PROCESS | 16374 | |10;stanford-crypto-aes;75;75;73;80;75;75;74;79;76;74 09:23:51 INFO - PROCESS | 16374 | |11;stanford-crypto-ccm;127;123;157;142;125;126;122;128;163;122 09:23:51 INFO - PROCESS | 16374 | |12;stanford-crypto-pbkdf2;154;152;151;153;154;159;152;156;150;152 09:23:51 INFO - PROCESS | 16374 | |13;stanford-crypto-sha256-iterative;64;66;61;64;62;62;63;63;61;60 09:23:51 INFO - PROCESS | 16374 | __end_tp_report 09:23:51 INFO - PROCESS | 16374 | __start_cc_report 09:23:51 INFO - PROCESS | 16374 | _x_x_mozilla_cycle_collect,1586 09:23:51 INFO - PROCESS | 16374 | __end_cc_report 09:23:51 INFO - PROCESS | 16374 | __startTimestamp1479749031450__endTimestamp 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | ------- Summary: start ------- 09:23:51 INFO - PROCESS | 16374 | Number of tests: 14 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 09:23:51 INFO - PROCESS | 16374 | Values: 102.0 111.0 111.0 111.0 112.0 110.0 111.0 111.0 112.0 109.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:128.50 stddev:14.09 (11.0%) stddev-sans-first:14.53 09:23:51 INFO - PROCESS | 16374 | Values: 141.0 122.0 119.0 161.0 124.0 128.0 129.0 119.0 149.0 125.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:3.27 (2.0%) stddev-sans-first:3.43 09:23:51 INFO - PROCESS | 16374 | Values: 163.0 160.0 160.0 159.0 170.0 162.0 159.0 162.0 160.0 160.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:11.65 (15.4%) stddev-sans-first:12.14 09:23:51 INFO - PROCESS | 16374 | Values: 75.0 75.0 76.0 106.0 75.0 76.0 76.0 77.0 100.0 75.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:82.00 stddev:16.59 (20.2%) stddev-sans-first:17.19 09:23:51 INFO - PROCESS | 16374 | Values: 82.0 81.0 124.0 82.0 82.0 83.0 104.0 83.0 82.0 117.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:23:51 INFO - PROCESS | 16374 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:146.00 stddev:3.63 (2.5%) stddev-sans-first:3.86 09:23:51 INFO - PROCESS | 16374 | Values: 147.0 146.0 145.0 146.0 145.0 147.0 145.0 145.0 146.0 157.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.00 stddev:1.29 (1.5%) stddev-sans-first:1.36 09:23:51 INFO - PROCESS | 16374 | Values: 85.0 84.0 85.0 84.0 84.0 84.0 88.0 84.0 86.0 85.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:2.17 (4.1%) stddev-sans-first:0.97 09:23:51 INFO - PROCESS | 16374 | Values: 59.0 52.0 52.0 53.0 52.0 53.0 55.0 53.0 52.0 53.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 09:23:51 INFO - PROCESS | 16374 | Values: 61.0 61.0 60.0 60.0 60.0 60.0 61.0 61.0 61.0 60.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:2.22 (3.0%) stddev-sans-first:2.35 09:23:51 INFO - PROCESS | 16374 | Values: 75.0 75.0 73.0 80.0 75.0 75.0 74.0 79.0 76.0 74.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:127.50 stddev:15.17 (11.9%) stddev-sans-first:15.90 09:23:51 INFO - PROCESS | 16374 | Values: 127.0 123.0 157.0 142.0 125.0 126.0 122.0 128.0 163.0 122.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.50 stddev:2.63 (1.7%) stddev-sans-first:2.77 09:23:51 INFO - PROCESS | 16374 | Values: 154.0 152.0 151.0 153.0 154.0 159.0 152.0 156.0 150.0 152.0 09:23:51 INFO - PROCESS | 16374 | 09:23:51 INFO - PROCESS | 16374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.81 09:23:51 INFO - PROCESS | 16374 | Values: 64.0 66.0 61.0 64.0 62.0 62.0 63.0 63.0 61.0 60.0 09:23:51 INFO - PROCESS | 16374 | -------- Summary: end -------- 09:23:51 INFO - PROCESS | 16374 | 09:23:52 INFO - TEST-INFO | 16374: exit 0 09:23:52 INFO - TEST-OK | kraken | took 61090ms 09:23:52 INFO - SUITE-END | took 1177s 09:23:52 INFO - Completed test suite (00:19:38) 09:23:52 INFO - javascript benchmark 09:23:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3189.4099591575555, 3234.4824828027504, 3242.4001559711464, 3243.5134729790516, 3264.9347013059723, 5455.727213639317, 5557.138643510252, 5572.916406253909, 5576.247206627104, 5609.439056094394, 5588.972055139729, 5613.635113717616, 5627.521660658849, 5633.070543360341, 5641.379448260688, 5081.237814327853, 5084.211947148179, 5100.234964755279, 5132.640715149941, 5196.662216955905, 5018.473060328668, 5130.6152038597065, 5176.197689358156, 5185.896282074375, 5187.533122019017, 5031.798728050873, 5033.949660503385, 5040.470750571192, 5045.520675535819, 5067.037262920052, 5109.948900511003, 5113.872153196163, 5171.922421163686, 5193.143131383317, 5201.24581935621, 4919.704817710949, 4931.112399768041, 5063.11395505785, 5080.288759573663, 5129.1280482317725, 5419.783208671648, 5440.265564148829, 5448.346198456171, 5458.4541545845495, 5517.69652669103, 5847.883042339172, 5910.34986151523, 5955.583109182359, 5958.374370691058, 5964.135200395962, 5836.970815145897, 5899.852503687399, 6003.549733769984, 6009.308929473079, 6019.969900150515, 5546.722663866791, 5582.49757521825, 5587.8882422352135, 5596.804111856106, 5621.100623900156, 6121.693915304217, 6124.785632502841, 6132.018876979661, 6132.908006379818, 6137.754489820357, 5724.255846739898, 5779.075347944308, 5896.086106653475, 5898.734556944948, 5900.616459930091, 5878.764849405976, 5919.200907877382, 5937.406259374028, 5953.047512398082, 6019.578629495893, 5951.226340575698, 5951.4941229995065, 5957.374475680078, 5957.672328021914, 5986.461218490357, 5790.7973220937065, 5910.7931222407005, 5954.434328738763, 5972.581919265696, 5972.641641501524, 4522.005158865044, 4560.361549383089, 4569.314602809605, 4571.2000399929875, 4593.724376537419, 4134.937975930364, 4140.068484590943, 4145.523264824524, 4181.1010632714115, 4196.727212731163, 5714.7428365723645, 5720.856978575569, 5721.342045664718, 5722.484976352148, 5739.942600573941, 5761.625494342854, 5877.324107727581, 5982.371850955674, 5994.460498555151, 5997.340292567814, 5681.573881958787, 5686.97156514223, 5692.117721753135, 5694.08894576874, 5694.572907031989, 5144.125498665236, 5168.9224661630105, 5183.326167598264, 5186.988537235278, 5188.610854185876, 6170.81487555374, 6200.627962322275, 6200.844978875474, 6206.565540412128, 6206.658633775186, 6039.063945088518, 6062.120992455981, 6068.21113255274, 6076.513878889767, 6079.878402431838, 6291.307956124914, 6309.337519560564, 6317.873642527032, 6334.271558770801, 6337.7781777637565, 5736.19693242938, 5767.9711601443405, 5796.797112101056, 5949.018411961978, 5960.284765827955, 5899.144624029577, 5973.372795856372, 5992.580519363777, 6004.549658775697, 6008.87982240344, 5785.884282314414, 5792.304923409218, 5808.82573522795, 5809.448102430262, 5810.389909059488, 5591.8881622368135, 5649.350324712711, 5767.279090113736, 5793.768249269982, 5799.043157878903, 5658.688772117408, 5679.034564124191, 5720.570957178312, 5782.5373970081455, 5821.621594596338, 5789.247397838422, 5827.883442331215, 5833.270841144857, 5836.883262334814, 5839.153322768259, 5656.0, 5682.232898558642, 5699.430056994267, 5702.315722113373, 5705.657660540381], "value": 5504.507277793283, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.8131857146428, 621.0435928669849, 649.259843778093, 659.1266571792377, 688.0298778722002, 33727.15682107949, 44103.558964410346, 44452.3332150018, 44569.108617827624, 47833.521664783344, 45619.0, 45975.54024459754, 46009.30986035212, 46082.30876536846, 46218.30672539906, 8260.710875119372, 8727.5636218189, 8870.60082296295, 8885.555722213896, 8888.288936885034, 8191.754247372588, 10429.269951103426, 10635.946820265888, 10637.840432393521, 10932.07077398422, 10708.089812365959, 10775.622853200139, 10789.082927951094, 10801.027907488324, 10804.0, 10547.630832920811, 10577.682669519927, 10599.311044782104, 10620.522076506575, 10622.46887655614, 10474.738131546772, 10603.416812075333, 10659.0, 10663.680089597325, 10668.14654827612, 42724.359134613005, 43001.35497967533, 43121.0, 43144.56855431437, 43178.0, 3660.103274697716, 3681.2821499807283, 3748.250349930025, 3763.209725957552, 3929.7445666031617, 31853.362932741446, 31903.361932761447, 31917.361652767046, 31936.840315798272, 32166.0, 4276.615104640598, 4371.956280437187, 4417.204903117437, 4548.522405147478, 4659.767011649404, 359376.0, 360812.0, 361025.0, 361452.0, 361796.0, 64259.67870160619, 64834.0, 64926.0, 64927.0, 65006.674966624865, 39323.41014884779, 39651.0, 39911.401328980086, 42192.0, 42199.7890010548, 17225.65548689019, 17318.220680069426, 17347.479575612753, 17354.0, 17361.826381736275, 13025.544105956245, 13161.078724489194, 14095.436182552789, 14230.075045122241, 14282.3572939218, 19645.0, 20499.590008199753, 20510.077046532642, 20539.178432862816, 20659.17363305481, 7218.6390680465765, 7221.53060051095, 7236.963815180996, 7389.453062530016, 7602.0, 1030.2324768047852, 1071.603506702525, 1077.0, 1136.4431428599926, 1208.4803534480081, 33514.49728254078, 33849.492257616155, 33871.153221169174, 33960.32079358399, 33966.15084622855, 1108.7837871615118, 1128.1257025805066, 1137.8008848451489, 1191.2733232728028, 1202.4528839378063, 14893.329800158803, 18015.459536213933, 18635.627287454176, 18725.0, 18781.0609469526, 572331.0, 574746.0, 576700.0, 577095.0, 580014.0, 59549.404505954386, 60192.0, 60206.397936020076, 60386.69806651027, 60434.0, 1311.731095125497, 1341.704824938512, 1367.9452821887014, 1381.4267079162034, 1401.9088759230822, 32152.35695286128, 34490.0, 34651.48022779711, 35032.29935401227, 35045.29909401849, 51252.74373628108, 51529.22706159336, 51693.48306516887, 51839.74080129575, 51875.481245188574, 382608.0, 385034.14965851104, 385726.0, 386675.0, 387106.0, 31325.373492530478, 31655.0, 31759.52360714545, 31816.840915795274, 32066.839665801523, 49493.752531237114, 49866.0, 50411.0, 50715.74642126766, 51003.48996509987, 42412.0, 43100.353494696974, 43193.3520997179, 43970.0, 44620.55379446294, 41834.37248441337, 42080.737577872715, 43266.56733432625, 43308.0, 44468.332975004756, 43479.347809782244, 43679.78160109179, 44249.0, 44768.55231447774, 44845.0, 36493.635063649024, 38743.926129752486, 38818.80590597029, 38926.653322499726, 39309.01727456722, 29312.650441294496, 29396.853015734785, 29596.704032959395, 29790.8510457455, 29805.254868628457], "value": 20991.94512109031, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.6503679207108, 401.67865707434044, 423.6335569732183, 423.9957600423996, 433.64007873465005, 16776.245068971893, 19280.3251886184, 19784.90107549462, 19936.302229421974, 20228.08973596188, 19097.61804763904, 19228.519287017833, 19669.606607867834, 19730.112144953477, 19830.603387932268, 4729.834455794048, 5630.690312032836, 5759.1937128802, 5775.3358363788075, 5872.823815285548, 5632.9436705632825, 5692.601517893729, 5724.742386592592, 5730.971345143268, 5738.770449182028, 5488.17677348397, 5679.346875109374, 5697.43025697429, 5705.629134106291, 5710.628809127415, 5670.853003176863, 5672.574556908248, 5744.195812586241, 5748.655080695151, 5751.654900705971, 4994.775235114428, 5094.4141423736, 5122.078025955327, 5125.589952803767, 5126.051680439131, 23036.53926921469, 23192.4201894954, 23225.419364515852, 23276.418089547897, 23291.53416931669, 2376.346504711201, 2428.3929017745563, 2456.4227406559444, 2919.459899918522, 3077.7845550811453, 13896.652583685387, 14505.129692218501, 14972.850271497255, 15223.0, 15276.312565934559, 1760.7534945107695, 1910.5414700471927, 1913.9425817225367, 1922.7692676878723, 1951.5121219695077, 80690.59654701689, 87078.56460717655, 87662.0, 88585.55707221423, 90749.09250907472, 11517.654470365902, 11700.122490813223, 11822.586209482626, 11836.644900652995, 11846.88153118475, 16523.421680241136, 16534.338626455046, 16538.83461165373, 16552.586185345222, 16556.337746490248, 8528.275096616733, 8686.91313086861, 8722.86915696265, 8846.203841654282, 8856.557172141367, 8648.351373647001, 8675.826483470422, 8714.21572058505, 8872.112788721077, 8876.644934202559, 4583.449986001635, 4845.9757701211265, 4865.197242455026, 5087.745612719349, 5112.642115051911, 1942.7377304064053, 2024.7570291565107, 2067.2041264113122, 2113.915443382278, 2154.181411063817, 762.3558093411169, 891.7280229530055, 951.509972364233, 993.2153598657125, 1024.2011231239644, 19360.612787744165, 19725.50686232827, 19853.404397868086, 19921.800781991995, 20151.19395224204, 986.9062439068277, 1013.4476710192963, 1025.7589466475372, 1035.1873779083535, 1058.9947050264852, 10360.896391035993, 11182.776344473064, 11239.269447485887, 11247.493862776195, 11277.774444511228, 498004.0, 501547.0, 506449.0, 522840.0, 534574.0, 58553.0, 60852.0, 94625.5268723652, 98900.0, 101114.0, 1038.8285932821152, 1041.9114375278034, 1074.731317170723, 1089.553283153903, 1090.432974853072, 17641.911790440965, 18015.2793888243, 18193.636127277117, 18317.90841045786, 18422.35521756732, 41419.378709319986, 41668.374974374805, 42088.78955605203, 42656.0, 43058.56941430671, 58043.70978145082, 58616.413835861094, 59108.70445647744, 59252.0, 59805.10292345531, 8488.193621605938, 8734.30125589964, 8757.518336491554, 8975.596098175467, 9059.728208153765, 13031.934840325737, 13325.600231992668, 13634.659133521742, 13737.24445155526, 14187.858121418654, 12334.136610437183, 12434.37828108609, 12679.492820287085, 12689.36553172356, 13013.674658133623, 12190.967174706904, 12292.446839892405, 12349.444275007825, 12671.366431678194, 12816.102872798814, 12587.87412125867, 12598.433070512032, 12666.493340266286, 12959.35203239853, 12997.48010079624, 8050.0, 8125.699888017889, 8150.2664760171865, 8388.119247478928, 8898.4660920345, 11071.833922491009, 12387.566435174725, 12446.439910204244, 12471.0, 12758.808617870554], "value": 9547.96632749159, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.2854644044078, 1523.6495606010617, 1661.509854592895, 1762.55936015996, 1786.7386283713347, 8150.103488616248, 8708.869366959501, 8717.302615790737, 8723.21491065804, 8723.302135829133, 7629.465937384385, 7828.334591559725, 8095.190480951902, 8245.422820402575, 8546.529940853266, 2416.891239894209, 2450.375154335642, 2453.1168779239547, 2456.9754302457013, 2459.5080983803223, 2443.1481115285796, 2467.087177744237, 2483.50329934013, 2491.352248415416, 2495.388629785696, 2440.2069327468553, 2448.4490989527394, 2452.8160387970975, 2457.213691618683, 2459.9016039358494, 2381.1903952656094, 2401.903923843053, 2405.987970060156, 2407.2898494943947, 2441.4750828571764, 2412.6381042843536, 2435.257246539805, 2454.312792418108, 2457.9553689681816, 2458.1150785717127, 8428.578571071423, 8513.787155321166, 8514.74455766328, 8586.356023298278, 8696.260817830493, 5337.4662533746705, 5468.589855760833, 5495.697736624484, 5496.148097044965, 5499.532539734128, 3466.272082862602, 3489.1974845785358, 3576.624454432273, 3590.4793804898404, 3610.6930910872607, 1142.8400323388803, 1187.139323990109, 1198.4786617821276, 1207.4325067218392, 1228.1280290993404, 11589.826152607717, 11595.130365222642, 11611.6516504505, 11643.06855451562, 11653.825192622118, 4519.706219095814, 4664.720116793003, 4737.0052289019695, 4775.379200703886, 4900.995295964319, 9629.470379129076, 9631.614735410505, 9634.807303854024, 9639.036096390304, 9650.08324209199, 5389.703566303812, 5393.13709806437, 5402.054640437987, 5402.216678581583, 5406.864828379322, 4398.318260669601, 4525.502194758574, 4992.076465853756, 5012.323336349619, 5085.720285384339, 3984.063745019918, 4072.857449989236, 4116.094459218967, 4156.854510092193, 4164.708470407103, 1387.0775934003975, 1403.4105675616265, 1403.9087459315317, 1423.0, 1438.3239877257672, 945.5650400815564, 1006.2654262388497, 1023.959041638341, 1037.4242295526055, 1040.458961340099, 5930.673812940329, 5987.0, 6018.97677394844, 6160.845978850564, 6206.379362063757, 940.6472572785206, 995.0646392391129, 1002.7693630464888, 1043.5512729526224, 1061.9893801062044, 3793.1275806564645, 3870.2453021661067, 3878.553966293856, 3885.592012838668, 3928.862489812843, 10313.174946004452, 10742.086922611665, 10784.514696838662, 10791.78416431667, 10797.892021079846, 10653.360798351969, 10656.467176641137, 10659.253852230424, 10669.093127084285, 10675.57297708083, 7739.5743234122665, 7961.1242763295995, 8184.713535026364, 8196.754097377208, 8205.138460461685, 5860.238169037998, 5927.614705044159, 5988.760449581968, 6115.205023346936, 6149.600275982047, 9903.851442228517, 9920.156786672926, 9931.602735890772, 10020.048095430922, 10123.088921996761, 9371.437713737198, 9742.07450292221, 9806.901930980599, 10097.0, 10100.747481313027, 6695.799126026227, 6862.107925969792, 6868.450523958171, 7689.3848492121615, 7863.449558531077, 7971.92028079735, 8180.059293181361, 8342.749717508485, 8535.786605334917, 8542.35932305092, 7304.233055529306, 7377.077865266841, 7566.546007239584, 7622.656980436004, 7848.568328741974, 7285.453590980592, 7454.701811927679, 7472.439567032386, 7488.812779680552, 7525.661345239368, 6918.377346038881, 7041.718331266897, 7047.577145371089, 7047.929520704933, 7048.224695283618, 5068.59451243907, 5076.162433198481, 5102.311187989574, 5123.692578445305, 5176.689398636094, 5262.552683021833, 5278.445763194963, 5310.522053015247, 5378.946210537844, 5621.831345059655], "value": 4676.91287323084, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.45679197244266, 357.7299139149942, 361.3658030157074, 367.36996051771206, 367.8105775525603, 5226.5034821691925, 5302.867428314294, 5303.302943058223, 5334.199870019499, 5350.357957045155, 4997.0, 5081.314022606947, 5135.666181698196, 5156.561692256163, 5270.947290527093, 4140.875773726778, 4144.41978123063, 4146.606072423115, 4155.542890282074, 4159.0, 4181.3309870420735, 4194.685398595102, 4196.475440569929, 4196.97901510492, 4200.7444230721285, 3906.6484016438517, 3976.383660532622, 4167.1457351242925, 4171.0, 4178.310578754502, 4161.417401563784, 4175.54069052404, 4192.496900371944, 4203.495580530356, 4206.684498662597, 3721.0883333583447, 3733.290674771785, 3735.1595890924323, 3744.475773391727, 3747.156889699823, 5020.3724534433195, 5061.797528098871, 5076.23856421536, 5102.413222479426, 5146.356705411824, 4716.457607375161, 4736.123817093849, 4747.629183279875, 4751.83368582098, 4761.8095276188915, 5437.238786569884, 5443.891122177574, 5445.101558242885, 5446.836594902159, 5447.319085114361, 3964.226975739732, 4070.877873663765, 4074.7351422157467, 4077.3883917412327, 4085.142120154771, 5647.181158731961, 5671.376148623648, 5671.489565939044, 5672.376038635747, 5681.318241811009, 4174.457320548309, 4188.623023927861, 4190.434291370687, 4196.790160491963, 4215.494140703136, 4042.2723909696538, 4188.183304255702, 4235.23765722173, 4241.172971270573, 4242.703010789215, 4705.294205869079, 4716.410448693913, 4723.905521889543, 4732.397181550134, 4737.170995075848, 5447.264619276347, 5460.5085542300585, 5463.672179669233, 5478.91781623276, 5482.491205628401, 1352.3914238592672, 1377.882879955215, 1389.9027068105338, 1390.3048475762118, 1397.7134687389062, 986.3687240166299, 993.7657566104432, 996.9930370325878, 1010.3634710132569, 1013.7566983923953, 5123.410807757155, 5134.15286477727, 5135.382354558302, 5139.537441630271, 5169.327987361694, 5343.946560534423, 5382.811601593926, 5383.5962302826665, 5385.5960802939935, 5428.67427954324, 4962.330085438492, 5090.949090509048, 5095.414027386824, 5109.489051094935, 5141.640085194001, 2834.588984597263, 2851.5009873272093, 2851.5294976328673, 2860.4994126027864, 2867.354845159864, 5643.858903527363, 5672.517835983905, 5673.886522269531, 5685.488306052475, 5685.60200785941, 5314.686699912352, 5342.866428339323, 5442.455754424605, 5471.835844924659, 5486.533644640251, 5575.804846830341, 5635.8591035224445, 5636.971815140898, 5644.334921198174, 5652.943470565242, 5374.516293533601, 5379.919301210563, 5388.218708287198, 5392.487713667196, 5413.783448662167, 5248.186531087687, 5554.305711786027, 5572.832815015556, 5594.440555944373, 5623.718814059363, 5901.881962360643, 5923.674197919156, 5924.585279030599, 5935.258092738408, 5961.314448838439, 4002.6597739192493, 4095.262852686426, 4116.8147433364975, 4117.135401565585, 4119.814608342692, 5428.185772134211, 5522.30971128609, 5546.251256080377, 5629.915551266652, 5660.235868157911, 5551.167324901297, 5553.750081246273, 5557.609857986544, 5559.527440167631, 5561.6663000220115, 5322.813701520428, 5554.805581804779, 5555.500004999408, 5556.0, 5563.833085007294, 5466.207399926909, 5485.890282194254, 5500.339959204921, 5512.200730894078, 5515.503604675599, 5572.192032155233, 5591.580631452576, 5602.411746766531, 5605.719714014364, 5609.411011843697, 5199.740012999259, 5368.865778355416, 5430.15832545956, 5441.0, 5474.288342515448], "value": 4207.3520079863065, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.5018712743155, 763.8777795552709, 777.3237283563298, 795.8937077462326, 810.2990912860375, 14378.065425747332, 14468.421263149461, 14743.557693269193, 15094.396224151034, 15114.244287785621, 13574.592762217124, 13633.113847599923, 13811.654708632264, 13869.653258668513, 13907.096038757474, 723.9927600724004, 842.7471758472465, 853.6158728572136, 855.2772906893696, 856.4219152072358, 744.036472767767, 828.8425199212161, 840.7183593496155, 853.9146085391474, 864.5201912938317, 905.1491597897955, 908.5684299957534, 909.0364213933219, 909.7816524034217, 910.2490445382585, 746.1978373248779, 905.7282815155427, 910.2990697163181, 910.3172620534632, 910.8406028944908, 563.0990415335472, 636.805774238857, 646.7768619826153, 650.7624716978316, 655.0501772429996, 14294.71410571793, 14302.71394572113, 14337.42650293987, 15250.771238431322, 15271.236438178157, 14214.0, 14307.28463576817, 14438.0, 14532.128072315694, 14532.782008269884, 11610.129240307011, 11774.823377649342, 11784.351860647661, 11876.406179691066, 11938.701532461671, 3842.3468010438014, 3876.5348158221195, 3948.881533553998, 4495.842645507424, 4657.836975705868, 64454.677726611066, 65006.674966624865, 65457.67271163662, 66122.99999999952, 66411.335886641, 11206.663800086011, 11272.492737826817, 11288.548458061585, 11362.602308919148, 11614.6515604532, 21376.893115534323, 21424.143034278455, 21497.785022149892, 21506.70959742389, 21744.456388590414, 8130.268275855202, 8239.299659528888, 8313.958430207811, 8342.332613390914, 8478.448900821428, 4344.076214646157, 4344.5296834629025, 4355.5208927018, 4413.514513403523, 4492.05666809967, 3165.683431656816, 3254.2677897473354, 3275.967240327614, 3280.7539434542505, 3313.552670389515, 617.8671585609115, 624.4286477872787, 630.4011189370117, 631.0408179567032, 638.6998110887876, 759.1156302907161, 786.897703298579, 787.8266781308217, 792.9405294602927, 817.9182081791893, 9721.0, 9833.0, 9857.211423086135, 10349.9482502587, 10375.84436233457, 725.6516871901517, 740.1968863782856, 769.8960640313486, 787.5038725602833, 807.0839597057264, 4723.244280915106, 4907.975460122748, 4986.052649996489, 4987.80048798044, 4994.300797888299, 71454.64272678707, 72876.63561682157, 74282.0, 79903.0, 92914.0, 46921.76539117283, 64727.67636161883, 69915.65042174756, 72178.63910680413, 72723.27276727164, 57865.999999999156, 67159.32840671531, 68093.97859032119, 69533.30466695268, 69898.0, 9792.412455252708, 9867.309288349747, 10010.64962726301, 10025.244855178393, 10110.79778404413, 44199.116017678825, 45024.54975450334, 45186.32220516629, 46958.29562556496, 47348.76325618487, 38064.23871522609, 41678.583214168684, 58905.0, 59297.70351148216, 61694.69152654208, 12792.61622151337, 12833.42249598789, 12968.870311297143, 13118.409671564612, 13416.195028298333, 14489.710205796036, 14549.41802327895, 14863.108213507225, 15385.0, 15891.920540397225, 12912.289824059766, 13368.866311337151, 14162.716745664822, 14473.710525789214, 15026.098434093989, 13461.932690336485, 13603.183808971493, 13632.454701812214, 13647.38586763618, 14079.718405631626, 13380.732385352434, 13521.0, 13661.795073073714, 13886.375113120135, 14797.926010370309, 10452.529636166542, 10534.894651053391, 11251.606193783178, 11631.243969141979, 11806.704832379259, 11153.888461115284, 11283.492242848928, 11438.94280528592, 11480.712982175179, 11551.826722599335], "value": 7277.627289964439, "unit": "score"}], "name": "dromaeo_css", "value": 7352.7149340054675, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 111.0, 112.0, 110.0, 111.0, 111.0, 112.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 122.0, 119.0, 161.0, 124.0, 128.0, 129.0, 119.0, 149.0, 125.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 160.0, 159.0, 170.0, 162.0, 159.0, 162.0, 160.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 106.0, 75.0, 76.0, 76.0, 77.0, 100.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 124.0, 82.0, 82.0, 83.0, 104.0, 83.0, 82.0, 117.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 146.0, 157.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 88.0, 84.0, 86.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 52.0, 52.0, 53.0, 52.0, 53.0, 55.0, 53.0, 52.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 60.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 73.0, 80.0, 75.0, 75.0, 74.0, 79.0, 76.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 123.0, 157.0, 142.0, 125.0, 126.0, 122.0, 128.0, 163.0, 122.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 151.0, 153.0, 154.0, 159.0, 152.0, 156.0, 150.0, 152.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 61.0, 64.0, 62.0, 62.0, 63.0, 63.0, 61.0, 60.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1463.7999999999995, "alertThreshold": 2.0}]} 09:23:52 INFO - Return code: 0 09:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:23:52 ERROR - # TBPL SUCCESS # 09:23:52 INFO - Running post-action listener: _resource_record_post_action 09:23:52 INFO - [mozharness: 2016-11-21 17:23:52.788145Z] Finished run-tests step (success) 09:23:52 INFO - Running post-run listener: _resource_record_post_run 09:23:52 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 266240; Write bytes: 362221568; Read time: 32; Write time: 314812 09:23:52 INFO - TinderboxPrint: CPU usage
13.0% 09:23:52 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 09:23:52 INFO - TinderboxPrint: I/O write bytes / time
362,221,568 / 314,812 09:23:52 INFO - TinderboxPrint: CPU idle
8,291.7 (87.0%) 09:23:52 INFO - TinderboxPrint: CPU user
1,187.9 (12.5%) 09:23:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:23:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118554624; Read time: 0; Write time: 117116 09:23:52 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 262144; Write bytes: 242429952; Read time: 16; Write time: 197480 09:23:53 INFO - Running post-run listener: _upload_blobber_files 09:23:53 INFO - Blob upload gear active. 09:23:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:23:53 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 09:23:53 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:23:53 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:23:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:54 INFO - (blobuploader) - INFO - Done attempting. 09:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:55 INFO - (blobuploader) - INFO - Done attempting. 09:23:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:23:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:23:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:23:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:23:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:23:59 INFO - (blobuploader) - INFO - Done attempting. 09:23:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:23:59 INFO - Return code: 0 09:23:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:23:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:23:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36a746bb98fb8298826db4a46468b6c17eec9dd834c4d6878a66a217a516aa759834485097313c060cf631df10a00832618a98781f60541d0a8b98f05f21755e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9968054f635ea6a5badb032489ff6b4001bcb8675e3f999c4030ada11e003c4f9ce789dbaa5889a6874bfe8568c50622e82e371974c7e0ac57b034e391a09e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65c78eb6a4400d866fed5d90f2513456145fa6ab4594e1bf6fc1e313eb0daea6c5f6f5571e30863222cd71f58eacbf8d86684b6f501d0af096847c6fa891c5f1"} 09:23:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:23:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:23:59 INFO - Contents: 09:23:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36a746bb98fb8298826db4a46468b6c17eec9dd834c4d6878a66a217a516aa759834485097313c060cf631df10a00832618a98781f60541d0a8b98f05f21755e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9968054f635ea6a5badb032489ff6b4001bcb8675e3f999c4030ada11e003c4f9ce789dbaa5889a6874bfe8568c50622e82e371974c7e0ac57b034e391a09e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65c78eb6a4400d866fed5d90f2513456145fa6ab4594e1bf6fc1e313eb0daea6c5f6f5571e30863222cd71f58eacbf8d86684b6f501d0af096847c6fa891c5f1"} 09:23:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:23:59 INFO - Copying logs to upload dir... 09:23:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:23:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.938070 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-21 09:23:58.854012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 09:23:58.858104) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36a746bb98fb8298826db4a46468b6c17eec9dd834c4d6878a66a217a516aa759834485097313c060cf631df10a00832618a98781f60541d0a8b98f05f21755e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9968054f635ea6a5badb032489ff6b4001bcb8675e3f999c4030ada11e003c4f9ce789dbaa5889a6874bfe8568c50622e82e371974c7e0ac57b034e391a09e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65c78eb6a4400d866fed5d90f2513456145fa6ab4594e1bf6fc1e313eb0daea6c5f6f5571e30863222cd71f58eacbf8d86684b6f501d0af096847c6fa891c5f1"} build_url:https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/U_BgMvU0QIql60S7KiqFmA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36a746bb98fb8298826db4a46468b6c17eec9dd834c4d6878a66a217a516aa759834485097313c060cf631df10a00832618a98781f60541d0a8b98f05f21755e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e9968054f635ea6a5badb032489ff6b4001bcb8675e3f999c4030ada11e003c4f9ce789dbaa5889a6874bfe8568c50622e82e371974c7e0ac57b034e391a09e0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/65c78eb6a4400d866fed5d90f2513456145fa6ab4594e1bf6fc1e313eb0daea6c5f6f5571e30863222cd71f58eacbf8d86684b6f501d0af096847c6fa891c5f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 09:23:58.888832) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:23:58.889176) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1479747483.747582-1552656889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 09:23:58.972722) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 09:23:58.973241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 09:23:58.973621) ========= ========= Total master_lag: 0.18 =========