builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1476493603.62 results: success (0) buildid: 20161014145716 builduid: 4eb7d28fb2a24b2886145bed4075e561 revision: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.617483) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.618162) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.618773) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.649299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.649947) ========= 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-1476491548.922296-1655581212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 18:06:43-- 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% 39.5M=0s 2016-10-14 18:06:43 (39.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077864 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.748414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.748692) ========= 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-1476491548.922296-1655581212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021961 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.800694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:43.801018) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 --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-1476491548.922296-1655581212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 18:06:44,056 truncating revision to first 12 chars 2016-10-14 18:06:44,056 Setting DEBUG logging. 2016-10-14 18:06:44,056 attempt 1/10 2016-10-14 18:06:44,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6ed5592738b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 18:06:44,582 unpacking tar archive at: fx-team-6ed5592738b6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.841761 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:44.656730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:44.657097) ========= script_repo_revision: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:44.657490) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:44.657797) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 18:06:44.672157) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 18:06:44.672597) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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-1476491548.922296-1655581212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:06:45 INFO - MultiFileLogger online at 20161014 18:06:45 in /builds/slave/test 18:06:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:06:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:06:45 INFO - {'append_to_log': False, 18:06:45 INFO - 'base_work_dir': '/builds/slave/test', 18:06:45 INFO - 'blob_upload_branch': 'Fx-Team', 18:06:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:06:45 INFO - 'branch': 'Fx-Team', 18:06:45 INFO - 'buildbot_json_path': 'buildprops.json', 18:06:45 INFO - 'config_files': ('talos/linux_config.py',), 18:06:45 INFO - 'default_actions': ('clobber', 18:06:45 INFO - 'read-buildbot-config', 18:06:45 INFO - 'download-and-extract', 18:06:45 INFO - 'populate-webroot', 18:06:45 INFO - 'create-virtualenv', 18:06:45 INFO - 'install', 18:06:45 INFO - 'run-tests'), 18:06:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:06:45 INFO - 'download_minidump_stackwalk': True, 18:06:45 INFO - 'download_symbols': 'ondemand', 18:06:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:06:45 INFO - 'tooltool.py': '/tools/tooltool.py', 18:06:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:06:45 INFO - '/tools/misc-python/virtualenv.py')}, 18:06:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:06:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:06:45 INFO - 'installer_path': 'installer.exe', 18:06:45 INFO - 'log_level': 'info', 18:06:45 INFO - 'log_name': 'talos', 18:06:45 INFO - 'log_to_console': True, 18:06:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:06:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:06:45 INFO - 'opt_config_files': (), 18:06:45 INFO - 'pip_index': False, 18:06:45 INFO - 'sps_profile': False, 18:06:45 INFO - 'sps_profile_interval': 0, 18:06:45 INFO - 'suite': 'dromaeojs-e10s', 18:06:45 INFO - 'system_bits': '32', 18:06:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:06:45 INFO - 'title': 'talos-linux64-ix-011', 18:06:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:06:45 INFO - 'use_talos_json': True, 18:06:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:06:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:06:45 INFO - 'work_dir': 'build'} 18:06:45 INFO - [mozharness: 2016-10-15 01:06:45.034719Z] Running clobber step. 18:06:45 INFO - Running pre-action listener: _resource_record_pre_action 18:06:45 INFO - Running main action method: clobber 18:06:45 INFO - rmtree: /builds/slave/test/build 18:06:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:06:45 INFO - Running post-action listener: _resource_record_post_action 18:06:45 INFO - [mozharness: 2016-10-15 01:06:45.499096Z] Finished clobber step (success) 18:06:45 INFO - [mozharness: 2016-10-15 01:06:45.499197Z] Running read-buildbot-config step. 18:06:45 INFO - Running pre-action listener: _resource_record_pre_action 18:06:45 INFO - Running main action method: read_buildbot_config 18:06:45 INFO - Using buildbot properties: 18:06:45 INFO - { 18:06:45 INFO - "project": "", 18:06:45 INFO - "product": "firefox", 18:06:45 INFO - "script_repo_revision": "production", 18:06:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:06:45 INFO - "repository": "", 18:06:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 18:06:45 INFO - "buildid": "20161014145716", 18:06:45 INFO - "pgo_build": "True", 18:06:45 INFO - "basedir": "/builds/slave/test", 18:06:45 INFO - "buildnumber": 1246, 18:06:45 INFO - "slavename": "talos-linux64-ix-011", 18:06:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:06:45 INFO - "platform": "ubuntu64_hw", 18:06:45 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 18:06:45 INFO - "branch": "fx-team", 18:06:45 INFO - "repo_path": "integration/fx-team", 18:06:45 INFO - "revision": "6ed5592738b6c40ea8aefcf8b699de9f60f30a91", 18:06:45 INFO - "stage_platform": "linux64-pgo", 18:06:45 INFO - "builduid": "4eb7d28fb2a24b2886145bed4075e561", 18:06:45 INFO - "slavebuilddir": "test" 18:06:45 INFO - } 18:06:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:06:45 INFO - Running post-action listener: _resource_record_post_action 18:06:45 INFO - [mozharness: 2016-10-15 01:06:45.501633Z] Finished read-buildbot-config step (success) 18:06:45 INFO - [mozharness: 2016-10-15 01:06:45.501722Z] Running download-and-extract step. 18:06:45 INFO - Running pre-action listener: _resource_record_pre_action 18:06:45 INFO - Running main action method: download_and_extract 18:06:45 INFO - mkdir: /builds/slave/test/build/tests 18:06: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')]} 18:06:45 INFO - trying https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:06:45 INFO - Downloading https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:06:46 INFO - Downloaded 1361 bytes. 18:06:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:06:46 INFO - Using the following test package requirements: 18:06:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:06:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:06:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:06:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'jsshell-linux-x86_64.zip'], 18:06:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:06:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:06:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:06:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:06:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:06:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:06:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:06:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:06:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:06:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:06:46 INFO - Fetch https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:06:47 INFO - Http code: 200 18:06:47 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 18:06:47 INFO - x-amz-cf-id: 27uJxgG1yfUgkI3JmqurxocBvriwWXA6vNV5Y3NPmBnn8_1kkyt-XA== 18:06:47 INFO - x-amz-version-id: LpjdAhGednnkqzIdfY8auFcU7uxALZp_ 18:06:48 INFO - Expected file size: 22123369 18:06:48 INFO - Obtained file size: 22123369 18:06:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:06:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:06:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:06:52 INFO - Fetch https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:06:52 INFO - Http code: 200 18:06:52 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 18:06:52 INFO - x-amz-cf-id: 3U7w-hjnw9nC3zkPjYpMq9S1pzmaiYEhn5k1PIPd5KmD3bKqMFN_Sg== 18:06:52 INFO - x-amz-version-id: LpjdAhGednnkqzIdfY8auFcU7uxALZp_ 18:06:53 INFO - Expected file size: 22123369 18:06:53 INFO - Obtained file size: 22123369 18:06:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:06:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:06:57 INFO - Fetch https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:06:58 INFO - Http code: 200 18:06:58 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 18:06:58 INFO - x-amz-cf-id: m9DgPynFmboDKJDI-aFMX9rYTavQ4UDREf0pExPY20b6xg_kW3gUXA== 18:06:58 INFO - x-amz-version-id: ZE0E5yr.leNc3Rvw0pUJdMrQJxikoGv9 18:06:59 INFO - Expected file size: 14409028 18:06:59 INFO - Obtained file size: 14409028 18:06:59 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')]} 18:06:59 INFO - trying https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:06:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:07:01 INFO - Downloaded 59611736 bytes. 18:07:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:07:01 INFO - mkdir: /builds/slave/test/properties 18:07:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:07:01 INFO - Writing to file /builds/slave/test/properties/build_url 18:07:01 INFO - Contents: 18:07:01 INFO - build_url:https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:07:02 INFO - Running post-action listener: _resource_record_post_action 18:07:02 INFO - Running post-action listener: set_extra_try_arguments 18:07:02 INFO - [mozharness: 2016-10-15 01:07:02.495056Z] Finished download-and-extract step (success) 18:07:02 INFO - [mozharness: 2016-10-15 01:07:02.495284Z] Running populate-webroot step. 18:07:02 INFO - Running pre-action listener: _resource_record_pre_action 18:07:02 INFO - Running main action method: populate_webroot 18:07:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:07:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:07:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:07:02 INFO - '--tppagecycles', 18:07:02 INFO - '7'], 18:07:02 INFO - 'tests': ['tsvgm']}}, 18:07:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:07:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:07:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:07:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:07:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:07:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:07:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['damp', 'tps']}, 18:07:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'tests': ['damp', 'tps']}, 18:07:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['dromaeo_dom']}, 18:07:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:07:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['basic_compositor_video']}, 18:07:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:07:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other-e10s': {'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['a11yr', 18:07:02 INFO - 'ts_paint', 18:07:02 INFO - 'tpaint', 18:07:02 INFO - 'sessionrestore', 18:07:02 INFO - 'sessionrestore_no_auto_restore', 18:07:02 INFO - 'tabpaint']}, 18:07:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tsvgx', 18:07:02 INFO - 'tsvgr_opacity', 18:07:02 INFO - 'tart', 18:07:02 INFO - 'tscrollx', 18:07:02 INFO - 'cart']}, 18:07:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:07:02 INFO - 'tsvgr_opacity', 18:07:02 INFO - 'tart', 18:07:02 INFO - 'tscrollx', 18:07:02 INFO - 'cart']}, 18:07:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s'], 18:07:02 INFO - 'tests': ['tp5o']}, 18:07:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'tests': ['tp5o']}, 18:07:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--disable-e10s', 18:07:02 INFO - '--xperf_path', 18:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:07:02 INFO - 'tests': ['tp5n']}, 18:07:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:02 INFO - 'talos_options': ['--xperf_path', 18:07:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:07:02 INFO - 'tests': ['tp5n']}}, 18:07:02 INFO - 'talos.zip': {'path': '', 18:07:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:07:02 INFO - Running post-action listener: _resource_record_post_action 18:07:02 INFO - [mozharness: 2016-10-15 01:07:02.512445Z] Finished populate-webroot step (success) 18:07:02 INFO - [mozharness: 2016-10-15 01:07:02.512533Z] Running create-virtualenv step. 18:07:02 INFO - Running pre-action listener: _resource_record_pre_action 18:07:02 INFO - Running main action method: create_virtualenv 18:07:02 INFO - Creating virtualenv /builds/slave/test/build/venv 18:07:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:07:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:07:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:07:02 INFO - Using real prefix '/usr' 18:07:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:07:03 INFO - Installing distribute.............................................................................................................................................................................................done. 18:07:05 INFO - Installing pip.................done. 18:07:05 INFO - Return code: 0 18:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:07:05 INFO - Reading from file tmpfile_stdout 18:07:05 INFO - Output received: 18:07:05 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) 18:07:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:07:05 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')]} 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 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')]} 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:05 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 18:07:05 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 18:07:05 INFO - Using env: {'DISPLAY': ':0', 18:07:05 INFO - 'HOME': '/home/cltbld', 18:07:05 INFO - 'LANG': 'en_US.UTF-8', 18:07:05 INFO - 'LANGUAGE': 'en_US:en', 18:07:05 INFO - 'LOGNAME': 'cltbld', 18:07:05 INFO - 'MAIL': '/var/mail/cltbld', 18:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:05 INFO - 'MOZ_NO_REMOTE': '1', 18:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:05 INFO - 'NO_EM_RESTART': '1', 18:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:05 INFO - 'PWD': '/builds/slave/test', 18:07:05 INFO - 'SHELL': '/bin/bash', 18:07:05 INFO - 'SHLVL': '1', 18:07:05 INFO - 'TERM': 'linux', 18:07:05 INFO - 'TMOUT': '86400', 18:07:05 INFO - 'USER': 'cltbld', 18:07:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:05 INFO - '_': '/tools/buildbot/bin/python'} 18:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:05 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 18:07:05 INFO - Cleaning up... 18:07:05 INFO - Return code: 0 18:07:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:07:05 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')]} 18:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 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')]} 18:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:05 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:05 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 18:07:05 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 18:07:05 INFO - Using env: {'DISPLAY': ':0', 18:07:05 INFO - 'HOME': '/home/cltbld', 18:07:05 INFO - 'LANG': 'en_US.UTF-8', 18:07:05 INFO - 'LANGUAGE': 'en_US:en', 18:07:05 INFO - 'LOGNAME': 'cltbld', 18:07:05 INFO - 'MAIL': '/var/mail/cltbld', 18:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:05 INFO - 'MOZ_NO_REMOTE': '1', 18:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:05 INFO - 'NO_EM_RESTART': '1', 18:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:05 INFO - 'PWD': '/builds/slave/test', 18:07:05 INFO - 'SHELL': '/bin/bash', 18:07:05 INFO - 'SHLVL': '1', 18:07:05 INFO - 'TERM': 'linux', 18:07:05 INFO - 'TMOUT': '86400', 18:07:05 INFO - 'USER': 'cltbld', 18:07:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:05 INFO - '_': '/tools/buildbot/bin/python'} 18:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:05 INFO - Downloading/unpacking psutil>=3.1.1 18:07:05 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 18:07:05 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 18:07:05 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 18:07:05 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 18:07:05 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 18:07:05 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 18:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:07:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:07:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:07:07 INFO - Installing collected packages: psutil 18:07:07 INFO - Running setup.py install for psutil 18:07:07 INFO - building 'psutil._psutil_linux' extension 18:07:07 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 18:07:08 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 18:07:08 INFO - building 'psutil._psutil_posix' extension 18:07:08 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 18:07:08 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 18:07:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:07:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:07:08 INFO - Successfully installed psutil 18:07:08 INFO - Cleaning up... 18:07:08 INFO - Return code: 0 18:07:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:07:08 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')]} 18:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:08 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')]} 18:07:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:08 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:08 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 18:07:08 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 18:07:08 INFO - Using env: {'DISPLAY': ':0', 18:07:08 INFO - 'HOME': '/home/cltbld', 18:07:08 INFO - 'LANG': 'en_US.UTF-8', 18:07:08 INFO - 'LANGUAGE': 'en_US:en', 18:07:08 INFO - 'LOGNAME': 'cltbld', 18:07:08 INFO - 'MAIL': '/var/mail/cltbld', 18:07:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:08 INFO - 'MOZ_NO_REMOTE': '1', 18:07:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:08 INFO - 'NO_EM_RESTART': '1', 18:07:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:08 INFO - 'PWD': '/builds/slave/test', 18:07:08 INFO - 'SHELL': '/bin/bash', 18:07:08 INFO - 'SHLVL': '1', 18:07:08 INFO - 'TERM': 'linux', 18:07:08 INFO - 'TMOUT': '86400', 18:07:08 INFO - 'USER': 'cltbld', 18:07:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:08 INFO - '_': '/tools/buildbot/bin/python'} 18:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:07:08 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 18:07:08 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 18:07:08 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 18:07:08 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 18:07:08 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 18:07:08 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 18:07:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:07:10 INFO - Installing collected packages: mozsystemmonitor 18:07:10 INFO - Running setup.py install for mozsystemmonitor 18:07:10 INFO - Successfully installed mozsystemmonitor 18:07:10 INFO - Cleaning up... 18:07:10 INFO - Return code: 0 18:07:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:07:10 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')]} 18:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:10 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')]} 18:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:10 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:10 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 18:07:10 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 18:07:10 INFO - Using env: {'DISPLAY': ':0', 18:07:10 INFO - 'HOME': '/home/cltbld', 18:07:10 INFO - 'LANG': 'en_US.UTF-8', 18:07:10 INFO - 'LANGUAGE': 'en_US:en', 18:07:10 INFO - 'LOGNAME': 'cltbld', 18:07:10 INFO - 'MAIL': '/var/mail/cltbld', 18:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:10 INFO - 'MOZ_NO_REMOTE': '1', 18:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:10 INFO - 'NO_EM_RESTART': '1', 18:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:10 INFO - 'PWD': '/builds/slave/test', 18:07:10 INFO - 'SHELL': '/bin/bash', 18:07:10 INFO - 'SHLVL': '1', 18:07:10 INFO - 'TERM': 'linux', 18:07:10 INFO - 'TMOUT': '86400', 18:07:10 INFO - 'USER': 'cltbld', 18:07:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:10 INFO - '_': '/tools/buildbot/bin/python'} 18:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:10 INFO - Downloading/unpacking jsonschema==2.5.1 18:07:10 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 18:07:10 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 18:07:10 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 18:07:10 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 18:07:10 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 18:07:10 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 18:07:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:07:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:07:13 INFO - warning: no files found matching '*.txt' 18:07:13 INFO - no previously-included directories found matching 'build' 18:07:13 INFO - no previously-included directories found matching 'dist' 18:07:13 INFO - no previously-included directories found matching '.git*' 18:07:13 INFO - Installing collected packages: jsonschema, functools32 18:07:13 INFO - Running setup.py install for functools32 18:07:13 INFO - warning: no files found matching '*.txt' 18:07:13 INFO - no previously-included directories found matching 'build' 18:07:13 INFO - no previously-included directories found matching 'dist' 18:07:13 INFO - no previously-included directories found matching '.git*' 18:07:13 INFO - Successfully installed jsonschema functools32 18:07:13 INFO - Cleaning up... 18:07:13 INFO - Return code: 0 18:07:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:07:13 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')]} 18:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:13 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')]} 18:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:13 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:13 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 18:07:13 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 18:07:13 INFO - Using env: {'DISPLAY': ':0', 18:07:13 INFO - 'HOME': '/home/cltbld', 18:07:13 INFO - 'LANG': 'en_US.UTF-8', 18:07:13 INFO - 'LANGUAGE': 'en_US:en', 18:07:13 INFO - 'LOGNAME': 'cltbld', 18:07:13 INFO - 'MAIL': '/var/mail/cltbld', 18:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:13 INFO - 'MOZ_NO_REMOTE': '1', 18:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:13 INFO - 'NO_EM_RESTART': '1', 18:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:13 INFO - 'PWD': '/builds/slave/test', 18:07:13 INFO - 'SHELL': '/bin/bash', 18:07:13 INFO - 'SHLVL': '1', 18:07:13 INFO - 'TERM': 'linux', 18:07:13 INFO - 'TMOUT': '86400', 18:07:13 INFO - 'USER': 'cltbld', 18:07:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:13 INFO - '_': '/tools/buildbot/bin/python'} 18:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:07:13 INFO - Cleaning up... 18:07:13 INFO - Return code: 0 18:07:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:07:13 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')]} 18:07:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:13 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')]} 18:07:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:13 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:13 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 18:07:13 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 18:07:13 INFO - Using env: {'DISPLAY': ':0', 18:07:13 INFO - 'HOME': '/home/cltbld', 18:07:13 INFO - 'LANG': 'en_US.UTF-8', 18:07:13 INFO - 'LANGUAGE': 'en_US:en', 18:07:13 INFO - 'LOGNAME': 'cltbld', 18:07:13 INFO - 'MAIL': '/var/mail/cltbld', 18:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:13 INFO - 'MOZ_NO_REMOTE': '1', 18:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:13 INFO - 'NO_EM_RESTART': '1', 18:07:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:13 INFO - 'PWD': '/builds/slave/test', 18:07:13 INFO - 'SHELL': '/bin/bash', 18:07:13 INFO - 'SHLVL': '1', 18:07:13 INFO - 'TERM': 'linux', 18:07:13 INFO - 'TMOUT': '86400', 18:07:13 INFO - 'USER': 'cltbld', 18:07:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:13 INFO - '_': '/tools/buildbot/bin/python'} 18:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:13 INFO - Downloading/unpacking blobuploader==1.2.4 18:07:13 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 18:07:13 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 18:07:13 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 18:07:13 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 18:07:13 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 18:07:13 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 18:07:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:07:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:07:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:07:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:07:16 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 18:07:16 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 18:07:16 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 18:07:16 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 18:07:16 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 18:07:16 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 18:07:16 INFO - Downloading docopt-0.6.1.tar.gz 18:07:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:07:16 INFO - Installing collected packages: blobuploader, requests, docopt 18:07:16 INFO - Running setup.py install for blobuploader 18:07:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:07:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:07:16 INFO - Running setup.py install for requests 18:07:16 INFO - Running setup.py install for docopt 18:07:17 INFO - Successfully installed blobuploader requests docopt 18:07:17 INFO - Cleaning up... 18:07:17 INFO - Return code: 0 18:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:17 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')]} 18:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:17 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')]} 18:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:17 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:17 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 18:07:17 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 18:07:17 INFO - Using env: {'DISPLAY': ':0', 18:07:17 INFO - 'HOME': '/home/cltbld', 18:07:17 INFO - 'LANG': 'en_US.UTF-8', 18:07:17 INFO - 'LANGUAGE': 'en_US:en', 18:07:17 INFO - 'LOGNAME': 'cltbld', 18:07:17 INFO - 'MAIL': '/var/mail/cltbld', 18:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:17 INFO - 'MOZ_NO_REMOTE': '1', 18:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:17 INFO - 'NO_EM_RESTART': '1', 18:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:17 INFO - 'PWD': '/builds/slave/test', 18:07:17 INFO - 'SHELL': '/bin/bash', 18:07:17 INFO - 'SHLVL': '1', 18:07:17 INFO - 'TERM': 'linux', 18:07:17 INFO - 'TMOUT': '86400', 18:07:17 INFO - 'USER': 'cltbld', 18:07:17 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:17 INFO - '_': '/tools/buildbot/bin/python'} 18:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:17 INFO - Running setup.py (path:/tmp/pip-KEHt3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:17 INFO - Running setup.py (path:/tmp/pip-jFBrZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:17 INFO - Running setup.py (path:/tmp/pip-REYe8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:17 INFO - Running setup.py (path:/tmp/pip-iLsfZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:17 INFO - Running setup.py (path:/tmp/pip-XwWUl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:17 INFO - Running setup.py (path:/tmp/pip-sbeaHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:17 INFO - Running setup.py (path:/tmp/pip-gqxhgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:17 INFO - Running setup.py (path:/tmp/pip-mXLxy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:17 INFO - Running setup.py (path:/tmp/pip-ZH5_7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:17 INFO - Running setup.py (path:/tmp/pip-BdtY5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:18 INFO - Running setup.py (path:/tmp/pip-kE9AXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:18 INFO - Running setup.py (path:/tmp/pip-U0ND6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:18 INFO - Running setup.py (path:/tmp/pip-jt6DOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:18 INFO - Running setup.py (path:/tmp/pip-iB1q5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:18 INFO - Running setup.py (path:/tmp/pip-uS9R9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:18 INFO - Running setup.py (path:/tmp/pip-HhsJZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:18 INFO - Running setup.py (path:/tmp/pip-q72pq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:07:18 INFO - Running setup.py install for manifestparser 18:07:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozcrash 18:07:18 INFO - Running setup.py install for mozdebug 18:07:18 INFO - Running setup.py install for mozdevice 18:07:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:07:18 INFO - Running setup.py install for mozfile 18:07:19 INFO - Running setup.py install for mozhttpd 18:07:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Running setup.py install for mozinfo 18:07:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Running setup.py install for mozInstall 18:07:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Running setup.py install for mozleak 18:07:19 INFO - Running setup.py install for mozlog 18:07:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Running setup.py install for moznetwork 18:07:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Running setup.py install for mozprocess 18:07:19 INFO - Running setup.py install for mozprofile 18:07:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:07:19 INFO - Running setup.py install for mozrunner 18:07:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:07:20 INFO - Running setup.py install for mozscreenshot 18:07:20 INFO - Running setup.py install for moztest 18:07:20 INFO - Running setup.py install for mozversion 18:07:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:07:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:07:20 INFO - Cleaning up... 18:07:20 INFO - Return code: 0 18:07:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:20 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:20 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 18:07:20 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 18:07:20 INFO - Using env: {'DISPLAY': ':0', 18:07:20 INFO - 'HOME': '/home/cltbld', 18:07:20 INFO - 'LANG': 'en_US.UTF-8', 18:07:20 INFO - 'LANGUAGE': 'en_US:en', 18:07:20 INFO - 'LOGNAME': 'cltbld', 18:07:20 INFO - 'MAIL': '/var/mail/cltbld', 18:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:20 INFO - 'MOZ_NO_REMOTE': '1', 18:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:20 INFO - 'NO_EM_RESTART': '1', 18:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:20 INFO - 'PWD': '/builds/slave/test', 18:07:20 INFO - 'SHELL': '/bin/bash', 18:07:20 INFO - 'SHLVL': '1', 18:07:20 INFO - 'TERM': 'linux', 18:07:20 INFO - 'TMOUT': '86400', 18:07:20 INFO - 'USER': 'cltbld', 18:07:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:20 INFO - '_': '/tools/buildbot/bin/python'} 18:07:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:07:20 INFO - Running setup.py (path:/tmp/pip-NKeWsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:07:20 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)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:07:20 INFO - Running setup.py (path:/tmp/pip-WhwZyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:07:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:07:20 INFO - Running setup.py (path:/tmp/pip-i4Y5yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:07:20 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)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:07:20 INFO - Running setup.py (path:/tmp/pip-3QDGB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:07:20 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)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:07:20 INFO - Running setup.py (path:/tmp/pip-3EZ_YW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:07:20 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)) 18:07:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:07:20 INFO - Running setup.py (path:/tmp/pip-eLGHIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:07:21 INFO - Running setup.py (path:/tmp/pip-jxiqTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:07:21 INFO - Running setup.py (path:/tmp/pip-_YeOXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:07:21 INFO - Running setup.py (path:/tmp/pip-pw83tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:07:21 INFO - Running setup.py (path:/tmp/pip-irleop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:07:21 INFO - Running setup.py (path:/tmp/pip-vB0Xvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:07:21 INFO - Running setup.py (path:/tmp/pip-IapYKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:07:21 INFO - Running setup.py (path:/tmp/pip-pe5QIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:07:21 INFO - Running setup.py (path:/tmp/pip-2K2b3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:21 INFO - Running setup.py (path:/tmp/pip-NoHrxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:07:21 INFO - Running setup.py (path:/tmp/pip-UA8LPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:07:21 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)) 18:07:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:07:21 INFO - Running setup.py (path:/tmp/pip-_oivVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:07:21 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)) 18:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:07:21 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)) 18:07:21 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)) 18:07:21 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)) 18:07:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:07:21 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 18:07:21 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 18:07:21 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 18:07:21 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 18:07:21 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 18:07:21 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 18:07:23 INFO - Downloading blessings-1.6.tar.gz 18:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:07:23 INFO - Installing collected packages: blessings 18:07:23 INFO - Running setup.py install for blessings 18:07:23 INFO - Successfully installed blessings 18:07:23 INFO - Cleaning up... 18:07:24 INFO - Return code: 0 18:07:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:24 INFO - Reading from file tmpfile_stdout 18:07:24 INFO - Current package versions: 18:07:24 INFO - argparse == 1.2.1 18:07:24 INFO - blessings == 1.6 18:07:24 INFO - blobuploader == 1.2.4 18:07:24 INFO - docopt == 0.6.1 18:07:24 INFO - functools32 == 3.2.3-2 18:07:24 INFO - jsonschema == 2.5.1 18:07:24 INFO - manifestparser == 1.1 18:07:24 INFO - mozInstall == 1.12 18:07:24 INFO - mozcrash == 0.17 18:07:24 INFO - mozdebug == 0.1 18:07:24 INFO - mozdevice == 0.48 18:07:24 INFO - mozfile == 1.2 18:07:24 INFO - mozhttpd == 0.7 18:07:24 INFO - mozinfo == 0.9 18:07:24 INFO - mozleak == 0.1 18:07:24 INFO - mozlog == 3.4 18:07:24 INFO - moznetwork == 0.27 18:07:24 INFO - mozprocess == 0.23 18:07:24 INFO - mozprofile == 0.28 18:07:24 INFO - mozrunner == 6.12 18:07:24 INFO - mozscreenshot == 0.1 18:07:24 INFO - mozsystemmonitor == 0.3 18:07:24 INFO - moztest == 0.7 18:07:24 INFO - mozversion == 1.4 18:07:24 INFO - psutil == 3.1.1 18:07:24 INFO - requests == 1.2.3 18:07:24 INFO - wsgiref == 0.1.2 18:07:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:24 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 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:24 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 18:07:24 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 18:07:24 INFO - Using env: {'DISPLAY': ':0', 18:07:24 INFO - 'HOME': '/home/cltbld', 18:07:24 INFO - 'LANG': 'en_US.UTF-8', 18:07:24 INFO - 'LANGUAGE': 'en_US:en', 18:07:24 INFO - 'LOGNAME': 'cltbld', 18:07:24 INFO - 'MAIL': '/var/mail/cltbld', 18:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:24 INFO - 'MOZ_NO_REMOTE': '1', 18:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:24 INFO - 'NO_EM_RESTART': '1', 18:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:24 INFO - 'PWD': '/builds/slave/test', 18:07:24 INFO - 'SHELL': '/bin/bash', 18:07:24 INFO - 'SHLVL': '1', 18:07:24 INFO - 'TERM': 'linux', 18:07:24 INFO - 'TMOUT': '86400', 18:07:24 INFO - 'USER': 'cltbld', 18:07:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:24 INFO - '_': '/tools/buildbot/bin/python'} 18:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 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)) 18:07:24 INFO - Cleaning up... 18:07:24 INFO - Return code: 0 18:07:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:07:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8abcbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2367790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, '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-1476491548.922296-1655581212', '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 18:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:07:24 INFO - Using env: {'DISPLAY': ':0', 18:07:24 INFO - 'HOME': '/home/cltbld', 18:07:24 INFO - 'LANG': 'en_US.UTF-8', 18:07:24 INFO - 'LANGUAGE': 'en_US:en', 18:07:24 INFO - 'LOGNAME': 'cltbld', 18:07:24 INFO - 'MAIL': '/var/mail/cltbld', 18:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:24 INFO - 'MOZ_NO_REMOTE': '1', 18:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:24 INFO - 'NO_EM_RESTART': '1', 18:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:24 INFO - 'PWD': '/builds/slave/test', 18:07:24 INFO - 'SHELL': '/bin/bash', 18:07:24 INFO - 'SHLVL': '1', 18:07:24 INFO - 'TERM': 'linux', 18:07:24 INFO - 'TMOUT': '86400', 18:07:24 INFO - 'USER': 'cltbld', 18:07:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:24 INFO - '_': '/tools/buildbot/bin/python'} 18:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:07:24 INFO - Cleaning up... 18:07:24 INFO - Return code: 0 18:07:24 INFO - Running post-action listener: _resource_record_post_action 18:07:24 INFO - Running post-action listener: _start_resource_monitoring 18:07:24 INFO - Starting resource monitoring. 18:07:24 INFO - [mozharness: 2016-10-15 01:07:24.743172Z] Finished create-virtualenv step (success) 18:07:24 INFO - [mozharness: 2016-10-15 01:07:24.743644Z] Running install step. 18:07:24 INFO - Running pre-action listener: _resource_record_pre_action 18:07:24 INFO - Running main action method: install 18:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:07:24 INFO - Reading from file tmpfile_stdout 18:07:24 INFO - Detecting whether we're running mozinstall >=1.0... 18:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:07:25 INFO - Reading from file tmpfile_stdout 18:07:25 INFO - Output received: 18:07:25 INFO - Usage: mozinstall [options] installer 18:07:25 INFO - Options: 18:07:25 INFO - -h, --help show this help message and exit 18:07:25 INFO - -d DEST, --destination=DEST 18:07:25 INFO - Directory to install application into. [default: 18:07:25 INFO - "/builds/slave/test"] 18:07:25 INFO - --app=APP Application being installed. [default: firefox] 18:07:25 INFO - mkdir: /builds/slave/test/build/application 18:07:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:07:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:07:42 INFO - Reading from file tmpfile_stdout 18:07:42 INFO - Output received: 18:07:42 INFO - /builds/slave/test/build/application/firefox/firefox 18:07:42 INFO - Running post-action listener: _resource_record_post_action 18:07:42 INFO - [mozharness: 2016-10-15 01:07:42.004815Z] Finished install step (success) 18:07:42 INFO - [mozharness: 2016-10-15 01:07:42.005058Z] Running run-tests step. 18:07:42 INFO - Running pre-action listener: _resource_record_pre_action 18:07:42 INFO - Running main action method: run_tests 18:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:07:42 INFO - Python 2.7.3 18:07:42 INFO - Return code: 0 18:07:42 INFO - grabbing minidump binary from tooltool 18:07:42 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')]} 18:07:42 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 0x2364930>, '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 0x2365830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2365cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:07:42 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 18:07:42 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 18:07:42 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 18:07:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:07:42 INFO - Return code: 0 18:07:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:07:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:07:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:07:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:07:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:07:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:07:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.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-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:07:42 INFO - Using env: {'DISPLAY': ':0', 18:07:42 INFO - 'HOME': '/home/cltbld', 18:07:42 INFO - 'LANG': 'en_US.UTF-8', 18:07:42 INFO - 'LANGUAGE': 'en_US:en', 18:07:42 INFO - 'LOGNAME': 'cltbld', 18:07:42 INFO - 'MAIL': '/var/mail/cltbld', 18:07:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:07:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:07:42 INFO - 'MOZ_NO_REMOTE': '1', 18:07:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:07:42 INFO - 'NO_EM_RESTART': '1', 18:07:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:07:42 INFO - 'PWD': '/builds/slave/test', 18:07:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:07:42 INFO - 'SHELL': '/bin/bash', 18:07:42 INFO - 'SHLVL': '1', 18:07:42 INFO - 'TERM': 'linux', 18:07:42 INFO - 'TMOUT': '86400', 18:07:42 INFO - 'USER': 'cltbld', 18:07:42 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1476491548.922296-1655581212', 18:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:07:42 INFO - '_': '/tools/buildbot/bin/python'} 18:07:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.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-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:07:42 INFO - mozversion application_buildid: 20161014145716 18:07:42 INFO - mozversion application_changeset: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 18:07:42 INFO - mozversion application_display_name: Nightly 18:07:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:07:42 INFO - mozversion application_name: Firefox 18:07:42 INFO - mozversion application_remotingname: firefox 18:07:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:07:42 INFO - mozversion application_vendor: Mozilla 18:07:42 INFO - mozversion application_version: 52.0a1 18:07:42 INFO - mozversion platform_buildid: 20161014145716 18:07:42 INFO - mozversion platform_changeset: 6ed5592738b6c40ea8aefcf8b699de9f60f30a91 18:07:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:07:42 INFO - mozversion platform_version: 52.0a1 18:07:42 INFO - using testdate: 1476493662 18:07:42 INFO - actual date: 1476493662 18:07:42 INFO - starting webserver on 'localhost:44567' 18:07:42 INFO - SUITE-START | Running 2 tests 18:07:42 INFO - TEST-START | dromaeo_css 18:07:42 INFO - operating with platform_type : linux_ 18:07:42 INFO - Initialising browser for dromaeo_css test... 18:07:42 INFO - TEST-INFO | started process 24119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PQsuo/profile http://localhost:44567/getInfo.html) 18:07:47 INFO - PROCESS | 24119 | __metrics Screen width/height:1600/1200 18:07:47 INFO - PROCESS | 24119 | colorDepth:24 18:07:47 INFO - PROCESS | 24119 | Browser inner width/height: 1024/697 18:07:47 INFO - PROCESS | 24119 | __metrics 18:07:48 ERROR - PROCESS | 24119 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:07:49 INFO - TEST-INFO | 24119: exit 0 18:07:49 INFO - Browser initialized. 18:07:49 INFO - Running cycle 1/1 for dromaeo_css test... 18:07:49 INFO - TEST-INFO | started process 24241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9PQsuo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:08:01 INFO - PROCESS | 24241 | RSS: Main: 182726656 18:08:01 INFO - PROCESS | 24241 | 18:08:51 INFO - PROCESS | 24241 | 1476493731030 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] 18:11:01 INFO - PROCESS | 24241 | Cycle 1(1): loaded http://localhost:44567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44567/tests/dromaeo/cssquery-ext.html) 18:11:04 INFO - PROCESS | 24241 | RSS: Main: 194314240 18:11:04 INFO - PROCESS | 24241 | 18:14:06 INFO - PROCESS | 24241 | Cycle 1(1): loaded http://localhost:44567/tests/dromaeo/cssquery-ext.html (next: http://localhost:44567/tests/dromaeo/cssquery-jquery.html) 18:14:07 INFO - PROCESS | 24241 | RSS: Main: 195162112 18:14:07 INFO - PROCESS | 24241 | 18:17:09 INFO - PROCESS | 24241 | Cycle 1(1): loaded http://localhost:44567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44567/tests/dromaeo/cssquery-mootools.html) 18:17:09 INFO - PROCESS | 24241 | RSS: Main: 197828608 18:17:09 INFO - PROCESS | 24241 | 18:20:11 INFO - PROCESS | 24241 | Cycle 1(1): loaded http://localhost:44567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44567/tests/dromaeo/cssquery-prototype.html) 18:20:12 INFO - PROCESS | 24241 | RSS: Main: 194195456 18:20:12 INFO - PROCESS | 24241 | 18:23:14 INFO - PROCESS | 24241 | Cycle 1(1): loaded http://localhost:44567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44567/tests/dromaeo/cssquery-yui.html) 18:23:15 INFO - PROCESS | 24241 | RSS: Main: 197726208 18:23:15 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | Cycle 1(1): loaded http://localhost:44567/tests/dromaeo/cssquery-yui.html (next: http://localhost:44567/tests/dromaeo/cssquery-dojo.html) 18:26:18 INFO - PROCESS | 24241 | RSS: Main: 196849664 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | __start_tp_report 18:26:18 INFO - PROCESS | 24241 | _x_x_mozilla_page_load 18:26:18 INFO - PROCESS | 24241 | _x_x_mozilla_page_load_details 18:26:18 INFO - PROCESS | 24241 | |i|pagename|runs| 18:26:18 INFO - PROCESS | 24241 | |0;dojo.html;2976.3005693661985;2982.4333376658433;2982.731554160125;2993.2965753048015;2997.685243049479;5148.819791307305;5295.761690723917;5304.973475132624;5347.786088556462;5385.91921121183;5221.791128354871;5259.368875734907;5325.600579956509;5342.958123165974;5351.625386222966;4818.759062046901;4833.806647734086;4933.605311575084;4943.159662857305;5041.8235361762345;4427.048184640301;4825.372701548811;4950.826721064764;4958.454569997298;5004.449510553836;4724.055188962221;4738.668293219476;4792.305115758213;4876.02479504097;4913.091078150554;4800.639952003614;4841.515848415165;4854.660173787836;4866.46468888422;4938.456769755324;4803.231482962744;4804.111239420718;4838.177509823338;4849;4878.731669758162;5193.766280517386;5301.1783173608155;5302.469753024705;5341.359036915556;5372.516473517402;5526.668399896019;5602.803901863415;5673.177389278531;5711.05767548354;5788.450097240755;5728.369879313273;5736.799212027559;5746.741396637161;5756.510696590794;5761.308642962829;5371.946280537184;5376.086065368897;5407.756650950717;5410.053240682904;5413.648112872651;5676.886462270814;5744.770209191669;5776.277965254343;5829.912551311733;5830.8542286442325;5621.606487545914;5635.126555383922;5644.520215781705;5645.491905728504;5709.172170035322;5659.151127330851;5661.49046585801;5733.541316694655;5733.569982251264;5737.713114344266;5545.334559852843;5575.581831362583;5613.522850557667;5651.265335506358;5663.207150998864;5673.120666296731;5686.09022556389;5695.088785794253;5695.316562012502;5695.7152142392715;4348.391225228471;4363.978180109079;4367.388565600819;4378;4388.9122217556105;3897.4933258676756;3900.941485877714;3912.5304963404574;3946.703997200164;3949.743266687656;5373.9731301343245;5375.489328513785;5384.515393614593;5399.082156033405;5415.972920135374;5478.671279723229;5558.194061861008;5667.376588575254;5669.234653321749;5756.740946657411;5358.410574836765;5360.061989151883;5365.812196573102;5384.946150538444;5415.241866138744;4826.131296366688;4855.781489832966;4873.220284754422;4885.438174609894;4910.926336104962;5764.769409223668;5841.357450680422;5903.026000709835;5952.702364881825;6001;5664.688442135722;5667;5678.119891416837;5721.342045664802;5727.914081288867;5803.9419605803405;5812.796552120655;5825.70871456417;5867.559933005127;5885.823425297248;5475.260839786737;5535.7785688572;5570.275864137636;5583.190437386637;5584.86037849057;5644.266245388073;5682.886342273048;5705.058665320175;5707.971460142673;5709.800156994485;5540.750666219949;5556.527695145958;5560.638558493685;5560.694161820977;5577.693226872399;5580.469855363896;5584.553235741212;5592.664440133605;5593.748281327432;5596.38439771633;5461.1808228766;5506.146547285177;5511.063119269814;5514.28314319152;5521;5536.474034966672;5616.21373007771;5618.52242559387;5621.775128994795;5621.831345059655;5382.246485492113;5457.263269458731;5484.7806087757635;5495.752691128829;5499.917501237404 18:26:18 INFO - PROCESS | 24241 | |1;ext.html;584.663818304475;587.1574290892567;602.5330368964051;604.5012864386882;627.5262177056322;42013.369799452994;43454.34818477721;43512.782436087815;43688.563114368844;43698.12603747931;43660;44171;44220.55779442205;44325.77837110818;44338.77830610851;8825.51459669718;8978.775530611754;8979.416337938013;9000.234980026673;9000.59497322622;8766.956165219164;8835.95582022089;8854.07032261613;8857.911420885805;8862.468251904906;8838.42550234236;8854.955725221365;8856.51289179098;8883.42257753244;8897.33270004749;8724.52015139167;8776.385653004292;8805.119488051208;8820.382573219846;8856.645734170625;8735.301175905912;8811.471311721318;8879.911200888038;8880.777980550472;8882.86675699865;41222.38166427476;41510.584894151274;41593;41611.79194104041;41624.37563436551;3517.2437925846066;3591.730620203495;3613.7651052681754;4010.7710455977654;4133.669306455507;32098.197545061328;32233.35533289321;32474.837625811957;32598.348033039445;34162.82918585416;4305.677074219415;4333.544977777351;4370.672199585012;4486.955130448687;4537.931931021038;333253;335437.87372757954;335636;335647;336779;55708;56564;56576.434235657114;56674;56722.43277567172;58390.41609583935;58465;58488.707556461944;58542.707286463294;58608.70695646494;16691.41580044717;16969.83030169707;16976.40582579604;17006;17031.914840425965;13087.476500940045;13110.213387196798;13123.60629181126;13168;13184.077114601885;14110;15608.895720634242;15626.76559851603;15816;16022.19889005545;5822.854428639233;5958.195643588147;6104.290798576406;6127.662978536223;6240.500759939194;867.5748883047262;1003.5484032185545;1020.2705065877933;1029.562435964712;1042.4839704346398;32377.838110809294;32590.674093259237;32686.346273074407;32756.181095472803;32766.83616581902;1028.1671845804922;1032.4115254305125;1059.2320567588438;1073.9892601074046;1158.1082566423806;14872.925635371754;16675.166241687868;16921.02060765666;17017.659646806995;17070.146492675318;495944;499451;499704;500693;502769;40646.1870762589;41325.586744132175;41390.1721965559;41489.1702165955;41787.373189402184;1287.4077924154806;1316.861729518406;1321.669582604349;1328.6678330417396;1344.7915573086186;29963.700362996093;31249.375012500077;31333.52999705052;31644.57759612688;32043.679563205;51665;52290.47709522856;52496;52578.47421525736;52604.47395525996;439112;441461;444233;445221;445862;27321.590176146976;27354;27378.86310568514;27547.035853745023;27752.444951101268;46777.53222467868;47308;48081.5191848077;48169;49466;40022;40585.59414405936;40962.590374095875;41298.174036519704;41808;39678.404823927085;39784;39935.866057960346;40516;41298.38052429156;39864.800675996434;40752.796236019814;40787.38818917659;41256.58743412527;41323.38014929718;33841;36020.81989590035;36204;36459;37139.628603713616;27495.862520687268;27992.30019249535;28258.85870570634;28312.150635480146;28407 18:26:18 INFO - PROCESS | 24241 | |2;jquery.html;375.4330960250023;386.3698926422589;391.2741863842572;392.59366555614946;413.0726518964924;17976.640467190664;19075.713864292047;19340.90329548352;19400.02999850007;19813.801861981377;19072.33246836361;19158.329458468957;19465.31871384502;19482.610347793037;19614.313499027536;5446.455354464551;5510.91733623994;5596.608237423382;5678.119891416837;5768.3654797972185;5602.1036634138545;5644.774209031654;5694.174344720013;5698.059820129673;5710.857228569277;5378.1663842104535;5592.273004509408;5637.295338082739;5637.46444087811;5660.462256085665;5614.887702245953;5673.943260567383;5677.545796336304;5688.402717714622;5694.829155125353;5010.498950104997;5026.924596131061;5035.269885866565;5051.393832740095;5060.544550990392;22342.66486002711;22443;22785.20251791179;22788.08847646092;22800.201992930168;2178.1287485005964;2184.388371256051;2313.051648823991;2414.082648593523;2811.7188281171925;14250.501232456918;14515.346809393603;14529.78205326921;14668.339924703414;15229.390824367012;1921.8750781199178;1924.7401600783855;1926.5087402712218;1997.1212666426725;2032.2074390987527;81968;82182.58908705418;83438;85290.57354713249;85777.57111214467;10114.645987390406;10200.6429774959;10462.581496740046;10787.352758834495;11101.555937762561;15226.695466090616;15244.569971756488;15262.847371526364;15333.923330383277;15342.92599518023;7768.223177682186;8168.754937351889;8201.273660350693;8341;8486.575671216415;7885.763427097197;7963.283304502506;7983.401244906655;8227.095019547965;8235.052968908532;4516.706414083074;4528.88677783058;4572.1312950539295;4632.3977882875015;4723.244280915037;1898.1078892920304;1936.322287199469;1946.2993322403922;1959.0106995966946;1970.270999730109;836.8033512124646;917.6604656277086;932.8367535681228;984.8621193032981;1078.0728573426848;18918.716219256723;19314.613707725766;19419.4174174775;19419.708704369445;19938.70091948622;956.4070276428658;961.5048250151178;1026.7946410717736;1049.58541376156;1060.6870973062964;10258.66593357147;10689.358638481715;10853.674389768319;10884;10979.231453798317;443452;450669;464229;468636;469389;84074.57962710147;86647;86812.56593716991;87836.56081719551;87973.56013219892;1008.621766837436;1009.1472705563787;1013.7110923386799;1027.6300531808542;1030.8247597908223;16602.25289861935;16692.165391730607;17245.482635520955;17255.137243138044;17464.912675437048;40691.593084069966;41828.790856045525;41938.79030604827;42215.944601383984;43107.13785724331;52545.47454525406;53929.73035134799;55219.44780552143;56208.718956404955;56771.148432772716;8051.718189863561;8167.0607880092175;8376.413651044368;8387.664493420194;8425.915740842513;11239.887601124212;12776.808347874603;12975.545855895376;13005.544805931748;13534;11181.72045698864;11360.1479889007;11927.880721192678;11949.283043017447;12022.879771202175;11118.110551156049;11238.7752244953;11317.264377815416;11617.767644647229;11773.52905883755;11399.487023084146;11407.201495895208;11459.942700286445;11531.596394126165;11548.249363791327;8195.221453961864;8304.377171712267;8330.375221858507;8469.153084691481;8879.733607991771;11216.439178040902;11320.716982075513;11369.2609980351;11401.942990284995;11522.020628246357 18:26:18 INFO - PROCESS | 24241 | |3;mootools.html;1482.8368879423265;1491.6420059185791;1640.9589760255992;1756.9560760980983;1771.3534559885645;7493.700251989928;7753.496022758517;8443.915560844389;9072.274218062548;9097.0902909709;8409.201125893045;8664.220220180183;8713.7821554461;8902.243309318716;8974.326925480582;2257.3679369776405;2302.988485057581;2305.896234669444;2309.515001849605;2310.318456055468;2216.8115710164657;2266.784655457729;2278.544291141778;2285.0859656137513;2293;2237.9216727414546;2241.0363543676212;2252.718410198725;2293.3234695764704;2300.4018955071633;2230.721159855018;2233.4304752288226;2236.049678886475;2239.484918468745;2247.8876056197205;2141.967870481944;2164.9242276520245;2167.696522486853;2170.6309927312395;2172.9782702172934;9012.324075694349;9143.268538516902;9161.404508706913;9164.8625270621;9166.954165229132;5177.275181474596;5327.920081198785;5332.813351532678;5333.413324534298;5335.8132465363915;3200.2319443333663;3234.4016356974034;3402.914927126817;3437.8968630941113;3451.861925523001;1016.7204018894789;1030.340582027503;1038.5274700011478;1040.9115225205867;1045.0698877998586;12846.293453860035;12853.807192892114;12858.807117893239;12930.54743083997;12988.935055324757;4439.223135951195;4658.534146585314;4680.9297860532115;4706.505816889246;4729.905401891943;10884.782304354027;10891.83662245067;10896.61861834832;10910.61812836547;10928.289661171999;5345.492178243061;5345.973270133624;5346.064438723286;5359.5712343012465;5364.168553874156;4210.578942105826;4645.465771436328;4909.607231421549;4970.826021089245;5021.573166280834;3899.200663863901;4012.137390461065;4021.2158629067053;4051.837926482967;4103.312330423577;1257.5724253753585;1270.866559011309;1272.0713878868478;1286.0676009892752;1292.5734507612465;949.2785483032807;951.5955718819474;963.1620490173594;991.6182269826024;993.7118235711707;5784.913226301609;5896.174535565025;6038.969805150946;6149.292831324366;6242.625442473466;920.7283851263759;938.1509733691021;939.2063706168277;965.3628605120587;991.3011327014437;4023.959760402417;4311.50417701962;4322.783860806947;4326.3510473428605;4435.423394958635;10491.265611407282;10633.096186824052;10759.78480430387;10760.192985526117;10780.838287425695;10615.044645981745;10728.517216725266;10729.678109656566;10734.838977415346;10747.355158690503;7942.44402891792;8086.15095414973;8226.465279756916;8235.21765432283;8254.958725206336;5859.414058594107;5890.617109887844;5969.91045134332;5995.550333724901;6163.938360616516;10007.699769006942;10014.298999069995;10316.845247321146;10429.426381549089;10505.894941050492;9366.297527685314;9681.903180968382;9704.514774261399;9986.850197247193;10030.99690030991;6806.9659651703405;7011;7413.555186688816;7532.096148462219;7550;8317.625706843328;8608.354373422144;8683.86974195375;8702.521361325187;8725.91274087251;7617.733379331697;7830;7916;7965.163657816078;8086.1913808618665;7619.390448763975;7759.2240775921955;7817.960910195413;7820.687172513036;7828.5694286812495;7309.671064802203;7442.441816863865;7448.329650331496;7451.329380355577;7453.2546745325035;5239.266502689703;5290.841274761763;5339.4660533947845;5402.945970540244;5424.430434804289;5183.170692689152;5303.575713942798;5333.466653334635;5385.6230063895155;5411.458854114557 18:26:18 INFO - PROCESS | 24241 | |4;prototype.html;315.569247976512;316.33096001955863;325.4759836662972;325.49873195279264;327.3338755632289;5411.431799661038;5452;5517.751701173447;5551.722413879305;5576.86057848554;5410.5401040911565;5481.862953426166;5487.832306239033;5492.203630473589;5515.200295957084;4241.172971270596;4242.97878510607;4251.723637963538;4264.102474398894;4297.35539669049;4024.315866302721;4219.198352313066;4286.828526858922;4290.42079319291;4321.697481176319;4149.294619914606;4169.6455801256925;4170.520390155126;4170.624643782059;4189.224993376235;4162.500499939996;4163.272242019559;4176.477940257452;4200;4214.936775948363;3654.7441679082476;3657.6890964267805;3661.9816900915325;3665.102049997741;3691.50164727761;5227.457899919533;5314.92027619586;5332.573394128461;5362.839114826562;5371.731413429313;4756.239001759736;4770.880727981794;4778.665493415462;4780.450248221464;4786.558854983983;5386.551457619055;5667.829965101054;5697.287839020122;5730.283714535683;5744.741486633112;3956.5647778744315;3973.5827738087664;3980.5621381647998;3988.860389886369;4008.2183974125055;5898.849724303763;5907.084401917667;5954.761809527614;5970.940290597082;5976.834517269178;4153.709240353207;4157.563455837154;4172.895677608084;4173.457450531472;4176.60322269384;3983.860564880273;4177.289860723684;4180.895477613084;4186.35111557709;4189.905047476262;4787.736674482867;4801.423829140525;4818.6626936114835;4820.903581928342;4857.53853383928;5743.8851222976145;5772.509336706343;5785.65286082828;5797.01450753373;5825.88348233033;1367.3573420492353;1398.706271682958;1411.5835828430638;1428.271581493425;1430.4850253908585;900.3607438718452;901.4636291406603;915.6017132547363;915.7865827778221;927.0868194828089;4864.6594738368685;4873.878153046202;4877.756112194376;4894;4899.8440686098;5113.309703190096;5119.772898789039;5187.610929180327;5220.347456567929;5247.553957913544;4797.784099715521;4804.95195048045;4818.771423146501;4862.222044472867;5111.361079865017;3085;3146.300997461391;3159.557661927332;3160.7945483543494;3167.8099314041233;6075.696215189223;6166.969165154145;6176.81469555914;6183.505319574423;6200.937990620127;5853.209816674779;5944.6730429826775;5955.166276721263;5988.760449581968;5994.910076348859;6082.601001769618;6108.267007958984;6136.754529818757;6140.662263575457;6143.84640383994;5635.084071415738;5880.764769409347;5883.764649413975;5891.23413956183;5911.438413350725;5752.626079304831;5813.273340832396;5909.497692696169;5940.8811823764145;5952.553558483044;6144.56988010835;6176.938230617637;6194.442500175006;6198.194234749454;6200.689965501617;4001.579439299007;4126.690498212706;4185.769782661861;4194.196495506962;4235.280002399538;5834.562407819346;5845.649261044351;5850.23946886919;5868.2664666916635;5868.618539794899;5720.227769251098;5736.6558006519745;5751.827445176651;5759.568032397503;5773.16289138081;5485.424030476902;5687.43125687428;5698.2592263005545;5701.087825947829;5728.250439789008;5639.943600563942;5643.88712225745;5650.971745141248;5653.42769040094;5663.858403539944;5535.39110697831;5679.290088738908;5690.203371527907;5799.82600521985;5805.245318108618;5607.794324220312;5620.887582248414;5621.184928185472;5629.408912064338;5637.955504027943 18:26:18 INFO - PROCESS | 24241 | |5;yui.html;710.3926143147612;720.8666396716604;731.9121705395352;784.7292684024013;842.696629213483;15518.456854010112;16400.917995410036;16458.83541164588;16637.251323690434;16669.166541672897;14954.626134346647;15033.84966150341;15096.245187740624;15113.168775717331;15177.772333415007;799.816042310269;821.3757544266341;823.2631794543879;825.4964471672275;826.7643721539363;818.9181081891793;819.7417813388794;822.2065706593137;823.0493779684474;823.3783493462457;858.1247127929508;859;859.415597393772;861.0872475176302;865.2429124516049;848.4824257203101;856.9185927336893;858.7724253072972;860.0152825015385;861.1861790607878;634.1534052040531;637.1939496536885;637.9585326953733;640.4780104215097;640.7372977079375;14263;14267.500637477639;14346.92826535871;14351.928240358731;14374.425022999067;12285.508579656804;12434.502619895193;12612.117151799377;13389.50187894782;13532.84970777485;11118.332900025944;11287.15346349019;11346.886531134665;11424.885751142465;11608.013318867906;3762.623737626243;3828.5979972102805;3830.8467661293516;4011.2178125265586;4015.217032678629;70674.64662676705;72044.63977680077;74019.88970165506;75935;76365.23634763692;9860.901390985999;10019.499025048719;10024.749381265527;10138.294697045012;10266.230032747424;20311.18755249803;20458.38624841257;20461.89769051145;20506.07722652484;20569.280075197297;7368.8894666580045;8019.839603207904;8030.959845200737;8124.675012999413;8163.95918020418;4412.492563355191;4538.092381523708;4557.384753058294;4583.449986001635;4584.381108550369;3520.559930008749;3670.724695647837;3671.9632803672157;3686.9815650921573;3769.133099387156;534.5509771791636;536.1368197202501;538.1900240138644;538.967661940277;550.9669419834822;597.8355952113203;651.947844172465;678.6979793991725;682.6620822692798;683.6820878291618;8578.356623253281;8905.04089100397;9058.50178240203;9178.21985131258;9200.40197387181;659.3637140159769;667.1427216027381;680.1498127340824;681.9590824550543;687.6630451078935;4159.9792001040405;4183.5398106208295;4491.573300536444;4521.909561808746;4630.976845115752;66269.66865165644;78176.60911695405;83662;125876;127264;105529;108351.45824270986;109994;110125.44937275263;110161;56715.71642141845;92516.53741731249;95738.52130739302;97631;98830.5058474703;8032.116467188722;8167.264946154874;8211;8211.95894020526;8300.460470069425;54160;54272;54526.18210726922;55107.72446137744;55359.446405535426;70964.83904351066;72092;80828;81238;83854;10266.794664106526;10315.12321452685;10424.374537527772;10585.153187744809;10708.30396024256;11835.112366572714;11915.225510342147;12057.216280941711;12058.095642826647;12542.310172940575;11198.328100314007;11736.06111511094;12000.519979200733;12015.939920300343;12061.15571909993;11452.141089418494;11832.645020649394;11916.16586838913;12403.503859845505;12421.75156496847;11522.366269854903;11823.349715765715;12186.756264874475;12194.804935111764;12207.45066471993;8855.557222138996;9000.729978100668;9023.864642030507;9065.954670226607;9273.489958052372;8798.604062817061;9285;9759.219262459128;9867.358621689567;9990.15083717892 18:26:18 INFO - PROCESS | 24241 | __end_tp_report 18:26:18 INFO - PROCESS | 24241 | __start_cc_report 18:26:18 INFO - PROCESS | 24241 | _x_x_mozilla_cycle_collect,302 18:26:18 INFO - PROCESS | 24241 | __end_cc_report 18:26:18 INFO - PROCESS | 24241 | __startTimestamp1476494778885__endTimestamp 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | ------- Summary: start ------- 18:26:18 INFO - PROCESS | 24241 | Number of tests: 6 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | [#0] dojo.html Cycles:165 Average:5281.88 Median:5499.92 stddev:603.89 (11.0%) stddev-sans-first:578.02 18:26:18 INFO - PROCESS | 24241 | Values: 2976.3 2982.4 2982.7 2993.3 2997.7 5148.8 5295.8 5305.0 5347.8 5385.9 5221.8 5259.4 5325.6 5343.0 5351.6 4818.8 4833.8 4933.6 4943.2 5041.8 4427.0 4825.4 4950.8 4958.5 5004.4 4724.1 4738.7 4792.3 4876.0 4913.1 4800.6 4841.5 4854.7 4866.5 4938.5 4803.2 4804.1 4838.2 4849.0 4878.7 5193.8 5301.2 5302.5 5341.4 5372.5 5526.7 5602.8 5673.2 5711.1 5788.5 5728.4 5736.8 5746.7 5756.5 5761.3 5371.9 5376.1 5407.8 5410.1 5413.6 5676.9 5744.8 5776.3 5829.9 5830.9 5621.6 5635.1 5644.5 5645.5 5709.2 5659.2 5661.5 5733.5 5733.6 5737.7 5545.3 5575.6 5613.5 5651.3 5663.2 5673.1 5686.1 5695.1 5695.3 5695.7 4348.4 4364.0 4367.4 4378.0 4388.9 3897.5 3900.9 3912.5 3946.7 3949.7 5374.0 5375.5 5384.5 5399.1 5416.0 5478.7 5558.2 5667.4 5669.2 5756.7 5358.4 5360.1 5365.8 5384.9 5415.2 4826.1 4855.8 4873.2 4885.4 4910.9 5764.8 5841.4 5903.0 5952.7 6001.0 5664.7 5667.0 5678.1 5721.3 5727.9 5803.9 5812.8 5825.7 5867.6 5885.8 5475.3 5535.8 5570.3 5583.2 5584.9 5644.3 5682.9 5705.1 5708.0 5709.8 5540.8 5556.5 5560.6 5560.7 5577.7 5580.5 5584.6 5592.7 5593.7 5596.4 5461.2 5506.1 5511.1 5514.3 5521.0 5536.5 5616.2 5618.5 5621.8 5621.8 5382.2 5457.3 5484.8 5495.8 5499.9 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | [#1] ext.html Cycles:180 Average:58286.86 Median:22761.92 stddev:114278.87 (502.1%) stddev-sans-first:114517.33 18:26:18 INFO - PROCESS | 24241 | Values: 584.7 587.2 602.5 604.5 627.5 42013.4 43454.3 43512.8 43688.6 43698.1 43660.0 44171.0 44220.6 44325.8 44338.8 8825.5 8978.8 8979.4 9000.2 9000.6 8767.0 8836.0 8854.1 8857.9 8862.5 8838.4 8855.0 8856.5 8883.4 8897.3 8724.5 8776.4 8805.1 8820.4 8856.6 8735.3 8811.5 8879.9 8880.8 8882.9 41222.4 41510.6 41593.0 41611.8 41624.4 3517.2 3591.7 3613.8 4010.8 4133.7 32098.2 32233.4 32474.8 32598.3 34162.8 4305.7 4333.5 4370.7 4487.0 4537.9 333253.0 335437.9 335636.0 335647.0 336779.0 55708.0 56564.0 56576.4 56674.0 56722.4 58390.4 58465.0 58488.7 58542.7 58608.7 16691.4 16969.8 16976.4 17006.0 17031.9 13087.5 13110.2 13123.6 13168.0 13184.1 14110.0 15608.9 15626.8 15816.0 16022.2 5822.9 5958.2 6104.3 6127.7 6240.5 867.6 1003.5 1020.3 1029.6 1042.5 32377.8 32590.7 32686.3 32756.2 32766.8 1028.2 1032.4 1059.2 1074.0 1158.1 14872.9 16675.2 16921.0 17017.7 17070.1 495944.0 499451.0 499704.0 500693.0 502769.0 40646.2 41325.6 41390.2 41489.2 41787.4 1287.4 1316.9 1321.7 1328.7 1344.8 29963.7 31249.4 31333.5 31644.6 32043.7 51665.0 52290.5 52496.0 52578.5 52604.5 439112.0 441461.0 444233.0 445221.0 445862.0 27321.6 27354.0 27378.9 27547.0 27752.4 46777.5 47308.0 48081.5 48169.0 49466.0 40022.0 40585.6 40962.6 41298.2 41808.0 39678.4 39784.0 39935.9 40516.0 41298.4 39864.8 40752.8 40787.4 41256.6 41323.4 33841.0 36020.8 36204.0 36459.0 37139.6 27495.9 27992.3 28258.9 28312.2 28407.0 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | [#2] jquery.html Cycles:180 Average:28020.53 Median:12556.63 stddev:75825.12 (603.9%) stddev-sans-first:76009.42 18:26:18 INFO - PROCESS | 24241 | Values: 375.4 386.4 391.3 392.6 413.1 17976.6 19075.7 19340.9 19400.0 19813.8 19072.3 19158.3 19465.3 19482.6 19614.3 5446.5 5510.9 5596.6 5678.1 5768.4 5602.1 5644.8 5694.2 5698.1 5710.9 5378.2 5592.3 5637.3 5637.5 5660.5 5614.9 5673.9 5677.5 5688.4 5694.8 5010.5 5026.9 5035.3 5051.4 5060.5 22342.7 22443.0 22785.2 22788.1 22800.2 2178.1 2184.4 2313.1 2414.1 2811.7 14250.5 14515.3 14529.8 14668.3 15229.4 1921.9 1924.7 1926.5 1997.1 2032.2 81968.0 82182.6 83438.0 85290.6 85777.6 10114.6 10200.6 10462.6 10787.4 11101.6 15226.7 15244.6 15262.8 15333.9 15342.9 7768.2 8168.8 8201.3 8341.0 8486.6 7885.8 7963.3 7983.4 8227.1 8235.1 4516.7 4528.9 4572.1 4632.4 4723.2 1898.1 1936.3 1946.3 1959.0 1970.3 836.8 917.7 932.8 984.9 1078.1 18918.7 19314.6 19419.4 19419.7 19938.7 956.4 961.5 1026.8 1049.6 1060.7 10258.7 10689.4 10853.7 10884.0 10979.2 443452.0 450669.0 464229.0 468636.0 469389.0 84074.6 86647.0 86812.6 87836.6 87973.6 1008.6 1009.1 1013.7 1027.6 1030.8 16602.3 16692.2 17245.5 17255.1 17464.9 40691.6 41828.8 41938.8 42215.9 43107.1 52545.5 53929.7 55219.4 56208.7 56771.1 8051.7 8167.1 8376.4 8387.7 8425.9 11239.9 12776.8 12975.5 13005.5 13534.0 11181.7 11360.1 11927.9 11949.3 12022.9 11118.1 11238.8 11317.3 11617.8 11773.5 11399.5 11407.2 11459.9 11531.6 11548.2 8195.2 8304.4 8330.4 8469.2 8879.7 11216.4 11320.7 11369.3 11401.9 11522.0 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | [#3] mootools.html Cycles:180 Average:5832.72 Median:5099.42 stddev:3338.22 (65.5%) stddev-sans-first:3331.58 18:26:18 INFO - PROCESS | 24241 | Values: 1482.8 1491.6 1641.0 1757.0 1771.4 7493.7 7753.5 8443.9 9072.3 9097.1 8409.2 8664.2 8713.8 8902.2 8974.3 2257.4 2303.0 2305.9 2309.5 2310.3 2216.8 2266.8 2278.5 2285.1 2293.0 2237.9 2241.0 2252.7 2293.3 2300.4 2230.7 2233.4 2236.0 2239.5 2247.9 2142.0 2164.9 2167.7 2170.6 2173.0 9012.3 9143.3 9161.4 9164.9 9167.0 5177.3 5327.9 5332.8 5333.4 5335.8 3200.2 3234.4 3402.9 3437.9 3451.9 1016.7 1030.3 1038.5 1040.9 1045.1 12846.3 12853.8 12858.8 12930.5 12988.9 4439.2 4658.5 4680.9 4706.5 4729.9 10884.8 10891.8 10896.6 10910.6 10928.3 5345.5 5346.0 5346.1 5359.6 5364.2 4210.6 4645.5 4909.6 4970.8 5021.6 3899.2 4012.1 4021.2 4051.8 4103.3 1257.6 1270.9 1272.1 1286.1 1292.6 949.3 951.6 963.2 991.6 993.7 5784.9 5896.2 6039.0 6149.3 6242.6 920.7 938.2 939.2 965.4 991.3 4024.0 4311.5 4322.8 4326.4 4435.4 10491.3 10633.1 10759.8 10760.2 10780.8 10615.0 10728.5 10729.7 10734.8 10747.4 7942.4 8086.2 8226.5 8235.2 8255.0 5859.4 5890.6 5969.9 5995.6 6163.9 10007.7 10014.3 10316.8 10429.4 10505.9 9366.3 9681.9 9704.5 9986.9 10031.0 6807.0 7011.0 7413.6 7532.1 7550.0 8317.6 8608.4 8683.9 8702.5 8725.9 7617.7 7830.0 7916.0 7965.2 8086.2 7619.4 7759.2 7818.0 7820.7 7828.6 7309.7 7442.4 7448.3 7451.3 7453.3 5239.3 5290.8 5339.5 5402.9 5424.4 5183.2 5303.6 5333.5 5385.6 5411.5 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | [#4] prototype.html Cycles:180 Average:4758.41 Median:5398.55 stddev:1422.85 (26.4%) stddev-sans-first:1387.21 18:26:18 INFO - PROCESS | 24241 | Values: 315.6 316.3 325.5 325.5 327.3 5411.4 5452.0 5517.8 5551.7 5576.9 5410.5 5481.9 5487.8 5492.2 5515.2 4241.2 4243.0 4251.7 4264.1 4297.4 4024.3 4219.2 4286.8 4290.4 4321.7 4149.3 4169.6 4170.5 4170.6 4189.2 4162.5 4163.3 4176.5 4200.0 4214.9 3654.7 3657.7 3662.0 3665.1 3691.5 5227.5 5314.9 5332.6 5362.8 5371.7 4756.2 4770.9 4778.7 4780.5 4786.6 5386.6 5667.8 5697.3 5730.3 5744.7 3956.6 3973.6 3980.6 3988.9 4008.2 5898.8 5907.1 5954.8 5970.9 5976.8 4153.7 4157.6 4172.9 4173.5 4176.6 3983.9 4177.3 4180.9 4186.4 4189.9 4787.7 4801.4 4818.7 4820.9 4857.5 5743.9 5772.5 5785.7 5797.0 5825.9 1367.4 1398.7 1411.6 1428.3 1430.5 900.4 901.5 915.6 915.8 927.1 4864.7 4873.9 4877.8 4894.0 4899.8 5113.3 5119.8 5187.6 5220.3 5247.6 4797.8 4805.0 4818.8 4862.2 5111.4 3085.0 3146.3 3159.6 3160.8 3167.8 6075.7 6167.0 6176.8 6183.5 6200.9 5853.2 5944.7 5955.2 5988.8 5994.9 6082.6 6108.3 6136.8 6140.7 6143.8 5635.1 5880.8 5883.8 5891.2 5911.4 5752.6 5813.3 5909.5 5940.9 5952.6 6144.6 6176.9 6194.4 6198.2 6200.7 4001.6 4126.7 4185.8 4194.2 4235.3 5834.6 5845.6 5850.2 5868.3 5868.6 5720.2 5736.7 5751.8 5759.6 5773.2 5485.4 5687.4 5698.3 5701.1 5728.3 5639.9 5643.9 5651.0 5653.4 5663.9 5535.4 5679.3 5690.2 5799.8 5805.2 5607.8 5620.9 5621.2 5629.4 5638.0 18:26:18 INFO - PROCESS | 24241 | 18:26:18 INFO - PROCESS | 24241 | [#5] yui.html Cycles:180 Average:20146.28 Median:54216.00 stddev:30069.67 (55.5%) stddev-sans-first:30118.61 18:26:18 INFO - PROCESS | 24241 | Values: 710.4 720.9 731.9 784.7 842.7 15518.5 16400.9 16458.8 16637.3 16669.2 14954.6 15033.8 15096.2 15113.2 15177.8 799.8 821.4 823.3 825.5 826.8 818.9 819.7 822.2 823.0 823.4 858.1 859.0 859.4 861.1 865.2 848.5 856.9 858.8 860.0 861.2 634.2 637.2 638.0 640.5 640.7 14263.0 14267.5 14346.9 14351.9 14374.4 12285.5 12434.5 12612.1 13389.5 13532.8 11118.3 11287.2 11346.9 11424.9 11608.0 3762.6 3828.6 3830.8 4011.2 4015.2 70674.6 72044.6 74019.9 75935.0 76365.2 9860.9 10019.5 10024.7 10138.3 10266.2 20311.2 20458.4 20461.9 20506.1 20569.3 7368.9 8019.8 8031.0 8124.7 8164.0 4412.5 4538.1 4557.4 4583.4 4584.4 3520.6 3670.7 3672.0 3687.0 3769.1 534.6 536.1 538.2 539.0 551.0 597.8 651.9 678.7 682.7 683.7 8578.4 8905.0 9058.5 9178.2 9200.4 659.4 667.1 680.1 682.0 687.7 4160.0 4183.5 4491.6 4521.9 4631.0 66269.7 78176.6 83662.0 125876.0 127264.0 105529.0 108351.5 109994.0 110125.4 110161.0 56715.7 92516.5 95738.5 97631.0 98830.5 8032.1 8167.3 8211.0 8212.0 8300.5 54160.0 54272.0 54526.2 55107.7 55359.4 70964.8 72092.0 80828.0 81238.0 83854.0 10266.8 10315.1 10424.4 10585.2 10708.3 11835.1 11915.2 12057.2 12058.1 12542.3 11198.3 11736.1 12000.5 12015.9 12061.2 11452.1 11832.6 11916.2 12403.5 12421.8 11522.4 11823.3 12186.8 12194.8 12207.5 8855.6 9000.7 9023.9 9066.0 9273.5 8798.6 9285.0 9759.2 9867.4 9990.2 18:26:18 INFO - PROCESS | 24241 | -------- Summary: end -------- 18:26:18 INFO - PROCESS | 24241 | 18:26:19 INFO - TEST-INFO | 24241: exit 0 18:26:19 INFO - TEST-OK | dromaeo_css | took 1117668ms 18:26:19 INFO - TEST-START | kraken 18:26:19 INFO - operating with platform_type : linux_ 18:26:19 INFO - Initialising browser for kraken test... 18:26:19 INFO - TEST-INFO | started process 24604 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbYYEjU/profile http://localhost:44567/getInfo.html) 18:26:25 INFO - PROCESS | 24604 | __metrics Screen width/height:1600/1200 18:26:25 INFO - PROCESS | 24604 | colorDepth:24 18:26:25 INFO - PROCESS | 24604 | Browser inner width/height: 1024/697 18:26:25 INFO - PROCESS | 24604 | __metrics 18:26:25 ERROR - PROCESS | 24604 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 18:26:27 INFO - TEST-INFO | 24604: exit 0 18:26:27 INFO - Browser initialized. 18:26:27 INFO - Running cycle 1/1 for kraken test... 18:26:27 INFO - TEST-INFO | started process 24726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbYYEjU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:26:39 INFO - PROCESS | 24726 | RSS: Main: 182677504 18:26:39 INFO - PROCESS | 24726 | 18:26:42 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44567/tests/kraken/driver.html?testName=audio-beat-detection) 18:26:42 INFO - PROCESS | 24726 | RSS: Main: 196358144 18:26:42 INFO - PROCESS | 24726 | 18:26:45 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44567/tests/kraken/driver.html?testName=audio-dft) 18:26:46 INFO - PROCESS | 24726 | RSS: Main: 194453504 18:26:46 INFO - PROCESS | 24726 | 18:26:49 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44567/tests/kraken/driver.html?testName=audio-fft) 18:26:49 INFO - PROCESS | 24726 | RSS: Main: 191262720 18:26:49 INFO - PROCESS | 24726 | 18:26:51 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44567/tests/kraken/driver.html?testName=audio-oscillator) 18:26:52 INFO - PROCESS | 24726 | RSS: Main: 191881216 18:26:52 INFO - PROCESS | 24726 | 18:26:54 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:26:55 INFO - PROCESS | 24726 | RSS: Main: 191983616 18:26:55 INFO - PROCESS | 24726 | 18:26:58 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44567/tests/kraken/driver.html?testName=imaging-darkroom) 18:26:58 INFO - PROCESS | 24726 | RSS: Main: 192421888 18:26:58 INFO - PROCESS | 24726 | 18:27:02 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44567/tests/kraken/driver.html?testName=imaging-desaturate) 18:27:03 INFO - PROCESS | 24726 | RSS: Main: 190504960 18:27:03 INFO - PROCESS | 24726 | 18:27:05 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44567/tests/kraken/driver.html?testName=json-parse-financial) 18:27:06 INFO - PROCESS | 24726 | RSS: Main: 191451136 18:27:06 INFO - PROCESS | 24726 | 18:27:07 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:27:08 INFO - PROCESS | 24726 | RSS: Main: 191897600 18:27:08 INFO - PROCESS | 24726 | 18:27:10 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:27:11 INFO - PROCESS | 24726 | RSS: Main: 191868928 18:27:11 INFO - PROCESS | 24726 | 18:27:13 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:27:13 INFO - PROCESS | 24726 | RSS: Main: 192098304 18:27:13 INFO - PROCESS | 24726 | 18:27:16 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:27:17 INFO - PROCESS | 24726 | RSS: Main: 192294912 18:27:17 INFO - PROCESS | 24726 | 18:27:19 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:27:20 INFO - PROCESS | 24726 | RSS: Main: 192512000 18:27:20 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | Cycle 1(1): loaded http://localhost:44567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44567/tests/kraken/driver.html?testName=ai-astar) 18:27:22 INFO - PROCESS | 24726 | RSS: Main: 193867776 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | __start_tp_report 18:27:22 INFO - PROCESS | 24726 | _x_x_mozilla_page_load 18:27:22 INFO - PROCESS | 24726 | _x_x_mozilla_page_load_details 18:27:22 INFO - PROCESS | 24726 | |i|pagename|runs| 18:27:22 INFO - PROCESS | 24726 | |0;ai-astar;104;112;116;115;115;116;114;114;116;113 18:27:22 INFO - PROCESS | 24726 | |1;audio-beat-detection;158;124;124;160;126;130;128;125;160;126 18:27:22 INFO - PROCESS | 24726 | |2;audio-dft;161;165;167;173;165;163;162;164;164;168 18:27:22 INFO - PROCESS | 24726 | |3;audio-fft;77;75;75;114;78;77;76;75;99;77 18:27:22 INFO - PROCESS | 24726 | |4;audio-oscillator;84;83;124;83;83;83;101;84;83;111 18:27:22 INFO - PROCESS | 24726 | |5;imaging-gaussian-blur;118;117;118;118;117;118;117;118;118;119 18:27:22 INFO - PROCESS | 24726 | |6;imaging-darkroom;149;148;149;147;149;148;147;148;149;148 18:27:22 INFO - PROCESS | 24726 | |7;imaging-desaturate;86;85;86;85;85;85;85;85;85;84 18:27:22 INFO - PROCESS | 24726 | |8;json-parse-financial;55;54;53;56;55;58;58;54;62;54 18:27:22 INFO - PROCESS | 24726 | |9;json-stringify-tinderbox;61;61;61;61;60;59;60;60;61;60 18:27:22 INFO - PROCESS | 24726 | |10;stanford-crypto-aes;89;81;81;81;84;80;81;81;80;81 18:27:22 INFO - PROCESS | 24726 | |11;stanford-crypto-ccm;132;133;131;134;129;134;135;132;179;135 18:27:22 INFO - PROCESS | 24726 | |12;stanford-crypto-pbkdf2;168;166;166;163;169;170;166;163;166;166 18:27:22 INFO - PROCESS | 24726 | |13;stanford-crypto-sha256-iterative;65;69;66;65;65;64;68;67;64;71 18:27:22 INFO - PROCESS | 24726 | __end_tp_report 18:27:22 INFO - PROCESS | 24726 | __start_cc_report 18:27:22 INFO - PROCESS | 24726 | _x_x_mozilla_cycle_collect,798 18:27:22 INFO - PROCESS | 24726 | __end_cc_report 18:27:22 INFO - PROCESS | 24726 | __startTimestamp1476494842534__endTimestamp 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | ------- Summary: start ------- 18:27:22 INFO - PROCESS | 24726 | Number of tests: 14 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.60 (3.1%) stddev-sans-first:1.42 18:27:22 INFO - PROCESS | 24726 | Values: 104.0 112.0 116.0 115.0 115.0 116.0 114.0 114.0 116.0 113.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:129.00 stddev:16.14 (12.5%) stddev-sans-first:15.05 18:27:22 INFO - PROCESS | 24726 | Values: 158.0 124.0 124.0 160.0 126.0 130.0 128.0 125.0 160.0 126.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:3.46 (2.1%) stddev-sans-first:3.32 18:27:22 INFO - PROCESS | 24726 | Values: 161.0 165.0 167.0 173.0 165.0 163.0 162.0 164.0 164.0 168.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:13.28 (17.2%) stddev-sans-first:13.94 18:27:22 INFO - PROCESS | 24726 | Values: 77.0 75.0 75.0 114.0 78.0 77.0 76.0 75.0 99.0 77.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:83.00 stddev:14.90 (18.0%) stddev-sans-first:15.53 18:27:22 INFO - PROCESS | 24726 | Values: 84.0 83.0 124.0 83.0 83.0 83.0 101.0 84.0 83.0 111.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 18:27:22 INFO - PROCESS | 24726 | Values: 118.0 117.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 119.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 18:27:22 INFO - PROCESS | 24726 | Values: 149.0 148.0 149.0 147.0 149.0 148.0 147.0 148.0 149.0 148.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 18:27:22 INFO - PROCESS | 24726 | Values: 86.0 85.0 86.0 85.0 85.0 85.0 85.0 85.0 85.0 84.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:2.73 (4.9%) stddev-sans-first:2.87 18:27:22 INFO - PROCESS | 24726 | Values: 55.0 54.0 53.0 56.0 55.0 58.0 58.0 54.0 62.0 54.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 18:27:22 INFO - PROCESS | 24726 | Values: 61.0 61.0 61.0 61.0 60.0 59.0 60.0 60.0 61.0 60.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:2.73 (3.4%) stddev-sans-first:1.17 18:27:22 INFO - PROCESS | 24726 | Values: 89.0 81.0 81.0 81.0 84.0 80.0 81.0 81.0 80.0 81.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:134.00 stddev:14.74 (11.0%) stddev-sans-first:15.50 18:27:22 INFO - PROCESS | 24726 | Values: 132.0 133.0 131.0 134.0 129.0 134.0 135.0 132.0 179.0 135.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:166.00 stddev:2.26 (1.4%) stddev-sans-first:2.32 18:27:22 INFO - PROCESS | 24726 | Values: 168.0 166.0 166.0 163.0 169.0 170.0 166.0 163.0 166.0 166.0 18:27:22 INFO - PROCESS | 24726 | 18:27:22 INFO - PROCESS | 24726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:2.32 (3.5%) stddev-sans-first:2.40 18:27:22 INFO - PROCESS | 24726 | Values: 65.0 69.0 66.0 65.0 65.0 64.0 68.0 67.0 64.0 71.0 18:27:22 INFO - PROCESS | 24726 | -------- Summary: end -------- 18:27:22 INFO - PROCESS | 24726 | 18:27:23 INFO - TEST-INFO | 24726: exit 0 18:27:23 INFO - TEST-OK | kraken | took 63826ms 18:27:23 INFO - SUITE-END | took 1181s 18:27:24 INFO - Completed test suite (00:19:41) 18:27:24 INFO - javascript benchmark 18:27:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7156.7315849378165, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2976.3005693661985, 2982.4333376658433, 2982.731554160125, 2993.2965753048015, 2997.685243049479, 5148.819791307305, 5295.761690723917, 5304.973475132624, 5347.786088556462, 5385.91921121183, 5221.791128354871, 5259.368875734907, 5325.600579956509, 5342.958123165974, 5351.625386222966, 4818.759062046901, 4833.806647734086, 4933.605311575084, 4943.159662857305, 5041.8235361762345, 4427.048184640301, 4825.372701548811, 4950.826721064764, 4958.454569997298, 5004.449510553836, 4724.055188962221, 4738.668293219476, 4792.305115758213, 4876.02479504097, 4913.091078150554, 4800.639952003614, 4841.515848415165, 4854.660173787836, 4866.46468888422, 4938.456769755324, 4803.231482962744, 4804.111239420718, 4838.177509823338, 4849.0, 4878.731669758162, 5193.766280517386, 5301.1783173608155, 5302.469753024705, 5341.359036915556, 5372.516473517402, 5526.668399896019, 5602.803901863415, 5673.177389278531, 5711.05767548354, 5788.450097240755, 5728.369879313273, 5736.799212027559, 5746.741396637161, 5756.510696590794, 5761.308642962829, 5371.946280537184, 5376.086065368897, 5407.756650950717, 5410.053240682904, 5413.648112872651, 5676.886462270814, 5744.770209191669, 5776.277965254343, 5829.912551311733, 5830.8542286442325, 5621.606487545914, 5635.126555383922, 5644.520215781705, 5645.491905728504, 5709.172170035322, 5659.151127330851, 5661.49046585801, 5733.541316694655, 5733.569982251264, 5737.713114344266, 5545.334559852843, 5575.581831362583, 5613.522850557667, 5651.265335506358, 5663.207150998864, 5673.120666296731, 5686.09022556389, 5695.088785794253, 5695.316562012502, 5695.7152142392715, 4348.391225228471, 4363.978180109079, 4367.388565600819, 4378.0, 4388.9122217556105, 3897.4933258676756, 3900.941485877714, 3912.5304963404574, 3946.703997200164, 3949.743266687656, 5373.9731301343245, 5375.489328513785, 5384.515393614593, 5399.082156033405, 5415.972920135374, 5478.671279723229, 5558.194061861008, 5667.376588575254, 5669.234653321749, 5756.740946657411, 5358.410574836765, 5360.061989151883, 5365.812196573102, 5384.946150538444, 5415.241866138744, 4826.131296366688, 4855.781489832966, 4873.220284754422, 4885.438174609894, 4910.926336104962, 5764.769409223668, 5841.357450680422, 5903.026000709835, 5952.702364881825, 6001.0, 5664.688442135722, 5667.0, 5678.119891416837, 5721.342045664802, 5727.914081288867, 5803.9419605803405, 5812.796552120655, 5825.70871456417, 5867.559933005127, 5885.823425297248, 5475.260839786737, 5535.7785688572, 5570.275864137636, 5583.190437386637, 5584.86037849057, 5644.266245388073, 5682.886342273048, 5705.058665320175, 5707.971460142673, 5709.800156994485, 5540.750666219949, 5556.527695145958, 5560.638558493685, 5560.694161820977, 5577.693226872399, 5580.469855363896, 5584.553235741212, 5592.664440133605, 5593.748281327432, 5596.38439771633, 5461.1808228766, 5506.146547285177, 5511.063119269814, 5514.28314319152, 5521.0, 5536.474034966672, 5616.21373007771, 5618.52242559387, 5621.775128994795, 5621.831345059655, 5382.246485492113, 5457.263269458731, 5484.7806087757635, 5495.752691128829, 5499.917501237404], "value": 5240.249845790292, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.663818304475, 587.1574290892567, 602.5330368964051, 604.5012864386882, 627.5262177056322, 42013.369799452994, 43454.34818477721, 43512.782436087815, 43688.563114368844, 43698.12603747931, 43660.0, 44171.0, 44220.55779442205, 44325.77837110818, 44338.77830610851, 8825.51459669718, 8978.775530611754, 8979.416337938013, 9000.234980026673, 9000.59497322622, 8766.956165219164, 8835.95582022089, 8854.07032261613, 8857.911420885805, 8862.468251904906, 8838.42550234236, 8854.955725221365, 8856.51289179098, 8883.42257753244, 8897.33270004749, 8724.52015139167, 8776.385653004292, 8805.119488051208, 8820.382573219846, 8856.645734170625, 8735.301175905912, 8811.471311721318, 8879.911200888038, 8880.777980550472, 8882.86675699865, 41222.38166427476, 41510.584894151274, 41593.0, 41611.79194104041, 41624.37563436551, 3517.2437925846066, 3591.730620203495, 3613.7651052681754, 4010.7710455977654, 4133.669306455507, 32098.197545061328, 32233.35533289321, 32474.837625811957, 32598.348033039445, 34162.82918585416, 4305.677074219415, 4333.544977777351, 4370.672199585012, 4486.955130448687, 4537.931931021038, 333253.0, 335437.87372757954, 335636.0, 335647.0, 336779.0, 55708.0, 56564.0, 56576.434235657114, 56674.0, 56722.43277567172, 58390.41609583935, 58465.0, 58488.707556461944, 58542.707286463294, 58608.70695646494, 16691.41580044717, 16969.83030169707, 16976.40582579604, 17006.0, 17031.914840425965, 13087.476500940045, 13110.213387196798, 13123.60629181126, 13168.0, 13184.077114601885, 14110.0, 15608.895720634242, 15626.76559851603, 15816.0, 16022.19889005545, 5822.854428639233, 5958.195643588147, 6104.290798576406, 6127.662978536223, 6240.500759939194, 867.5748883047262, 1003.5484032185545, 1020.2705065877933, 1029.562435964712, 1042.4839704346398, 32377.838110809294, 32590.674093259237, 32686.346273074407, 32756.181095472803, 32766.83616581902, 1028.1671845804922, 1032.4115254305125, 1059.2320567588438, 1073.9892601074046, 1158.1082566423806, 14872.925635371754, 16675.166241687868, 16921.02060765666, 17017.659646806995, 17070.146492675318, 495944.0, 499451.0, 499704.0, 500693.0, 502769.0, 40646.1870762589, 41325.586744132175, 41390.1721965559, 41489.1702165955, 41787.373189402184, 1287.4077924154806, 1316.861729518406, 1321.669582604349, 1328.6678330417396, 1344.7915573086186, 29963.700362996093, 31249.375012500077, 31333.52999705052, 31644.57759612688, 32043.679563205, 51665.0, 52290.47709522856, 52496.0, 52578.47421525736, 52604.47395525996, 439112.0, 441461.0, 444233.0, 445221.0, 445862.0, 27321.590176146976, 27354.0, 27378.86310568514, 27547.035853745023, 27752.444951101268, 46777.53222467868, 47308.0, 48081.5191848077, 48169.0, 49466.0, 40022.0, 40585.59414405936, 40962.590374095875, 41298.174036519704, 41808.0, 39678.404823927085, 39784.0, 39935.866057960346, 40516.0, 41298.38052429156, 39864.800675996434, 40752.796236019814, 40787.38818917659, 41256.58743412527, 41323.38014929718, 33841.0, 36020.81989590035, 36204.0, 36459.0, 37139.628603713616, 27495.862520687268, 27992.30019249535, 28258.85870570634, 28312.150635480146, 28407.0], "value": 19597.51002971622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4330960250023, 386.3698926422589, 391.2741863842572, 392.59366555614946, 413.0726518964924, 17976.640467190664, 19075.713864292047, 19340.90329548352, 19400.02999850007, 19813.801861981377, 19072.33246836361, 19158.329458468957, 19465.31871384502, 19482.610347793037, 19614.313499027536, 5446.455354464551, 5510.91733623994, 5596.608237423382, 5678.119891416837, 5768.3654797972185, 5602.1036634138545, 5644.774209031654, 5694.174344720013, 5698.059820129673, 5710.857228569277, 5378.1663842104535, 5592.273004509408, 5637.295338082739, 5637.46444087811, 5660.462256085665, 5614.887702245953, 5673.943260567383, 5677.545796336304, 5688.402717714622, 5694.829155125353, 5010.498950104997, 5026.924596131061, 5035.269885866565, 5051.393832740095, 5060.544550990392, 22342.66486002711, 22443.0, 22785.20251791179, 22788.08847646092, 22800.201992930168, 2178.1287485005964, 2184.388371256051, 2313.051648823991, 2414.082648593523, 2811.7188281171925, 14250.501232456918, 14515.346809393603, 14529.78205326921, 14668.339924703414, 15229.390824367012, 1921.8750781199178, 1924.7401600783855, 1926.5087402712218, 1997.1212666426725, 2032.2074390987527, 81968.0, 82182.58908705418, 83438.0, 85290.57354713249, 85777.57111214467, 10114.645987390406, 10200.6429774959, 10462.581496740046, 10787.352758834495, 11101.555937762561, 15226.695466090616, 15244.569971756488, 15262.847371526364, 15333.923330383277, 15342.92599518023, 7768.223177682186, 8168.754937351889, 8201.273660350693, 8341.0, 8486.575671216415, 7885.763427097197, 7963.283304502506, 7983.401244906655, 8227.095019547965, 8235.052968908532, 4516.706414083074, 4528.88677783058, 4572.1312950539295, 4632.3977882875015, 4723.244280915037, 1898.1078892920304, 1936.322287199469, 1946.2993322403922, 1959.0106995966946, 1970.270999730109, 836.8033512124646, 917.6604656277086, 932.8367535681228, 984.8621193032981, 1078.0728573426848, 18918.716219256723, 19314.613707725766, 19419.4174174775, 19419.708704369445, 19938.70091948622, 956.4070276428658, 961.5048250151178, 1026.7946410717736, 1049.58541376156, 1060.6870973062964, 10258.66593357147, 10689.358638481715, 10853.674389768319, 10884.0, 10979.231453798317, 443452.0, 450669.0, 464229.0, 468636.0, 469389.0, 84074.57962710147, 86647.0, 86812.56593716991, 87836.56081719551, 87973.56013219892, 1008.621766837436, 1009.1472705563787, 1013.7110923386799, 1027.6300531808542, 1030.8247597908223, 16602.25289861935, 16692.165391730607, 17245.482635520955, 17255.137243138044, 17464.912675437048, 40691.593084069966, 41828.790856045525, 41938.79030604827, 42215.944601383984, 43107.13785724331, 52545.47454525406, 53929.73035134799, 55219.44780552143, 56208.718956404955, 56771.148432772716, 8051.718189863561, 8167.0607880092175, 8376.413651044368, 8387.664493420194, 8425.915740842513, 11239.887601124212, 12776.808347874603, 12975.545855895376, 13005.544805931748, 13534.0, 11181.72045698864, 11360.1479889007, 11927.880721192678, 11949.283043017447, 12022.879771202175, 11118.110551156049, 11238.7752244953, 11317.264377815416, 11617.767644647229, 11773.52905883755, 11399.487023084146, 11407.201495895208, 11459.942700286445, 11531.596394126165, 11548.249363791327, 8195.221453961864, 8304.377171712267, 8330.375221858507, 8469.153084691481, 8879.733607991771, 11216.439178040902, 11320.716982075513, 11369.2609980351, 11401.942990284995, 11522.020628246357], "value": 9172.161179024892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.8368879423265, 1491.6420059185791, 1640.9589760255992, 1756.9560760980983, 1771.3534559885645, 7493.700251989928, 7753.496022758517, 8443.915560844389, 9072.274218062548, 9097.0902909709, 8409.201125893045, 8664.220220180183, 8713.7821554461, 8902.243309318716, 8974.326925480582, 2257.3679369776405, 2302.988485057581, 2305.896234669444, 2309.515001849605, 2310.318456055468, 2216.8115710164657, 2266.784655457729, 2278.544291141778, 2285.0859656137513, 2293.0, 2237.9216727414546, 2241.0363543676212, 2252.718410198725, 2293.3234695764704, 2300.4018955071633, 2230.721159855018, 2233.4304752288226, 2236.049678886475, 2239.484918468745, 2247.8876056197205, 2141.967870481944, 2164.9242276520245, 2167.696522486853, 2170.6309927312395, 2172.9782702172934, 9012.324075694349, 9143.268538516902, 9161.404508706913, 9164.8625270621, 9166.954165229132, 5177.275181474596, 5327.920081198785, 5332.813351532678, 5333.413324534298, 5335.8132465363915, 3200.2319443333663, 3234.4016356974034, 3402.914927126817, 3437.8968630941113, 3451.861925523001, 1016.7204018894789, 1030.340582027503, 1038.5274700011478, 1040.9115225205867, 1045.0698877998586, 12846.293453860035, 12853.807192892114, 12858.807117893239, 12930.54743083997, 12988.935055324757, 4439.223135951195, 4658.534146585314, 4680.9297860532115, 4706.505816889246, 4729.905401891943, 10884.782304354027, 10891.83662245067, 10896.61861834832, 10910.61812836547, 10928.289661171999, 5345.492178243061, 5345.973270133624, 5346.064438723286, 5359.5712343012465, 5364.168553874156, 4210.578942105826, 4645.465771436328, 4909.607231421549, 4970.826021089245, 5021.573166280834, 3899.200663863901, 4012.137390461065, 4021.2158629067053, 4051.837926482967, 4103.312330423577, 1257.5724253753585, 1270.866559011309, 1272.0713878868478, 1286.0676009892752, 1292.5734507612465, 949.2785483032807, 951.5955718819474, 963.1620490173594, 991.6182269826024, 993.7118235711707, 5784.913226301609, 5896.174535565025, 6038.969805150946, 6149.292831324366, 6242.625442473466, 920.7283851263759, 938.1509733691021, 939.2063706168277, 965.3628605120587, 991.3011327014437, 4023.959760402417, 4311.50417701962, 4322.783860806947, 4326.3510473428605, 4435.423394958635, 10491.265611407282, 10633.096186824052, 10759.78480430387, 10760.192985526117, 10780.838287425695, 10615.044645981745, 10728.517216725266, 10729.678109656566, 10734.838977415346, 10747.355158690503, 7942.44402891792, 8086.15095414973, 8226.465279756916, 8235.21765432283, 8254.958725206336, 5859.414058594107, 5890.617109887844, 5969.91045134332, 5995.550333724901, 6163.938360616516, 10007.699769006942, 10014.298999069995, 10316.845247321146, 10429.426381549089, 10505.894941050492, 9366.297527685314, 9681.903180968382, 9704.514774261399, 9986.850197247193, 10030.99690030991, 6806.9659651703405, 7011.0, 7413.555186688816, 7532.096148462219, 7550.0, 8317.625706843328, 8608.354373422144, 8683.86974195375, 8702.521361325187, 8725.91274087251, 7617.733379331697, 7830.0, 7916.0, 7965.163657816078, 8086.1913808618665, 7619.390448763975, 7759.2240775921955, 7817.960910195413, 7820.687172513036, 7828.5694286812495, 7309.671064802203, 7442.441816863865, 7448.329650331496, 7451.329380355577, 7453.2546745325035, 5239.266502689703, 5290.841274761763, 5339.4660533947845, 5402.945970540244, 5424.430434804289, 5183.170692689152, 5303.575713942798, 5333.466653334635, 5385.6230063895155, 5411.458854114557], "value": 4646.866590927081, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.569247976512, 316.33096001955863, 325.4759836662972, 325.49873195279264, 327.3338755632289, 5411.431799661038, 5452.0, 5517.751701173447, 5551.722413879305, 5576.86057848554, 5410.5401040911565, 5481.862953426166, 5487.832306239033, 5492.203630473589, 5515.200295957084, 4241.172971270596, 4242.97878510607, 4251.723637963538, 4264.102474398894, 4297.35539669049, 4024.315866302721, 4219.198352313066, 4286.828526858922, 4290.42079319291, 4321.697481176319, 4149.294619914606, 4169.6455801256925, 4170.520390155126, 4170.624643782059, 4189.224993376235, 4162.500499939996, 4163.272242019559, 4176.477940257452, 4200.0, 4214.936775948363, 3654.7441679082476, 3657.6890964267805, 3661.9816900915325, 3665.102049997741, 3691.50164727761, 5227.457899919533, 5314.92027619586, 5332.573394128461, 5362.839114826562, 5371.731413429313, 4756.239001759736, 4770.880727981794, 4778.665493415462, 4780.450248221464, 4786.558854983983, 5386.551457619055, 5667.829965101054, 5697.287839020122, 5730.283714535683, 5744.741486633112, 3956.5647778744315, 3973.5827738087664, 3980.5621381647998, 3988.860389886369, 4008.2183974125055, 5898.849724303763, 5907.084401917667, 5954.761809527614, 5970.940290597082, 5976.834517269178, 4153.709240353207, 4157.563455837154, 4172.895677608084, 4173.457450531472, 4176.60322269384, 3983.860564880273, 4177.289860723684, 4180.895477613084, 4186.35111557709, 4189.905047476262, 4787.736674482867, 4801.423829140525, 4818.6626936114835, 4820.903581928342, 4857.53853383928, 5743.8851222976145, 5772.509336706343, 5785.65286082828, 5797.01450753373, 5825.88348233033, 1367.3573420492353, 1398.706271682958, 1411.5835828430638, 1428.271581493425, 1430.4850253908585, 900.3607438718452, 901.4636291406603, 915.6017132547363, 915.7865827778221, 927.0868194828089, 4864.6594738368685, 4873.878153046202, 4877.756112194376, 4894.0, 4899.8440686098, 5113.309703190096, 5119.772898789039, 5187.610929180327, 5220.347456567929, 5247.553957913544, 4797.784099715521, 4804.95195048045, 4818.771423146501, 4862.222044472867, 5111.361079865017, 3085.0, 3146.300997461391, 3159.557661927332, 3160.7945483543494, 3167.8099314041233, 6075.696215189223, 6166.969165154145, 6176.81469555914, 6183.505319574423, 6200.937990620127, 5853.209816674779, 5944.6730429826775, 5955.166276721263, 5988.760449581968, 5994.910076348859, 6082.601001769618, 6108.267007958984, 6136.754529818757, 6140.662263575457, 6143.84640383994, 5635.084071415738, 5880.764769409347, 5883.764649413975, 5891.23413956183, 5911.438413350725, 5752.626079304831, 5813.273340832396, 5909.497692696169, 5940.8811823764145, 5952.553558483044, 6144.56988010835, 6176.938230617637, 6194.442500175006, 6198.194234749454, 6200.689965501617, 4001.579439299007, 4126.690498212706, 4185.769782661861, 4194.196495506962, 4235.280002399538, 5834.562407819346, 5845.649261044351, 5850.23946886919, 5868.2664666916635, 5868.618539794899, 5720.227769251098, 5736.6558006519745, 5751.827445176651, 5759.568032397503, 5773.16289138081, 5485.424030476902, 5687.43125687428, 5698.2592263005545, 5701.087825947829, 5728.250439789008, 5639.943600563942, 5643.88712225745, 5650.971745141248, 5653.42769040094, 5663.858403539944, 5535.39110697831, 5679.290088738908, 5690.203371527907, 5799.82600521985, 5805.245318108618, 5607.794324220312, 5620.887582248414, 5621.184928185472, 5629.408912064338, 5637.955504027943], "value": 4296.72120799397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.3926143147612, 720.8666396716604, 731.9121705395352, 784.7292684024013, 842.696629213483, 15518.456854010112, 16400.917995410036, 16458.83541164588, 16637.251323690434, 16669.166541672897, 14954.626134346647, 15033.84966150341, 15096.245187740624, 15113.168775717331, 15177.772333415007, 799.816042310269, 821.3757544266341, 823.2631794543879, 825.4964471672275, 826.7643721539363, 818.9181081891793, 819.7417813388794, 822.2065706593137, 823.0493779684474, 823.3783493462457, 858.1247127929508, 859.0, 859.415597393772, 861.0872475176302, 865.2429124516049, 848.4824257203101, 856.9185927336893, 858.7724253072972, 860.0152825015385, 861.1861790607878, 634.1534052040531, 637.1939496536885, 637.9585326953733, 640.4780104215097, 640.7372977079375, 14263.0, 14267.500637477639, 14346.92826535871, 14351.928240358731, 14374.425022999067, 12285.508579656804, 12434.502619895193, 12612.117151799377, 13389.50187894782, 13532.84970777485, 11118.332900025944, 11287.15346349019, 11346.886531134665, 11424.885751142465, 11608.013318867906, 3762.623737626243, 3828.5979972102805, 3830.8467661293516, 4011.2178125265586, 4015.217032678629, 70674.64662676705, 72044.63977680077, 74019.88970165506, 75935.0, 76365.23634763692, 9860.901390985999, 10019.499025048719, 10024.749381265527, 10138.294697045012, 10266.230032747424, 20311.18755249803, 20458.38624841257, 20461.89769051145, 20506.07722652484, 20569.280075197297, 7368.8894666580045, 8019.839603207904, 8030.959845200737, 8124.675012999413, 8163.95918020418, 4412.492563355191, 4538.092381523708, 4557.384753058294, 4583.449986001635, 4584.381108550369, 3520.559930008749, 3670.724695647837, 3671.9632803672157, 3686.9815650921573, 3769.133099387156, 534.5509771791636, 536.1368197202501, 538.1900240138644, 538.967661940277, 550.9669419834822, 597.8355952113203, 651.947844172465, 678.6979793991725, 682.6620822692798, 683.6820878291618, 8578.356623253281, 8905.04089100397, 9058.50178240203, 9178.21985131258, 9200.40197387181, 659.3637140159769, 667.1427216027381, 680.1498127340824, 681.9590824550543, 687.6630451078935, 4159.9792001040405, 4183.5398106208295, 4491.573300536444, 4521.909561808746, 4630.976845115752, 66269.66865165644, 78176.60911695405, 83662.0, 125876.0, 127264.0, 105529.0, 108351.45824270986, 109994.0, 110125.44937275263, 110161.0, 56715.71642141845, 92516.53741731249, 95738.52130739302, 97631.0, 98830.5058474703, 8032.116467188722, 8167.264946154874, 8211.0, 8211.95894020526, 8300.460470069425, 54160.0, 54272.0, 54526.18210726922, 55107.72446137744, 55359.446405535426, 70964.83904351066, 72092.0, 80828.0, 81238.0, 83854.0, 10266.794664106526, 10315.12321452685, 10424.374537527772, 10585.153187744809, 10708.30396024256, 11835.112366572714, 11915.225510342147, 12057.216280941711, 12058.095642826647, 12542.310172940575, 11198.328100314007, 11736.06111511094, 12000.519979200733, 12015.939920300343, 12061.15571909993, 11452.141089418494, 11832.645020649394, 11916.16586838913, 12403.503859845505, 12421.75156496847, 11522.366269854903, 11823.349715765715, 12186.756264874475, 12194.804935111764, 12207.45066471993, 8855.557222138996, 9000.729978100668, 9023.864642030507, 9065.954670226607, 9273.489958052372, 8798.604062817061, 9285.0, 9759.219262459128, 9867.358621689567, 9990.15083717892], "value": 7143.693683213234, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 116.0, 115.0, 115.0, 116.0, 114.0, 114.0, 116.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 124.0, 160.0, 126.0, 130.0, 128.0, 125.0, 160.0, 126.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 165.0, 167.0, 173.0, 165.0, 163.0, 162.0, 164.0, 164.0, 168.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 114.0, 78.0, 77.0, 76.0, 75.0, 99.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 124.0, 83.0, 83.0, 83.0, 101.0, 84.0, 83.0, 111.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 147.0, 149.0, 148.0, 147.0, 148.0, 149.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 53.0, 56.0, 55.0, 58.0, 58.0, 54.0, 62.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 60.0, 59.0, 60.0, 60.0, 61.0, 60.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 81.0, 81.0, 84.0, 80.0, 81.0, 81.0, 80.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 131.0, 134.0, 129.0, 134.0, 135.0, 132.0, 179.0, 135.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 166.0, 163.0, 169.0, 170.0, 166.0, 163.0, 166.0, 166.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 65.0, 65.0, 64.0, 68.0, 67.0, 64.0, 71.0], "value": 66.4, "unit": "score"}]}]} 18:27:24 INFO - Return code: 0 18:27:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:27:24 ERROR - # TBPL SUCCESS # 18:27:24 INFO - Running post-action listener: _resource_record_post_action 18:27:24 INFO - [mozharness: 2016-10-15 01:27:24.322199Z] Finished run-tests step (success) 18:27:24 INFO - Running post-run listener: _resource_record_post_run 18:27:24 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401821696; Read time: 12; Write time: 626972 18:27:24 INFO - TinderboxPrint: CPU usage
13.4% 18:27:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:27:24 INFO - TinderboxPrint: I/O write bytes / time
401,821,696 / 626,972 18:27:24 INFO - TinderboxPrint: CPU idle
8,274.3 (86.5%) 18:27:24 INFO - TinderboxPrint: CPU user
1,218.1 (12.7%) 18:27:24 INFO - TinderboxPrint: Swap in / out
0 / 0 18:27:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103743488; Read time: 0; Write time: 210960 18:27:24 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 298078208; Read time: 0; Write time: 416012 18:27:24 INFO - Running post-run listener: _upload_blobber_files 18:27:24 INFO - Blob upload gear active. 18:27:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:27:24 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 18:27:24 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:27:24 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:27:25 INFO - (blobuploader) - INFO - Open directory for files ... 18:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:26 INFO - (blobuploader) - INFO - Done attempting. 18:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:27 INFO - (blobuploader) - INFO - Done attempting. 18:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:27:30 INFO - (blobuploader) - INFO - Done attempting. 18:27:30 INFO - (blobuploader) - INFO - Iteration through files over. 18:27:30 INFO - Return code: 0 18:27:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:27:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:27:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cba8b7108f2ab75609e8a00ac06a2545559c09796f3ebf797bb250e68401f9c655a3b1e95275e6b9891050a5a3ef1a13d46287978609df02ef8fb87b21f7c0f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de186152c610e6097964dea5d5cbcdebab373d6a26881a2c95e31c098144334a46aa5758066987a4db41ea59799331818688f8877572ee072cc8a43d262e252d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ce9fe3ec7268e95111aadcacba94d200bc51722bc379bb717416b9c2d036924fa4e6a32c1cd058b7b286a701c67785ebbac6201ac7d6329dc1f0ab114ff715"} 18:27:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:27:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:27:30 INFO - Contents: 18:27:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cba8b7108f2ab75609e8a00ac06a2545559c09796f3ebf797bb250e68401f9c655a3b1e95275e6b9891050a5a3ef1a13d46287978609df02ef8fb87b21f7c0f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de186152c610e6097964dea5d5cbcdebab373d6a26881a2c95e31c098144334a46aa5758066987a4db41ea59799331818688f8877572ee072cc8a43d262e252d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ce9fe3ec7268e95111aadcacba94d200bc51722bc379bb717416b9c2d036924fa4e6a32c1cd058b7b286a701c67785ebbac6201ac7d6329dc1f0ab114ff715"} 18:27:30 INFO - Running post-run listener: copy_logs_to_upload_dir 18:27:30 INFO - Copying logs to upload dir... 18:27:30 INFO - mkdir: /builds/slave/test/build/upload/logs 18:27:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.816025 ========= master_lag: 0.55 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 18:27:31.041267) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 18:27:31.046048) ========= 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-1476491548.922296-1655581212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cba8b7108f2ab75609e8a00ac06a2545559c09796f3ebf797bb250e68401f9c655a3b1e95275e6b9891050a5a3ef1a13d46287978609df02ef8fb87b21f7c0f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de186152c610e6097964dea5d5cbcdebab373d6a26881a2c95e31c098144334a46aa5758066987a4db41ea59799331818688f8877572ee072cc8a43d262e252d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ce9fe3ec7268e95111aadcacba94d200bc51722bc379bb717416b9c2d036924fa4e6a32c1cd058b7b286a701c67785ebbac6201ac7d6329dc1f0ab114ff715"} build_url:https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011346 build_url: 'https://queue.taskcluster.net/v1/task/fOsKLmwQRGCs5o2LXCe2LQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cba8b7108f2ab75609e8a00ac06a2545559c09796f3ebf797bb250e68401f9c655a3b1e95275e6b9891050a5a3ef1a13d46287978609df02ef8fb87b21f7c0f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/de186152c610e6097964dea5d5cbcdebab373d6a26881a2c95e31c098144334a46aa5758066987a4db41ea59799331818688f8877572ee072cc8a43d262e252d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ce9fe3ec7268e95111aadcacba94d200bc51722bc379bb717416b9c2d036924fa4e6a32c1cd058b7b286a701c67785ebbac6201ac7d6329dc1f0ab114ff715"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 18:27:31.071458) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:27:31.071810) ========= 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-1476491548.922296-1655581212 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 18:27:31.121471) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 18:27:31.121804) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 18:27:31.122098) ========= ========= Total master_lag: 0.68 =========