builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1481818264.12 results: success (0) buildid: 20161215063801 builduid: adbe000ebf494d1fbf8093ad87797113 revision: 40a2d26936006c5256ece3268a89f418500cd63e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.123773) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.124190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.124496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.155279) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.155575) ========= 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-1481812932.494275-299112558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-15 08:11:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-12-15 08:11:05 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.294840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.295326) ========= 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-1481812932.494275-299112558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019996 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.347069) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:04.347522) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 40a2d26936006c5256ece3268a89f418500cd63e --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 40a2d26936006c5256ece3268a89f418500cd63e --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-1481812932.494275-299112558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-15 08:11:05,263 truncating revision to first 12 chars 2016-12-15 08:11:05,263 Setting DEBUG logging. 2016-12-15 08:11:05,263 attempt 1/10 2016-12-15 08:11:05,263 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/40a2d2693600?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-15 08:11:05,664 unpacking tar archive at: mozilla-aurora-40a2d2693600/testing/mozharness/ program finished with exit code 0 elapsedTime=0.737759 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:05.099871) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:05.100217) ========= script_repo_revision: 40a2d26936006c5256ece3268a89f418500cd63e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:05.100665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:05.101033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-15 08:11:05.109484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-15 08:11:05.109810) ========= /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-1481812932.494275-299112558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:06 INFO - MultiFileLogger online at 20161215 08:11:06 in /builds/slave/test 08:11:06 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 08:11:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:06 INFO - {'append_to_log': False, 08:11:06 INFO - 'base_work_dir': '/builds/slave/test', 08:11:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:11:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:06 INFO - 'branch': 'Mozilla-Aurora', 08:11:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:06 INFO - 'config_files': ('talos/linux_config.py',), 08:11:06 INFO - 'default_actions': ('clobber', 08:11:06 INFO - 'read-buildbot-config', 08:11:06 INFO - 'download-and-extract', 08:11:06 INFO - 'populate-webroot', 08:11:06 INFO - 'create-virtualenv', 08:11:06 INFO - 'install', 08:11:06 INFO - 'run-tests'), 08:11:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:06 INFO - 'download_minidump_stackwalk': True, 08:11:06 INFO - 'download_symbols': 'ondemand', 08:11:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:06 INFO - 'installer_path': 'installer.exe', 08:11:06 INFO - 'log_level': 'info', 08:11:06 INFO - 'log_name': 'talos', 08:11:06 INFO - 'log_to_console': True, 08:11:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:06 INFO - 'opt_config_files': (), 08:11:06 INFO - 'pip_index': False, 08:11:06 INFO - 'sps_profile': False, 08:11:06 INFO - 'sps_profile_interval': 0, 08:11:06 INFO - 'suite': 'dromaeojs', 08:11:06 INFO - 'system_bits': '32', 08:11:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:06 INFO - 'title': 'talos-linux64-ix-011', 08:11:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:06 INFO - 'use_talos_json': True, 08:11:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:06 INFO - 'work_dir': 'build'} 08:11:06 INFO - [mozharness: 2016-12-15 16:11:06.115124Z] Running clobber step. 08:11:06 INFO - Running pre-action listener: _resource_record_pre_action 08:11:06 INFO - Running main action method: clobber 08:11:06 INFO - rmtree: /builds/slave/test/build 08:11:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:11:06 INFO - Running post-action listener: _resource_record_post_action 08:11:06 INFO - [mozharness: 2016-12-15 16:11:06.578280Z] Finished clobber step (success) 08:11:06 INFO - [mozharness: 2016-12-15 16:11:06.578380Z] Running read-buildbot-config step. 08:11:06 INFO - Running pre-action listener: _resource_record_pre_action 08:11:06 INFO - Running main action method: read_buildbot_config 08:11:06 INFO - Using buildbot properties: 08:11:06 INFO - { 08:11:06 INFO - "project": "", 08:11:06 INFO - "product": "firefox", 08:11:06 INFO - "script_repo_revision": "production", 08:11:06 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:11:06 INFO - "repository": "", 08:11:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:11:06 INFO - "buildid": "20161215063801", 08:11:06 INFO - "pgo_build": "True", 08:11:06 INFO - "basedir": "/builds/slave/test", 08:11:06 INFO - "buildnumber": 676, 08:11:06 INFO - "slavename": "talos-linux64-ix-011", 08:11:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:11:06 INFO - "platform": "ubuntu64_hw", 08:11:06 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:11:06 INFO - "branch": "mozilla-aurora", 08:11:06 INFO - "repo_path": "releases/mozilla-aurora", 08:11:06 INFO - "revision": "40a2d26936006c5256ece3268a89f418500cd63e", 08:11:06 INFO - "stage_platform": "linux64-pgo", 08:11:06 INFO - "builduid": "adbe000ebf494d1fbf8093ad87797113", 08:11:06 INFO - "slavebuilddir": "test" 08:11:06 INFO - } 08:11:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:11:06 INFO - Running post-action listener: _resource_record_post_action 08:11:06 INFO - [mozharness: 2016-12-15 16:11:06.580824Z] Finished read-buildbot-config step (success) 08:11:06 INFO - [mozharness: 2016-12-15 16:11:06.580912Z] Running download-and-extract step. 08:11:06 INFO - Running pre-action listener: _resource_record_pre_action 08:11:06 INFO - Running main action method: download_and_extract 08:11:06 INFO - mkdir: /builds/slave/test/build/tests 08:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:06 INFO - trying https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:11:06 INFO - Downloading https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/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 08:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/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 08:11:07 INFO - Downloaded 1361 bytes. 08:11:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:11:07 INFO - Using the following test package requirements: 08:11:07 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:11:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:11:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'jsshell-linux-x86_64.zip'], 08:11:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:11:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:11:07 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:11:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:11:07 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:11:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:07 INFO - Fetch https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:11:07 INFO - Http code: 200 08:11:07 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 08:11:07 INFO - x-amz-cf-id: Wqh-VyIG6AkwWnIi82JjwSLgsw5NqIUdCIvll-L6Cub8L3iT71AxMA== 08:11:07 INFO - x-amz-version-id: m9ezHtNWc14UhRYofZdsnkI1fn7M8GEN 08:11:09 INFO - Expected file size: 21953930 08:11:09 INFO - Obtained file size: 21953930 08:11:13 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 08:11:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:11:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:13 INFO - Fetch https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:11:14 INFO - Http code: 200 08:11:14 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 08:11:14 INFO - x-amz-cf-id: S1Q6_7AE58iXe8DslGgEbv8jhBQ3aQ-7PvFEyCHhsO-eDm8kRI6IWw== 08:11:14 INFO - x-amz-version-id: m9ezHtNWc14UhRYofZdsnkI1fn7M8GEN 08:11:14 INFO - Expected file size: 21953930 08:11:14 INFO - Obtained file size: 21953930 08:11:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:11:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:11:18 INFO - Fetch https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:11:19 INFO - Http code: 200 08:11:19 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:11:19 INFO - x-amz-cf-id: qVcmbPHMdCi35saQSPjD6AVjXE6c2RG4-35Yw5D0o3clmxlxVdZw5w== 08:11:19 INFO - x-amz-version-id: stOG560o5XFQMvy9PX_wKlvPMQp1VDpO 08:11:19 INFO - Expected file size: 14409038 08:11:19 INFO - Obtained file size: 14409038 08:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:19 INFO - trying https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:11:19 INFO - Downloading https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/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 08:11:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/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 08:11:22 INFO - Downloaded 63945348 bytes. 08:11:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:11:22 INFO - mkdir: /builds/slave/test/properties 08:11:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:22 INFO - Contents: 08:11:22 INFO - build_url:https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:11:23 INFO - Running post-action listener: _resource_record_post_action 08:11:23 INFO - Running post-action listener: set_extra_try_arguments 08:11:23 INFO - [mozharness: 2016-12-15 16:11:23.136966Z] Finished download-and-extract step (success) 08:11:23 INFO - [mozharness: 2016-12-15 16:11:23.137192Z] Running populate-webroot step. 08:11:23 INFO - Running pre-action listener: _resource_record_pre_action 08:11:23 INFO - Running main action method: populate_webroot 08:11:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:23 INFO - '--tppagecycles', 08:11:23 INFO - '7'], 08:11:23 INFO - 'tests': ['tsvgm']}}, 08:11:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['damp', 'tps']}, 08:11:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'tests': ['damp', 'tps']}, 08:11:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['dromaeo_dom']}, 08:11:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['basic_compositor_video']}, 08:11:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['a11yr', 08:11:23 INFO - 'ts_paint', 08:11:23 INFO - 'tpaint', 08:11:23 INFO - 'sessionrestore', 08:11:23 INFO - 'sessionrestore_no_auto_restore', 08:11:23 INFO - 'tabpaint']}, 08:11:23 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:23 INFO - 'ts_paint', 08:11:23 INFO - 'tpaint', 08:11:23 INFO - 'sessionrestore', 08:11:23 INFO - 'sessionrestore_no_auto_restore', 08:11:23 INFO - 'tabpaint']}, 08:11:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:23 INFO - 'ts_paint', 08:11:23 INFO - 'tpaint', 08:11:23 INFO - 'sessionrestore', 08:11:23 INFO - 'sessionrestore_no_auto_restore', 08:11:23 INFO - 'tabpaint']}, 08:11:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:23 INFO - 'ts_paint', 08:11:23 INFO - 'tpaint', 08:11:23 INFO - 'sessionrestore', 08:11:23 INFO - 'sessionrestore_no_auto_restore', 08:11:23 INFO - 'tabpaint']}, 08:11:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['a11yr', 08:11:23 INFO - 'ts_paint', 08:11:23 INFO - 'tpaint', 08:11:23 INFO - 'sessionrestore', 08:11:23 INFO - 'sessionrestore_no_auto_restore', 08:11:23 INFO - 'tabpaint']}, 08:11:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['a11yr', 08:11:23 INFO - 'ts_paint', 08:11:23 INFO - 'tpaint', 08:11:23 INFO - 'sessionrestore', 08:11:23 INFO - 'sessionrestore_no_auto_restore', 08:11:23 INFO - 'tabpaint']}, 08:11:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['tsvgx', 08:11:23 INFO - 'tsvgr_opacity', 08:11:23 INFO - 'tart', 08:11:23 INFO - 'tscrollx', 08:11:23 INFO - 'cart']}, 08:11:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:23 INFO - 'tsvgr_opacity', 08:11:23 INFO - 'tart', 08:11:23 INFO - 'tscrollx', 08:11:23 INFO - 'cart']}, 08:11:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'talos_options': ['--disable-e10s'], 08:11:23 INFO - 'tests': ['tp5o']}, 08:11:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'tests': ['tp5o']}, 08:11:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'talos_options': ['--disable-e10s', 08:11:23 INFO - '--xperf_path', 08:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:23 INFO - 'tests': ['tp5n']}, 08:11:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:23 INFO - 'talos_options': ['--xperf_path', 08:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:23 INFO - 'tests': ['tp5n']}}, 08:11:23 INFO - 'talos.zip': {'path': '', 08:11:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:23 INFO - Running post-action listener: _resource_record_post_action 08:11:23 INFO - [mozharness: 2016-12-15 16:11:23.159118Z] Finished populate-webroot step (success) 08:11:23 INFO - [mozharness: 2016-12-15 16:11:23.159205Z] Running create-virtualenv step. 08:11:23 INFO - Running pre-action listener: _resource_record_pre_action 08:11:23 INFO - Running main action method: create_virtualenv 08:11:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:11:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:23 INFO - Using real prefix '/usr' 08:11:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:25 INFO - Installing pip.................done. 08:11:25 INFO - Return code: 0 08:11:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:11:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:11:25 INFO - Reading from file tmpfile_stdout 08:11:25 INFO - Output received: 08:11:25 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) 08:11:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11:25 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')]} 08:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:25 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')]} 08:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:25 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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:25 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 08:11:25 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 08:11:25 INFO - Using env: {'DISPLAY': ':0', 08:11:25 INFO - 'HOME': '/home/cltbld', 08:11:25 INFO - 'LANG': 'en_US.UTF-8', 08:11:25 INFO - 'LANGUAGE': 'en_US:en', 08:11:25 INFO - 'LOGNAME': 'cltbld', 08:11:25 INFO - 'MAIL': '/var/mail/cltbld', 08:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:25 INFO - 'MOZ_NO_REMOTE': '1', 08:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:25 INFO - 'NO_EM_RESTART': '1', 08:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:25 INFO - 'PWD': '/builds/slave/test', 08:11:25 INFO - 'SHELL': '/bin/bash', 08:11:25 INFO - 'SHLVL': '1', 08:11:25 INFO - 'TERM': 'linux', 08:11:25 INFO - 'TMOUT': '86400', 08:11:25 INFO - 'USER': 'cltbld', 08:11:25 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:25 INFO - '_': '/tools/buildbot/bin/python'} 08:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:26 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 08:11:26 INFO - Cleaning up... 08:11:26 INFO - Return code: 0 08:11:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11:26 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')]} 08:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:26 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')]} 08:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:26 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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:26 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 08:11:26 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 08:11:26 INFO - Using env: {'DISPLAY': ':0', 08:11:26 INFO - 'HOME': '/home/cltbld', 08:11:26 INFO - 'LANG': 'en_US.UTF-8', 08:11:26 INFO - 'LANGUAGE': 'en_US:en', 08:11:26 INFO - 'LOGNAME': 'cltbld', 08:11:26 INFO - 'MAIL': '/var/mail/cltbld', 08:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:26 INFO - 'MOZ_NO_REMOTE': '1', 08:11:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:26 INFO - 'NO_EM_RESTART': '1', 08:11:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:26 INFO - 'PWD': '/builds/slave/test', 08:11:26 INFO - 'SHELL': '/bin/bash', 08:11:26 INFO - 'SHLVL': '1', 08:11:26 INFO - 'TERM': 'linux', 08:11:26 INFO - 'TMOUT': '86400', 08:11:26 INFO - 'USER': 'cltbld', 08:11:26 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:26 INFO - '_': '/tools/buildbot/bin/python'} 08:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:26 INFO - Downloading/unpacking psutil>=3.1.1 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:26 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 08:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:28 INFO - Installing collected packages: psutil 08:11:28 INFO - Running setup.py install for psutil 08:11:28 INFO - building 'psutil._psutil_linux' extension 08:11:28 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 08:11:28 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 08:11:28 INFO - building 'psutil._psutil_posix' extension 08:11:28 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 08:11:28 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 08:11:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:11:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:11:28 INFO - Successfully installed psutil 08:11:28 INFO - Cleaning up... 08:11:29 INFO - Return code: 0 08:11:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:11:29 INFO - Using env: {'DISPLAY': ':0', 08:11:29 INFO - 'HOME': '/home/cltbld', 08:11:29 INFO - 'LANG': 'en_US.UTF-8', 08:11:29 INFO - 'LANGUAGE': 'en_US:en', 08:11:29 INFO - 'LOGNAME': 'cltbld', 08:11:29 INFO - 'MAIL': '/var/mail/cltbld', 08:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:29 INFO - 'MOZ_NO_REMOTE': '1', 08:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:29 INFO - 'NO_EM_RESTART': '1', 08:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:29 INFO - 'PWD': '/builds/slave/test', 08:11:29 INFO - 'SHELL': '/bin/bash', 08:11:29 INFO - 'SHLVL': '1', 08:11:29 INFO - 'TERM': 'linux', 08:11:29 INFO - 'TMOUT': '86400', 08:11:29 INFO - 'USER': 'cltbld', 08:11:29 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:29 INFO - '_': '/tools/buildbot/bin/python'} 08:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:29 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 08:11:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:11:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:11:31 INFO - Installing collected packages: mozsystemmonitor 08:11:31 INFO - Running setup.py install for mozsystemmonitor 08:11:31 INFO - Successfully installed mozsystemmonitor 08:11:31 INFO - Cleaning up... 08:11:31 INFO - Return code: 0 08:11:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:11:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:11:31 INFO - Using env: {'DISPLAY': ':0', 08:11:31 INFO - 'HOME': '/home/cltbld', 08:11:31 INFO - 'LANG': 'en_US.UTF-8', 08:11:31 INFO - 'LANGUAGE': 'en_US:en', 08:11:31 INFO - 'LOGNAME': 'cltbld', 08:11:31 INFO - 'MAIL': '/var/mail/cltbld', 08:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:31 INFO - 'MOZ_NO_REMOTE': '1', 08:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:31 INFO - 'NO_EM_RESTART': '1', 08:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:31 INFO - 'PWD': '/builds/slave/test', 08:11:31 INFO - 'SHELL': '/bin/bash', 08:11:31 INFO - 'SHLVL': '1', 08:11:31 INFO - 'TERM': 'linux', 08:11:31 INFO - 'TMOUT': '86400', 08:11:31 INFO - 'USER': 'cltbld', 08:11:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:31 INFO - '_': '/tools/buildbot/bin/python'} 08:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:31 INFO - Downloading/unpacking jsonschema==2.5.1 08:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:11:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:11:33 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 08:11:33 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 08:11:33 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 08:11:33 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 08:11:33 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 08:11:33 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 08:11:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:11:33 INFO - warning: no files found matching '*.txt' 08:11:33 INFO - no previously-included directories found matching 'build' 08:11:33 INFO - no previously-included directories found matching 'dist' 08:11:33 INFO - no previously-included directories found matching '.git*' 08:11:33 INFO - Installing collected packages: jsonschema, functools32 08:11:33 INFO - Running setup.py install for functools32 08:11:34 INFO - warning: no files found matching '*.txt' 08:11:34 INFO - no previously-included directories found matching 'build' 08:11:34 INFO - no previously-included directories found matching 'dist' 08:11:34 INFO - no previously-included directories found matching '.git*' 08:11:34 INFO - Successfully installed jsonschema functools32 08:11:34 INFO - Cleaning up... 08:11:34 INFO - Return code: 0 08:11:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:11:34 INFO - Using env: {'DISPLAY': ':0', 08:11:34 INFO - 'HOME': '/home/cltbld', 08:11:34 INFO - 'LANG': 'en_US.UTF-8', 08:11:34 INFO - 'LANGUAGE': 'en_US:en', 08:11:34 INFO - 'LOGNAME': 'cltbld', 08:11:34 INFO - 'MAIL': '/var/mail/cltbld', 08:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:34 INFO - 'MOZ_NO_REMOTE': '1', 08:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:34 INFO - 'NO_EM_RESTART': '1', 08:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:34 INFO - 'PWD': '/builds/slave/test', 08:11:34 INFO - 'SHELL': '/bin/bash', 08:11:34 INFO - 'SHLVL': '1', 08:11:34 INFO - 'TERM': 'linux', 08:11:34 INFO - 'TMOUT': '86400', 08:11:34 INFO - 'USER': 'cltbld', 08:11:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:34 INFO - '_': '/tools/buildbot/bin/python'} 08:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:11:34 INFO - Cleaning up... 08:11:34 INFO - Return code: 0 08:11:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:11:34 INFO - Using env: {'DISPLAY': ':0', 08:11:34 INFO - 'HOME': '/home/cltbld', 08:11:34 INFO - 'LANG': 'en_US.UTF-8', 08:11:34 INFO - 'LANGUAGE': 'en_US:en', 08:11:34 INFO - 'LOGNAME': 'cltbld', 08:11:34 INFO - 'MAIL': '/var/mail/cltbld', 08:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:34 INFO - 'MOZ_NO_REMOTE': '1', 08:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:34 INFO - 'NO_EM_RESTART': '1', 08:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:34 INFO - 'PWD': '/builds/slave/test', 08:11:34 INFO - 'SHELL': '/bin/bash', 08:11:34 INFO - 'SHLVL': '1', 08:11:34 INFO - 'TERM': 'linux', 08:11:34 INFO - 'TMOUT': '86400', 08:11:34 INFO - 'USER': 'cltbld', 08:11:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:34 INFO - '_': '/tools/buildbot/bin/python'} 08:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:34 INFO - Downloading/unpacking blobuploader==1.2.4 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:11:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:11:36 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 08:11:36 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 08:11:36 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 08:11:36 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 08:11:36 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 08:11:36 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 08:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:11:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 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 08:11:37 INFO - Downloading docopt-0.6.1.tar.gz 08:11:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:11:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:11:37 INFO - Running setup.py install for blobuploader 08:11:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:11:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:11:37 INFO - Running setup.py install for requests 08:11:37 INFO - Running setup.py install for docopt 08:11:37 INFO - Successfully installed blobuploader requests docopt 08:11:37 INFO - Cleaning up... 08:11:37 INFO - Return code: 0 08:11:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:37 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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:37 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 08:11:37 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 08:11:37 INFO - Using env: {'DISPLAY': ':0', 08:11:37 INFO - 'HOME': '/home/cltbld', 08:11:37 INFO - 'LANG': 'en_US.UTF-8', 08:11:37 INFO - 'LANGUAGE': 'en_US:en', 08:11:37 INFO - 'LOGNAME': 'cltbld', 08:11:37 INFO - 'MAIL': '/var/mail/cltbld', 08:11:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:37 INFO - 'MOZ_NO_REMOTE': '1', 08:11:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:37 INFO - 'NO_EM_RESTART': '1', 08:11:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:37 INFO - 'PWD': '/builds/slave/test', 08:11:37 INFO - 'SHELL': '/bin/bash', 08:11:37 INFO - 'SHLVL': '1', 08:11:37 INFO - 'TERM': 'linux', 08:11:37 INFO - 'TMOUT': '86400', 08:11:37 INFO - 'USER': 'cltbld', 08:11:37 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:37 INFO - '_': '/tools/buildbot/bin/python'} 08:11:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:38 INFO - Running setup.py (path:/tmp/pip-kbtgqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:38 INFO - Running setup.py (path:/tmp/pip-jlUvkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:38 INFO - Running setup.py (path:/tmp/pip-9SqzYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:38 INFO - Running setup.py (path:/tmp/pip-zhjiCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:38 INFO - Running setup.py (path:/tmp/pip-S2Q7pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:38 INFO - Running setup.py (path:/tmp/pip-4BojP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:38 INFO - Running setup.py (path:/tmp/pip-ild5mK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:38 INFO - Running setup.py (path:/tmp/pip-Pcoefe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:38 INFO - Running setup.py (path:/tmp/pip-4Qm90i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:38 INFO - Running setup.py (path:/tmp/pip-8jVjPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:38 INFO - Running setup.py (path:/tmp/pip-RYMlYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:39 INFO - Running setup.py (path:/tmp/pip-qdkqfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:39 INFO - Running setup.py (path:/tmp/pip-fJi7y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:39 INFO - Running setup.py (path:/tmp/pip-s_5zsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:39 INFO - Running setup.py (path:/tmp/pip-gUhNO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:39 INFO - Running setup.py (path:/tmp/pip-mhmar1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:39 INFO - Running setup.py (path:/tmp/pip-G8wKiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:11:39 INFO - Running setup.py install for manifestparser 08:11:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:11:39 INFO - Running setup.py install for mozcrash 08:11:39 INFO - Running setup.py install for mozdebug 08:11:39 INFO - Running setup.py install for mozdevice 08:11:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:11:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:11:39 INFO - Running setup.py install for mozfile 08:11:39 INFO - Running setup.py install for mozhttpd 08:11:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Running setup.py install for mozinfo 08:11:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Running setup.py install for mozInstall 08:11:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Running setup.py install for mozleak 08:11:40 INFO - Running setup.py install for mozlog 08:11:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Running setup.py install for moznetwork 08:11:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Running setup.py install for mozprocess 08:11:40 INFO - Running setup.py install for mozprofile 08:11:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Running setup.py install for mozrunner 08:11:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:11:40 INFO - Running setup.py install for mozscreenshot 08:11:40 INFO - Running setup.py install for moztest 08:11:41 INFO - Running setup.py install for mozversion 08:11:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:11:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:11:41 INFO - Cleaning up... 08:11:41 INFO - Return code: 0 08:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:11:41 INFO - Using env: {'DISPLAY': ':0', 08:11:41 INFO - 'HOME': '/home/cltbld', 08:11:41 INFO - 'LANG': 'en_US.UTF-8', 08:11:41 INFO - 'LANGUAGE': 'en_US:en', 08:11:41 INFO - 'LOGNAME': 'cltbld', 08:11:41 INFO - 'MAIL': '/var/mail/cltbld', 08:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:41 INFO - 'MOZ_NO_REMOTE': '1', 08:11:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:41 INFO - 'NO_EM_RESTART': '1', 08:11:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:41 INFO - 'PWD': '/builds/slave/test', 08:11:41 INFO - 'SHELL': '/bin/bash', 08:11:41 INFO - 'SHLVL': '1', 08:11:41 INFO - 'TERM': 'linux', 08:11:41 INFO - 'TMOUT': '86400', 08:11:41 INFO - 'USER': 'cltbld', 08:11:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:41 INFO - '_': '/tools/buildbot/bin/python'} 08:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:11:41 INFO - Running setup.py (path:/tmp/pip-Ui4pB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:11:41 INFO - Running setup.py (path:/tmp/pip-Q6xEna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:11:41 INFO - Running setup.py (path:/tmp/pip-_xsD5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:11:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:11:41 INFO - Running setup.py (path:/tmp/pip-tAaR3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:11:41 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)) 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:11:41 INFO - Running setup.py (path:/tmp/pip-GnEv6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:11:41 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)) 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:11:41 INFO - Running setup.py (path:/tmp/pip-CAXE2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:11:41 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)) 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:11:41 INFO - Running setup.py (path:/tmp/pip-HZ54C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:11:41 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)) 08:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:11:41 INFO - Running setup.py (path:/tmp/pip-KQqVGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:11:42 INFO - Running setup.py (path:/tmp/pip-2ZEMob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:11:42 INFO - Running setup.py (path:/tmp/pip-sK8842-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:11:42 INFO - Running setup.py (path:/tmp/pip-GMLMpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:11:42 INFO - Running setup.py (path:/tmp/pip-Qdjx31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:11:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:11:42 INFO - Running setup.py (path:/tmp/pip-fqeiYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:11:42 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)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:11:42 INFO - Running setup.py (path:/tmp/pip-eo7c63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:11:42 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)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:42 INFO - Running setup.py (path:/tmp/pip-pAfstU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:11:42 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)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:11:42 INFO - Running setup.py (path:/tmp/pip-Uf3WZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:11:42 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)) 08:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:11:42 INFO - Running setup.py (path:/tmp/pip-_6Infa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:11:42 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)) 08:11:42 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)) 08:11:42 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)) 08:11:42 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)) 08:11:42 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)) 08:11:42 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)) 08:11:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:44 INFO - Downloading blessings-1.6.tar.gz 08:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:11:44 INFO - Installing collected packages: blessings 08:11:44 INFO - Running setup.py install for blessings 08:11:44 INFO - Successfully installed blessings 08:11:44 INFO - Cleaning up... 08:11:44 INFO - Return code: 0 08:11:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:11:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:45 INFO - Reading from file tmpfile_stdout 08:11:45 INFO - Current package versions: 08:11:45 INFO - argparse == 1.2.1 08:11:45 INFO - blessings == 1.6 08:11:45 INFO - blobuploader == 1.2.4 08:11:45 INFO - docopt == 0.6.1 08:11:45 INFO - functools32 == 3.2.3-2 08:11:45 INFO - jsonschema == 2.5.1 08:11:45 INFO - manifestparser == 1.1 08:11:45 INFO - mozInstall == 1.12 08:11:45 INFO - mozcrash == 1.0 08:11:45 INFO - mozdebug == 0.1 08:11:45 INFO - mozdevice == 0.48 08:11:45 INFO - mozfile == 1.2 08:11:45 INFO - mozhttpd == 0.7 08:11:45 INFO - mozinfo == 0.9 08:11:45 INFO - mozleak == 0.1 08:11:45 INFO - mozlog == 3.4 08:11:45 INFO - moznetwork == 0.27 08:11:45 INFO - mozprocess == 0.23 08:11:45 INFO - mozprofile == 0.28 08:11:45 INFO - mozrunner == 6.13 08:11:45 INFO - mozscreenshot == 0.1 08:11:45 INFO - mozsystemmonitor == 0.3 08:11:45 INFO - moztest == 0.7 08:11:45 INFO - mozversion == 1.4 08:11:45 INFO - psutil == 3.1.1 08:11:45 INFO - requests == 1.2.3 08:11:45 INFO - wsgiref == 0.1.2 08:11:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:11:45 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')]} 08:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:45 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')]} 08:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:45 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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:45 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 08:11:45 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 08:11:45 INFO - Using env: {'DISPLAY': ':0', 08:11:45 INFO - 'HOME': '/home/cltbld', 08:11:45 INFO - 'LANG': 'en_US.UTF-8', 08:11:45 INFO - 'LANGUAGE': 'en_US:en', 08:11:45 INFO - 'LOGNAME': 'cltbld', 08:11:45 INFO - 'MAIL': '/var/mail/cltbld', 08:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:45 INFO - 'MOZ_NO_REMOTE': '1', 08:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:45 INFO - 'NO_EM_RESTART': '1', 08:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:45 INFO - 'PWD': '/builds/slave/test', 08:11:45 INFO - 'SHELL': '/bin/bash', 08:11:45 INFO - 'SHLVL': '1', 08:11:45 INFO - 'TERM': 'linux', 08:11:45 INFO - 'TMOUT': '86400', 08:11:45 INFO - 'USER': 'cltbld', 08:11:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:45 INFO - '_': '/tools/buildbot/bin/python'} 08:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 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)) 08:11:45 INFO - Cleaning up... 08:11:45 INFO - Return code: 0 08:11:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:11:45 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')]} 08:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:45 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')]} 08:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11:45 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 0x7f6338d79f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, '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-1481812932.494275-299112558', '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 08:11:45 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 08:11:45 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 08:11:45 INFO - Using env: {'DISPLAY': ':0', 08:11:45 INFO - 'HOME': '/home/cltbld', 08:11:45 INFO - 'LANG': 'en_US.UTF-8', 08:11:45 INFO - 'LANGUAGE': 'en_US:en', 08:11:45 INFO - 'LOGNAME': 'cltbld', 08:11:45 INFO - 'MAIL': '/var/mail/cltbld', 08:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:45 INFO - 'MOZ_NO_REMOTE': '1', 08:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:45 INFO - 'NO_EM_RESTART': '1', 08:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:45 INFO - 'PWD': '/builds/slave/test', 08:11:45 INFO - 'SHELL': '/bin/bash', 08:11:45 INFO - 'SHLVL': '1', 08:11:45 INFO - 'TERM': 'linux', 08:11:45 INFO - 'TMOUT': '86400', 08:11:45 INFO - 'USER': 'cltbld', 08:11:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:45 INFO - '_': '/tools/buildbot/bin/python'} 08:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:11:45 INFO - Cleaning up... 08:11:45 INFO - Return code: 0 08:11:45 INFO - Running post-action listener: _resource_record_post_action 08:11:45 INFO - Running post-action listener: _start_resource_monitoring 08:11:45 INFO - Starting resource monitoring. 08:11:45 INFO - [mozharness: 2016-12-15 16:11:45.632119Z] Finished create-virtualenv step (success) 08:11:45 INFO - [mozharness: 2016-12-15 16:11:45.632631Z] Running install step. 08:11:45 INFO - Running pre-action listener: _resource_record_pre_action 08:11:45 INFO - Running main action method: install 08:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:11:45 INFO - Reading from file tmpfile_stdout 08:11:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:11:45 INFO - Reading from file tmpfile_stdout 08:11:45 INFO - Output received: 08:11:45 INFO - Usage: mozinstall [options] installer 08:11:45 INFO - Options: 08:11:45 INFO - -h, --help show this help message and exit 08:11:45 INFO - -d DEST, --destination=DEST 08:11:45 INFO - Directory to install application into. [default: 08:11:45 INFO - "/builds/slave/test"] 08:11:45 INFO - --app=APP Application being installed. [default: firefox] 08:11:45 INFO - mkdir: /builds/slave/test/build/application 08:11:45 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'] 08:11:45 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 08:12:03 INFO - Reading from file tmpfile_stdout 08:12:03 INFO - Output received: 08:12:03 INFO - /builds/slave/test/build/application/firefox/firefox 08:12:03 INFO - Running post-action listener: _resource_record_post_action 08:12:03 INFO - [mozharness: 2016-12-15 16:12:03.561103Z] Finished install step (success) 08:12:03 INFO - [mozharness: 2016-12-15 16:12:03.561346Z] Running run-tests step. 08:12:03 INFO - Running pre-action listener: _resource_record_pre_action 08:12:03 INFO - Running main action method: run_tests 08:12:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:03 INFO - Python 2.7.3 08:12:03 INFO - Return code: 0 08:12:03 INFO - grabbing minidump binary from tooltool 08:12:03 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')]} 08:12:03 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 0xd9ef60>, '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 0xd9fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:03 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 08:12:03 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 08:12:03 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 08:12:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:03 INFO - Return code: 0 08:12:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:12:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:12:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:03 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/eNAuIzJgQZS76VhJ17BFxQ/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 08:12:03 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/eNAuIzJgQZS76VhJ17BFxQ/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 08:12:03 INFO - Using env: {'DISPLAY': ':0', 08:12:03 INFO - 'HOME': '/home/cltbld', 08:12:03 INFO - 'LANG': 'en_US.UTF-8', 08:12:03 INFO - 'LANGUAGE': 'en_US:en', 08:12:03 INFO - 'LOGNAME': 'cltbld', 08:12:03 INFO - 'MAIL': '/var/mail/cltbld', 08:12:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:03 INFO - 'MOZ_NO_REMOTE': '1', 08:12:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:03 INFO - 'NO_EM_RESTART': '1', 08:12:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:03 INFO - 'PWD': '/builds/slave/test', 08:12:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:03 INFO - 'SHELL': '/bin/bash', 08:12:03 INFO - 'SHLVL': '1', 08:12:03 INFO - 'TERM': 'linux', 08:12:03 INFO - 'TMOUT': '86400', 08:12:03 INFO - 'USER': 'cltbld', 08:12:03 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1481812932.494275-299112558', 08:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:03 INFO - '_': '/tools/buildbot/bin/python'} 08:12:03 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/eNAuIzJgQZS76VhJ17BFxQ/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 08:12:03 INFO - mozversion application_buildid: 20161215063801 08:12:03 INFO - mozversion application_changeset: 40a2d26936006c5256ece3268a89f418500cd63e 08:12:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:12:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:03 INFO - mozversion application_name: Firefox 08:12:03 INFO - mozversion application_remotingname: firefox-dev 08:12:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:12:03 INFO - mozversion application_vendor: Mozilla 08:12:03 INFO - mozversion application_version: 52.0a2 08:12:03 INFO - mozversion platform_buildid: 20161215063801 08:12:03 INFO - mozversion platform_changeset: 40a2d26936006c5256ece3268a89f418500cd63e 08:12:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:12:03 INFO - mozversion platform_version: 52.0a2 08:12:03 INFO - using testdate: 1481818323 08:12:03 INFO - actual date: 1481818323 08:12:03 INFO - starting webserver on 'localhost:52433' 08:12:03 INFO - SUITE-START | Running 2 tests 08:12:03 INFO - TEST-START | dromaeo_css 08:12:03 INFO - operating with platform_type : linux_ 08:12:03 INFO - Initialising browser for dromaeo_css test... 08:12:03 INFO - TEST-INFO | started process 24899 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx7kCfi/profile http://localhost:52433/getInfo.html) 08:12:09 INFO - PROCESS | 24899 | __metrics Screen width/height:1600/1200 08:12:09 INFO - PROCESS | 24899 | colorDepth:24 08:12:09 INFO - PROCESS | 24899 | Browser inner width/height: 1024/697 08:12:09 INFO - PROCESS | 24899 | __metrics 08:12:09 INFO - PROCESS | 24899 | 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" 08:12:09 INFO - PROCESS | 24899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:10 INFO - PROCESS | 24899 | console.error: PushService: 08:12:10 INFO - PROCESS | 24899 | stateChangeProcessEnqueue: Error transitioning state 08:12:10 INFO - PROCESS | 24899 | UnknownError 08:12:11 INFO - TEST-INFO | 24899: exit 0 08:12:11 INFO - Browser initialized. 08:12:11 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:11 INFO - TEST-INFO | started process 24992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx7kCfi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:22 INFO - PROCESS | 24992 | RSS: Main: 144318464 08:12:22 INFO - PROCESS | 24992 | 08:13:14 INFO - PROCESS | 24992 | 1481818394479 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] 08:15:25 INFO - PROCESS | 24992 | Cycle 1(1): loaded http://localhost:52433/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52433/tests/dromaeo/cssquery-ext.html) 08:15:26 INFO - PROCESS | 24992 | RSS: Main: 237350912 08:15:26 INFO - PROCESS | 24992 | 08:18:28 INFO - PROCESS | 24992 | Cycle 1(1): loaded http://localhost:52433/tests/dromaeo/cssquery-ext.html (next: http://localhost:52433/tests/dromaeo/cssquery-jquery.html) 08:18:29 INFO - PROCESS | 24992 | RSS: Main: 236158976 08:18:29 INFO - PROCESS | 24992 | 08:21:31 INFO - PROCESS | 24992 | Cycle 1(1): loaded http://localhost:52433/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52433/tests/dromaeo/cssquery-mootools.html) 08:21:31 INFO - PROCESS | 24992 | RSS: Main: 175480832 08:21:31 INFO - PROCESS | 24992 | 08:24:33 INFO - PROCESS | 24992 | Cycle 1(1): loaded http://localhost:52433/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52433/tests/dromaeo/cssquery-prototype.html) 08:24:34 INFO - PROCESS | 24992 | RSS: Main: 175382528 08:24:34 INFO - PROCESS | 24992 | 08:27:37 INFO - PROCESS | 24992 | Cycle 1(1): loaded http://localhost:52433/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52433/tests/dromaeo/cssquery-yui.html) 08:27:37 INFO - PROCESS | 24992 | RSS: Main: 176791552 08:27:37 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | Cycle 1(1): loaded http://localhost:52433/tests/dromaeo/cssquery-yui.html (next: http://localhost:52433/tests/dromaeo/cssquery-dojo.html) 08:30:40 INFO - PROCESS | 24992 | RSS: Main: 264986624 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | __start_tp_report 08:30:40 INFO - PROCESS | 24992 | _x_x_mozilla_page_load 08:30:40 INFO - PROCESS | 24992 | _x_x_mozilla_page_load_details 08:30:40 INFO - PROCESS | 24992 | |i|pagename|runs| 08:30:40 INFO - PROCESS | 24992 | |0;dojo.html;3292.4073666739987;3325.1520862180155;3325.650806665301;3333.7333013358902;3359.5296658467805;5644.181593668921;5702.429757024295;5726.942730572699;5730.7707691692285;5745.59780815342;5782.739776710047;5826.854328641786;5829.650220986733;5832.533397328214;5838.065909454488;5207.192885102796;5247.86880327991;5264;5268.710220937847;5317.601179911503;5126.615503837208;5312.840614781563;5320.042392369372;5323.494268044549;5354.116570765819;5120.4623514530995;5178.922316165261;5180.197069454241;5180.611454140936;5214.8696282592855;5236.6857988520815;5262;5265.605079619006;5337.6797392156595;5338.225957236218;5161.019406312788;5186.403563590197;5251.212318152269;5289.629725919187;5290.894182116374;5605.187247849039;5630.634008789457;5641.379448260688;5668.121441176624;5709.25779648643;6066.332703402622;6087.604305720159;6095.847603809896;6188.071789231606;6190.0405437157315;6231.813045608639;6246.937530624681;6260.217472815898;6267.6866156691985;6267.780627678055;5623.156526521014;5664.490195882349;5681.801136960186;5712.742926568314;5739.225204597409;6333.1241220599;6338.714757835816;6369.5222858285815;6374.426301632782;6376.808695739135;6028.367021462684;6079.331273559905;6084.756609735561;6085.117657939662;6086.239220097488;5989.401059894063;6040.486558642477;6076.574639775174;6114;6117.449429551361;6165.815025549241;6181.876362472815;6182.319944806068;6188.350223226586;6188.381161883775;6144.078388241799;6170.81487555374;6227.844303892349;6233.252009758858;6234.5635805494085;4671.299305104261;4683.227267500893;4696.741679207608;4746.454157771831;4829.058333624909;4234.364845273172;4269.359596060615;4285.0358669299785;4286.335617979218;4286.464191976003;5839.124131380242;5846.356900740915;5846.678432686158;5846.824595262149;5849.561282903799;5987.6108052976415;6252.718627661766;6262.655553944485;6263.686815659199;6270.843228919313;5693.886122277531;5764.5676574257095;5785.30576330843;5815.098659707667;5908.793192238251;5362.705051222142;5370.704611246419;5423.105187644073;5430.809921652803;5432.266644003009;6477.77327793525;6485.319041500763;6486.254080780771;6494.318096599978;6494.480441564663;5979.162917191509;5994;6106.389361063858;6131.63210207389;6144.692765361625;6406.359364063556;6409.391107844747;6412.935870641234;6419.903701444576;6426.518011149089;6028.457438830526;6033.939660603338;6035.547333949883;6037.124616930609;6040.0939859019745;5934.109883517507;6055.6063855849225;6083.6349819011;6099.603525770811;6174.043023331391;6053.757849685963;6055.788047418319;6069.817905462844;6076.088586711851;6076.969615151896;6013.639181649115;6025.276966763841;6032.54755893301;6042.758289668364;6042.848928776816;5751.252337196138;5866.266716660418;5925.703714814156;5956.166136740773;5968.164456976114;6039.849003774765;6103.664298463627;6105.450509453993;6110.633361998294;6127.877442451215;5910.349861515144;5970.611910225822;5974.671393073423;5981.641101533748;6011.489023433057 08:30:40 INFO - PROCESS | 24992 | |1;ext.html;596.1445325957252;604.0908432808623;633.3096924352454;642.8489305013323;655.2268323378414;44357.11285774287;45524.54475455249;45525.54474455254;45543;47540.52459475404;46299;46647.533524664745;46650.76674616622;46681.533184668144;46946;8260.793480162984;8467.237948584627;8652.61063252152;8783.077776833436;8801.867971980426;10475.109615682675;10730.248882578222;10730.946345268301;10999.725006874813;11008.669739907775;10740;10839.349639021644;10843.295185812936;10844.024037836592;10847.728806779854;10693.946530267376;10694.839577406345;10736.57053717858;10742.516586753576;10751.569937202503;10610.416427096507;10703.929607039312;10709.143268538499;10713.410762408064;10714.571417143305;43765.12469750619;44475.332870006976;44508.3323750144;44530.109397812186;44738.10523789506;3684.6868016218655;3843.846246150151;3899.512560929884;3981.3231750602467;4038.3942408638645;32159;32350.838245808856;32770;33853.15367115817;34277.14307142316;4355.716878402925;4384.320430333303;4402.273624851896;4404.581564751344;4521.276595744665;368770;369499;372207;372748;374202.99999999726;60302.396976029675;60426.395736042075;60676.69661651664;60782.69608651928;60792;39215.60784392177;40097.39853902194;40224.597754022085;42630.57369426328;63339.683301583194;18507.629847403245;18640.254389824528;18679.81320186808;18695.252189912524;18705.906470467562;13481.730365392637;13678.452861885613;13787.655308617164;13790;13809.378577963815;19770.901145494467;20380.38858834237;20509.2821751238;21210.893945530483;21212.681809772865;7004.789856304319;7103.325184107502;7165.641717914188;7234.6020968847215;7425.85148297031;1003.7340104872214;1043.4521876015153;1050.4800123938699;1055.6621880998007;1092.8633920759905;34111.31777364439;34253.486197707054;34320.656793432245;34416;34598.82700586481;1133.7109037195462;1145.3128123126223;1147.4148184426003;1156.0924674130767;1179.0913122997238;17825;17841.643167136586;18042.368517101837;18071.548211294823;18081.547961301072;559180;565305;566556;566890;567160;61685;62280.68859655673;62645;62861.37138628647;62876;1298.6818229533824;1347.2994043097535;1352.8511863695182;1418.2625034981959;1433.6129245103764;27919.581206282328;33641.495377569845;34614.82692586521;36841.078973024814;36847.815760921025;56892;57313;57342.13986790285;57356;57363.71318143383;502819;504640;505476;505718;507060;26664.866675666497;27470.35177889333;28095.43809123847;29277.85361073181;30492.237694057825;47873.521264786905;48213;48662.5133748658;48962.51037489722;48996.2650560249;40476.1904761909;42112.15775684531;42980.69865703909;45383.54616453793;45639.771801140785;42325;42552.361714573686;42900.78549607232;44060.559394405645;44442.11115777731;42503.574964249965;43785.34321985109;43976.78011609922;44339.11321773482;44365.77817110894;36156.27687446289;38391.808040960736;38450.230995379374;38729.4190587147;39075.80462097671;28387;29274.414511710074;29791.702082978893;29819;30809.8459507701 08:30:40 INFO - PROCESS | 24992 | |2;jquery.html;420.9684273679471;427.83994674029026;433.25047667535165;438.78280251275623;444.41115521933426;18628.348007819728;20369.694454583194;20470.692939605917;20903.37289881302;20995.265165719164;19300.806991930076;20119.798802011974;20186.39440816778;20395.898020509914;20642.999999999964;5720.2849643794525;6000.099985002241;6005.87988240235;6012.128241405016;6020.157177995085;5724.398938111501;5815.214945982301;5831.650100993933;5856.033754430514;5894.056950887859;5796.420357964191;5802.651840889539;5806.767729290823;5808.651480911159;5808.912866307009;5641.289010106853;5874.765009399619;5936.050231962909;5960.374160713106;5962.105684147391;5202.297689811865;5366.087765079946;5369.516743493065;5370.43610420904;5377.435369286208;23254.3023709289;23486.882565587235;23760.287191384286;24025.27924162278;24415;2521.621756736486;2539.2255362114547;2566.268613445159;2762.709915458868;2880.2943278896596;7356.77929662111;14671.16610423697;14899.553013409506;14910.62723431912;15051;1865.2259312385345;1882.6893562562161;1939.3309308288617;1950.1711772496774;1983.633027889845;56467.71766141184;77888;80286;82474.58762706208;94308.52845735727;10255.692329230134;10590.682279531626;10598.417087060287;10660.94669526663;11425.542978280942;13858.475567687547;14494.782578261334;14601.92699036498;14630.561083167522;14633.634159146106;8534.359923005799;8633.913660863436;8636;8765.211130998241;8850;8448.619812108469;8489.872651910226;8499.235068843835;8560;8669.176428239307;6806.965965170142;6884.931150688429;6905.861882762417;6955.408790252885;7115.1106111736035;1916.8945707985915;1961.852861035428;1997.10130441302;2005.6891181866833;2035;928.8606708993705;980.5734505490135;984.7341217871278;1038.7922415516928;1079.5627770752858;19658.670342678353;20193.798062019192;20224.797752022292;20636.484087897923;20780.58438831215;1052.7736536644659;1058.6506452870535;1093.4696672114019;1109.7724966381872;1110.3948348150277;10662.520186591622;11571;11757.529698812123;11793.52825886955;11793.941030294794;471188;472396;476380;482798;483237;51971;63050.0542491863;85965.57017215;89129.55435222782;89841;1041.271110222847;1057.2335057083553;1063.9521221545049;1064.4518073192312;1066.7706443114612;17407.738883917005;17926.282948681906;18341.633167336844;18364.265429382674;18432;40478.392824107075;40786.79606601948;41206.587934120274;41543;41800.37299440572;54168.45831541634;54315.72842135764;54444;55546.44453555575;55957.16064258958;8681.609327580149;8712.303015758851;8734.388592798698;8872.556372181494;8925.687600933936;12383.257004579755;12798.296093714935;12808.231506109663;12930.482780688668;13099.035144728367;10755.193360497837;11105.611303604659;11278.887211127783;11446.313221206754;11808.350540720343;10752.193585481276;10788.838167427652;10794;11107.611233606785;11499.137564682514;11601.361925094201;11737.002354799937;11891.940540297242;11894.107941904565;12537.185082969578;8907.242884354644;9054.773630659287;9076.863847042432;9197.034311397474;9199.678011269574;11706.297622142698;11750.70623234426;11920.582779602672;12036.699082523008;12285.201461904948 08:30:40 INFO - PROCESS | 24992 | |3;mootools.html;1352.2832898563752;1464.5313499680108;1511.3652266048261;1644.3093900561762;1830.6247219320041;7793.454458187922;8598.22615964564;8862.202401783838;8870.112988701134;9187.494687792168;8971.05803890592;9048.502332371718;9052.275817934566;9066.501342426163;9077.546122693871;2492.3395300245406;2519.4961007798515;2524.406764410362;2524.6591710119083;2528.15306872198;2442.511497700458;2536.3405514566252;2539.415934335104;2542.427953710419;2546.1852207293673;2504.161106029473;2505.7243703192635;2547.0066673997158;2548.5412625727363;2550.8852101655375;2463.07634637012;2478.4423504711476;2484.925452236436;2490.414752533153;2502.049221295905;2420.165043060141;2443.645671377658;2480.4419005723566;2480.8511489310517;2481.1192026830395;8749.693760718344;8803.77990550235;8852.203301702877;8923.15230053144;8934.508602026886;5503.697296648683;5752.769889204426;5758.79844205455;5763.625364351304;5765.913511297334;3759.3233218020746;3783.2193337896624;3842.731008829383;3892.1826416452577;3898.649121579043;1155.4858088150777;1177.8292147638545;1197.15600501647;1207.96376108716;1249.5938819883575;12530.122891397607;12704.428300726397;12715.55495557651;12716.173448725804;12720.936395317964;4709.576138147515;4746.740671232032;4765.332853400527;4809;4929.3345398371475;9745.171660408803;9753.122219000325;9770.169535589555;9772.902270977342;9785.119339259501;5517.806876759294;5521.3926468088475;5521.420250873681;5521.503064724194;5536.86157846049;4402.955970440319;4529.977350113294;4794.256890182028;5069.949300506948;5225.608079394061;4096.250589529969;4117.8970525737095;4159.46257920368;4200.243956087872;4237.63980061692;1289.8323217981601;1307.5881097454271;1308.535469908188;1308.7382523495148;1328.0637150808657;983.3509883477014;1008.5461542305992;1015.1878497202209;1019.5208252121491;1037.5331101004579;5943.3462319144855;6184.103305020747;6206.224221972254;6259.843503912348;6331.841703957438;449.3933190193213;456.6324109092146;456.63697360598405;463.11776066593194;1038.314712289885;4096.631303182728;4234.788260586958;4259.424977628042;4290;4292.678049146327;10914.836277455845;11059.281146725438;11239.887601124048;11256.943715281372;11280.210385273116;11130.944345278222;11132.443377831076;11147.163962702667;11147.94426027881;11160.051395631463;7776.377889768805;7863.252990965849;7887.408444366695;8097.352211823158;8408.32733381328;6160.375474335787;6216.751329946752;6231.813045608639;6262.060690896402;6327.841803954754;10201.489925503547;10306.278560500694;10314.948425257826;10340.948295258475;10356.275060745675;9398.906010939803;9701.757456063655;10282.331648442827;10358.741031474274;10376.481175941324;7540.8491830164185;7697.653605587874;7698.07623085211;7759.650815713419;7933.206679332021;8657.783555411164;8832;8833.558322083998;8890.422122562013;8926.553672316228;7877.881831772643;7957.920420795718;7996.640151193326;8039.959800200962;8122.350211982909;7662.8084297893;7730.884036739341;7767;7785.532868027936;8011.519308841488;7346.96326518364;7466.328030477283;7476;7478.177400486051;7478.364339031244;5293.2589437479555;5416.4041955385665;5437.891242175056;5490.149026900836;5594.86012849682;5476.863078422912;5483.7258137092185;5525.778968841362;5609;5623 08:30:40 INFO - PROCESS | 24992 | |4;prototype.html;343.5722525455808;354.92901419716065;358.78831489421253;359.3477837724529;362.31160794490467;5477.452254774521;5479.972600136994;5504.174373843925;5505.614606977513;5562.415946325638;5363.275957745703;5384.623076384654;5451.727413629323;5503.7807277776055;5527.668339899609;3786.4131059685656;4035.8183881725317;4160.687948403866;4265;4269.167512335081;4286.0999190170105;4289.5924887135825;4292.97853510732;4295.355696645497;4301.397804307399;4270.829166833323;4273.615374616284;4277.631158029431;4284.592963668447;4287.31402975524;4057.3711074783455;4103.281925662997;4243.832945939891;4258.444933040182;4321.935170972422;3758.7180961428003;3781.4138808484727;3785.7160712946365;3796.3356412627954;3815.503984482027;5278.653943244486;5293.258943747878;5301.8070934039915;5309.601779866525;5324.54741346986;4728.574428301469;4859.805607775685;4867.148249056437;4873.34209881665;4895.853124406273;5607.355154157283;5633.15502674598;5649.4633009864;5655.208270842086;5661.575381846337;4040.272750904836;4211.157768446323;4212.452381190456;4228.090960443488;4243.172581346638;5591.832245032656;5702.116171993348;5844.766209351621;5874.706264686792;5893.174955506232;4110.897227569335;4177.6866734995;4193.454850869368;4199.979000105041;4207.516135644379;4214.557471465513;4248.660107191417;4252.808623611945;4252.872413827528;4261.339492378686;4660.976695116503;4857.708537487762;4865.781039853215;4867.70793752376;4875.219964805614;5633.436656334416;5691.459311365414;5692.601517893708;5694.857628559319;5703.344115426696;1426.587678198576;1434.8278206615064;1449.5289031064947;1449.7680371140566;1451.5790420778067;958.5908714190268;1000.3747657713928;1007.6825799873017;1007.9798404031878;1023.9095363437915;5304.037506122682;5312.76092575835;5325.920111198335;5328.573714102862;5331.920021199685;5607.261748857867;5646.809552602766;5648.870225954825;5651.802186923438;5657.321121465368;5047.87380315495;5255.975084858493;5285.735713214324;5307.487366100643;5337.62636615441;2962.718706595952;2969.599104120959;2972.895948641787;2996.6853480384248;3005;5861.531077513789;5862.355140934494;5865.35481097079;5867;5871.4715675589405;5668.914966275509;5985.191999080069;6038.879222415527;6061.424164704346;6061.757529698851;6109.47263184204;6114.449699527064;6117.388261173847;6122.326544080148;6157.261128664589;5623.381428042994;5872.500837428866;5901.350851406428;5931.851703707442;5963.940360596512;5808.970955145197;5811.1573821794755;5829.125631155361;5841.153032810304;5849.151872978479;5732.942670573241;5761.971190144022;5937.960856849948;5960.254968128984;6086.3000754913755;4090.852302541071;4160.791960402028;4217.481706585565;4233.491980962304;4235.216484950294;5790.305163380422;5835.387284335084;5866.413358664099;5878.559108066826;5880.8235752927485;5717.540887762843;5728.627639203439;5736.139579063007;5741.741621626953;5775.393583673654;5669.716514174357;5700.429957004267;5705.885882282414;5717.828465146053;5717.914231286617;5370.4629537045985;5525.723713814374;5602.915956260578;5637.57718171147;5701.458361455655;5650.830475085754;5684.687342196219;5690.174924635988;5696.829095127153;5701.144828275792;5574.498295153456;5595.76893083521;5596.776128954796;5600.327960644749;5636.774529018958 08:30:40 INFO - PROCESS | 24992 | |5;yui.html;787.6101329841725;792.7553740627216;810.1614828652342;816.955067471289;899.2536194958185;14374.568762937102;15046.473373431932;16044.278007489662;16192.83807161928;16255.862089653743;14427.927860360684;14617.92691036546;14630.34163462644;15106.622334441645;15474.767878481804;837.8994520657499;856.6701819799391;857.3741168946673;857.5326447086353;857.7298151082389;714.7069701422417;730.390124246255;829.1998221716043;845.3533047218882;847.4660963592928;887.8934527856666;891.0554811899408;891.692366133686;891.8171774786185;891.9375643704943;878.2754227762122;878.5387671472464;878.569500944539;878.947263164209;880.6257340630239;550.4605486623132;563.8139413993372;642.6979319719725;650.3561474140614;653.8267359149829;14768.55694329161;14832.777508337384;14838.554843354717;14838.70322593553;14845.851541484662;13015.86984130156;13295;13363.331833408389;13491.595252142451;13510.527131550349;12223.511059557695;12553.309567973758;12617.116801823877;12790.808137877939;13025.023123265793;4329;4354.346847972798;4405.977970110161;4461.821527138911;4498.987727761228;64185.67907160481;64401.67799161021;64554.67722661403;64991.350086499006;66591.66704166448;11105.722356941142;11637.418129093512;11686.649400517997;11727.824082638766;11966.760664786656;20052.89973550123;20113.49716257076;20281.594368112554;20301.59396812085;20393.286234981704;8182.263596276244;8192.713255036046;8223.671053157927;8246.752597422086;8262.42163048593;4802.399700037496;4860.270959356054;4866.829660961849;4905.166121759309;5111.744412779346;3537.2218112015316;3632.200915798573;3637.890863274106;3639.181184233579;3640.6177351378255;628.0422355907278;630.19020558582;643.3405759096963;643.7457204404328;646.6217262901162;609.8167565309079;633.2274624957545;679.3172861274387;781.734210368466;793.3573805217792;8669.696560620474;9568.425894446216;9594.952025239829;9742.805143897082;10014.148797352162;663.4857985061616;670.637855558003;714.9928500715031;725.1696807155882;733.1385621894359;4652.883677908079;4680.625549955996;4684.391029166187;4696.248600224016;4751.95248047522;60597;88230.11769882348;91560;94524;94680.52659736657;78979;81473;83664.58167709244;85038.5748071268;86562;45105.32342014872;65597.5147462057;67110.32889671139;74808.25191748122;76820.2317976813;10204.693859184237;10377.584896604052;10457.895421045996;10601.25791194609;10666.093382062612;33322.83338583291;41872.3719144207;46447;47072.7646361766;47094.52905470901;59656.10515842179;61314.38685613087;61982.69008654928;62668;64029.0395644075;12445.25328480294;12592.559260425842;12995.740085198433;13327.874091236105;13426.462941482232;14520.927395362956;14621.634459138606;14910.925445372704;14955;15198.088114712711;12828.166169198972;12957.740845182854;13149.60551183466;13277.601671949857;13721;13546;13996.720065598834;14023.439062437388;14134.293285335898;14252.71494570082;13215.207087574776;13417.66455838612;13529.873388616566;13599.388027538982;13606.523771667944;11191.66425007251;11192.986660276498;11221.495032723384;11336.206465547333;11378.829317560077;11088.223824332219;11171.608993685182;11526.135539834379;11527.711807204887;11686.24039437434 08:30:40 INFO - PROCESS | 24992 | __end_tp_report 08:30:40 INFO - PROCESS | 24992 | __start_cc_report 08:30:40 INFO - PROCESS | 24992 | _x_x_mozilla_cycle_collect,1048 08:30:40 INFO - PROCESS | 24992 | __end_cc_report 08:30:40 INFO - PROCESS | 24992 | __startTimestamp1481819440528__endTimestamp 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | ------- Summary: start ------- 08:30:40 INFO - PROCESS | 24992 | Number of tests: 6 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | [#0] dojo.html Cycles:165 Average:5730.00 Median:5970.61 stddev:648.24 (10.9%) stddev-sans-first:621.39 08:30:40 INFO - PROCESS | 24992 | Values: 3292.4 3325.2 3325.7 3333.7 3359.5 5644.2 5702.4 5726.9 5730.8 5745.6 5782.7 5826.9 5829.7 5832.5 5838.1 5207.2 5247.9 5264.0 5268.7 5317.6 5126.6 5312.8 5320.0 5323.5 5354.1 5120.5 5178.9 5180.2 5180.6 5214.9 5236.7 5262.0 5265.6 5337.7 5338.2 5161.0 5186.4 5251.2 5289.6 5290.9 5605.2 5630.6 5641.4 5668.1 5709.3 6066.3 6087.6 6095.8 6188.1 6190.0 6231.8 6246.9 6260.2 6267.7 6267.8 5623.2 5664.5 5681.8 5712.7 5739.2 6333.1 6338.7 6369.5 6374.4 6376.8 6028.4 6079.3 6084.8 6085.1 6086.2 5989.4 6040.5 6076.6 6114.0 6117.4 6165.8 6181.9 6182.3 6188.4 6188.4 6144.1 6170.8 6227.8 6233.3 6234.6 4671.3 4683.2 4696.7 4746.5 4829.1 4234.4 4269.4 4285.0 4286.3 4286.5 5839.1 5846.4 5846.7 5846.8 5849.6 5987.6 6252.7 6262.7 6263.7 6270.8 5693.9 5764.6 5785.3 5815.1 5908.8 5362.7 5370.7 5423.1 5430.8 5432.3 6477.8 6485.3 6486.3 6494.3 6494.5 5979.2 5994.0 6106.4 6131.6 6144.7 6406.4 6409.4 6412.9 6419.9 6426.5 6028.5 6033.9 6035.5 6037.1 6040.1 5934.1 6055.6 6083.6 6099.6 6174.0 6053.8 6055.8 6069.8 6076.1 6077.0 6013.6 6025.3 6032.5 6042.8 6042.8 5751.3 5866.3 5925.7 5956.2 5968.2 6039.8 6103.7 6105.5 6110.6 6127.9 5910.3 5970.6 5974.7 5981.6 6011.5 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | [#1] ext.html Cycles:180 Average:64515.21 Median:21314.47 stddev:129278.29 (606.5%) stddev-sans-first:129551.88 08:30:40 INFO - PROCESS | 24992 | Values: 596.1 604.1 633.3 642.8 655.2 44357.1 45524.5 45525.5 45543.0 47540.5 46299.0 46647.5 46650.8 46681.5 46946.0 8260.8 8467.2 8652.6 8783.1 8801.9 10475.1 10730.2 10730.9 10999.7 11008.7 10740.0 10839.3 10843.3 10844.0 10847.7 10693.9 10694.8 10736.6 10742.5 10751.6 10610.4 10703.9 10709.1 10713.4 10714.6 43765.1 44475.3 44508.3 44530.1 44738.1 3684.7 3843.8 3899.5 3981.3 4038.4 32159.0 32350.8 32770.0 33853.2 34277.1 4355.7 4384.3 4402.3 4404.6 4521.3 368770.0 369499.0 372207.0 372748.0 374203.0 60302.4 60426.4 60676.7 60782.7 60792.0 39215.6 40097.4 40224.6 42630.6 63339.7 18507.6 18640.3 18679.8 18695.3 18705.9 13481.7 13678.5 13787.7 13790.0 13809.4 19770.9 20380.4 20509.3 21210.9 21212.7 7004.8 7103.3 7165.6 7234.6 7425.9 1003.7 1043.5 1050.5 1055.7 1092.9 34111.3 34253.5 34320.7 34416.0 34598.8 1133.7 1145.3 1147.4 1156.1 1179.1 17825.0 17841.6 18042.4 18071.5 18081.5 559180.0 565305.0 566556.0 566890.0 567160.0 61685.0 62280.7 62645.0 62861.4 62876.0 1298.7 1347.3 1352.9 1418.3 1433.6 27919.6 33641.5 34614.8 36841.1 36847.8 56892.0 57313.0 57342.1 57356.0 57363.7 502819.0 504640.0 505476.0 505718.0 507060.0 26664.9 27470.4 28095.4 29277.9 30492.2 47873.5 48213.0 48662.5 48962.5 48996.3 40476.2 42112.2 42980.7 45383.5 45639.8 42325.0 42552.4 42900.8 44060.6 44442.1 42503.6 43785.3 43976.8 44339.1 44365.8 36156.3 38391.8 38450.2 38729.4 39075.8 28387.0 29274.4 29791.7 29819.0 30809.8 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | [#2] jquery.html Cycles:180 Average:28334.83 Median:13468.31 stddev:78365.01 (581.8%) stddev-sans-first:78556.82 08:30:40 INFO - PROCESS | 24992 | Values: 421.0 427.8 433.3 438.8 444.4 18628.3 20369.7 20470.7 20903.4 20995.3 19300.8 20119.8 20186.4 20395.9 20643.0 5720.3 6000.1 6005.9 6012.1 6020.2 5724.4 5815.2 5831.7 5856.0 5894.1 5796.4 5802.7 5806.8 5808.7 5808.9 5641.3 5874.8 5936.1 5960.4 5962.1 5202.3 5366.1 5369.5 5370.4 5377.4 23254.3 23486.9 23760.3 24025.3 24415.0 2521.6 2539.2 2566.3 2762.7 2880.3 7356.8 14671.2 14899.6 14910.6 15051.0 1865.2 1882.7 1939.3 1950.2 1983.6 56467.7 77888.0 80286.0 82474.6 94308.5 10255.7 10590.7 10598.4 10660.9 11425.5 13858.5 14494.8 14601.9 14630.6 14633.6 8534.4 8633.9 8636.0 8765.2 8850.0 8448.6 8489.9 8499.2 8560.0 8669.2 6807.0 6884.9 6905.9 6955.4 7115.1 1916.9 1961.9 1997.1 2005.7 2035.0 928.9 980.6 984.7 1038.8 1079.6 19658.7 20193.8 20224.8 20636.5 20780.6 1052.8 1058.7 1093.5 1109.8 1110.4 10662.5 11571.0 11757.5 11793.5 11793.9 471188.0 472396.0 476380.0 482798.0 483237.0 51971.0 63050.1 85965.6 89129.6 89841.0 1041.3 1057.2 1064.0 1064.5 1066.8 17407.7 17926.3 18341.6 18364.3 18432.0 40478.4 40786.8 41206.6 41543.0 41800.4 54168.5 54315.7 54444.0 55546.4 55957.2 8681.6 8712.3 8734.4 8872.6 8925.7 12383.3 12798.3 12808.2 12930.5 13099.0 10755.2 11105.6 11278.9 11446.3 11808.4 10752.2 10788.8 10794.0 11107.6 11499.1 11601.4 11737.0 11891.9 11894.1 12537.2 8907.2 9054.8 9076.9 9197.0 9199.7 11706.3 11750.7 11920.6 12036.7 12285.2 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | [#3] mootools.html Cycles:180 Average:5946.31 Median:4756.04 stddev:3305.46 (69.5%) stddev-sans-first:3296.69 08:30:40 INFO - PROCESS | 24992 | Values: 1352.3 1464.5 1511.4 1644.3 1830.6 7793.5 8598.2 8862.2 8870.1 9187.5 8971.1 9048.5 9052.3 9066.5 9077.5 2492.3 2519.5 2524.4 2524.7 2528.2 2442.5 2536.3 2539.4 2542.4 2546.2 2504.2 2505.7 2547.0 2548.5 2550.9 2463.1 2478.4 2484.9 2490.4 2502.0 2420.2 2443.6 2480.4 2480.9 2481.1 8749.7 8803.8 8852.2 8923.2 8934.5 5503.7 5752.8 5758.8 5763.6 5765.9 3759.3 3783.2 3842.7 3892.2 3898.6 1155.5 1177.8 1197.2 1208.0 1249.6 12530.1 12704.4 12715.6 12716.2 12720.9 4709.6 4746.7 4765.3 4809.0 4929.3 9745.2 9753.1 9770.2 9772.9 9785.1 5517.8 5521.4 5521.4 5521.5 5536.9 4403.0 4530.0 4794.3 5069.9 5225.6 4096.3 4117.9 4159.5 4200.2 4237.6 1289.8 1307.6 1308.5 1308.7 1328.1 983.4 1008.5 1015.2 1019.5 1037.5 5943.3 6184.1 6206.2 6259.8 6331.8 449.4 456.6 456.6 463.1 1038.3 4096.6 4234.8 4259.4 4290.0 4292.7 10914.8 11059.3 11239.9 11256.9 11280.2 11130.9 11132.4 11147.2 11147.9 11160.1 7776.4 7863.3 7887.4 8097.4 8408.3 6160.4 6216.8 6231.8 6262.1 6327.8 10201.5 10306.3 10314.9 10340.9 10356.3 9398.9 9701.8 10282.3 10358.7 10376.5 7540.8 7697.7 7698.1 7759.7 7933.2 8657.8 8832.0 8833.6 8890.4 8926.6 7877.9 7957.9 7996.6 8040.0 8122.4 7662.8 7730.9 7767.0 7785.5 8011.5 7347.0 7466.3 7476.0 7478.2 7478.4 5293.3 5416.4 5437.9 5490.1 5594.9 5476.9 5483.7 5525.8 5609.0 5623.0 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | [#4] prototype.html Cycles:180 Average:4782.19 Median:5377.54 stddev:1398.43 (26.0%) stddev-sans-first:1362.09 08:30:40 INFO - PROCESS | 24992 | Values: 343.6 354.9 358.8 359.3 362.3 5477.5 5480.0 5504.2 5505.6 5562.4 5363.3 5384.6 5451.7 5503.8 5527.7 3786.4 4035.8 4160.7 4265.0 4269.2 4286.1 4289.6 4293.0 4295.4 4301.4 4270.8 4273.6 4277.6 4284.6 4287.3 4057.4 4103.3 4243.8 4258.4 4321.9 3758.7 3781.4 3785.7 3796.3 3815.5 5278.7 5293.3 5301.8 5309.6 5324.5 4728.6 4859.8 4867.1 4873.3 4895.9 5607.4 5633.2 5649.5 5655.2 5661.6 4040.3 4211.2 4212.5 4228.1 4243.2 5591.8 5702.1 5844.8 5874.7 5893.2 4110.9 4177.7 4193.5 4200.0 4207.5 4214.6 4248.7 4252.8 4252.9 4261.3 4661.0 4857.7 4865.8 4867.7 4875.2 5633.4 5691.5 5692.6 5694.9 5703.3 1426.6 1434.8 1449.5 1449.8 1451.6 958.6 1000.4 1007.7 1008.0 1023.9 5304.0 5312.8 5325.9 5328.6 5331.9 5607.3 5646.8 5648.9 5651.8 5657.3 5047.9 5256.0 5285.7 5307.5 5337.6 2962.7 2969.6 2972.9 2996.7 3005.0 5861.5 5862.4 5865.4 5867.0 5871.5 5668.9 5985.2 6038.9 6061.4 6061.8 6109.5 6114.4 6117.4 6122.3 6157.3 5623.4 5872.5 5901.4 5931.9 5963.9 5809.0 5811.2 5829.1 5841.2 5849.2 5732.9 5762.0 5938.0 5960.3 6086.3 4090.9 4160.8 4217.5 4233.5 4235.2 5790.3 5835.4 5866.4 5878.6 5880.8 5717.5 5728.6 5736.1 5741.7 5775.4 5669.7 5700.4 5705.9 5717.8 5717.9 5370.5 5525.7 5602.9 5637.6 5701.5 5650.8 5684.7 5690.2 5696.8 5701.1 5574.5 5595.8 5596.8 5600.3 5636.8 08:30:40 INFO - PROCESS | 24992 | 08:30:40 INFO - PROCESS | 24992 | [#5] yui.html Cycles:180 Average:18108.66 Median:4666.75 stddev:23749.08 (508.9%) stddev-sans-first:23780.09 08:30:40 INFO - PROCESS | 24992 | Values: 787.6 792.8 810.2 817.0 899.3 14374.6 15046.5 16044.3 16192.8 16255.9 14427.9 14617.9 14630.3 15106.6 15474.8 837.9 856.7 857.4 857.5 857.7 714.7 730.4 829.2 845.4 847.5 887.9 891.1 891.7 891.8 891.9 878.3 878.5 878.6 878.9 880.6 550.5 563.8 642.7 650.4 653.8 14768.6 14832.8 14838.6 14838.7 14845.9 13015.9 13295.0 13363.3 13491.6 13510.5 12223.5 12553.3 12617.1 12790.8 13025.0 4329.0 4354.3 4406.0 4461.8 4499.0 64185.7 64401.7 64554.7 64991.4 66591.7 11105.7 11637.4 11686.6 11727.8 11966.8 20052.9 20113.5 20281.6 20301.6 20393.3 8182.3 8192.7 8223.7 8246.8 8262.4 4802.4 4860.3 4866.8 4905.2 5111.7 3537.2 3632.2 3637.9 3639.2 3640.6 628.0 630.2 643.3 643.7 646.6 609.8 633.2 679.3 781.7 793.4 8669.7 9568.4 9595.0 9742.8 10014.1 663.5 670.6 715.0 725.2 733.1 4652.9 4680.6 4684.4 4696.2 4752.0 60597.0 88230.1 91560.0 94524.0 94680.5 78979.0 81473.0 83664.6 85038.6 86562.0 45105.3 65597.5 67110.3 74808.3 76820.2 10204.7 10377.6 10457.9 10601.3 10666.1 33322.8 41872.4 46447.0 47072.8 47094.5 59656.1 61314.4 61982.7 62668.0 64029.0 12445.3 12592.6 12995.7 13327.9 13426.5 14520.9 14621.6 14910.9 14955.0 15198.1 12828.2 12957.7 13149.6 13277.6 13721.0 13546.0 13996.7 14023.4 14134.3 14252.7 13215.2 13417.7 13529.9 13599.4 13606.5 11191.7 11193.0 11221.5 11336.2 11378.8 11088.2 11171.6 11526.1 11527.7 11686.2 08:30:40 INFO - PROCESS | 24992 | -------- Summary: end -------- 08:30:40 INFO - PROCESS | 24992 | 08:30:41 INFO - TEST-INFO | 24992: exit 0 08:30:41 INFO - TEST-OK | dromaeo_css | took 1117468ms 08:30:41 INFO - TEST-START | kraken 08:30:41 INFO - operating with platform_type : linux_ 08:30:41 INFO - Initialising browser for kraken test... 08:30:41 INFO - TEST-INFO | started process 25312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnk2Obc/profile http://localhost:52433/getInfo.html) 08:30:46 INFO - PROCESS | 25312 | __metrics Screen width/height:1600/1200 08:30:46 INFO - PROCESS | 25312 | colorDepth:24 08:30:46 INFO - PROCESS | 25312 | Browser inner width/height: 1024/697 08:30:46 INFO - PROCESS | 25312 | __metrics 08:30:47 INFO - PROCESS | 25312 | 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" 08:30:47 INFO - PROCESS | 25312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:30:48 INFO - PROCESS | 25312 | console.error: PushService: 08:30:48 INFO - PROCESS | 25312 | stateChangeProcessEnqueue: Error transitioning state 08:30:48 INFO - PROCESS | 25312 | UnknownError 08:30:49 INFO - TEST-INFO | 25312: exit 0 08:30:49 INFO - Browser initialized. 08:30:49 INFO - Running cycle 1/1 for kraken test... 08:30:49 INFO - TEST-INFO | started process 25403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnk2Obc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:00 INFO - PROCESS | 25403 | RSS: Main: 144134144 08:31:00 INFO - PROCESS | 25403 | 08:31:03 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52433/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:04 INFO - PROCESS | 25403 | RSS: Main: 185470976 08:31:04 INFO - PROCESS | 25403 | 08:31:06 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52433/tests/kraken/driver.html?testName=audio-dft) 08:31:07 INFO - PROCESS | 25403 | RSS: Main: 174133248 08:31:07 INFO - PROCESS | 25403 | 08:31:10 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52433/tests/kraken/driver.html?testName=audio-fft) 08:31:10 INFO - PROCESS | 25403 | RSS: Main: 265580544 08:31:10 INFO - PROCESS | 25403 | 08:31:12 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52433/tests/kraken/driver.html?testName=audio-oscillator) 08:31:13 INFO - PROCESS | 25403 | RSS: Main: 172818432 08:31:13 INFO - PROCESS | 25403 | 08:31:15 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52433/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:16 INFO - PROCESS | 25403 | RSS: Main: 175116288 08:31:16 INFO - PROCESS | 25403 | 08:31:19 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52433/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:19 INFO - PROCESS | 25403 | RSS: Main: 213917696 08:31:19 INFO - PROCESS | 25403 | 08:31:23 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52433/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:23 INFO - PROCESS | 25403 | RSS: Main: 212860928 08:31:23 INFO - PROCESS | 25403 | 08:31:26 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52433/tests/kraken/driver.html?testName=json-parse-financial) 08:31:26 INFO - PROCESS | 25403 | RSS: Main: 210866176 08:31:26 INFO - PROCESS | 25403 | 08:31:28 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52433/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:31:28 INFO - PROCESS | 25403 | RSS: Main: 173154304 08:31:28 INFO - PROCESS | 25403 | 08:31:30 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:31:31 INFO - PROCESS | 25403 | RSS: Main: 179888128 08:31:31 INFO - PROCESS | 25403 | 08:31:33 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:31:33 INFO - PROCESS | 25403 | RSS: Main: 189341696 08:31:33 INFO - PROCESS | 25403 | 08:31:36 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:31:37 INFO - PROCESS | 25403 | RSS: Main: 197931008 08:31:37 INFO - PROCESS | 25403 | 08:31:39 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:31:40 INFO - PROCESS | 25403 | RSS: Main: 194019328 08:31:40 INFO - PROCESS | 25403 | 08:31:41 INFO - PROCESS | 25403 | Cycle 1(1): loaded http://localhost:52433/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52433/tests/kraken/driver.html?testName=ai-astar) 08:31:42 INFO - PROCESS | 25403 | RSS: Main: 245342208 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | __start_tp_report 08:31:42 INFO - PROCESS | 25403 | _x_x_mozilla_page_load 08:31:42 INFO - PROCESS | 25403 | _x_x_mozilla_page_load_details 08:31:42 INFO - PROCESS | 25403 | |i|pagename|runs| 08:31:42 INFO - PROCESS | 25403 | |0;ai-astar;108;113;112;112;112;111;110;113;110;111 08:31:42 INFO - PROCESS | 25403 | |1;audio-beat-detection;149;118;116;157;124;119;117;121;144;118 08:31:42 INFO - PROCESS | 25403 | |2;audio-dft;162;161;161;161;161;164;162;162;162;160 08:31:42 INFO - PROCESS | 25403 | |3;audio-fft;75;75;75;113;75;76;76;76;104;76 08:31:42 INFO - PROCESS | 25403 | |4;audio-oscillator;82;82;116;81;83;81;98;82;82;113 08:31:42 INFO - PROCESS | 25403 | |5;imaging-gaussian-blur;118;117;117;116;116;117;117;116;116;117 08:31:42 INFO - PROCESS | 25403 | |6;imaging-darkroom;146;146;146;147;146;145;146;147;147;146 08:31:42 INFO - PROCESS | 25403 | |7;imaging-desaturate;86;84;84;85;85;84;85;85;84;84 08:31:42 INFO - PROCESS | 25403 | |8;json-parse-financial;48;51;49;50;49;50;50;49;49;49 08:31:42 INFO - PROCESS | 25403 | |9;json-stringify-tinderbox;58;60;59;59;61;59;59;59;59;59 08:31:42 INFO - PROCESS | 25403 | |10;stanford-crypto-aes;75;83;74;76;82;75;74;75;81;75 08:31:42 INFO - PROCESS | 25403 | |11;stanford-crypto-ccm;124;121;123;133;121;128;121;131;173;131 08:31:42 INFO - PROCESS | 25403 | |12;stanford-crypto-pbkdf2;157;156;156;160;153;154;154;156;156;157 08:31:42 INFO - PROCESS | 25403 | |13;stanford-crypto-sha256-iterative;63;63;64;64;62;65;63;62;62;62 08:31:42 INFO - PROCESS | 25403 | __end_tp_report 08:31:42 INFO - PROCESS | 25403 | __start_cc_report 08:31:42 INFO - PROCESS | 25403 | _x_x_mozilla_cycle_collect,1597 08:31:42 INFO - PROCESS | 25403 | __end_cc_report 08:31:42 INFO - PROCESS | 25403 | __startTimestamp1481819502207__endTimestamp 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | ------- Summary: start ------- 08:31:42 INFO - PROCESS | 25403 | Number of tests: 14 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:1.55 (1.4%) stddev-sans-first:1.13 08:31:42 INFO - PROCESS | 25403 | Values: 108.0 113.0 112.0 112.0 112.0 111.0 110.0 113.0 110.0 111.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#1] audio-beat-detection Cycles:10 Average:128.30 Median:122.50 stddev:15.45 (12.6%) stddev-sans-first:14.46 08:31:42 INFO - PROCESS | 25403 | Values: 149.0 118.0 116.0 157.0 124.0 119.0 117.0 121.0 144.0 118.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 08:31:42 INFO - PROCESS | 25403 | Values: 162.0 161.0 161.0 161.0 161.0 164.0 162.0 162.0 162.0 160.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:14.08 (18.7%) stddev-sans-first:14.70 08:31:42 INFO - PROCESS | 25403 | Values: 75.0 75.0 75.0 113.0 75.0 76.0 76.0 76.0 104.0 76.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:13.89 (16.9%) stddev-sans-first:14.43 08:31:42 INFO - PROCESS | 25403 | Values: 82.0 82.0 116.0 81.0 83.0 81.0 98.0 82.0 82.0 113.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.53 08:31:42 INFO - PROCESS | 25403 | Values: 118.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:31:42 INFO - PROCESS | 25403 | Values: 146.0 146.0 146.0 147.0 146.0 145.0 146.0 147.0 147.0 146.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.53 08:31:42 INFO - PROCESS | 25403 | Values: 86.0 84.0 84.0 85.0 85.0 84.0 85.0 85.0 84.0 84.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.50 stddev:0.84 (1.7%) stddev-sans-first:0.73 08:31:42 INFO - PROCESS | 25403 | Values: 48.0 51.0 49.0 50.0 49.0 50.0 50.0 49.0 49.0 49.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.79 (1.3%) stddev-sans-first:0.71 08:31:42 INFO - PROCESS | 25403 | Values: 58.0 60.0 59.0 59.0 61.0 59.0 59.0 59.0 59.0 59.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:75.50 stddev:3.53 (4.7%) stddev-sans-first:3.67 08:31:42 INFO - PROCESS | 25403 | Values: 75.0 83.0 74.0 76.0 82.0 75.0 74.0 75.0 81.0 75.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:129.50 stddev:15.59 (12.0%) stddev-sans-first:16.36 08:31:42 INFO - PROCESS | 25403 | Values: 124.0 121.0 123.0 133.0 121.0 128.0 121.0 131.0 173.0 131.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.00 stddev:1.97 (1.3%) stddev-sans-first:2.05 08:31:42 INFO - PROCESS | 25403 | Values: 157.0 156.0 156.0 160.0 153.0 154.0 154.0 156.0 156.0 157.0 08:31:42 INFO - PROCESS | 25403 | 08:31:42 INFO - PROCESS | 25403 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.05 (1.7%) stddev-sans-first:1.12 08:31:42 INFO - PROCESS | 25403 | Values: 63.0 63.0 64.0 64.0 62.0 65.0 63.0 62.0 62.0 62.0 08:31:42 INFO - PROCESS | 25403 | -------- Summary: end -------- 08:31:42 INFO - PROCESS | 25403 | 08:31:43 INFO - TEST-INFO | 25403: exit 0 08:31:43 INFO - TEST-OK | kraken | took 61990ms 08:31:43 INFO - SUITE-END | took 1179s 08:31:43 INFO - Completed test suite (00:19:39) 08:31:43 INFO - javascript benchmark 08:31:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3292.4073666739987, 3325.1520862180155, 3325.650806665301, 3333.7333013358902, 3359.5296658467805, 5644.181593668921, 5702.429757024295, 5726.942730572699, 5730.7707691692285, 5745.59780815342, 5782.739776710047, 5826.854328641786, 5829.650220986733, 5832.533397328214, 5838.065909454488, 5207.192885102796, 5247.86880327991, 5264.0, 5268.710220937847, 5317.601179911503, 5126.615503837208, 5312.840614781563, 5320.042392369372, 5323.494268044549, 5354.116570765819, 5120.4623514530995, 5178.922316165261, 5180.197069454241, 5180.611454140936, 5214.8696282592855, 5236.6857988520815, 5262.0, 5265.605079619006, 5337.6797392156595, 5338.225957236218, 5161.019406312788, 5186.403563590197, 5251.212318152269, 5289.629725919187, 5290.894182116374, 5605.187247849039, 5630.634008789457, 5641.379448260688, 5668.121441176624, 5709.25779648643, 6066.332703402622, 6087.604305720159, 6095.847603809896, 6188.071789231606, 6190.0405437157315, 6231.813045608639, 6246.937530624681, 6260.217472815898, 6267.6866156691985, 6267.780627678055, 5623.156526521014, 5664.490195882349, 5681.801136960186, 5712.742926568314, 5739.225204597409, 6333.1241220599, 6338.714757835816, 6369.5222858285815, 6374.426301632782, 6376.808695739135, 6028.367021462684, 6079.331273559905, 6084.756609735561, 6085.117657939662, 6086.239220097488, 5989.401059894063, 6040.486558642477, 6076.574639775174, 6114.0, 6117.449429551361, 6165.815025549241, 6181.876362472815, 6182.319944806068, 6188.350223226586, 6188.381161883775, 6144.078388241799, 6170.81487555374, 6227.844303892349, 6233.252009758858, 6234.5635805494085, 4671.299305104261, 4683.227267500893, 4696.741679207608, 4746.454157771831, 4829.058333624909, 4234.364845273172, 4269.359596060615, 4285.0358669299785, 4286.335617979218, 4286.464191976003, 5839.124131380242, 5846.356900740915, 5846.678432686158, 5846.824595262149, 5849.561282903799, 5987.6108052976415, 6252.718627661766, 6262.655553944485, 6263.686815659199, 6270.843228919313, 5693.886122277531, 5764.5676574257095, 5785.30576330843, 5815.098659707667, 5908.793192238251, 5362.705051222142, 5370.704611246419, 5423.105187644073, 5430.809921652803, 5432.266644003009, 6477.77327793525, 6485.319041500763, 6486.254080780771, 6494.318096599978, 6494.480441564663, 5979.162917191509, 5994.0, 6106.389361063858, 6131.63210207389, 6144.692765361625, 6406.359364063556, 6409.391107844747, 6412.935870641234, 6419.903701444576, 6426.518011149089, 6028.457438830526, 6033.939660603338, 6035.547333949883, 6037.124616930609, 6040.0939859019745, 5934.109883517507, 6055.6063855849225, 6083.6349819011, 6099.603525770811, 6174.043023331391, 6053.757849685963, 6055.788047418319, 6069.817905462844, 6076.088586711851, 6076.969615151896, 6013.639181649115, 6025.276966763841, 6032.54755893301, 6042.758289668364, 6042.848928776816, 5751.252337196138, 5866.266716660418, 5925.703714814156, 5956.166136740773, 5968.164456976114, 6039.849003774765, 6103.664298463627, 6105.450509453993, 6110.633361998294, 6127.877442451215, 5910.349861515144, 5970.611910225822, 5974.671393073423, 5981.641101533748, 6011.489023433057], "value": 5686.384791140186, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.1445325957252, 604.0908432808623, 633.3096924352454, 642.8489305013323, 655.2268323378414, 44357.11285774287, 45524.54475455249, 45525.54474455254, 45543.0, 47540.52459475404, 46299.0, 46647.533524664745, 46650.76674616622, 46681.533184668144, 46946.0, 8260.793480162984, 8467.237948584627, 8652.61063252152, 8783.077776833436, 8801.867971980426, 10475.109615682675, 10730.248882578222, 10730.946345268301, 10999.725006874813, 11008.669739907775, 10740.0, 10839.349639021644, 10843.295185812936, 10844.024037836592, 10847.728806779854, 10693.946530267376, 10694.839577406345, 10736.57053717858, 10742.516586753576, 10751.569937202503, 10610.416427096507, 10703.929607039312, 10709.143268538499, 10713.410762408064, 10714.571417143305, 43765.12469750619, 44475.332870006976, 44508.3323750144, 44530.109397812186, 44738.10523789506, 3684.6868016218655, 3843.846246150151, 3899.512560929884, 3981.3231750602467, 4038.3942408638645, 32159.0, 32350.838245808856, 32770.0, 33853.15367115817, 34277.14307142316, 4355.716878402925, 4384.320430333303, 4402.273624851896, 4404.581564751344, 4521.276595744665, 368770.0, 369499.0, 372207.0, 372748.0, 374202.99999999726, 60302.396976029675, 60426.395736042075, 60676.69661651664, 60782.69608651928, 60792.0, 39215.60784392177, 40097.39853902194, 40224.597754022085, 42630.57369426328, 63339.683301583194, 18507.629847403245, 18640.254389824528, 18679.81320186808, 18695.252189912524, 18705.906470467562, 13481.730365392637, 13678.452861885613, 13787.655308617164, 13790.0, 13809.378577963815, 19770.901145494467, 20380.38858834237, 20509.2821751238, 21210.893945530483, 21212.681809772865, 7004.789856304319, 7103.325184107502, 7165.641717914188, 7234.6020968847215, 7425.85148297031, 1003.7340104872214, 1043.4521876015153, 1050.4800123938699, 1055.6621880998007, 1092.8633920759905, 34111.31777364439, 34253.486197707054, 34320.656793432245, 34416.0, 34598.82700586481, 1133.7109037195462, 1145.3128123126223, 1147.4148184426003, 1156.0924674130767, 1179.0913122997238, 17825.0, 17841.643167136586, 18042.368517101837, 18071.548211294823, 18081.547961301072, 559180.0, 565305.0, 566556.0, 566890.0, 567160.0, 61685.0, 62280.68859655673, 62645.0, 62861.37138628647, 62876.0, 1298.6818229533824, 1347.2994043097535, 1352.8511863695182, 1418.2625034981959, 1433.6129245103764, 27919.581206282328, 33641.495377569845, 34614.82692586521, 36841.078973024814, 36847.815760921025, 56892.0, 57313.0, 57342.13986790285, 57356.0, 57363.71318143383, 502819.0, 504640.0, 505476.0, 505718.0, 507060.0, 26664.866675666497, 27470.35177889333, 28095.43809123847, 29277.85361073181, 30492.237694057825, 47873.521264786905, 48213.0, 48662.5133748658, 48962.51037489722, 48996.2650560249, 40476.1904761909, 42112.15775684531, 42980.69865703909, 45383.54616453793, 45639.771801140785, 42325.0, 42552.361714573686, 42900.78549607232, 44060.559394405645, 44442.11115777731, 42503.574964249965, 43785.34321985109, 43976.78011609922, 44339.11321773482, 44365.77817110894, 36156.27687446289, 38391.808040960736, 38450.230995379374, 38729.4190587147, 39075.80462097671, 28387.0, 29274.414511710074, 29791.702082978893, 29819.0, 30809.8459507701], "value": 21313.00854422145, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [420.9684273679471, 427.83994674029026, 433.25047667535165, 438.78280251275623, 444.41115521933426, 18628.348007819728, 20369.694454583194, 20470.692939605917, 20903.37289881302, 20995.265165719164, 19300.806991930076, 20119.798802011974, 20186.39440816778, 20395.898020509914, 20642.999999999964, 5720.2849643794525, 6000.099985002241, 6005.87988240235, 6012.128241405016, 6020.157177995085, 5724.398938111501, 5815.214945982301, 5831.650100993933, 5856.033754430514, 5894.056950887859, 5796.420357964191, 5802.651840889539, 5806.767729290823, 5808.651480911159, 5808.912866307009, 5641.289010106853, 5874.765009399619, 5936.050231962909, 5960.374160713106, 5962.105684147391, 5202.297689811865, 5366.087765079946, 5369.516743493065, 5370.43610420904, 5377.435369286208, 23254.3023709289, 23486.882565587235, 23760.287191384286, 24025.27924162278, 24415.0, 2521.621756736486, 2539.2255362114547, 2566.268613445159, 2762.709915458868, 2880.2943278896596, 7356.77929662111, 14671.16610423697, 14899.553013409506, 14910.62723431912, 15051.0, 1865.2259312385345, 1882.6893562562161, 1939.3309308288617, 1950.1711772496774, 1983.633027889845, 56467.71766141184, 77888.0, 80286.0, 82474.58762706208, 94308.52845735727, 10255.692329230134, 10590.682279531626, 10598.417087060287, 10660.94669526663, 11425.542978280942, 13858.475567687547, 14494.782578261334, 14601.92699036498, 14630.561083167522, 14633.634159146106, 8534.359923005799, 8633.913660863436, 8636.0, 8765.211130998241, 8850.0, 8448.619812108469, 8489.872651910226, 8499.235068843835, 8560.0, 8669.176428239307, 6806.965965170142, 6884.931150688429, 6905.861882762417, 6955.408790252885, 7115.1106111736035, 1916.8945707985915, 1961.852861035428, 1997.10130441302, 2005.6891181866833, 2035.0, 928.8606708993705, 980.5734505490135, 984.7341217871278, 1038.7922415516928, 1079.5627770752858, 19658.670342678353, 20193.798062019192, 20224.797752022292, 20636.484087897923, 20780.58438831215, 1052.7736536644659, 1058.6506452870535, 1093.4696672114019, 1109.7724966381872, 1110.3948348150277, 10662.520186591622, 11571.0, 11757.529698812123, 11793.52825886955, 11793.941030294794, 471188.0, 472396.0, 476380.0, 482798.0, 483237.0, 51971.0, 63050.0542491863, 85965.57017215, 89129.55435222782, 89841.0, 1041.271110222847, 1057.2335057083553, 1063.9521221545049, 1064.4518073192312, 1066.7706443114612, 17407.738883917005, 17926.282948681906, 18341.633167336844, 18364.265429382674, 18432.0, 40478.392824107075, 40786.79606601948, 41206.587934120274, 41543.0, 41800.37299440572, 54168.45831541634, 54315.72842135764, 54444.0, 55546.44453555575, 55957.16064258958, 8681.609327580149, 8712.303015758851, 8734.388592798698, 8872.556372181494, 8925.687600933936, 12383.257004579755, 12798.296093714935, 12808.231506109663, 12930.482780688668, 13099.035144728367, 10755.193360497837, 11105.611303604659, 11278.887211127783, 11446.313221206754, 11808.350540720343, 10752.193585481276, 10788.838167427652, 10794.0, 11107.611233606785, 11499.137564682514, 11601.361925094201, 11737.002354799937, 11891.940540297242, 11894.107941904565, 12537.185082969578, 8907.242884354644, 9054.773630659287, 9076.863847042432, 9197.034311397474, 9199.678011269574, 11706.297622142698, 11750.70623234426, 11920.582779602672, 12036.699082523008, 12285.201461904948], "value": 9506.759443849694, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1352.2832898563752, 1464.5313499680108, 1511.3652266048261, 1644.3093900561762, 1830.6247219320041, 7793.454458187922, 8598.22615964564, 8862.202401783838, 8870.112988701134, 9187.494687792168, 8971.05803890592, 9048.502332371718, 9052.275817934566, 9066.501342426163, 9077.546122693871, 2492.3395300245406, 2519.4961007798515, 2524.406764410362, 2524.6591710119083, 2528.15306872198, 2442.511497700458, 2536.3405514566252, 2539.415934335104, 2542.427953710419, 2546.1852207293673, 2504.161106029473, 2505.7243703192635, 2547.0066673997158, 2548.5412625727363, 2550.8852101655375, 2463.07634637012, 2478.4423504711476, 2484.925452236436, 2490.414752533153, 2502.049221295905, 2420.165043060141, 2443.645671377658, 2480.4419005723566, 2480.8511489310517, 2481.1192026830395, 8749.693760718344, 8803.77990550235, 8852.203301702877, 8923.15230053144, 8934.508602026886, 5503.697296648683, 5752.769889204426, 5758.79844205455, 5763.625364351304, 5765.913511297334, 3759.3233218020746, 3783.2193337896624, 3842.731008829383, 3892.1826416452577, 3898.649121579043, 1155.4858088150777, 1177.8292147638545, 1197.15600501647, 1207.96376108716, 1249.5938819883575, 12530.122891397607, 12704.428300726397, 12715.55495557651, 12716.173448725804, 12720.936395317964, 4709.576138147515, 4746.740671232032, 4765.332853400527, 4809.0, 4929.3345398371475, 9745.171660408803, 9753.122219000325, 9770.169535589555, 9772.902270977342, 9785.119339259501, 5517.806876759294, 5521.3926468088475, 5521.420250873681, 5521.503064724194, 5536.86157846049, 4402.955970440319, 4529.977350113294, 4794.256890182028, 5069.949300506948, 5225.608079394061, 4096.250589529969, 4117.8970525737095, 4159.46257920368, 4200.243956087872, 4237.63980061692, 1289.8323217981601, 1307.5881097454271, 1308.535469908188, 1308.7382523495148, 1328.0637150808657, 983.3509883477014, 1008.5461542305992, 1015.1878497202209, 1019.5208252121491, 1037.5331101004579, 5943.3462319144855, 6184.103305020747, 6206.224221972254, 6259.843503912348, 6331.841703957438, 449.3933190193213, 456.6324109092146, 456.63697360598405, 463.11776066593194, 1038.314712289885, 4096.631303182728, 4234.788260586958, 4259.424977628042, 4290.0, 4292.678049146327, 10914.836277455845, 11059.281146725438, 11239.887601124048, 11256.943715281372, 11280.210385273116, 11130.944345278222, 11132.443377831076, 11147.163962702667, 11147.94426027881, 11160.051395631463, 7776.377889768805, 7863.252990965849, 7887.408444366695, 8097.352211823158, 8408.32733381328, 6160.375474335787, 6216.751329946752, 6231.813045608639, 6262.060690896402, 6327.841803954754, 10201.489925503547, 10306.278560500694, 10314.948425257826, 10340.948295258475, 10356.275060745675, 9398.906010939803, 9701.757456063655, 10282.331648442827, 10358.741031474274, 10376.481175941324, 7540.8491830164185, 7697.653605587874, 7698.07623085211, 7759.650815713419, 7933.206679332021, 8657.783555411164, 8832.0, 8833.558322083998, 8890.422122562013, 8926.553672316228, 7877.881831772643, 7957.920420795718, 7996.640151193326, 8039.959800200962, 8122.350211982909, 7662.8084297893, 7730.884036739341, 7767.0, 7785.532868027936, 8011.519308841488, 7346.96326518364, 7466.328030477283, 7476.0, 7478.177400486051, 7478.364339031244, 5293.2589437479555, 5416.4041955385665, 5437.891242175056, 5490.149026900836, 5594.86012849682, 5476.863078422912, 5483.7258137092185, 5525.778968841362, 5609.0, 5623.0], "value": 4746.38871711832, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.5722525455808, 354.92901419716065, 358.78831489421253, 359.3477837724529, 362.31160794490467, 5477.452254774521, 5479.972600136994, 5504.174373843925, 5505.614606977513, 5562.415946325638, 5363.275957745703, 5384.623076384654, 5451.727413629323, 5503.7807277776055, 5527.668339899609, 3786.4131059685656, 4035.8183881725317, 4160.687948403866, 4265.0, 4269.167512335081, 4286.0999190170105, 4289.5924887135825, 4292.97853510732, 4295.355696645497, 4301.397804307399, 4270.829166833323, 4273.615374616284, 4277.631158029431, 4284.592963668447, 4287.31402975524, 4057.3711074783455, 4103.281925662997, 4243.832945939891, 4258.444933040182, 4321.935170972422, 3758.7180961428003, 3781.4138808484727, 3785.7160712946365, 3796.3356412627954, 3815.503984482027, 5278.653943244486, 5293.258943747878, 5301.8070934039915, 5309.601779866525, 5324.54741346986, 4728.574428301469, 4859.805607775685, 4867.148249056437, 4873.34209881665, 4895.853124406273, 5607.355154157283, 5633.15502674598, 5649.4633009864, 5655.208270842086, 5661.575381846337, 4040.272750904836, 4211.157768446323, 4212.452381190456, 4228.090960443488, 4243.172581346638, 5591.832245032656, 5702.116171993348, 5844.766209351621, 5874.706264686792, 5893.174955506232, 4110.897227569335, 4177.6866734995, 4193.454850869368, 4199.979000105041, 4207.516135644379, 4214.557471465513, 4248.660107191417, 4252.808623611945, 4252.872413827528, 4261.339492378686, 4660.976695116503, 4857.708537487762, 4865.781039853215, 4867.70793752376, 4875.219964805614, 5633.436656334416, 5691.459311365414, 5692.601517893708, 5694.857628559319, 5703.344115426696, 1426.587678198576, 1434.8278206615064, 1449.5289031064947, 1449.7680371140566, 1451.5790420778067, 958.5908714190268, 1000.3747657713928, 1007.6825799873017, 1007.9798404031878, 1023.9095363437915, 5304.037506122682, 5312.76092575835, 5325.920111198335, 5328.573714102862, 5331.920021199685, 5607.261748857867, 5646.809552602766, 5648.870225954825, 5651.802186923438, 5657.321121465368, 5047.87380315495, 5255.975084858493, 5285.735713214324, 5307.487366100643, 5337.62636615441, 2962.718706595952, 2969.599104120959, 2972.895948641787, 2996.6853480384248, 3005.0, 5861.531077513789, 5862.355140934494, 5865.35481097079, 5867.0, 5871.4715675589405, 5668.914966275509, 5985.191999080069, 6038.879222415527, 6061.424164704346, 6061.757529698851, 6109.47263184204, 6114.449699527064, 6117.388261173847, 6122.326544080148, 6157.261128664589, 5623.381428042994, 5872.500837428866, 5901.350851406428, 5931.851703707442, 5963.940360596512, 5808.970955145197, 5811.1573821794755, 5829.125631155361, 5841.153032810304, 5849.151872978479, 5732.942670573241, 5761.971190144022, 5937.960856849948, 5960.254968128984, 6086.3000754913755, 4090.852302541071, 4160.791960402028, 4217.481706585565, 4233.491980962304, 4235.216484950294, 5790.305163380422, 5835.387284335084, 5866.413358664099, 5878.559108066826, 5880.8235752927485, 5717.540887762843, 5728.627639203439, 5736.139579063007, 5741.741621626953, 5775.393583673654, 5669.716514174357, 5700.429957004267, 5705.885882282414, 5717.828465146053, 5717.914231286617, 5370.4629537045985, 5525.723713814374, 5602.915956260578, 5637.57718171147, 5701.458361455655, 5650.830475085754, 5684.687342196219, 5690.174924635988, 5696.829095127153, 5701.144828275792, 5574.498295153456, 5595.76893083521, 5596.776128954796, 5600.327960644749, 5636.774529018958], "value": 4342.354902229659, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.6101329841725, 792.7553740627216, 810.1614828652342, 816.955067471289, 899.2536194958185, 14374.568762937102, 15046.473373431932, 16044.278007489662, 16192.83807161928, 16255.862089653743, 14427.927860360684, 14617.92691036546, 14630.34163462644, 15106.622334441645, 15474.767878481804, 837.8994520657499, 856.6701819799391, 857.3741168946673, 857.5326447086353, 857.7298151082389, 714.7069701422417, 730.390124246255, 829.1998221716043, 845.3533047218882, 847.4660963592928, 887.8934527856666, 891.0554811899408, 891.692366133686, 891.8171774786185, 891.9375643704943, 878.2754227762122, 878.5387671472464, 878.569500944539, 878.947263164209, 880.6257340630239, 550.4605486623132, 563.8139413993372, 642.6979319719725, 650.3561474140614, 653.8267359149829, 14768.55694329161, 14832.777508337384, 14838.554843354717, 14838.70322593553, 14845.851541484662, 13015.86984130156, 13295.0, 13363.331833408389, 13491.595252142451, 13510.527131550349, 12223.511059557695, 12553.309567973758, 12617.116801823877, 12790.808137877939, 13025.023123265793, 4329.0, 4354.346847972798, 4405.977970110161, 4461.821527138911, 4498.987727761228, 64185.67907160481, 64401.67799161021, 64554.67722661403, 64991.350086499006, 66591.66704166448, 11105.722356941142, 11637.418129093512, 11686.649400517997, 11727.824082638766, 11966.760664786656, 20052.89973550123, 20113.49716257076, 20281.594368112554, 20301.59396812085, 20393.286234981704, 8182.263596276244, 8192.713255036046, 8223.671053157927, 8246.752597422086, 8262.42163048593, 4802.399700037496, 4860.270959356054, 4866.829660961849, 4905.166121759309, 5111.744412779346, 3537.2218112015316, 3632.200915798573, 3637.890863274106, 3639.181184233579, 3640.6177351378255, 628.0422355907278, 630.19020558582, 643.3405759096963, 643.7457204404328, 646.6217262901162, 609.8167565309079, 633.2274624957545, 679.3172861274387, 781.734210368466, 793.3573805217792, 8669.696560620474, 9568.425894446216, 9594.952025239829, 9742.805143897082, 10014.148797352162, 663.4857985061616, 670.637855558003, 714.9928500715031, 725.1696807155882, 733.1385621894359, 4652.883677908079, 4680.625549955996, 4684.391029166187, 4696.248600224016, 4751.95248047522, 60597.0, 88230.11769882348, 91560.0, 94524.0, 94680.52659736657, 78979.0, 81473.0, 83664.58167709244, 85038.5748071268, 86562.0, 45105.32342014872, 65597.5147462057, 67110.32889671139, 74808.25191748122, 76820.2317976813, 10204.693859184237, 10377.584896604052, 10457.895421045996, 10601.25791194609, 10666.093382062612, 33322.83338583291, 41872.3719144207, 46447.0, 47072.7646361766, 47094.52905470901, 59656.10515842179, 61314.38685613087, 61982.69008654928, 62668.0, 64029.0395644075, 12445.25328480294, 12592.559260425842, 12995.740085198433, 13327.874091236105, 13426.462941482232, 14520.927395362956, 14621.634459138606, 14910.925445372704, 14955.0, 15198.088114712711, 12828.166169198972, 12957.740845182854, 13149.60551183466, 13277.601671949857, 13721.0, 13546.0, 13996.720065598834, 14023.439062437388, 14134.293285335898, 14252.71494570082, 13215.207087574776, 13417.66455838612, 13529.873388616566, 13599.388027538982, 13606.523771667944, 11191.66425007251, 11192.986660276498, 11221.495032723384, 11336.206465547333, 11378.829317560077, 11088.223824332219, 11171.608993685182, 11526.135539834379, 11527.711807204887, 11686.24039437434], "value": 7374.441397717771, "unit": "score"}], "name": "dromaeo_css", "value": 7479.902767840124, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 113.0, 112.0, 112.0, 112.0, 111.0, 110.0, 113.0, 110.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 116.0, 157.0, 124.0, 119.0, 117.0, 121.0, 144.0, 118.0], "value": 128.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 161.0, 164.0, 162.0, 162.0, 162.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 75.0, 76.0, 76.0, 76.0, 104.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 116.0, 81.0, 83.0, 81.0, 98.0, 82.0, 82.0, 113.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 147.0, 147.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 51.0, 49.0, 50.0, 49.0, 50.0, 50.0, 49.0, 49.0, 49.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 59.0, 61.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 74.0, 76.0, 82.0, 75.0, 74.0, 75.0, 81.0, 75.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 121.0, 123.0, 133.0, 121.0, 128.0, 121.0, 131.0, 173.0, 131.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 156.0, 156.0, 160.0, 153.0, 154.0, 154.0, 156.0, 156.0, 157.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 62.0, 65.0, 63.0, 62.0, 62.0, 62.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1455.8000000000002, "alertThreshold": 2.0}]} 08:31:43 INFO - Return code: 0 08:31:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:31:43 INFO - # TBPL SUCCESS # 08:31:43 INFO - Running post-action listener: _resource_record_post_action 08:31:43 INFO - [mozharness: 2016-12-15 16:31:43.498430Z] Finished run-tests step (success) 08:31:43 INFO - Running post-run listener: _resource_record_post_run 08:31:43 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 352043008; Read time: 16; Write time: 560624 08:31:43 INFO - TinderboxPrint: CPU usage
13.0% 08:31:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:31:43 INFO - TinderboxPrint: I/O write bytes / time
352,043,008 / 560,624 08:31:43 INFO - TinderboxPrint: CPU idle
8,311.1 (87.0%) 08:31:43 INFO - TinderboxPrint: CPU user
1,189.5 (12.4%) 08:31:43 INFO - TinderboxPrint: Swap in / out
0 / 0 08:31:43 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 108138496; Read time: 0; Write time: 249660 08:31:43 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 243904512; Read time: 16; Write time: 310964 08:31:44 INFO - Running post-run listener: _upload_blobber_files 08:31:44 INFO - Blob upload gear active. 08:31:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:31:44 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 08:31:44 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'] 08:31:44 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 08:31:44 INFO - (blobuploader) - INFO - Open directory for files ... 08:31:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:31:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:45 INFO - (blobuploader) - INFO - Done attempting. 08:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:31:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:46 INFO - (blobuploader) - INFO - Done attempting. 08:31:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:31:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:31:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:31:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:31:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:31:50 INFO - (blobuploader) - INFO - Done attempting. 08:31:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:31:50 INFO - Return code: 0 08:31:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:31:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:31:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb3e8b530e346a34fbd794bdc702530ce723be5a3666fe8a062858939be33d249c9ed1ad1059a39824d755e0792dcf66f44e0d5ad4dde7b61b97a6f151443543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa0592bd789e4fd05a244996eebcc85af205a9fb8f247158f6a6694d6371f9059b23d535eeca00b6b180e1de2ebadbefaf3c0b31e971a614771144d16e4a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2551f6634d0acf9d9d210c513552122c904169216cfe99a9943973f8e047fbe1c006f2c314144e8bdb8e55e3e5356d952d717f8deab819f2674f04d127d59db"} 08:31:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:31:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:31:50 INFO - Contents: 08:31:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb3e8b530e346a34fbd794bdc702530ce723be5a3666fe8a062858939be33d249c9ed1ad1059a39824d755e0792dcf66f44e0d5ad4dde7b61b97a6f151443543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa0592bd789e4fd05a244996eebcc85af205a9fb8f247158f6a6694d6371f9059b23d535eeca00b6b180e1de2ebadbefaf3c0b31e971a614771144d16e4a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2551f6634d0acf9d9d210c513552122c904169216cfe99a9943973f8e047fbe1c006f2c314144e8bdb8e55e3e5356d952d717f8deab819f2674f04d127d59db"} 08:31:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:31:50 INFO - Copying logs to upload dir... 08:31:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:31:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.680176 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-12-15 08:31:49.806305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 08:31:49.809420) ========= 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-1481812932.494275-299112558 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/eb3e8b530e346a34fbd794bdc702530ce723be5a3666fe8a062858939be33d249c9ed1ad1059a39824d755e0792dcf66f44e0d5ad4dde7b61b97a6f151443543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa0592bd789e4fd05a244996eebcc85af205a9fb8f247158f6a6694d6371f9059b23d535eeca00b6b180e1de2ebadbefaf3c0b31e971a614771144d16e4a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2551f6634d0acf9d9d210c513552122c904169216cfe99a9943973f8e047fbe1c006f2c314144e8bdb8e55e3e5356d952d717f8deab819f2674f04d127d59db"} build_url:https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011410 build_url: 'https://queue.taskcluster.net/v1/task/eNAuIzJgQZS76VhJ17BFxQ/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/eb3e8b530e346a34fbd794bdc702530ce723be5a3666fe8a062858939be33d249c9ed1ad1059a39824d755e0792dcf66f44e0d5ad4dde7b61b97a6f151443543", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aaa0592bd789e4fd05a244996eebcc85af205a9fb8f247158f6a6694d6371f9059b23d535eeca00b6b180e1de2ebadbefaf3c0b31e971a614771144d16e4a9a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2551f6634d0acf9d9d210c513552122c904169216cfe99a9943973f8e047fbe1c006f2c314144e8bdb8e55e3e5356d952d717f8deab819f2674f04d127d59db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-15 08:31:49.834040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:31:49.834361) ========= 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-1481812932.494275-299112558 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-15 08:31:49.916829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 08:31:49.917145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-15 08:31:49.917436) ========= ========= Total master_lag: 0.17 =========