builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1480432626.29 results: success (0) buildid: 20161129043006 builduid: 2de9cebe67b940d5a79bf8c3ea19f9a8 revision: f8107cf961444a8d7fdc2c0f446238af9893f875 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.291024) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.291984) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.292495) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.313822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.314118) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-29 07:17:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-11-29 07:17:06 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090045 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.418519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.418885) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021537 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.468615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:06.468972) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8107cf961444a8d7fdc2c0f446238af9893f875 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8107cf961444a8d7fdc2c0f446238af9893f875 --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=56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-29 07:17:06,871 truncating revision to first 12 chars 2016-11-29 07:17:06,871 Setting DEBUG logging. 2016-11-29 07:17:06,871 attempt 1/10 2016-11-29 07:17:06,871 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8107cf96144?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 07:17:07,197 unpacking tar archive at: mozilla-central-f8107cf96144/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:07.128801) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:07.129145) ========= script_repo_revision: f8107cf961444a8d7fdc2c0f446238af9893f875 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:07.129618) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:07.129928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 07:17:07.144188) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-29 07:17:07.144487) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:17:07 INFO - MultiFileLogger online at 20161129 07:17:07 in /builds/slave/test 07:17:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:17:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:17:07 INFO - {'append_to_log': False, 07:17:07 INFO - 'base_work_dir': '/builds/slave/test', 07:17:07 INFO - 'blob_upload_branch': 'Firefox', 07:17:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:17:07 INFO - 'branch': 'Firefox', 07:17:07 INFO - 'buildbot_json_path': 'buildprops.json', 07:17:07 INFO - 'config_files': ('talos/linux_config.py',), 07:17:07 INFO - 'default_actions': ('clobber', 07:17:07 INFO - 'read-buildbot-config', 07:17:07 INFO - 'download-and-extract', 07:17:07 INFO - 'populate-webroot', 07:17:07 INFO - 'create-virtualenv', 07:17:07 INFO - 'install', 07:17:07 INFO - 'run-tests'), 07:17:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:17:07 INFO - 'download_minidump_stackwalk': True, 07:17:07 INFO - 'download_symbols': 'ondemand', 07:17:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:17:07 INFO - 'tooltool.py': '/tools/tooltool.py', 07:17:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:17:07 INFO - '/tools/misc-python/virtualenv.py')}, 07:17:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:17:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:17:07 INFO - 'installer_path': 'installer.exe', 07:17:07 INFO - 'log_level': 'info', 07:17:07 INFO - 'log_name': 'talos', 07:17:07 INFO - 'log_to_console': True, 07:17:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:17:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:17:07 INFO - 'opt_config_files': (), 07:17:07 INFO - 'pip_index': False, 07:17:07 INFO - 'sps_profile': False, 07:17:07 INFO - 'sps_profile_interval': 0, 07:17:07 INFO - 'suite': 'dromaeojs', 07:17:07 INFO - 'system_bits': '32', 07:17:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:17:07 INFO - 'title': 'talos-linux64-ix-037', 07:17:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:17:07 INFO - 'use_talos_json': True, 07:17:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:17:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:17:07 INFO - 'work_dir': 'build'} 07:17:07 INFO - [mozharness: 2016-11-29 15:17:07.650310Z] Running clobber step. 07:17:07 INFO - Running pre-action listener: _resource_record_pre_action 07:17:07 INFO - Running main action method: clobber 07:17:07 INFO - rmtree: /builds/slave/test/build 07:17:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:17:08 INFO - Running post-action listener: _resource_record_post_action 07:17:08 INFO - [mozharness: 2016-11-29 15:17:08.119253Z] Finished clobber step (success) 07:17:08 INFO - [mozharness: 2016-11-29 15:17:08.119352Z] Running read-buildbot-config step. 07:17:08 INFO - Running pre-action listener: _resource_record_pre_action 07:17:08 INFO - Running main action method: read_buildbot_config 07:17:08 INFO - Using buildbot properties: 07:17:08 INFO - { 07:17:08 INFO - "project": "", 07:17:08 INFO - "product": "firefox", 07:17:08 INFO - "script_repo_revision": "production", 07:17:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:17:08 INFO - "repository": "", 07:17:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 07:17:08 INFO - "buildid": "20161129043006", 07:17:08 INFO - "pgo_build": "True", 07:17:08 INFO - "basedir": "/builds/slave/test", 07:17:08 INFO - "buildnumber": 110, 07:17:08 INFO - "slavename": "talos-linux64-ix-037", 07:17:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:17:08 INFO - "platform": "ubuntu64_hw", 07:17:08 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 07:17:08 INFO - "branch": "mozilla-central", 07:17:08 INFO - "repo_path": "mozilla-central", 07:17:08 INFO - "revision": "f8107cf961444a8d7fdc2c0f446238af9893f875", 07:17:08 INFO - "stage_platform": "linux64-pgo", 07:17:08 INFO - "builduid": "2de9cebe67b940d5a79bf8c3ea19f9a8", 07:17:08 INFO - "slavebuilddir": "test" 07:17:08 INFO - } 07:17:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:17:08 INFO - Running post-action listener: _resource_record_post_action 07:17:08 INFO - [mozharness: 2016-11-29 15:17:08.121780Z] Finished read-buildbot-config step (success) 07:17:08 INFO - [mozharness: 2016-11-29 15:17:08.121869Z] Running download-and-extract step. 07:17:08 INFO - Running pre-action listener: _resource_record_pre_action 07:17:08 INFO - Running main action method: download_and_extract 07:17:08 INFO - mkdir: /builds/slave/test/build/tests 07:17: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')]} 07:17:08 INFO - trying https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:17:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:17:08 INFO - Downloaded 1361 bytes. 07:17:08 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:17:08 INFO - Using the following test package requirements: 07:17:08 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:08 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:17:08 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:17:08 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'jsshell-linux-x86_64.zip'], 07:17:08 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:17:08 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:17:08 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:17:08 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:17:08 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:17:08 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:17:08 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:17:08 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:17:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:17:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:08 INFO - Fetch https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:17:09 INFO - Http code: 200 07:17:09 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 07:17:09 INFO - x-amz-cf-id: JWsM7myTEwAcSApDSKPof3jB1yd8n0yY_mB4URcYd2esr4tje9qosg== 07:17:09 INFO - x-amz-version-id: 6yqNRLVH5F9G_69MNnFjL7U93wHY0aNU 07:17:09 INFO - Expected file size: 21781218 07:17:09 INFO - Obtained file size: 21781218 07:17:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:17:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:17:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:17:13 INFO - Fetch https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:17:14 INFO - Http code: 200 07:17:14 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 07:17:14 INFO - x-amz-cf-id: 1V-pZRRWcxUhdW2gTHclN0rrgIs6JVcbOvIfhwENUt6D5sDf48NG6A== 07:17:14 INFO - x-amz-version-id: 6yqNRLVH5F9G_69MNnFjL7U93wHY0aNU 07:17:14 INFO - Expected file size: 21781218 07:17:14 INFO - Obtained file size: 21781218 07:17:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:17:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:17:18 INFO - Fetch https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:17:19 INFO - Http code: 200 07:17:19 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 07:17:19 INFO - x-amz-cf-id: Pf3M3zjboD2uZoGS0kQEsJIIMRZtYaMrD5oCMJj8AK_tHjVnlAKVCQ== 07:17:19 INFO - x-amz-version-id: yWBKGFjnfZVJU_bATReDOcfSEKibpC8k 07:17:19 INFO - Expected file size: 14409702 07:17:19 INFO - Obtained file size: 14409702 07:17: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')]} 07:17:20 INFO - trying https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:20 INFO - Downloading https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:17:22 INFO - Downloaded 59852792 bytes. 07:17:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:22 INFO - mkdir: /builds/slave/test/properties 07:17:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:17:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:17:22 INFO - Contents: 07:17:22 INFO - build_url:https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:17:23 INFO - Running post-action listener: _resource_record_post_action 07:17:23 INFO - Running post-action listener: set_extra_try_arguments 07:17:23 INFO - [mozharness: 2016-11-29 15:17:23.630578Z] Finished download-and-extract step (success) 07:17:23 INFO - [mozharness: 2016-11-29 15:17:23.630804Z] Running populate-webroot step. 07:17:23 INFO - Running pre-action listener: _resource_record_pre_action 07:17:23 INFO - Running main action method: populate_webroot 07:17:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:17:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:17:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:17:23 INFO - '--tppagecycles', 07:17:23 INFO - '7'], 07:17:23 INFO - 'tests': ['tsvgm']}}, 07:17:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:17:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:17:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:17:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:17:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:17:23 INFO - 'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:17:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:17:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:17:23 INFO - 'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['damp', 'tps']}, 07:17:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:17:23 INFO - 'tests': ['damp', 'tps']}, 07:17:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['dromaeo_dom']}, 07:17:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:17:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['basic_compositor_video']}, 07:17:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:17:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['a11yr', 07:17:23 INFO - 'ts_paint', 07:17:23 INFO - 'tpaint', 07:17:23 INFO - 'sessionrestore', 07:17:23 INFO - 'sessionrestore_no_auto_restore', 07:17:23 INFO - 'tabpaint']}, 07:17:23 INFO - 'other-e10s': {'tests': ['a11yr', 07:17:23 INFO - 'ts_paint', 07:17:23 INFO - 'tpaint', 07:17:23 INFO - 'sessionrestore', 07:17:23 INFO - 'sessionrestore_no_auto_restore', 07:17:23 INFO - 'tabpaint']}, 07:17:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:17:23 INFO - 'ts_paint', 07:17:23 INFO - 'tpaint', 07:17:23 INFO - 'sessionrestore', 07:17:23 INFO - 'sessionrestore_no_auto_restore', 07:17:23 INFO - 'tabpaint']}, 07:17:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:17:23 INFO - 'ts_paint', 07:17:23 INFO - 'tpaint', 07:17:23 INFO - 'sessionrestore', 07:17:23 INFO - 'sessionrestore_no_auto_restore', 07:17:23 INFO - 'tabpaint']}, 07:17:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['a11yr', 07:17:23 INFO - 'ts_paint', 07:17:23 INFO - 'tpaint', 07:17:23 INFO - 'sessionrestore', 07:17:23 INFO - 'sessionrestore_no_auto_restore', 07:17:23 INFO - 'tabpaint']}, 07:17:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['a11yr', 07:17:23 INFO - 'ts_paint', 07:17:23 INFO - 'tpaint', 07:17:23 INFO - 'sessionrestore', 07:17:23 INFO - 'sessionrestore_no_auto_restore', 07:17:23 INFO - 'tabpaint']}, 07:17:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['tsvgx', 07:17:23 INFO - 'tsvgr_opacity', 07:17:23 INFO - 'tart', 07:17:23 INFO - 'tscrollx', 07:17:23 INFO - 'cart', 07:17:23 INFO - 'tsvg_static']}, 07:17:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:17:23 INFO - 'tsvgr_opacity', 07:17:23 INFO - 'tart', 07:17:23 INFO - 'tscrollx', 07:17:23 INFO - 'cart', 07:17:23 INFO - 'tsvg_static']}, 07:17:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:17:23 INFO - 'talos_options': ['--disable-e10s'], 07:17:23 INFO - 'tests': ['tp5o']}, 07:17:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:17:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:17:23 INFO - 'talos_options': ['--disable-e10s', 07:17:23 INFO - '--xperf_path', 07:17:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:23 INFO - 'tests': ['tp5n']}, 07:17:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:17:23 INFO - 'talos_options': ['--xperf_path', 07:17:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:17:23 INFO - 'tests': ['tp5n']}}, 07:17:23 INFO - 'talos.zip': {'path': '', 07:17:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:17:23 INFO - Running post-action listener: _resource_record_post_action 07:17:23 INFO - [mozharness: 2016-11-29 15:17:23.648147Z] Finished populate-webroot step (success) 07:17:23 INFO - [mozharness: 2016-11-29 15:17:23.648235Z] Running create-virtualenv step. 07:17:23 INFO - Running pre-action listener: _resource_record_pre_action 07:17:23 INFO - Running main action method: create_virtualenv 07:17:23 INFO - Creating virtualenv /builds/slave/test/build/venv 07:17:23 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:17:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:17:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:17:23 INFO - Using real prefix '/usr' 07:17:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:17:24 INFO - Installing distribute.............................................................................................................................................................................................done. 07:17:26 INFO - Installing pip.................done. 07:17:26 INFO - Return code: 0 07:17:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:17:26 INFO - Reading from file tmpfile_stdout 07:17:26 INFO - Output received: 07:17:26 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) 07:17:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:17:26 INFO - Using env: {'DISPLAY': ':0', 07:17:26 INFO - 'HOME': '/home/cltbld', 07:17:26 INFO - 'LANG': 'en_US.UTF-8', 07:17:26 INFO - 'LANGUAGE': 'en_US:en', 07:17:26 INFO - 'LOGNAME': 'cltbld', 07:17:26 INFO - 'MAIL': '/var/mail/cltbld', 07:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:26 INFO - 'MOZ_NO_REMOTE': '1', 07:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:26 INFO - 'NO_EM_RESTART': '1', 07:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:26 INFO - 'PWD': '/builds/slave/test', 07:17:26 INFO - 'SHELL': '/bin/bash', 07:17:26 INFO - 'SHLVL': '1', 07:17:26 INFO - 'TERM': 'linux', 07:17:26 INFO - 'TMOUT': '86400', 07:17:26 INFO - 'USER': 'cltbld', 07:17:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:26 INFO - '_': '/tools/buildbot/bin/python'} 07:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:17:26 INFO - Cleaning up... 07:17:26 INFO - Return code: 0 07:17:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:17:26 INFO - Using env: {'DISPLAY': ':0', 07:17:26 INFO - 'HOME': '/home/cltbld', 07:17:26 INFO - 'LANG': 'en_US.UTF-8', 07:17:26 INFO - 'LANGUAGE': 'en_US:en', 07:17:26 INFO - 'LOGNAME': 'cltbld', 07:17:26 INFO - 'MAIL': '/var/mail/cltbld', 07:17:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:26 INFO - 'MOZ_NO_REMOTE': '1', 07:17:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:26 INFO - 'NO_EM_RESTART': '1', 07:17:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:26 INFO - 'PWD': '/builds/slave/test', 07:17:26 INFO - 'SHELL': '/bin/bash', 07:17:26 INFO - 'SHLVL': '1', 07:17:26 INFO - 'TERM': 'linux', 07:17:26 INFO - 'TMOUT': '86400', 07:17:26 INFO - 'USER': 'cltbld', 07:17:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:26 INFO - '_': '/tools/buildbot/bin/python'} 07:17:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:26 INFO - Downloading/unpacking psutil>=3.1.1 07:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:17:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:28 INFO - Installing collected packages: psutil 07:17:28 INFO - Running setup.py install for psutil 07:17:29 INFO - building 'psutil._psutil_linux' extension 07:17:29 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 07:17:29 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 07:17:29 INFO - building 'psutil._psutil_posix' extension 07:17:29 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 07:17:29 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 07:17:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:17:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:17:29 INFO - Successfully installed psutil 07:17:29 INFO - Cleaning up... 07:17:29 INFO - Return code: 0 07:17:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:17:29 INFO - Using env: {'DISPLAY': ':0', 07:17:29 INFO - 'HOME': '/home/cltbld', 07:17:29 INFO - 'LANG': 'en_US.UTF-8', 07:17:29 INFO - 'LANGUAGE': 'en_US:en', 07:17:29 INFO - 'LOGNAME': 'cltbld', 07:17:29 INFO - 'MAIL': '/var/mail/cltbld', 07:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:29 INFO - 'MOZ_NO_REMOTE': '1', 07:17:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:29 INFO - 'NO_EM_RESTART': '1', 07:17:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:29 INFO - 'PWD': '/builds/slave/test', 07:17:29 INFO - 'SHELL': '/bin/bash', 07:17:29 INFO - 'SHLVL': '1', 07:17:29 INFO - 'TERM': 'linux', 07:17:29 INFO - 'TMOUT': '86400', 07:17:29 INFO - 'USER': 'cltbld', 07:17:29 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:29 INFO - '_': '/tools/buildbot/bin/python'} 07:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:17:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:17:31 INFO - Installing collected packages: mozsystemmonitor 07:17:31 INFO - Running setup.py install for mozsystemmonitor 07:17:31 INFO - Successfully installed mozsystemmonitor 07:17:31 INFO - Cleaning up... 07:17:31 INFO - Return code: 0 07:17:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:17:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:17:31 INFO - Using env: {'DISPLAY': ':0', 07:17:31 INFO - 'HOME': '/home/cltbld', 07:17:31 INFO - 'LANG': 'en_US.UTF-8', 07:17:31 INFO - 'LANGUAGE': 'en_US:en', 07:17:31 INFO - 'LOGNAME': 'cltbld', 07:17:31 INFO - 'MAIL': '/var/mail/cltbld', 07:17:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:31 INFO - 'MOZ_NO_REMOTE': '1', 07:17:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:31 INFO - 'NO_EM_RESTART': '1', 07:17:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:31 INFO - 'PWD': '/builds/slave/test', 07:17:31 INFO - 'SHELL': '/bin/bash', 07:17:31 INFO - 'SHLVL': '1', 07:17:31 INFO - 'TERM': 'linux', 07:17:31 INFO - 'TMOUT': '86400', 07:17:31 INFO - 'USER': 'cltbld', 07:17:31 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:31 INFO - '_': '/tools/buildbot/bin/python'} 07:17:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:32 INFO - Downloading/unpacking jsonschema==2.5.1 07:17:32 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 07:17:32 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 07:17:32 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 07:17:32 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 07:17:32 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 07:17:32 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 07:17:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:17:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:34 INFO - Downloading functools32-3.2.3-2.tar.gz 07:17:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:17:34 INFO - warning: no files found matching '*.txt' 07:17:34 INFO - no previously-included directories found matching 'build' 07:17:34 INFO - no previously-included directories found matching 'dist' 07:17:34 INFO - no previously-included directories found matching '.git*' 07:17:34 INFO - Installing collected packages: jsonschema, functools32 07:17:34 INFO - Running setup.py install for functools32 07:17:34 INFO - warning: no files found matching '*.txt' 07:17:34 INFO - no previously-included directories found matching 'build' 07:17:34 INFO - no previously-included directories found matching 'dist' 07:17:34 INFO - no previously-included directories found matching '.git*' 07:17:34 INFO - Successfully installed jsonschema functools32 07:17:34 INFO - Cleaning up... 07:17:34 INFO - Return code: 0 07:17:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:17:34 INFO - Using env: {'DISPLAY': ':0', 07:17:34 INFO - 'HOME': '/home/cltbld', 07:17:34 INFO - 'LANG': 'en_US.UTF-8', 07:17:34 INFO - 'LANGUAGE': 'en_US:en', 07:17:34 INFO - 'LOGNAME': 'cltbld', 07:17:34 INFO - 'MAIL': '/var/mail/cltbld', 07:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:34 INFO - 'MOZ_NO_REMOTE': '1', 07:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:34 INFO - 'NO_EM_RESTART': '1', 07:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:34 INFO - 'PWD': '/builds/slave/test', 07:17:34 INFO - 'SHELL': '/bin/bash', 07:17:34 INFO - 'SHLVL': '1', 07:17:34 INFO - 'TERM': 'linux', 07:17:34 INFO - 'TMOUT': '86400', 07:17:34 INFO - 'USER': 'cltbld', 07:17:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:34 INFO - '_': '/tools/buildbot/bin/python'} 07:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:17:34 INFO - Cleaning up... 07:17:34 INFO - Return code: 0 07:17:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:17:34 INFO - Using env: {'DISPLAY': ':0', 07:17:34 INFO - 'HOME': '/home/cltbld', 07:17:34 INFO - 'LANG': 'en_US.UTF-8', 07:17:34 INFO - 'LANGUAGE': 'en_US:en', 07:17:34 INFO - 'LOGNAME': 'cltbld', 07:17:34 INFO - 'MAIL': '/var/mail/cltbld', 07:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:34 INFO - 'MOZ_NO_REMOTE': '1', 07:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:34 INFO - 'NO_EM_RESTART': '1', 07:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:34 INFO - 'PWD': '/builds/slave/test', 07:17:34 INFO - 'SHELL': '/bin/bash', 07:17:34 INFO - 'SHLVL': '1', 07:17:34 INFO - 'TERM': 'linux', 07:17:34 INFO - 'TMOUT': '86400', 07:17:34 INFO - 'USER': 'cltbld', 07:17:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:34 INFO - '_': '/tools/buildbot/bin/python'} 07:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:17:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:17:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:37 INFO - Downloading docopt-0.6.1.tar.gz 07:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:17:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:17:37 INFO - Running setup.py install for blobuploader 07:17:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:17:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:17:37 INFO - Running setup.py install for requests 07:17:38 INFO - Running setup.py install for docopt 07:17:38 INFO - Successfully installed blobuploader requests docopt 07:17:38 INFO - Cleaning up... 07:17:38 INFO - Return code: 0 07:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:38 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 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:38 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 07:17:38 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 07:17:38 INFO - Using env: {'DISPLAY': ':0', 07:17:38 INFO - 'HOME': '/home/cltbld', 07:17:38 INFO - 'LANG': 'en_US.UTF-8', 07:17:38 INFO - 'LANGUAGE': 'en_US:en', 07:17:38 INFO - 'LOGNAME': 'cltbld', 07:17:38 INFO - 'MAIL': '/var/mail/cltbld', 07:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:38 INFO - 'MOZ_NO_REMOTE': '1', 07:17:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:38 INFO - 'NO_EM_RESTART': '1', 07:17:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:38 INFO - 'PWD': '/builds/slave/test', 07:17:38 INFO - 'SHELL': '/bin/bash', 07:17:38 INFO - 'SHLVL': '1', 07:17:38 INFO - 'TERM': 'linux', 07:17:38 INFO - 'TMOUT': '86400', 07:17:38 INFO - 'USER': 'cltbld', 07:17:38 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:38 INFO - '_': '/tools/buildbot/bin/python'} 07:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:38 INFO - Running setup.py (path:/tmp/pip-8Zupzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:38 INFO - Running setup.py (path:/tmp/pip-4oG8Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:38 INFO - Running setup.py (path:/tmp/pip-UIPsmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:38 INFO - Running setup.py (path:/tmp/pip-v_8HLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:38 INFO - Running setup.py (path:/tmp/pip-2nIA0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:38 INFO - Running setup.py (path:/tmp/pip-6uU89M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:39 INFO - Running setup.py (path:/tmp/pip-SESNXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:39 INFO - Running setup.py (path:/tmp/pip-gC14A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:39 INFO - Running setup.py (path:/tmp/pip-zNU5Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:39 INFO - Running setup.py (path:/tmp/pip-KWdHpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:39 INFO - Running setup.py (path:/tmp/pip-8H0Xrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:39 INFO - Running setup.py (path:/tmp/pip-g0Ng_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:39 INFO - Running setup.py (path:/tmp/pip-EjUvnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:39 INFO - Running setup.py (path:/tmp/pip-Rbi5oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:39 INFO - Running setup.py (path:/tmp/pip-yPz7My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:39 INFO - Running setup.py (path:/tmp/pip-lcQE8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:39 INFO - Running setup.py (path:/tmp/pip-x9uleM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:17:39 INFO - Running setup.py install for manifestparser 07:17:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:17:39 INFO - Running setup.py install for mozcrash 07:17:40 INFO - Running setup.py install for mozdebug 07:17:40 INFO - Running setup.py install for mozdevice 07:17:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Running setup.py install for mozfile 07:17:40 INFO - Running setup.py install for mozhttpd 07:17:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Running setup.py install for mozinfo 07:17:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Running setup.py install for mozInstall 07:17:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Running setup.py install for mozleak 07:17:40 INFO - Running setup.py install for mozlog 07:17:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Running setup.py install for moznetwork 07:17:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:17:40 INFO - Running setup.py install for mozprocess 07:17:41 INFO - Running setup.py install for mozprofile 07:17:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozrunner 07:17:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Running setup.py install for mozscreenshot 07:17:41 INFO - Running setup.py install for moztest 07:17:41 INFO - Running setup.py install for mozversion 07:17:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:17:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:17:41 INFO - Cleaning up... 07:17:41 INFO - Return code: 0 07:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:41 INFO - Using env: {'DISPLAY': ':0', 07:17:41 INFO - 'HOME': '/home/cltbld', 07:17:41 INFO - 'LANG': 'en_US.UTF-8', 07:17:41 INFO - 'LANGUAGE': 'en_US:en', 07:17:41 INFO - 'LOGNAME': 'cltbld', 07:17:41 INFO - 'MAIL': '/var/mail/cltbld', 07:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:41 INFO - 'MOZ_NO_REMOTE': '1', 07:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:41 INFO - 'NO_EM_RESTART': '1', 07:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:41 INFO - 'PWD': '/builds/slave/test', 07:17:41 INFO - 'SHELL': '/bin/bash', 07:17:41 INFO - 'SHLVL': '1', 07:17:41 INFO - 'TERM': 'linux', 07:17:41 INFO - 'TMOUT': '86400', 07:17:41 INFO - 'USER': 'cltbld', 07:17:41 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:41 INFO - '_': '/tools/buildbot/bin/python'} 07:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:17:41 INFO - Running setup.py (path:/tmp/pip-cV1WLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:17:41 INFO - Running setup.py (path:/tmp/pip-zvyg_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:17:42 INFO - Running setup.py (path:/tmp/pip-2_uWi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:17:42 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)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:17:42 INFO - Running setup.py (path:/tmp/pip-Flyity-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:17:42 INFO - Running setup.py (path:/tmp/pip-ecXi0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:17:42 INFO - Running setup.py (path:/tmp/pip-2elBR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:17:42 INFO - Running setup.py (path:/tmp/pip-eBvrN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:17:42 INFO - Running setup.py (path:/tmp/pip-zoo_h2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:17:42 INFO - Running setup.py (path:/tmp/pip-gXnFZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:17:42 INFO - Running setup.py (path:/tmp/pip-ksodBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:17:42 INFO - Running setup.py (path:/tmp/pip-eTfFuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:17:42 INFO - Running setup.py (path:/tmp/pip-YdgV4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:17:42 INFO - Running setup.py (path:/tmp/pip-JyfJFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:17:42 INFO - Running setup.py (path:/tmp/pip-9vK8IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:42 INFO - Running setup.py (path:/tmp/pip-qLMEsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:17:42 INFO - Running setup.py (path:/tmp/pip-obHlnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:17:43 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)) 07:17:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:17:43 INFO - Running setup.py (path:/tmp/pip-vibguB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:17:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:17:45 INFO - Downloading blessings-1.6.tar.gz 07:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:17:45 INFO - Installing collected packages: blessings 07:17:45 INFO - Running setup.py install for blessings 07:17:45 INFO - Successfully installed blessings 07:17:45 INFO - Cleaning up... 07:17:45 INFO - Return code: 0 07:17:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:17:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:45 INFO - Reading from file tmpfile_stdout 07:17:45 INFO - Current package versions: 07:17:45 INFO - argparse == 1.2.1 07:17:45 INFO - blessings == 1.6 07:17:45 INFO - blobuploader == 1.2.4 07:17:45 INFO - docopt == 0.6.1 07:17:45 INFO - functools32 == 3.2.3-2 07:17:45 INFO - jsonschema == 2.5.1 07:17:45 INFO - manifestparser == 1.1 07:17:45 INFO - mozInstall == 1.12 07:17:45 INFO - mozcrash == 1.0 07:17:45 INFO - mozdebug == 0.1 07:17:45 INFO - mozdevice == 0.49 07:17:45 INFO - mozfile == 1.2 07:17:45 INFO - mozhttpd == 0.7 07:17:45 INFO - mozinfo == 0.9 07:17:45 INFO - mozleak == 0.1 07:17:45 INFO - mozlog == 3.4 07:17:45 INFO - moznetwork == 0.27 07:17:45 INFO - mozprocess == 0.23 07:17:45 INFO - mozprofile == 0.28 07:17:45 INFO - mozrunner == 6.13 07:17:45 INFO - mozscreenshot == 0.1 07:17:45 INFO - mozsystemmonitor == 0.3 07:17:45 INFO - moztest == 0.7 07:17:45 INFO - mozversion == 1.4 07:17:45 INFO - psutil == 3.1.1 07:17:45 INFO - requests == 1.2.3 07:17:45 INFO - wsgiref == 0.1.2 07:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:17:45 INFO - Using env: {'DISPLAY': ':0', 07:17:45 INFO - 'HOME': '/home/cltbld', 07:17:45 INFO - 'LANG': 'en_US.UTF-8', 07:17:45 INFO - 'LANGUAGE': 'en_US:en', 07:17:45 INFO - 'LOGNAME': 'cltbld', 07:17:45 INFO - 'MAIL': '/var/mail/cltbld', 07:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:45 INFO - 'MOZ_NO_REMOTE': '1', 07:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:45 INFO - 'NO_EM_RESTART': '1', 07:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:45 INFO - 'PWD': '/builds/slave/test', 07:17:45 INFO - 'SHELL': '/bin/bash', 07:17:45 INFO - 'SHLVL': '1', 07:17:45 INFO - 'TERM': 'linux', 07:17:45 INFO - 'TMOUT': '86400', 07:17:45 INFO - 'USER': 'cltbld', 07:17:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:45 INFO - '_': '/tools/buildbot/bin/python'} 07:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:17:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:17:45 INFO - Cleaning up... 07:17:45 INFO - Return code: 0 07:17:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:17: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')]} 07:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17: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')]} 07:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:17:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f994d6ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b20b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cbc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', '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 07:17:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:17:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:17:45 INFO - Using env: {'DISPLAY': ':0', 07:17:45 INFO - 'HOME': '/home/cltbld', 07:17:45 INFO - 'LANG': 'en_US.UTF-8', 07:17:45 INFO - 'LANGUAGE': 'en_US:en', 07:17:45 INFO - 'LOGNAME': 'cltbld', 07:17:45 INFO - 'MAIL': '/var/mail/cltbld', 07:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:45 INFO - 'MOZ_NO_REMOTE': '1', 07:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:17:45 INFO - 'NO_EM_RESTART': '1', 07:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:45 INFO - 'PWD': '/builds/slave/test', 07:17:45 INFO - 'SHELL': '/bin/bash', 07:17:45 INFO - 'SHLVL': '1', 07:17:45 INFO - 'TERM': 'linux', 07:17:45 INFO - 'TMOUT': '86400', 07:17:45 INFO - 'USER': 'cltbld', 07:17:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:45 INFO - '_': '/tools/buildbot/bin/python'} 07:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:17:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:17:46 INFO - Cleaning up... 07:17:46 INFO - Return code: 0 07:17:46 INFO - Running post-action listener: _resource_record_post_action 07:17:46 INFO - Running post-action listener: _start_resource_monitoring 07:17:46 INFO - Starting resource monitoring. 07:17:46 INFO - [mozharness: 2016-11-29 15:17:46.073970Z] Finished create-virtualenv step (success) 07:17:46 INFO - [mozharness: 2016-11-29 15:17:46.074493Z] Running install step. 07:17:46 INFO - Running pre-action listener: _resource_record_pre_action 07:17:46 INFO - Running main action method: install 07:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:46 INFO - Reading from file tmpfile_stdout 07:17:46 INFO - Detecting whether we're running mozinstall >=1.0... 07:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:17:46 INFO - Reading from file tmpfile_stdout 07:17:46 INFO - Output received: 07:17:46 INFO - Usage: mozinstall [options] installer 07:17:46 INFO - Options: 07:17:46 INFO - -h, --help show this help message and exit 07:17:46 INFO - -d DEST, --destination=DEST 07:17:46 INFO - Directory to install application into. [default: 07:17:46 INFO - "/builds/slave/test"] 07:17:46 INFO - --app=APP Application being installed. [default: firefox] 07:17:46 INFO - mkdir: /builds/slave/test/build/application 07:17:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:17:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:18:03 INFO - Reading from file tmpfile_stdout 07:18:03 INFO - Output received: 07:18:03 INFO - /builds/slave/test/build/application/firefox/firefox 07:18:03 INFO - Running post-action listener: _resource_record_post_action 07:18:03 INFO - [mozharness: 2016-11-29 15:18:03.389274Z] Finished install step (success) 07:18:03 INFO - [mozharness: 2016-11-29 15:18:03.389518Z] Running run-tests step. 07:18:03 INFO - Running pre-action listener: _resource_record_pre_action 07:18:03 INFO - Running main action method: run_tests 07:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:18:03 INFO - Python 2.7.3 07:18:03 INFO - Return code: 0 07:18:03 INFO - grabbing minidump binary from tooltool 07:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:18:03 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d4afc0>, '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 0x2d4bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d4c350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:18:03 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:18:03 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:18:03 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:18:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:18:03 INFO - Return code: 0 07:18:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:18:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:18:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:18:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:18:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:18:03 INFO - Using env: {'DISPLAY': ':0', 07:18:03 INFO - 'HOME': '/home/cltbld', 07:18:03 INFO - 'LANG': 'en_US.UTF-8', 07:18:03 INFO - 'LANGUAGE': 'en_US:en', 07:18:03 INFO - 'LOGNAME': 'cltbld', 07:18:03 INFO - 'MAIL': '/var/mail/cltbld', 07:18:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:18:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:18:03 INFO - 'MOZ_NO_REMOTE': '1', 07:18:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:18:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:18:03 INFO - 'NO_EM_RESTART': '1', 07:18:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:18:03 INFO - 'PWD': '/builds/slave/test', 07:18:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:18:03 INFO - 'SHELL': '/bin/bash', 07:18:03 INFO - 'SHLVL': '1', 07:18:03 INFO - 'TERM': 'linux', 07:18:03 INFO - 'TMOUT': '86400', 07:18:03 INFO - 'USER': 'cltbld', 07:18:03 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957', 07:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:18:03 INFO - '_': '/tools/buildbot/bin/python'} 07:18:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:18:03 INFO - mozversion application_buildid: 20161129043006 07:18:03 INFO - mozversion application_changeset: f8107cf961444a8d7fdc2c0f446238af9893f875 07:18:03 INFO - mozversion application_display_name: Nightly 07:18:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:18:03 INFO - mozversion application_name: Firefox 07:18:03 INFO - mozversion application_remotingname: firefox 07:18:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:18:03 INFO - mozversion application_vendor: Mozilla 07:18:03 INFO - mozversion application_version: 53.0a1 07:18:03 INFO - mozversion platform_buildid: 20161129043006 07:18:03 INFO - mozversion platform_changeset: f8107cf961444a8d7fdc2c0f446238af9893f875 07:18:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:18:03 INFO - mozversion platform_version: 53.0a1 07:18:03 INFO - using testdate: 1480432683 07:18:03 INFO - actual date: 1480432683 07:18:03 INFO - starting webserver on 'localhost:51771' 07:18:03 INFO - SUITE-START | Running 2 tests 07:18:03 INFO - TEST-START | dromaeo_css 07:18:03 INFO - operating with platform_type : linux_ 07:18:03 INFO - Initialising browser for dromaeo_css test... 07:18:03 INFO - TEST-INFO | started process 15386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLEcLmD/profile http://localhost:51771/getInfo.html) 07:18:07 INFO - PROCESS | 15386 | __metrics Screen width/height:1600/1200 07:18:07 INFO - PROCESS | 15386 | colorDepth:24 07:18:07 INFO - PROCESS | 15386 | Browser inner width/height: 1024/697 07:18:07 INFO - PROCESS | 15386 | __metrics 07:18:08 INFO - PROCESS | 15386 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:18:08 INFO - PROCESS | 15386 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:09 INFO - TEST-INFO | 15386: exit 0 07:18:09 INFO - Browser initialized. 07:18:09 INFO - Running cycle 1/1 for dromaeo_css test... 07:18:09 INFO - TEST-INFO | started process 15468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLEcLmD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:21 INFO - PROCESS | 15468 | RSS: Main: 172961792 07:18:21 INFO - PROCESS | 15468 | 07:19:13 INFO - PROCESS | 15468 | 1480432753066 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] 07:21:22 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:51771/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51771/tests/dromaeo/cssquery-ext.html) 07:21:25 INFO - PROCESS | 15468 | RSS: Main: 323166208 07:21:25 INFO - PROCESS | 15468 | 07:24:28 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:51771/tests/dromaeo/cssquery-ext.html (next: http://localhost:51771/tests/dromaeo/cssquery-jquery.html) 07:24:29 INFO - PROCESS | 15468 | RSS: Main: 286564352 07:24:29 INFO - PROCESS | 15468 | 07:27:31 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:51771/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51771/tests/dromaeo/cssquery-mootools.html) 07:27:31 INFO - PROCESS | 15468 | RSS: Main: 263307264 07:27:31 INFO - PROCESS | 15468 | 07:30:33 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:51771/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51771/tests/dromaeo/cssquery-prototype.html) 07:30:34 INFO - PROCESS | 15468 | RSS: Main: 253616128 07:30:34 INFO - PROCESS | 15468 | 07:33:37 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:51771/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51771/tests/dromaeo/cssquery-yui.html) 07:33:37 INFO - PROCESS | 15468 | RSS: Main: 220991488 07:33:37 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | Cycle 1(1): loaded http://localhost:51771/tests/dromaeo/cssquery-yui.html (next: http://localhost:51771/tests/dromaeo/cssquery-dojo.html) 07:36:40 INFO - PROCESS | 15468 | RSS: Main: 313352192 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | __start_tp_report 07:36:40 INFO - PROCESS | 15468 | _x_x_mozilla_page_load 07:36:40 INFO - PROCESS | 15468 | _x_x_mozilla_page_load_details 07:36:40 INFO - PROCESS | 15468 | |i|pagename|runs| 07:36:40 INFO - PROCESS | 15468 | |0;dojo.html;3092.9845350773244;3116.79740816847;3136.247300647844;3154.101081191861;3154.227214332489;5192.792288308473;5258.868528286795;5296.655717378372;5366.356037275527;5394.649347792396;5310.893782124355;5332.973335133319;5348.144296912495;5349.491798279167;5421.810236641728;4787.353707249529;4840.854774356775;4884.365032545764;4897.461279259296;4920.778564964585;4900.681455705386;4928.507149285061;5024.296598476216;5026.421961474441;5071.898562028758;4766.1182681203745;4960.379952505937;4965.900681986376;5007.624428167884;5070.062038522867;4768.1178981888115;4850.757462126915;4854.199057155565;4857.319975203474;4861.902761944777;4753.928691069636;4781.880452988703;4808.975955120237;4815.085133824562;4877.902441951177;5344;5352.785888564453;5355.196720491918;5358.812441564526;5420.376656684492;5612.242347283105;5744.138379243105;5746.770129194827;5749.798757043525;5756;5688.175214593902;5700.40145784695;5752.856178595527;5762.481376676119;5873.383294754032;5360.383555891044;5408.161734931092;5412.485813847678;5412.485813847678;5417.322834645709;5882.735276912549;5884.705764711747;5888.793892213837;5889.646621202742;5890.145928840294;5562.332520097533;5566.1372487263725;5595.1907790143405;5605.439456054362;5628.746706398222;5739.598228124075;5745.482906538432;5745.827625171251;5754.597178197486;5797.652140871562;5731.627444216113;5745.253117094834;5746.626469279484;5746.913796293059;5748.770049197985;5529.778808847601;5556.972215138899;5579.7489112990015;5752.798652047159;5804.94195058044;4338.956610433918;4364.585364390441;4388.824447022147;4401.955980440219;4436.778161091933;3914.5889681583594;3923.43110249018;3928;3956.2680904032845;3978.1049263915966;5382.91925621116;5387.164989426645;5388.946110538923;5393.865153371197;5399.568034557305;5649.68926709035;5654.349749778746;5712.600117991784;5721.914171287434;5807.82576522705;5440.537554307849;5446.945530544723;5447.4824891635235;5448.210009548593;5451.563874889999;5003.099442100384;5012.54887060159;5014.598832093424;5014.674046186986;5015.874603134951;5906.320773111147;5960.195373624679;5971.701414929236;5977.641341519523;5981.132735753292;5766.250387449605;5769.68266745333;5773.624714393551;5788.652680839163;5796.710164491843;5912.379200183918;5927.911081333697;5928.258967629046;5932.673702946379;5932.991391463548;5562.91655625174;5578.748956297058;5615.775368985358;5661.0659241226385;5675.177099320658;5795.797147099831;5801.1878337033695;5801.477866991991;5802.0426629605645;5810.389909059657;5513.7794488221625;5558.110702287615;5641.40765219646;5641.66150030983;5650.039493286234;5521.282233309644;5617.831465056055;5636.718164091861;5638.577106716931;5640.041192997118;5576.776928922797;5631;5635;5642.069058605284;5645.548356131581;5530.944690553043;5648.350439699487;5658.151277308437;5682.062459694104;5687.118496633028;5565.16522521625;5568.276124103841;5568.526675232651;5569.081101618188;5573.331200255995 07:36:40 INFO - PROCESS | 15468 | |1;ext.html;597.4085655201351;636.592580748321;644.9000404937236;645.5706954875009;664.7573635622999;37742.62257377426;40341.79829100854;40359.39460908089;40419.38322467098;40475.190496190095;41058.7947060265;41583.792081039624;41622.25399714025;41677.58322416775;41702;7933.444658873881;8175.305099066557;8315.417920745535;8453.873191902127;8459.83080338393;9949.75125621858;10255.538500767447;10258.640947566837;10526.736831579195;10532.26274160809;10252.846207306897;10270.12703920164;10320.329178603404;10322.690319290434;10331.121854642326;10186.643467478676;10239.488025598728;10256.794864102714;10291.639792607297;10297.07326340633;10039.046290602455;10054.34646747959;10123.746906327327;10127.848082278771;10128.848067278997;39528.40707389363;39906.60093399087;39908.40137397941;39912.401313980314;39984.60015399867;3372.9494057589154;3438.2951494943727;3701.3152566774966;3710.6103859094947;3909.4331321958443;29386.706132938612;29858.253543661365;29883.551746723817;29940.70059299401;29948;3714.609965953563;3893.9026524336837;3928.685705143582;3932.685385169208;3968.761874287552;334087;334565;335157;336586;336855.99999999756;56762.7161864188;57136.71431642815;57186.42813571894;57234.713826431434;57262.42737572654;61341.386586133565;61402.692986534785;61433.07850382248;61460;61497.692511537156;14310.85689143116;14502.419903203965;14686.55940321792;14701.338439770236;14707.338169782386;10162.796744065077;10459.267851250339;10473.581056757645;10659.4137322448;11034.834477482844;16648.58378540522;17304.65390692204;18382.172802223933;18395.356162534248;18929.90535047316;6673.432758215606;6795.252522222551;6965.129358830146;6972.686229119702;7067.257937916547;948.9857652135223;985.6845809341086;1019.592163134752;1050.8108540462638;1122.3041714137123;28618.856905715755;30582.847085764875;30785.38429231403;30890;31294.530582040832;1102.5424448853796;1112.57165991094;1131.7679875625477;1141.1669481278714;1180.598596477202;15631.609209769847;15900.602484937968;16003.919980400024;16100.919495402448;16195.014845679689;444184;444579;447736;448928.8838895138;450419;55095.173572396445;55539.44460555343;55607;55658;55711.442885571436;1317.426919290112;1343.0464370297002;1348.871857173567;1349.9460021599418;1369.6370461827623;28857.711422886343;29767.404651907273;30575.388492230475;30687.539686904267;30809.8459507701;46837;47295.29057064078;47488.762556187;47518.76240618775;47644;399784;400682;400776;400792;400972;26862.731372686023;27194.592081118404;27207.72792272131;27214.863925680245;27257.31856703598;44538.55461445344;44713.32930005987;44779;44790.3281450772;45880.77059614814;38031;38646;38703.61296387;38859.417108742826;40319;37423.81288093651;37839.62160378361;38060;38406;38746.80626596849;38908.41637375385;39551;39722.20555588814;39835;39926.2014759709;32180.678193218704;34412.31175376529;34905;35067.82466087755;35111.297774044884;26751.86624066945;27016.45967080608;27202.863985679945;27463.365461488454;27545.44909101767 07:36:40 INFO - PROCESS | 15468 | |2;jquery.html;362.6772172766239;375.44059351566176;389.88108626868814;393.98621048263317;401.60241361052556;14632.195229262386;15347.84652153478;18253.726194107097;18786.624267514642;18826.43520694378;16674.49976500704;16682.66634667309;16785.24466399012;16837.073960932175;16849.157542122877;4211.241976444238;5469.234307196985;5678.176664383662;5689.9146512802345;5693.491224825425;4295.52749197588;4341.41390912226;4443.822247110112;6192.133101365813;6412.583182093173;6188.752449901998;6195.5663103582765;6369.681515924185;6431;6431.549791514596;6276.843078923018;6295.527835412317;6307.716152773136;6314.242290925118;6322.336154703758;5383.865403364908;5530.142827861688;5565.276514053147;5634.746436410331;5635.971820140914;20566.485837854172;21284.680729789066;21397.251096211712;22396;22604;2604.5442047641777;2781.485425196345;2868.6270784798053;2921.0798598441424;2969.465496210681;9908.603655853758;9922.80154396908;10062.496875156286;10312.432816195107;10473.790524189473;1856.1554492705786;1912.1204246046834;1942.8348590369835;1952.8925909074994;1968.9507762305914;71994.64002680006;76496;77931;78567.21432785656;79043.60478197572;10739.463026848627;10771;10865.619703310345;11089;11214.66356009321;14830.62923426923;15317.387304507694;15328.23358832054;15332.080075195525;15380.384784608714;7482.850342993219;7688.769336919901;7786.844263114819;7838.372930165573;7945.205479452008;7062.646867656596;7188;7219.963900180465;7323;7415.703371865173;4628.305754136906;4647.767611619405;4671.8364857229835;4730.864592497845;4734.928976065362;1940.8156225158586;1960.9411717648493;1970.615729932678;1985.930492432758;1995.3814317561603;881.6341218394423;938.6339327662217;955.3933252384786;1023.4729114505886;1063.9202059845388;18281.908590457228;18765.343212987755;18995.525111872037;19034.143463544173;19045.809541904404;948.9952550237342;978.1685567267907;991.4348821171862;1006.9244806639531;1010.1363334349026;9856.852147217798;10315.84526232107;10378.42918639467;10385.792284154275;10387.169026477864;436520;445087;445582;448347;451421;75550.62224688841;86863;87737;87779;87779.56110219535;928.3501548915921;945.4185675809327;967.4388854464394;972.3485264872411;979.9951000244953;16273.186340683154;16461.753073704145;16970.856564871166;16975.660486790443;17121.315147393965;40042.79978600088;40194.39708404318;40754.38868417036;41029.1794164121;42399.5760042408;54548;54808;55957.00537432821;56004.159937601784;58000;8252.876206857021;8414.368922330726;8509.064002959545;8575.699850505202;8584.527850968258;8396.790080248044;11612.88387116118;12492.750144997231;12758.74482510326;12846.550370736979;10949;11239.887601123884;11719.589814356457;11756.11829112837;12068.396580171131;10690.572377104829;10774.515146818569;11105.111591072533;11144.498497567467;11177.776444471228;11030.338179709242;11223.55105795759;11382.886171138183;11648.41757912084;11893.643190704293;8056.556889370906;8171.387145964195;8183.222593853575;8291.58542072906;8473.57632118404;9107.453552786854;10993.945030274797;11044.502997364978;11141.83287250708;11568 07:36:40 INFO - PROCESS | 15468 | |3;mootools.html;1308.4700696218035;1418.6098822823726;1466.3767898643077;1561.7735428362887;1729.0835856995798;7395.630218489075;7995.880061799077;8301.543415112174;8303.211194936486;8497.660093596263;8292.875606865902;8360.623771930263;8366.330693544516;8366.665333386658;8368.91631083689;1998.6102709971562;2065.5249292662697;2278.1912421090483;2315.7452680205165;2319.014418871981;2228.821694264463;2316.5945959457113;2319.072371051576;2320.4662927526597;2331.370529956919;2199.692043113965;2225.376894469551;2242.9439264018365;2259;2259.3334966184934;2247.6628505724107;2253.143805353963;2261.2537862505333;2263.151318255654;2273.9658905116353;2232.6427771556473;2260.367097212783;2264.6603009548535;2264.728232612081;2267.047839907243;8178.713745018896;8229.629666664954;8326.750197494084;8334.66661333546;8336.791580210482;4949.133901567211;5083.74581270935;5084.161113416282;5085.593152547787;5086.21163719624;3086.82889877853;3121.4069326828057;3198.392305461955;3243.4486137356707;3245.75656825739;1064.2177999170603;1067.5516283161014;1098.8406681031286;1118.692359601116;1138.8690300615453;10776.73058173544;10945.726356841064;10952.780944381147;11270.43647817614;11364.261323013978;4412.867613971586;4538.364628951884;4607.815687372467;4628.190066738374;4628.5371462853445;9774.657886973922;9788.853167202498;9789.755256118655;9793.118619324296;9793.314467987173;4965.255211718271;5017.874553136127;5025.79896804131;5029.044481548567;5047.697138171721;4226.5139508956245;4460.50934397216;4595.126925884071;4611.054733779567;4626.83806066786;3845.115623406576;3859.4403811447182;3942.8619998299923;3953.347697629916;3980.9402858957137;1263.4440846027903;1279.3027799849106;1285.1068507387276;1296.092735085444;1299.9220046797034;775.7556369743513;843.3632607381388;871.834351473218;945.8723072385278;968.843660695622;5465.1529013002255;5477.589180811455;5519.144532597454;5745.827625171251;5892.6759028253;987.1362557761959;1017.6590842067842;1027.787211090905;1047.6542740895486;1088.684281558355;3750.7809961762537;3850.7111966602615;3861.5945325740954;3888.1251718363706;3961.603839616015;10130.493475326204;10269;10326.638567650247;10335.17318614509;10346.896531034743;10002.636461768725;10280.331778434378;10285.331453455501;10294.691159265234;10313.587456501806;7680.423968202295;7738.2261773822165;7853.764387068397;7859.842803143905;7863.174366691644;5323.121684922099;5398.2982212312145;5455.290812194548;5518.972405137949;5545.750441230073;9212.677556285498;9212.861807072764;9266.258699303904;9298.116678915492;9342.579583918605;9388.718338449857;9446.197073248852;9481.09929556691;9509.904900950902;9558.95220523893;6448.935510644834;6606.768763093269;6885.51801373899;7039.788806335613;7178.892316615151;7793.454458187873;8047.798805029687;8058.919410806051;8061.113277539349;8068.757937261891;7081.539699919489;7081.893771593327;7199.568025918462;7247.420206383371;7326.267373262631;7034.964825175842;7235.384992275715;7238.855222895408;7442.9255707442235;7531.736389226351;6466.7066586683795;6550.082988381535;6592.439642630238;6601.438877695257;6605.471562275103;4884.902301954012;4890.682105663121;4917.778699958582;5068.516426950841;5142.948570514247;4995.350604421402;5023.422306434661;5060.51925067118;5119.232115182753;5195.29863468442 07:36:40 INFO - PROCESS | 15468 | |4;prototype.html;317.70453478265205;329.7296217101976;332.8152875154289;334.9330133973205;339.0337538016651;5209.505097015782;5262.631615786891;5309.982206761425;5317.494837990394;5332.680039197651;5001.624878134146;5030.597552195824;5079.857032167761;5112.590992720583;5235.424103348629;4092.570280120589;4094.4409743910055;4100.692448066392;4107.876763697094;4123.814428350716;4094.9590504094876;4112.321466957948;4118.9588104118875;4120.793960301988;4131.132462182945;3900.9804950975204;3938.448617193581;4040.878773636796;4061.8578349757618;4080.8165631966694;4044.6562042226446;4060.512738471373;4060.675145988314;4061.5532291447917;4087.4686290782156;3605.441156620728;3625.0574850538787;3625.6918161956264;3632.400653892105;3641.581218159919;4886.6823656462575;5026.547610715053;5034.320366750479;5053.67151135175;5080.187170052774;4674.415698037746;4691.202495575761;4708.317293992386;4715.7877895494785;4720.221163508017;5433.212184233264;5441.29263195782;5442.346918369782;5447.291852059247;5493.23094766733;3921.313770090223;3994.8801535953967;3995.06116062725;3999.7600743769526;4012.21456451879;5598.720063996784;5617.831465056055;5634.3802181759975;5638.548916086662;5642.210090587321;4096.959030409717;4099.446574712435;4100.159467309194;4100.774457404812;4110.219058378899;3996;4151.232022075926;4152.626263636287;4158.708890377705;4182.644475219579;4644.210484217691;4654.881229576192;4672.229082201398;4676.625869930397;4678.50875658051;5447.53695935842;5452.936677347959;5456.91814622781;5459.836204913859;5486.61593688438;1345.0272125350934;1383.2806940391142;1386.708791153869;1391.172252509755;1391.464286249801;974.5614473486818;977.867987821635;985.9359141655913;990.846418805072;995.3530205366425;4997.30037794709;4999.350084489066;5006.6245031622775;5007.4491805901325;5074.543291103819;5387.676739395649;5400.702961337164;5418.4039755626845;5422.511973922287;5434.538064264502;4955.231939049453;5080.822171223989;5215.217717342429;5232.2471971889845;5245.790168393298;2823.6188114604674;2847.576211894053;2847.729465700755;2858.871350789178;2861.3418913649975;5493.642913210629;5600.635958662674;5638.323401191883;5654.74553645087;5680.233168522279;5646.57650676201;5665.433456654301;5669.744861481243;5736.225609542742;5754.597178197486;5686.60193786431;5767.307923049261;5797.246357973437;5799.217105690762;5870.970645146747;5494.725263736717;5497.422770609029;5531.446855314436;5570.637908535932;5641;5528.557715382679;5536.889262214652;5554.861128471821;5568.888622227614;5569.331680198402;5654.434556544313;5746.741396637245;5771.278590176228;5781.508571771446;5864.736086876186;4023.416604592376;4052.756834589934;4060.3706425504092;4077.7553346799286;4080.6327430531396;5331.733413329241;5411.594130440154;5505.2108064878275;5659.490645841894;5664.923664503731;5427.426046446486;5450.427705091067;5458.508734213781;5464.4808743170925;5490.890182196254;5424.511793938565;5439.972800135974;5459.208414779914;5468.644538105011;5471.644343117685;5248.399238232376;5389.353277606712;5402.945970540244;5404.432534583812;5450.482204190595;5450.400455949763;5450.727463626882;5464.371597266207;5479.753411096431;5485.244721689021;5221.921671175011;5341.359036915595;5350.678959262456;5366.570674345965;5373.570114390917 07:36:40 INFO - PROCESS | 15468 | |5;yui.html;717.2612209424293;720.981975450614;738.0958326050588;743.1008479739515;757.5416872791959;14258.928705356471;15260.771088433683;15429.768553471707;15494.38022479101;15501.224938753074;14471.493497727583;14992.550223493285;15099.320530576122;15124;15139.31873065712;799.2926260259654;811.0551207842856;815.5799763121997;815.7063457155419;817.0644611919349;672.5829985409054;694.4236283884364;783.2246076384396;806.7257132574923;812.0742353716738;831.1356189562847;839.3830534557096;842.7808769719886;842.9494230346169;843.8185790055137;837.2757564706546;837.4891316297054;837.5435387713711;837.623069618671;837.7989282572139;498.34878446663765;510.8518529626404;594.586762200271;612.5161122713051;613.25489530221;14065.296735163201;14086.788698169536;14136.293185340692;14137.858621413758;14175.220362880038;13904.652383690387;13955.651108722363;14011.29943502831;14031.368588413547;14184.29078546079;11731.354775487345;11773;11785.057195424346;12064.6380608581;12149.878501214964;3526.559180102487;3720.8511659533588;3721.1999420124534;3736.57029441615;3759.774413535197;80411.5979420105;81638.59180704117;82079.17920820774;82931;83392;10560.2079844012;10655.733606659896;11236.66290011301;11299.830502542469;11307;18474.63050738978;18553.44339669812;18603.81396186048;18607.720884186747;18664.533386665444;7697.730579429693;7852.057753069668;7915;8031.638576263966;8106.4325497215805;4141.344371617859;4160.958390416117;4176.227397931392;4181.289180839204;4197.202531519001;3549.4853246279145;3630.364686179908;3676.522052133259;3684.5630204220374;3700.685441737429;583.5040215816607;592.8606777407306;595.6515438468545;596.0195478437945;603.9214902062704;689.9306075582926;696.3176087434241;711.2673945835797;721.3435773446244;723.3995783499682;9504.809903801885;9720.574601497268;9791.902080979098;9847.212223022141;10013.098821106136;614.6435067660746;690.9101816763789;718.5042320798632;723.9746608868664;727.4871215792854;4372.278574035312;4518.390017347681;4579.152856721517;4650.302454631832;4686.531346865286;74454;90209.54895225482;90862;92719;92867.53566232126;77738;79030;80153;80159.59920200362;80931;66718;68159.65920170367;68649;68993.31006689869;70166.29833701598;9071.455712657262;9229.630814767334;9274.304427167854;9322.161005509266;9384.95307523458;47069.52930470651;47571.76214118907;49093.75453122712;49235.75382123067;49620.50379496159;52710;53136.468635313155;54531.72734136304;58330.4166958325;58438.415615843296;12916.547920822726;13246.735065298833;13259.204447733167;13721.656958576115;13817.170969741848;14748.115113093249;14749.926250368679;15104.169270690218;15583.454579089677;16180.190990450667;13753.518626848012;13825.170489770244;13947.4421023162;14228.217448040457;14520.927395363378;10562.577496900038;13433.865661343261;13471.865281347062;13862.376193071133;14199.432022718975;13407.195568265935;13898.36076998515;13981.580552583438;14018.649533761738;14342.641433964234;10524.789504210026;10713.946430267799;10826.561109944885;11471.713207169887;11598;10242.436665983443;10636.787264254826;11913;12095.516179353079;12233.755324893275 07:36:40 INFO - PROCESS | 15468 | __end_tp_report 07:36:40 INFO - PROCESS | 15468 | __start_cc_report 07:36:40 INFO - PROCESS | 15468 | _x_x_mozilla_cycle_collect,2836 07:36:40 INFO - PROCESS | 15468 | __end_cc_report 07:36:40 INFO - PROCESS | 15468 | __startTimestamp1480433800869__endTimestamp 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | ------- Summary: start ------- 07:36:40 INFO - PROCESS | 15468 | Number of tests: 6 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | [#0] dojo.html Cycles:165 Average:5337.31 Median:5562.92 stddev:599.79 (10.8%) stddev-sans-first:575.20 07:36:40 INFO - PROCESS | 15468 | Values: 3093.0 3116.8 3136.2 3154.1 3154.2 5192.8 5258.9 5296.7 5366.4 5394.6 5310.9 5333.0 5348.1 5349.5 5421.8 4787.4 4840.9 4884.4 4897.5 4920.8 4900.7 4928.5 5024.3 5026.4 5071.9 4766.1 4960.4 4965.9 5007.6 5070.1 4768.1 4850.8 4854.2 4857.3 4861.9 4753.9 4781.9 4809.0 4815.1 4877.9 5344.0 5352.8 5355.2 5358.8 5420.4 5612.2 5744.1 5746.8 5749.8 5756.0 5688.2 5700.4 5752.9 5762.5 5873.4 5360.4 5408.2 5412.5 5412.5 5417.3 5882.7 5884.7 5888.8 5889.6 5890.1 5562.3 5566.1 5595.2 5605.4 5628.7 5739.6 5745.5 5745.8 5754.6 5797.7 5731.6 5745.3 5746.6 5746.9 5748.8 5529.8 5557.0 5579.7 5752.8 5804.9 4339.0 4364.6 4388.8 4402.0 4436.8 3914.6 3923.4 3928.0 3956.3 3978.1 5382.9 5387.2 5388.9 5393.9 5399.6 5649.7 5654.3 5712.6 5721.9 5807.8 5440.5 5446.9 5447.5 5448.2 5451.6 5003.1 5012.5 5014.6 5014.7 5015.9 5906.3 5960.2 5971.7 5977.6 5981.1 5766.3 5769.7 5773.6 5788.7 5796.7 5912.4 5927.9 5928.3 5932.7 5933.0 5562.9 5578.7 5615.8 5661.1 5675.2 5795.8 5801.2 5801.5 5802.0 5810.4 5513.8 5558.1 5641.4 5641.7 5650.0 5521.3 5617.8 5636.7 5638.6 5640.0 5576.8 5631.0 5635.0 5642.1 5645.5 5530.9 5648.4 5658.2 5682.1 5687.1 5565.2 5568.3 5568.5 5569.1 5573.3 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | [#1] ext.html Cycles:180 Average:55369.19 Median:3712.61 stddev:104811.28 (2823.1%) stddev-sans-first:105024.63 07:36:40 INFO - PROCESS | 15468 | Values: 597.4 636.6 644.9 645.6 664.8 37742.6 40341.8 40359.4 40419.4 40475.2 41058.8 41583.8 41622.3 41677.6 41702.0 7933.4 8175.3 8315.4 8453.9 8459.8 9949.8 10255.5 10258.6 10526.7 10532.3 10252.8 10270.1 10320.3 10322.7 10331.1 10186.6 10239.5 10256.8 10291.6 10297.1 10039.0 10054.3 10123.7 10127.8 10128.8 39528.4 39906.6 39908.4 39912.4 39984.6 3372.9 3438.3 3701.3 3710.6 3909.4 29386.7 29858.3 29883.6 29940.7 29948.0 3714.6 3893.9 3928.7 3932.7 3968.8 334087.0 334565.0 335157.0 336586.0 336856.0 56762.7 57136.7 57186.4 57234.7 57262.4 61341.4 61402.7 61433.1 61460.0 61497.7 14310.9 14502.4 14686.6 14701.3 14707.3 10162.8 10459.3 10473.6 10659.4 11034.8 16648.6 17304.7 18382.2 18395.4 18929.9 6673.4 6795.3 6965.1 6972.7 7067.3 949.0 985.7 1019.6 1050.8 1122.3 28618.9 30582.8 30785.4 30890.0 31294.5 1102.5 1112.6 1131.8 1141.2 1180.6 15631.6 15900.6 16003.9 16100.9 16195.0 444184.0 444579.0 447736.0 448928.9 450419.0 55095.2 55539.4 55607.0 55658.0 55711.4 1317.4 1343.0 1348.9 1349.9 1369.6 28857.7 29767.4 30575.4 30687.5 30809.8 46837.0 47295.3 47488.8 47518.8 47644.0 399784.0 400682.0 400776.0 400792.0 400972.0 26862.7 27194.6 27207.7 27214.9 27257.3 44538.6 44713.3 44779.0 44790.3 45880.8 38031.0 38646.0 38703.6 38859.4 40319.0 37423.8 37839.6 38060.0 38406.0 38746.8 38908.4 39551.0 39722.2 39835.0 39926.2 32180.7 34412.3 34905.0 35067.8 35111.3 26751.9 27016.5 27202.9 27463.4 27545.4 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | [#2] jquery.html Cycles:180 Average:27034.79 Median:40474.39 stddev:73500.26 (181.6%) stddev-sans-first:73679.16 07:36:40 INFO - PROCESS | 15468 | Values: 362.7 375.4 389.9 394.0 401.6 14632.2 15347.8 18253.7 18786.6 18826.4 16674.5 16682.7 16785.2 16837.1 16849.2 4211.2 5469.2 5678.2 5689.9 5693.5 4295.5 4341.4 4443.8 6192.1 6412.6 6188.8 6195.6 6369.7 6431.0 6431.5 6276.8 6295.5 6307.7 6314.2 6322.3 5383.9 5530.1 5565.3 5634.7 5636.0 20566.5 21284.7 21397.3 22396.0 22604.0 2604.5 2781.5 2868.6 2921.1 2969.5 9908.6 9922.8 10062.5 10312.4 10473.8 1856.2 1912.1 1942.8 1952.9 1969.0 71994.6 76496.0 77931.0 78567.2 79043.6 10739.5 10771.0 10865.6 11089.0 11214.7 14830.6 15317.4 15328.2 15332.1 15380.4 7482.9 7688.8 7786.8 7838.4 7945.2 7062.6 7188.0 7220.0 7323.0 7415.7 4628.3 4647.8 4671.8 4730.9 4734.9 1940.8 1960.9 1970.6 1985.9 1995.4 881.6 938.6 955.4 1023.5 1063.9 18281.9 18765.3 18995.5 19034.1 19045.8 949.0 978.2 991.4 1006.9 1010.1 9856.9 10315.8 10378.4 10385.8 10387.2 436520.0 445087.0 445582.0 448347.0 451421.0 75550.6 86863.0 87737.0 87779.0 87779.6 928.4 945.4 967.4 972.3 980.0 16273.2 16461.8 16970.9 16975.7 17121.3 40042.8 40194.4 40754.4 41029.2 42399.6 54548.0 54808.0 55957.0 56004.2 58000.0 8252.9 8414.4 8509.1 8575.7 8584.5 8396.8 11612.9 12492.8 12758.7 12846.6 10949.0 11239.9 11719.6 11756.1 12068.4 10690.6 10774.5 11105.1 11144.5 11177.8 11030.3 11223.6 11382.9 11648.4 11893.6 8056.6 8171.4 8183.2 8291.6 8473.6 9107.5 10993.9 11044.5 11141.8 11568.0 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | [#3] mootools.html Cycles:180 Average:5466.72 Median:5020.65 stddev:3030.71 (60.4%) stddev-sans-first:3023.09 07:36:40 INFO - PROCESS | 15468 | Values: 1308.5 1418.6 1466.4 1561.8 1729.1 7395.6 7995.9 8301.5 8303.2 8497.7 8292.9 8360.6 8366.3 8366.7 8368.9 1998.6 2065.5 2278.2 2315.7 2319.0 2228.8 2316.6 2319.1 2320.5 2331.4 2199.7 2225.4 2242.9 2259.0 2259.3 2247.7 2253.1 2261.3 2263.2 2274.0 2232.6 2260.4 2264.7 2264.7 2267.0 8178.7 8229.6 8326.8 8334.7 8336.8 4949.1 5083.7 5084.2 5085.6 5086.2 3086.8 3121.4 3198.4 3243.4 3245.8 1064.2 1067.6 1098.8 1118.7 1138.9 10776.7 10945.7 10952.8 11270.4 11364.3 4412.9 4538.4 4607.8 4628.2 4628.5 9774.7 9788.9 9789.8 9793.1 9793.3 4965.3 5017.9 5025.8 5029.0 5047.7 4226.5 4460.5 4595.1 4611.1 4626.8 3845.1 3859.4 3942.9 3953.3 3980.9 1263.4 1279.3 1285.1 1296.1 1299.9 775.8 843.4 871.8 945.9 968.8 5465.2 5477.6 5519.1 5745.8 5892.7 987.1 1017.7 1027.8 1047.7 1088.7 3750.8 3850.7 3861.6 3888.1 3961.6 10130.5 10269.0 10326.6 10335.2 10346.9 10002.6 10280.3 10285.3 10294.7 10313.6 7680.4 7738.2 7853.8 7859.8 7863.2 5323.1 5398.3 5455.3 5519.0 5545.8 9212.7 9212.9 9266.3 9298.1 9342.6 9388.7 9446.2 9481.1 9509.9 9559.0 6448.9 6606.8 6885.5 7039.8 7178.9 7793.5 8047.8 8058.9 8061.1 8068.8 7081.5 7081.9 7199.6 7247.4 7326.3 7035.0 7235.4 7238.9 7442.9 7531.7 6466.7 6550.1 6592.4 6601.4 6605.5 4884.9 4890.7 4917.8 5068.5 5142.9 4995.4 5023.4 5060.5 5119.2 5195.3 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | [#4] prototype.html Cycles:180 Average:4587.85 Median:5240.61 stddev:1332.44 (25.4%) stddev-sans-first:1297.06 07:36:40 INFO - PROCESS | 15468 | Values: 317.7 329.7 332.8 334.9 339.0 5209.5 5262.6 5310.0 5317.5 5332.7 5001.6 5030.6 5079.9 5112.6 5235.4 4092.6 4094.4 4100.7 4107.9 4123.8 4095.0 4112.3 4119.0 4120.8 4131.1 3901.0 3938.4 4040.9 4061.9 4080.8 4044.7 4060.5 4060.7 4061.6 4087.5 3605.4 3625.1 3625.7 3632.4 3641.6 4886.7 5026.5 5034.3 5053.7 5080.2 4674.4 4691.2 4708.3 4715.8 4720.2 5433.2 5441.3 5442.3 5447.3 5493.2 3921.3 3994.9 3995.1 3999.8 4012.2 5598.7 5617.8 5634.4 5638.5 5642.2 4097.0 4099.4 4100.2 4100.8 4110.2 3996.0 4151.2 4152.6 4158.7 4182.6 4644.2 4654.9 4672.2 4676.6 4678.5 5447.5 5452.9 5456.9 5459.8 5486.6 1345.0 1383.3 1386.7 1391.2 1391.5 974.6 977.9 985.9 990.8 995.4 4997.3 4999.4 5006.6 5007.4 5074.5 5387.7 5400.7 5418.4 5422.5 5434.5 4955.2 5080.8 5215.2 5232.2 5245.8 2823.6 2847.6 2847.7 2858.9 2861.3 5493.6 5600.6 5638.3 5654.7 5680.2 5646.6 5665.4 5669.7 5736.2 5754.6 5686.6 5767.3 5797.2 5799.2 5871.0 5494.7 5497.4 5531.4 5570.6 5641.0 5528.6 5536.9 5554.9 5568.9 5569.3 5654.4 5746.7 5771.3 5781.5 5864.7 4023.4 4052.8 4060.4 4077.8 4080.6 5331.7 5411.6 5505.2 5659.5 5664.9 5427.4 5450.4 5458.5 5464.5 5490.9 5424.5 5440.0 5459.2 5468.6 5471.6 5248.4 5389.4 5402.9 5404.4 5450.5 5450.4 5450.7 5464.4 5479.8 5485.2 5221.9 5341.4 5350.7 5366.6 5373.6 07:36:40 INFO - PROCESS | 15468 | 07:36:40 INFO - PROCESS | 15468 | [#5] yui.html Cycles:180 Average:18443.40 Median:25878.03 stddev:24676.84 (95.4%) stddev-sans-first:24710.16 07:36:40 INFO - PROCESS | 15468 | Values: 717.3 721.0 738.1 743.1 757.5 14258.9 15260.8 15429.8 15494.4 15501.2 14471.5 14992.6 15099.3 15124.0 15139.3 799.3 811.1 815.6 815.7 817.1 672.6 694.4 783.2 806.7 812.1 831.1 839.4 842.8 842.9 843.8 837.3 837.5 837.5 837.6 837.8 498.3 510.9 594.6 612.5 613.3 14065.3 14086.8 14136.3 14137.9 14175.2 13904.7 13955.7 14011.3 14031.4 14184.3 11731.4 11773.0 11785.1 12064.6 12149.9 3526.6 3720.9 3721.2 3736.6 3759.8 80411.6 81638.6 82079.2 82931.0 83392.0 10560.2 10655.7 11236.7 11299.8 11307.0 18474.6 18553.4 18603.8 18607.7 18664.5 7697.7 7852.1 7915.0 8031.6 8106.4 4141.3 4161.0 4176.2 4181.3 4197.2 3549.5 3630.4 3676.5 3684.6 3700.7 583.5 592.9 595.7 596.0 603.9 689.9 696.3 711.3 721.3 723.4 9504.8 9720.6 9791.9 9847.2 10013.1 614.6 690.9 718.5 724.0 727.5 4372.3 4518.4 4579.2 4650.3 4686.5 74454.0 90209.5 90862.0 92719.0 92867.5 77738.0 79030.0 80153.0 80159.6 80931.0 66718.0 68159.7 68649.0 68993.3 70166.3 9071.5 9229.6 9274.3 9322.2 9385.0 47069.5 47571.8 49093.8 49235.8 49620.5 52710.0 53136.5 54531.7 58330.4 58438.4 12916.5 13246.7 13259.2 13721.7 13817.2 14748.1 14749.9 15104.2 15583.5 16180.2 13753.5 13825.2 13947.4 14228.2 14520.9 10562.6 13433.9 13471.9 13862.4 14199.4 13407.2 13898.4 13981.6 14018.6 14342.6 10524.8 10713.9 10826.6 11471.7 11598.0 10242.4 10636.8 11913.0 12095.5 12233.8 07:36:40 INFO - PROCESS | 15468 | -------- Summary: end -------- 07:36:40 INFO - PROCESS | 15468 | 07:36:41 INFO - TEST-INFO | 15468: exit 0 07:36:41 INFO - TEST-OK | dromaeo_css | took 1118143ms 07:36:41 INFO - TEST-START | kraken 07:36:41 INFO - operating with platform_type : linux_ 07:36:41 INFO - Initialising browser for kraken test... 07:36:41 INFO - TEST-INFO | started process 15814 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwQ97x/profile http://localhost:51771/getInfo.html) 07:36:45 INFO - PROCESS | 15814 | __metrics Screen width/height:1600/1200 07:36:45 INFO - PROCESS | 15814 | colorDepth:24 07:36:45 INFO - PROCESS | 15814 | Browser inner width/height: 1024/697 07:36:45 INFO - PROCESS | 15814 | __metrics 07:36:46 INFO - PROCESS | 15814 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:36:46 INFO - PROCESS | 15814 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:36:46 INFO - PROCESS | 15814 | console.error: PushService: 07:36:46 INFO - PROCESS | 15814 | stateChangeProcessEnqueue: Error transitioning state 07:36:46 INFO - PROCESS | 15814 | UnknownError 07:36:47 INFO - TEST-INFO | 15814: exit 0 07:36:47 INFO - Browser initialized. 07:36:47 INFO - Running cycle 1/1 for kraken test... 07:36:47 INFO - TEST-INFO | started process 15897 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwQ97x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:59 INFO - PROCESS | 15897 | RSS: Main: 173236224 07:36:59 INFO - PROCESS | 15897 | 07:37:02 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51771/tests/kraken/driver.html?testName=audio-beat-detection) 07:37:03 INFO - PROCESS | 15897 | RSS: Main: 234647552 07:37:03 INFO - PROCESS | 15897 | 07:37:05 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51771/tests/kraken/driver.html?testName=audio-dft) 07:37:06 INFO - PROCESS | 15897 | RSS: Main: 216375296 07:37:06 INFO - PROCESS | 15897 | 07:37:09 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51771/tests/kraken/driver.html?testName=audio-fft) 07:37:10 INFO - PROCESS | 15897 | RSS: Main: 298549248 07:37:10 INFO - PROCESS | 15897 | 07:37:12 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51771/tests/kraken/driver.html?testName=audio-oscillator) 07:37:12 INFO - PROCESS | 15897 | RSS: Main: 208609280 07:37:12 INFO - PROCESS | 15897 | 07:37:14 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51771/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:37:15 INFO - PROCESS | 15897 | RSS: Main: 213336064 07:37:15 INFO - PROCESS | 15897 | 07:37:18 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51771/tests/kraken/driver.html?testName=imaging-darkroom) 07:37:19 INFO - PROCESS | 15897 | RSS: Main: 252379136 07:37:19 INFO - PROCESS | 15897 | 07:37:22 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51771/tests/kraken/driver.html?testName=imaging-desaturate) 07:37:23 INFO - PROCESS | 15897 | RSS: Main: 252424192 07:37:23 INFO - PROCESS | 15897 | 07:37:25 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51771/tests/kraken/driver.html?testName=json-parse-financial) 07:37:26 INFO - PROCESS | 15897 | RSS: Main: 251305984 07:37:26 INFO - PROCESS | 15897 | 07:37:27 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51771/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:37:28 INFO - PROCESS | 15897 | RSS: Main: 213278720 07:37:28 INFO - PROCESS | 15897 | 07:37:30 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:37:30 INFO - PROCESS | 15897 | RSS: Main: 220954624 07:37:30 INFO - PROCESS | 15897 | 07:37:33 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:33 INFO - PROCESS | 15897 | RSS: Main: 230006784 07:37:33 INFO - PROCESS | 15897 | 07:37:36 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:37 INFO - PROCESS | 15897 | RSS: Main: 238559232 07:37:37 INFO - PROCESS | 15897 | 07:37:39 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:40 INFO - PROCESS | 15897 | RSS: Main: 235323392 07:37:40 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | Cycle 1(1): loaded http://localhost:51771/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51771/tests/kraken/driver.html?testName=ai-astar) 07:37:42 INFO - PROCESS | 15897 | RSS: Main: 285364224 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | __start_tp_report 07:37:42 INFO - PROCESS | 15897 | _x_x_mozilla_page_load 07:37:42 INFO - PROCESS | 15897 | _x_x_mozilla_page_load_details 07:37:42 INFO - PROCESS | 15897 | |i|pagename|runs| 07:37:42 INFO - PROCESS | 15897 | |0;ai-astar;102;111;113;110;111;110;110;113;112;109 07:37:42 INFO - PROCESS | 15897 | |1;audio-beat-detection;150;123;125;155;125;139;127;124;144;123 07:37:42 INFO - PROCESS | 15897 | |2;audio-dft;162;162;164;162;162;162;163;162;162;161 07:37:42 INFO - PROCESS | 15897 | |3;audio-fft;75;76;76;114;77;75;77;76;96;76 07:37:42 INFO - PROCESS | 15897 | |4;audio-oscillator;82;83;107;82;83;83;102;82;81;108 07:37:42 INFO - PROCESS | 15897 | |5;imaging-gaussian-blur;117;117;116;118;118;118;117;118;118;117 07:37:42 INFO - PROCESS | 15897 | |6;imaging-darkroom;145;146;146;146;146;146;146;146;146;145 07:37:42 INFO - PROCESS | 15897 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;95;95 07:37:42 INFO - PROCESS | 15897 | |8;json-parse-financial;52;52;52;52;52;53;53;53;52;52 07:37:42 INFO - PROCESS | 15897 | |9;json-stringify-tinderbox;62;62;61;62;63;62;62;61;62;63 07:37:42 INFO - PROCESS | 15897 | |10;stanford-crypto-aes;89;89;90;84;80;88;81;90;80;84 07:37:42 INFO - PROCESS | 15897 | |11;stanford-crypto-ccm;134;132;143;130;133;133;144;155;171;146 07:37:42 INFO - PROCESS | 15897 | |12;stanford-crypto-pbkdf2;166;165;163;164;168;163;167;166;163;165 07:37:42 INFO - PROCESS | 15897 | |13;stanford-crypto-sha256-iterative;66;74;66;66;66;65;65;67;65;66 07:37:42 INFO - PROCESS | 15897 | __end_tp_report 07:37:42 INFO - PROCESS | 15897 | __start_cc_report 07:37:42 INFO - PROCESS | 15897 | _x_x_mozilla_cycle_collect,1705 07:37:42 INFO - PROCESS | 15897 | __end_cc_report 07:37:42 INFO - PROCESS | 15897 | __startTimestamp1480433862351__endTimestamp 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | ------- Summary: start ------- 07:37:42 INFO - PROCESS | 15897 | Number of tests: 14 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.14 (2.8%) stddev-sans-first:1.41 07:37:42 INFO - PROCESS | 15897 | Values: 102.0 111.0 113.0 110.0 111.0 110.0 110.0 113.0 112.0 109.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:133.00 stddev:12.35 (9.3%) stddev-sans-first:11.57 07:37:42 INFO - PROCESS | 15897 | Values: 150.0 123.0 125.0 155.0 125.0 139.0 127.0 124.0 144.0 123.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 07:37:42 INFO - PROCESS | 15897 | Values: 162.0 162.0 164.0 162.0 162.0 162.0 163.0 162.0 162.0 161.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.96 (17.1%) stddev-sans-first:13.51 07:37:42 INFO - PROCESS | 15897 | Values: 75.0 76.0 76.0 114.0 77.0 75.0 77.0 76.0 96.0 76.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:82.00 stddev:11.41 (13.9%) stddev-sans-first:11.79 07:37:42 INFO - PROCESS | 15897 | Values: 82.0 83.0 107.0 82.0 83.0 83.0 102.0 82.0 81.0 108.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:37:42 INFO - PROCESS | 15897 | Values: 117.0 117.0 116.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 07:37:42 INFO - PROCESS | 15897 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:37:42 INFO - PROCESS | 15897 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 07:37:42 INFO - PROCESS | 15897 | Values: 52.0 52.0 52.0 52.0 52.0 53.0 53.0 53.0 52.0 52.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 07:37:42 INFO - PROCESS | 15897 | Values: 62.0 62.0 61.0 62.0 63.0 62.0 62.0 61.0 62.0 63.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:88.50 stddev:4.17 (4.7%) stddev-sans-first:4.23 07:37:42 INFO - PROCESS | 15897 | Values: 89.0 89.0 90.0 84.0 80.0 88.0 81.0 90.0 80.0 84.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#11] stanford-crypto-ccm Cycles:10 Average:142.10 Median:143.50 stddev:12.91 (9.0%) stddev-sans-first:13.36 07:37:42 INFO - PROCESS | 15897 | Values: 134.0 132.0 143.0 130.0 133.0 133.0 144.0 155.0 171.0 146.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.50 stddev:1.76 (1.1%) stddev-sans-first:1.83 07:37:42 INFO - PROCESS | 15897 | Values: 166.0 165.0 163.0 164.0 168.0 163.0 167.0 166.0 163.0 165.0 07:37:42 INFO - PROCESS | 15897 | 07:37:42 INFO - PROCESS | 15897 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.00 stddev:2.67 (4.1%) stddev-sans-first:2.83 07:37:42 INFO - PROCESS | 15897 | Values: 66.0 74.0 66.0 66.0 66.0 65.0 65.0 67.0 65.0 66.0 07:37:42 INFO - PROCESS | 15897 | -------- Summary: end -------- 07:37:42 INFO - PROCESS | 15897 | 07:37:43 INFO - TEST-INFO | 15897: exit 0 07:37:43 INFO - TEST-OK | kraken | took 61735ms 07:37:43 INFO - SUITE-END | took 1179s 07:37:44 INFO - Completed test suite (00:19:40) 07:37:44 INFO - javascript benchmark 07:37:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.9845350773244, 3116.79740816847, 3136.247300647844, 3154.101081191861, 3154.227214332489, 5192.792288308473, 5258.868528286795, 5296.655717378372, 5366.356037275527, 5394.649347792396, 5310.893782124355, 5332.973335133319, 5348.144296912495, 5349.491798279167, 5421.810236641728, 4787.353707249529, 4840.854774356775, 4884.365032545764, 4897.461279259296, 4920.778564964585, 4900.681455705386, 4928.507149285061, 5024.296598476216, 5026.421961474441, 5071.898562028758, 4766.1182681203745, 4960.379952505937, 4965.900681986376, 5007.624428167884, 5070.062038522867, 4768.1178981888115, 4850.757462126915, 4854.199057155565, 4857.319975203474, 4861.902761944777, 4753.928691069636, 4781.880452988703, 4808.975955120237, 4815.085133824562, 4877.902441951177, 5344.0, 5352.785888564453, 5355.196720491918, 5358.812441564526, 5420.376656684492, 5612.242347283105, 5744.138379243105, 5746.770129194827, 5749.798757043525, 5756.0, 5688.175214593902, 5700.40145784695, 5752.856178595527, 5762.481376676119, 5873.383294754032, 5360.383555891044, 5408.161734931092, 5412.485813847678, 5412.485813847678, 5417.322834645709, 5882.735276912549, 5884.705764711747, 5888.793892213837, 5889.646621202742, 5890.145928840294, 5562.332520097533, 5566.1372487263725, 5595.1907790143405, 5605.439456054362, 5628.746706398222, 5739.598228124075, 5745.482906538432, 5745.827625171251, 5754.597178197486, 5797.652140871562, 5731.627444216113, 5745.253117094834, 5746.626469279484, 5746.913796293059, 5748.770049197985, 5529.778808847601, 5556.972215138899, 5579.7489112990015, 5752.798652047159, 5804.94195058044, 4338.956610433918, 4364.585364390441, 4388.824447022147, 4401.955980440219, 4436.778161091933, 3914.5889681583594, 3923.43110249018, 3928.0, 3956.2680904032845, 3978.1049263915966, 5382.91925621116, 5387.164989426645, 5388.946110538923, 5393.865153371197, 5399.568034557305, 5649.68926709035, 5654.349749778746, 5712.600117991784, 5721.914171287434, 5807.82576522705, 5440.537554307849, 5446.945530544723, 5447.4824891635235, 5448.210009548593, 5451.563874889999, 5003.099442100384, 5012.54887060159, 5014.598832093424, 5014.674046186986, 5015.874603134951, 5906.320773111147, 5960.195373624679, 5971.701414929236, 5977.641341519523, 5981.132735753292, 5766.250387449605, 5769.68266745333, 5773.624714393551, 5788.652680839163, 5796.710164491843, 5912.379200183918, 5927.911081333697, 5928.258967629046, 5932.673702946379, 5932.991391463548, 5562.91655625174, 5578.748956297058, 5615.775368985358, 5661.0659241226385, 5675.177099320658, 5795.797147099831, 5801.1878337033695, 5801.477866991991, 5802.0426629605645, 5810.389909059657, 5513.7794488221625, 5558.110702287615, 5641.40765219646, 5641.66150030983, 5650.039493286234, 5521.282233309644, 5617.831465056055, 5636.718164091861, 5638.577106716931, 5640.041192997118, 5576.776928922797, 5631.0, 5635.0, 5642.069058605284, 5645.548356131581, 5530.944690553043, 5648.350439699487, 5658.151277308437, 5682.062459694104, 5687.118496633028, 5565.16522521625, 5568.276124103841, 5568.526675232651, 5569.081101618188, 5573.331200255995], "value": 5297.245617229638, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.4085655201351, 636.592580748321, 644.9000404937236, 645.5706954875009, 664.7573635622999, 37742.62257377426, 40341.79829100854, 40359.39460908089, 40419.38322467098, 40475.190496190095, 41058.7947060265, 41583.792081039624, 41622.25399714025, 41677.58322416775, 41702.0, 7933.444658873881, 8175.305099066557, 8315.417920745535, 8453.873191902127, 8459.83080338393, 9949.75125621858, 10255.538500767447, 10258.640947566837, 10526.736831579195, 10532.26274160809, 10252.846207306897, 10270.12703920164, 10320.329178603404, 10322.690319290434, 10331.121854642326, 10186.643467478676, 10239.488025598728, 10256.794864102714, 10291.639792607297, 10297.07326340633, 10039.046290602455, 10054.34646747959, 10123.746906327327, 10127.848082278771, 10128.848067278997, 39528.40707389363, 39906.60093399087, 39908.40137397941, 39912.401313980314, 39984.60015399867, 3372.9494057589154, 3438.2951494943727, 3701.3152566774966, 3710.6103859094947, 3909.4331321958443, 29386.706132938612, 29858.253543661365, 29883.551746723817, 29940.70059299401, 29948.0, 3714.609965953563, 3893.9026524336837, 3928.685705143582, 3932.685385169208, 3968.761874287552, 334087.0, 334565.0, 335157.0, 336586.0, 336855.99999999756, 56762.7161864188, 57136.71431642815, 57186.42813571894, 57234.713826431434, 57262.42737572654, 61341.386586133565, 61402.692986534785, 61433.07850382248, 61460.0, 61497.692511537156, 14310.85689143116, 14502.419903203965, 14686.55940321792, 14701.338439770236, 14707.338169782386, 10162.796744065077, 10459.267851250339, 10473.581056757645, 10659.4137322448, 11034.834477482844, 16648.58378540522, 17304.65390692204, 18382.172802223933, 18395.356162534248, 18929.90535047316, 6673.432758215606, 6795.252522222551, 6965.129358830146, 6972.686229119702, 7067.257937916547, 948.9857652135223, 985.6845809341086, 1019.592163134752, 1050.8108540462638, 1122.3041714137123, 28618.856905715755, 30582.847085764875, 30785.38429231403, 30890.0, 31294.530582040832, 1102.5424448853796, 1112.57165991094, 1131.7679875625477, 1141.1669481278714, 1180.598596477202, 15631.609209769847, 15900.602484937968, 16003.919980400024, 16100.919495402448, 16195.014845679689, 444184.0, 444579.0, 447736.0, 448928.8838895138, 450419.0, 55095.173572396445, 55539.44460555343, 55607.0, 55658.0, 55711.442885571436, 1317.426919290112, 1343.0464370297002, 1348.871857173567, 1349.9460021599418, 1369.6370461827623, 28857.711422886343, 29767.404651907273, 30575.388492230475, 30687.539686904267, 30809.8459507701, 46837.0, 47295.29057064078, 47488.762556187, 47518.76240618775, 47644.0, 399784.0, 400682.0, 400776.0, 400792.0, 400972.0, 26862.731372686023, 27194.592081118404, 27207.72792272131, 27214.863925680245, 27257.31856703598, 44538.55461445344, 44713.32930005987, 44779.0, 44790.3281450772, 45880.77059614814, 38031.0, 38646.0, 38703.61296387, 38859.417108742826, 40319.0, 37423.81288093651, 37839.62160378361, 38060.0, 38406.0, 38746.80626596849, 38908.41637375385, 39551.0, 39722.20555588814, 39835.0, 39926.2014759709, 32180.678193218704, 34412.31175376529, 34905.0, 35067.82466087755, 35111.297774044884, 26751.86624066945, 27016.45967080608, 27202.863985679945, 27463.365461488454, 27545.44909101767], "value": 19468.776449439247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.6772172766239, 375.44059351566176, 389.88108626868814, 393.98621048263317, 401.60241361052556, 14632.195229262386, 15347.84652153478, 18253.726194107097, 18786.624267514642, 18826.43520694378, 16674.49976500704, 16682.66634667309, 16785.24466399012, 16837.073960932175, 16849.157542122877, 4211.241976444238, 5469.234307196985, 5678.176664383662, 5689.9146512802345, 5693.491224825425, 4295.52749197588, 4341.41390912226, 4443.822247110112, 6192.133101365813, 6412.583182093173, 6188.752449901998, 6195.5663103582765, 6369.681515924185, 6431.0, 6431.549791514596, 6276.843078923018, 6295.527835412317, 6307.716152773136, 6314.242290925118, 6322.336154703758, 5383.865403364908, 5530.142827861688, 5565.276514053147, 5634.746436410331, 5635.971820140914, 20566.485837854172, 21284.680729789066, 21397.251096211712, 22396.0, 22604.0, 2604.5442047641777, 2781.485425196345, 2868.6270784798053, 2921.0798598441424, 2969.465496210681, 9908.603655853758, 9922.80154396908, 10062.496875156286, 10312.432816195107, 10473.790524189473, 1856.1554492705786, 1912.1204246046834, 1942.8348590369835, 1952.8925909074994, 1968.9507762305914, 71994.64002680006, 76496.0, 77931.0, 78567.21432785656, 79043.60478197572, 10739.463026848627, 10771.0, 10865.619703310345, 11089.0, 11214.66356009321, 14830.62923426923, 15317.387304507694, 15328.23358832054, 15332.080075195525, 15380.384784608714, 7482.850342993219, 7688.769336919901, 7786.844263114819, 7838.372930165573, 7945.205479452008, 7062.646867656596, 7188.0, 7219.963900180465, 7323.0, 7415.703371865173, 4628.305754136906, 4647.767611619405, 4671.8364857229835, 4730.864592497845, 4734.928976065362, 1940.8156225158586, 1960.9411717648493, 1970.615729932678, 1985.930492432758, 1995.3814317561603, 881.6341218394423, 938.6339327662217, 955.3933252384786, 1023.4729114505886, 1063.9202059845388, 18281.908590457228, 18765.343212987755, 18995.525111872037, 19034.143463544173, 19045.809541904404, 948.9952550237342, 978.1685567267907, 991.4348821171862, 1006.9244806639531, 1010.1363334349026, 9856.852147217798, 10315.84526232107, 10378.42918639467, 10385.792284154275, 10387.169026477864, 436520.0, 445087.0, 445582.0, 448347.0, 451421.0, 75550.62224688841, 86863.0, 87737.0, 87779.0, 87779.56110219535, 928.3501548915921, 945.4185675809327, 967.4388854464394, 972.3485264872411, 979.9951000244953, 16273.186340683154, 16461.753073704145, 16970.856564871166, 16975.660486790443, 17121.315147393965, 40042.79978600088, 40194.39708404318, 40754.38868417036, 41029.1794164121, 42399.5760042408, 54548.0, 54808.0, 55957.00537432821, 56004.159937601784, 58000.0, 8252.876206857021, 8414.368922330726, 8509.064002959545, 8575.699850505202, 8584.527850968258, 8396.790080248044, 11612.88387116118, 12492.750144997231, 12758.74482510326, 12846.550370736979, 10949.0, 11239.887601123884, 11719.589814356457, 11756.11829112837, 12068.396580171131, 10690.572377104829, 10774.515146818569, 11105.111591072533, 11144.498497567467, 11177.776444471228, 11030.338179709242, 11223.55105795759, 11382.886171138183, 11648.41757912084, 11893.643190704293, 8056.556889370906, 8171.387145964195, 8183.222593853575, 8291.58542072906, 8473.57632118404, 9107.453552786854, 10993.945030274797, 11044.502997364978, 11141.83287250708, 11568.0], "value": 8937.531823817377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1308.4700696218035, 1418.6098822823726, 1466.3767898643077, 1561.7735428362887, 1729.0835856995798, 7395.630218489075, 7995.880061799077, 8301.543415112174, 8303.211194936486, 8497.660093596263, 8292.875606865902, 8360.623771930263, 8366.330693544516, 8366.665333386658, 8368.91631083689, 1998.6102709971562, 2065.5249292662697, 2278.1912421090483, 2315.7452680205165, 2319.014418871981, 2228.821694264463, 2316.5945959457113, 2319.072371051576, 2320.4662927526597, 2331.370529956919, 2199.692043113965, 2225.376894469551, 2242.9439264018365, 2259.0, 2259.3334966184934, 2247.6628505724107, 2253.143805353963, 2261.2537862505333, 2263.151318255654, 2273.9658905116353, 2232.6427771556473, 2260.367097212783, 2264.6603009548535, 2264.728232612081, 2267.047839907243, 8178.713745018896, 8229.629666664954, 8326.750197494084, 8334.66661333546, 8336.791580210482, 4949.133901567211, 5083.74581270935, 5084.161113416282, 5085.593152547787, 5086.21163719624, 3086.82889877853, 3121.4069326828057, 3198.392305461955, 3243.4486137356707, 3245.75656825739, 1064.2177999170603, 1067.5516283161014, 1098.8406681031286, 1118.692359601116, 1138.8690300615453, 10776.73058173544, 10945.726356841064, 10952.780944381147, 11270.43647817614, 11364.261323013978, 4412.867613971586, 4538.364628951884, 4607.815687372467, 4628.190066738374, 4628.5371462853445, 9774.657886973922, 9788.853167202498, 9789.755256118655, 9793.118619324296, 9793.314467987173, 4965.255211718271, 5017.874553136127, 5025.79896804131, 5029.044481548567, 5047.697138171721, 4226.5139508956245, 4460.50934397216, 4595.126925884071, 4611.054733779567, 4626.83806066786, 3845.115623406576, 3859.4403811447182, 3942.8619998299923, 3953.347697629916, 3980.9402858957137, 1263.4440846027903, 1279.3027799849106, 1285.1068507387276, 1296.092735085444, 1299.9220046797034, 775.7556369743513, 843.3632607381388, 871.834351473218, 945.8723072385278, 968.843660695622, 5465.1529013002255, 5477.589180811455, 5519.144532597454, 5745.827625171251, 5892.6759028253, 987.1362557761959, 1017.6590842067842, 1027.787211090905, 1047.6542740895486, 1088.684281558355, 3750.7809961762537, 3850.7111966602615, 3861.5945325740954, 3888.1251718363706, 3961.603839616015, 10130.493475326204, 10269.0, 10326.638567650247, 10335.17318614509, 10346.896531034743, 10002.636461768725, 10280.331778434378, 10285.331453455501, 10294.691159265234, 10313.587456501806, 7680.423968202295, 7738.2261773822165, 7853.764387068397, 7859.842803143905, 7863.174366691644, 5323.121684922099, 5398.2982212312145, 5455.290812194548, 5518.972405137949, 5545.750441230073, 9212.677556285498, 9212.861807072764, 9266.258699303904, 9298.116678915492, 9342.579583918605, 9388.718338449857, 9446.197073248852, 9481.09929556691, 9509.904900950902, 9558.95220523893, 6448.935510644834, 6606.768763093269, 6885.51801373899, 7039.788806335613, 7178.892316615151, 7793.454458187873, 8047.798805029687, 8058.919410806051, 8061.113277539349, 8068.757937261891, 7081.539699919489, 7081.893771593327, 7199.568025918462, 7247.420206383371, 7326.267373262631, 7034.964825175842, 7235.384992275715, 7238.855222895408, 7442.9255707442235, 7531.736389226351, 6466.7066586683795, 6550.082988381535, 6592.439642630238, 6601.438877695257, 6605.471562275103, 4884.902301954012, 4890.682105663121, 4917.778699958582, 5068.516426950841, 5142.948570514247, 4995.350604421402, 5023.422306434661, 5060.51925067118, 5119.232115182753, 5195.29863468442], "value": 4424.263861909236, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.70453478265205, 329.7296217101976, 332.8152875154289, 334.9330133973205, 339.0337538016651, 5209.505097015782, 5262.631615786891, 5309.982206761425, 5317.494837990394, 5332.680039197651, 5001.624878134146, 5030.597552195824, 5079.857032167761, 5112.590992720583, 5235.424103348629, 4092.570280120589, 4094.4409743910055, 4100.692448066392, 4107.876763697094, 4123.814428350716, 4094.9590504094876, 4112.321466957948, 4118.9588104118875, 4120.793960301988, 4131.132462182945, 3900.9804950975204, 3938.448617193581, 4040.878773636796, 4061.8578349757618, 4080.8165631966694, 4044.6562042226446, 4060.512738471373, 4060.675145988314, 4061.5532291447917, 4087.4686290782156, 3605.441156620728, 3625.0574850538787, 3625.6918161956264, 3632.400653892105, 3641.581218159919, 4886.6823656462575, 5026.547610715053, 5034.320366750479, 5053.67151135175, 5080.187170052774, 4674.415698037746, 4691.202495575761, 4708.317293992386, 4715.7877895494785, 4720.221163508017, 5433.212184233264, 5441.29263195782, 5442.346918369782, 5447.291852059247, 5493.23094766733, 3921.313770090223, 3994.8801535953967, 3995.06116062725, 3999.7600743769526, 4012.21456451879, 5598.720063996784, 5617.831465056055, 5634.3802181759975, 5638.548916086662, 5642.210090587321, 4096.959030409717, 4099.446574712435, 4100.159467309194, 4100.774457404812, 4110.219058378899, 3996.0, 4151.232022075926, 4152.626263636287, 4158.708890377705, 4182.644475219579, 4644.210484217691, 4654.881229576192, 4672.229082201398, 4676.625869930397, 4678.50875658051, 5447.53695935842, 5452.936677347959, 5456.91814622781, 5459.836204913859, 5486.61593688438, 1345.0272125350934, 1383.2806940391142, 1386.708791153869, 1391.172252509755, 1391.464286249801, 974.5614473486818, 977.867987821635, 985.9359141655913, 990.846418805072, 995.3530205366425, 4997.30037794709, 4999.350084489066, 5006.6245031622775, 5007.4491805901325, 5074.543291103819, 5387.676739395649, 5400.702961337164, 5418.4039755626845, 5422.511973922287, 5434.538064264502, 4955.231939049453, 5080.822171223989, 5215.217717342429, 5232.2471971889845, 5245.790168393298, 2823.6188114604674, 2847.576211894053, 2847.729465700755, 2858.871350789178, 2861.3418913649975, 5493.642913210629, 5600.635958662674, 5638.323401191883, 5654.74553645087, 5680.233168522279, 5646.57650676201, 5665.433456654301, 5669.744861481243, 5736.225609542742, 5754.597178197486, 5686.60193786431, 5767.307923049261, 5797.246357973437, 5799.217105690762, 5870.970645146747, 5494.725263736717, 5497.422770609029, 5531.446855314436, 5570.637908535932, 5641.0, 5528.557715382679, 5536.889262214652, 5554.861128471821, 5568.888622227614, 5569.331680198402, 5654.434556544313, 5746.741396637245, 5771.278590176228, 5781.508571771446, 5864.736086876186, 4023.416604592376, 4052.756834589934, 4060.3706425504092, 4077.7553346799286, 4080.6327430531396, 5331.733413329241, 5411.594130440154, 5505.2108064878275, 5659.490645841894, 5664.923664503731, 5427.426046446486, 5450.427705091067, 5458.508734213781, 5464.4808743170925, 5490.890182196254, 5424.511793938565, 5439.972800135974, 5459.208414779914, 5468.644538105011, 5471.644343117685, 5248.399238232376, 5389.353277606712, 5402.945970540244, 5404.432534583812, 5450.482204190595, 5450.400455949763, 5450.727463626882, 5464.371597266207, 5479.753411096431, 5485.244721689021, 5221.921671175011, 5341.359036915595, 5350.678959262456, 5366.570674345965, 5373.570114390917], "value": 4166.556277439118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.2612209424293, 720.981975450614, 738.0958326050588, 743.1008479739515, 757.5416872791959, 14258.928705356471, 15260.771088433683, 15429.768553471707, 15494.38022479101, 15501.224938753074, 14471.493497727583, 14992.550223493285, 15099.320530576122, 15124.0, 15139.31873065712, 799.2926260259654, 811.0551207842856, 815.5799763121997, 815.7063457155419, 817.0644611919349, 672.5829985409054, 694.4236283884364, 783.2246076384396, 806.7257132574923, 812.0742353716738, 831.1356189562847, 839.3830534557096, 842.7808769719886, 842.9494230346169, 843.8185790055137, 837.2757564706546, 837.4891316297054, 837.5435387713711, 837.623069618671, 837.7989282572139, 498.34878446663765, 510.8518529626404, 594.586762200271, 612.5161122713051, 613.25489530221, 14065.296735163201, 14086.788698169536, 14136.293185340692, 14137.858621413758, 14175.220362880038, 13904.652383690387, 13955.651108722363, 14011.29943502831, 14031.368588413547, 14184.29078546079, 11731.354775487345, 11773.0, 11785.057195424346, 12064.6380608581, 12149.878501214964, 3526.559180102487, 3720.8511659533588, 3721.1999420124534, 3736.57029441615, 3759.774413535197, 80411.5979420105, 81638.59180704117, 82079.17920820774, 82931.0, 83392.0, 10560.2079844012, 10655.733606659896, 11236.66290011301, 11299.830502542469, 11307.0, 18474.63050738978, 18553.44339669812, 18603.81396186048, 18607.720884186747, 18664.533386665444, 7697.730579429693, 7852.057753069668, 7915.0, 8031.638576263966, 8106.4325497215805, 4141.344371617859, 4160.958390416117, 4176.227397931392, 4181.289180839204, 4197.202531519001, 3549.4853246279145, 3630.364686179908, 3676.522052133259, 3684.5630204220374, 3700.685441737429, 583.5040215816607, 592.8606777407306, 595.6515438468545, 596.0195478437945, 603.9214902062704, 689.9306075582926, 696.3176087434241, 711.2673945835797, 721.3435773446244, 723.3995783499682, 9504.809903801885, 9720.574601497268, 9791.902080979098, 9847.212223022141, 10013.098821106136, 614.6435067660746, 690.9101816763789, 718.5042320798632, 723.9746608868664, 727.4871215792854, 4372.278574035312, 4518.390017347681, 4579.152856721517, 4650.302454631832, 4686.531346865286, 74454.0, 90209.54895225482, 90862.0, 92719.0, 92867.53566232126, 77738.0, 79030.0, 80153.0, 80159.59920200362, 80931.0, 66718.0, 68159.65920170367, 68649.0, 68993.31006689869, 70166.29833701598, 9071.455712657262, 9229.630814767334, 9274.304427167854, 9322.161005509266, 9384.95307523458, 47069.52930470651, 47571.76214118907, 49093.75453122712, 49235.75382123067, 49620.50379496159, 52710.0, 53136.468635313155, 54531.72734136304, 58330.4166958325, 58438.415615843296, 12916.547920822726, 13246.735065298833, 13259.204447733167, 13721.656958576115, 13817.170969741848, 14748.115113093249, 14749.926250368679, 15104.169270690218, 15583.454579089677, 16180.190990450667, 13753.518626848012, 13825.170489770244, 13947.4421023162, 14228.217448040457, 14520.927395363378, 10562.577496900038, 13433.865661343261, 13471.865281347062, 13862.376193071133, 14199.432022718975, 13407.195568265935, 13898.36076998515, 13981.580552583438, 14018.649533761738, 14342.641433964234, 10524.789504210026, 10713.946430267799, 10826.561109944885, 11471.713207169887, 11598.0, 10242.436665983443, 10636.787264254826, 11913.0, 12095.516179353079, 12233.755324893275], "value": 7204.874556255833, "unit": "score"}], "name": "dromaeo_css", "value": 7046.651668144527, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 110.0, 111.0, 110.0, 110.0, 113.0, 112.0, 109.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 125.0, 155.0, 125.0, 139.0, 127.0, 124.0, 144.0, 123.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 77.0, 75.0, 77.0, 76.0, 96.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 107.0, 82.0, 83.0, 83.0, 102.0, 82.0, 81.0, 108.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 62.0, 63.0, 62.0, 62.0, 61.0, 62.0, 63.0], "value": 62.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 90.0, 84.0, 80.0, 88.0, 81.0, 90.0, 80.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 143.0, 130.0, 133.0, 133.0, 144.0, 155.0, 171.0, 146.0], "value": 142.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 163.0, 164.0, 168.0, 163.0, 167.0, 166.0, 163.0, 165.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 74.0, 66.0, 66.0, 66.0, 65.0, 65.0, 67.0, 65.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1509.1999999999998, "alertThreshold": 2.0}]} 07:37:44 INFO - Return code: 0 07:37:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:37:44 INFO - # TBPL SUCCESS # 07:37:44 INFO - Running post-action listener: _resource_record_post_action 07:37:44 INFO - [mozharness: 2016-11-29 15:37:44.171893Z] Finished run-tests step (success) 07:37:44 INFO - Running post-run listener: _resource_record_post_run 07:37:44 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 2228224; Write bytes: 394051584; Read time: 604; Write time: 210916 07:37:44 INFO - TinderboxPrint: CPU usage
13.1% 07:37:44 INFO - TinderboxPrint: I/O read bytes / time
2,228,224 / 604 07:37:44 INFO - TinderboxPrint: I/O write bytes / time
394,051,584 / 210,916 07:37:44 INFO - TinderboxPrint: CPU idle
8,308.5 (86.9%) 07:37:44 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 07:37:44 INFO - TinderboxPrint: Swap in / out
0 / 0 07:37:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103682048; Read time: 0; Write time: 61596 07:37:44 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 2228224; Write bytes: 289980416; Read time: 604; Write time: 149304 07:37:44 INFO - Running post-run listener: _upload_blobber_files 07:37:44 INFO - Blob upload gear active. 07:37:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:37:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:37:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:37:45 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:45 INFO - (blobuploader) - INFO - Done attempting. 07:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:46 INFO - (blobuploader) - INFO - Done attempting. 07:37:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:37:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:37:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:51 INFO - (blobuploader) - INFO - Done attempting. 07:37:51 INFO - (blobuploader) - INFO - Iteration through files over. 07:37:51 INFO - Return code: 0 07:37:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:37:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:37:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcac2b247a66af7e7e088013a142e4873b09c226762d26ef6b6e99296ec9b94c219539f719e4be1ffef621f60a65c453a8db52591c4cd3040d7c45598339530c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fc5132278ed1c9e02dc69ab28260823ad7606c4aa9066a4fa28243828be886bec71e3503731ec2b1c8bcfe9c9ee9bfc9aba2c0ba5ee15dceead1cf4d3ec359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db3f100012fd062ede377163f0bf41b6157f1f4c1fc326f012fc60f571542db70e4b9d38f956fe69f5313efc3e27a61f5fe31c27e58381ace823b4890db2dc3"} 07:37:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:37:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:37:51 INFO - Contents: 07:37:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcac2b247a66af7e7e088013a142e4873b09c226762d26ef6b6e99296ec9b94c219539f719e4be1ffef621f60a65c453a8db52591c4cd3040d7c45598339530c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fc5132278ed1c9e02dc69ab28260823ad7606c4aa9066a4fa28243828be886bec71e3503731ec2b1c8bcfe9c9ee9bfc9aba2c0ba5ee15dceead1cf4d3ec359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db3f100012fd062ede377163f0bf41b6157f1f4c1fc326f012fc60f571542db70e4b9d38f956fe69f5313efc3e27a61f5fe31c27e58381ace823b4890db2dc3"} 07:37:51 INFO - Running post-run listener: copy_logs_to_upload_dir 07:37:51 INFO - Copying logs to upload dir... 07:37:51 INFO - mkdir: /builds/slave/test/build/upload/logs 07:37:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.289948 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-11-29 07:37:51.454140) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 07:37:51.458088) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcac2b247a66af7e7e088013a142e4873b09c226762d26ef6b6e99296ec9b94c219539f719e4be1ffef621f60a65c453a8db52591c4cd3040d7c45598339530c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fc5132278ed1c9e02dc69ab28260823ad7606c4aa9066a4fa28243828be886bec71e3503731ec2b1c8bcfe9c9ee9bfc9aba2c0ba5ee15dceead1cf4d3ec359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db3f100012fd062ede377163f0bf41b6157f1f4c1fc326f012fc60f571542db70e4b9d38f956fe69f5313efc3e27a61f5fe31c27e58381ace823b4890db2dc3"} build_url:https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/WrErXHmPQ-GG6-iD_tZfiw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fcac2b247a66af7e7e088013a142e4873b09c226762d26ef6b6e99296ec9b94c219539f719e4be1ffef621f60a65c453a8db52591c4cd3040d7c45598339530c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18fc5132278ed1c9e02dc69ab28260823ad7606c4aa9066a4fa28243828be886bec71e3503731ec2b1c8bcfe9c9ee9bfc9aba2c0ba5ee15dceead1cf4d3ec359", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1db3f100012fd062ede377163f0bf41b6157f1f4c1fc326f012fc60f571542db70e4b9d38f956fe69f5313efc3e27a61f5fe31c27e58381ace823b4890db2dc3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 07:37:51.489148) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:37:51.489887) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1480431733.461919-460290957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 07:37:51.573002) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 07:37:51.573353) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 07:37:51.573692) ========= ========= Total master_lag: 0.18 =========