builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1475679008.17 results: success (0) buildid: 20161005062400 builduid: b301c0dbd0d5461eae34058a1332194b revision: bbfb1c7bcc50f7b335d34c65fc54fb3af9584596 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.166598) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.167342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.167618) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.197190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.197465) ========= 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=836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 07:50:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 89.0M=0s 2016-10-05 07:50:08 (89.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.329296 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.540548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.540870) ========= 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=836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.590540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:08.590902) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bbfb1c7bcc50f7b335d34c65fc54fb3af9584596 --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 bbfb1c7bcc50f7b335d34c65fc54fb3af9584596 --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=836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 07:50:08,696 truncating revision to first 12 chars 2016-10-05 07:50:08,696 Setting DEBUG logging. 2016-10-05 07:50:08,696 attempt 1/10 2016-10-05 07:50:08,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bbfb1c7bcc50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 07:50:09,002 unpacking tar archive at: mozilla-central-bbfb1c7bcc50/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640511 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:09.244698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:09.245023) ========= script_repo_revision: bbfb1c7bcc50f7b335d34c65fc54fb3af9584596 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:09.245427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:09.245706) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 07:50:09.255173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-05 07:50:09.255451) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:50:09 INFO - MultiFileLogger online at 20161005 07:50:09 in /builds/slave/test 07:50:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:50:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:50:09 INFO - {'append_to_log': False, 07:50:09 INFO - 'base_work_dir': '/builds/slave/test', 07:50:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:50:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:50:09 INFO - 'branch': 'Firefox-Non-PGO', 07:50:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:50:09 INFO - 'config_files': ('talos/linux_config.py',), 07:50:09 INFO - 'default_actions': ('clobber', 07:50:09 INFO - 'read-buildbot-config', 07:50:09 INFO - 'download-and-extract', 07:50:09 INFO - 'populate-webroot', 07:50:09 INFO - 'create-virtualenv', 07:50:09 INFO - 'install', 07:50:09 INFO - 'run-tests'), 07:50:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:50:09 INFO - 'download_minidump_stackwalk': True, 07:50:09 INFO - 'download_symbols': 'ondemand', 07:50:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:50:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:50:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:50:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:50:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:50:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:50:09 INFO - 'installer_path': 'installer.exe', 07:50:09 INFO - 'log_level': 'info', 07:50:09 INFO - 'log_name': 'talos', 07:50:09 INFO - 'log_to_console': True, 07:50:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:50:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:50:09 INFO - 'opt_config_files': (), 07:50:09 INFO - 'pip_index': False, 07:50:09 INFO - 'sps_profile': False, 07:50:09 INFO - 'sps_profile_interval': 0, 07:50:09 INFO - 'suite': 'dromaeojs', 07:50:09 INFO - 'system_bits': '32', 07:50:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:50:09 INFO - 'title': 'talos-linux64-ix-028', 07:50:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:50:09 INFO - 'use_talos_json': True, 07:50:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:50:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:50:09 INFO - 'work_dir': 'build'} 07:50:09 INFO - [mozharness: 2016-10-05 14:50:09.457951Z] Running clobber step. 07:50:09 INFO - Running pre-action listener: _resource_record_pre_action 07:50:09 INFO - Running main action method: clobber 07:50:09 INFO - rmtree: /builds/slave/test/build 07:50:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:50:09 INFO - Running post-action listener: _resource_record_post_action 07:50:09 INFO - [mozharness: 2016-10-05 14:50:09.903069Z] Finished clobber step (success) 07:50:09 INFO - [mozharness: 2016-10-05 14:50:09.903169Z] Running read-buildbot-config step. 07:50:09 INFO - Running pre-action listener: _resource_record_pre_action 07:50:09 INFO - Running main action method: read_buildbot_config 07:50:09 INFO - Using buildbot properties: 07:50:09 INFO - { 07:50:09 INFO - "project": "", 07:50:09 INFO - "product": "firefox", 07:50:09 INFO - "script_repo_revision": "production", 07:50:09 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:50:09 INFO - "repository": "", 07:50:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:50:09 INFO - "buildid": "20161005062400", 07:50:09 INFO - "pgo_build": "False", 07:50:09 INFO - "basedir": "/builds/slave/test", 07:50:09 INFO - "buildnumber": 658, 07:50:09 INFO - "slavename": "talos-linux64-ix-028", 07:50:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:50:09 INFO - "platform": "ubuntu64_hw", 07:50:09 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:50:09 INFO - "branch": "mozilla-central", 07:50:09 INFO - "repo_path": "mozilla-central", 07:50:09 INFO - "revision": "bbfb1c7bcc50f7b335d34c65fc54fb3af9584596", 07:50:09 INFO - "stage_platform": "linux64", 07:50:09 INFO - "builduid": "b301c0dbd0d5461eae34058a1332194b", 07:50:09 INFO - "slavebuilddir": "test" 07:50:09 INFO - } 07:50:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:50:09 INFO - Running post-action listener: _resource_record_post_action 07:50:09 INFO - [mozharness: 2016-10-05 14:50:09.905582Z] Finished read-buildbot-config step (success) 07:50:09 INFO - [mozharness: 2016-10-05 14:50:09.905669Z] Running download-and-extract step. 07:50:09 INFO - Running pre-action listener: _resource_record_pre_action 07:50:09 INFO - Running main action method: download_and_extract 07:50:09 INFO - mkdir: /builds/slave/test/build/tests 07:50:09 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:50:09 INFO - trying https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:50:09 INFO - Downloading https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:50:10 INFO - Downloaded 1361 bytes. 07:50:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:50:10 INFO - Using the following test package requirements: 07:50:10 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:50:10 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:50:10 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:50:10 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'jsshell-linux-x86_64.zip'], 07:50:10 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:50:10 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:50:10 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:50:10 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:50:10 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:50:10 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:50:10 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:50:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:50:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:50:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:50:10 INFO - Fetch https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:50:11 INFO - Http code: 200 07:50:11 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 07:50:11 INFO - x-amz-cf-id: U7b0iGdq9Xisz0SyGk8UOgeawF40chK_sIMv_ECm80C7fCl3Kq_Y6Q== 07:50:11 INFO - x-amz-version-id: hNkENIk5LAxq65bDP74L0A_J5CmuJU3h 07:50:11 INFO - Expected file size: 20420976 07:50:11 INFO - Obtained file size: 20420976 07:50:15 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:50:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:50:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:50:15 INFO - Fetch https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:50:15 INFO - Http code: 200 07:50:15 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 07:50:15 INFO - x-amz-cf-id: wIrv-tLT6W1x1j7WpohZ6fcrhaYXPmR_uPizsoQPA24tY6CXkjFblQ== 07:50:15 INFO - x-amz-version-id: hNkENIk5LAxq65bDP74L0A_J5CmuJU3h 07:50:16 INFO - Expected file size: 20420976 07:50:16 INFO - Obtained file size: 20420976 07:50:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:50:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:50:20 INFO - Fetch https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:50:21 INFO - Http code: 200 07:50:21 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 07:50:21 INFO - x-amz-cf-id: 2T3fXzvjzC727cndI4Njki2G_xJO9ozHkMRAHBbFp30K6luEaNz7-w== 07:50:21 INFO - x-amz-version-id: fW6gCK_3w.n.Qqw3pV2h7ZktMtCtPRXP 07:50:21 INFO - Expected file size: 14409006 07:50:21 INFO - Obtained file size: 14409006 07:50:21 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:50:21 INFO - trying https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:50:21 INFO - Downloading https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:50:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:50:22 INFO - Downloaded 55804633 bytes. 07:50:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:50:22 INFO - mkdir: /builds/slave/test/properties 07:50:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:50:22 INFO - Writing to file /builds/slave/test/properties/build_url 07:50:22 INFO - Contents: 07:50:22 INFO - build_url:https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:50:23 INFO - Running post-action listener: _resource_record_post_action 07:50:23 INFO - Running post-action listener: set_extra_try_arguments 07:50:23 INFO - [mozharness: 2016-10-05 14:50:23.342445Z] Finished download-and-extract step (success) 07:50:23 INFO - [mozharness: 2016-10-05 14:50:23.342744Z] Running populate-webroot step. 07:50:23 INFO - Running pre-action listener: _resource_record_pre_action 07:50:23 INFO - Running main action method: populate_webroot 07:50:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:50:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:50:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:50:23 INFO - '--tppagecycles', 07:50:23 INFO - '7'], 07:50:23 INFO - 'tests': ['tsvgm']}}, 07:50:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:50:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:50:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:50:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:50:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:50:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['damp', 'tps']}, 07:50:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'tests': ['damp', 'tps']}, 07:50:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['dromaeo_dom']}, 07:50:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:50:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['basic_compositor_video']}, 07:50:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:50:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['a11yr', 07:50:23 INFO - 'ts_paint', 07:50:23 INFO - 'tpaint', 07:50:23 INFO - 'sessionrestore', 07:50:23 INFO - 'sessionrestore_no_auto_restore', 07:50:23 INFO - 'tabpaint']}, 07:50:23 INFO - 'other-e10s': {'tests': ['a11yr', 07:50:23 INFO - 'ts_paint', 07:50:23 INFO - 'tpaint', 07:50:23 INFO - 'sessionrestore', 07:50:23 INFO - 'sessionrestore_no_auto_restore', 07:50:23 INFO - 'tabpaint']}, 07:50:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:50:23 INFO - 'ts_paint', 07:50:23 INFO - 'tpaint', 07:50:23 INFO - 'sessionrestore', 07:50:23 INFO - 'sessionrestore_no_auto_restore', 07:50:23 INFO - 'tabpaint']}, 07:50:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:50:23 INFO - 'ts_paint', 07:50:23 INFO - 'tpaint', 07:50:23 INFO - 'sessionrestore', 07:50:23 INFO - 'sessionrestore_no_auto_restore', 07:50:23 INFO - 'tabpaint']}, 07:50:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['a11yr', 07:50:23 INFO - 'ts_paint', 07:50:23 INFO - 'tpaint', 07:50:23 INFO - 'sessionrestore', 07:50:23 INFO - 'sessionrestore_no_auto_restore', 07:50:23 INFO - 'tabpaint']}, 07:50:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['a11yr', 07:50:23 INFO - 'ts_paint', 07:50:23 INFO - 'tpaint', 07:50:23 INFO - 'sessionrestore', 07:50:23 INFO - 'sessionrestore_no_auto_restore', 07:50:23 INFO - 'tabpaint']}, 07:50:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['tsvgx', 07:50:23 INFO - 'tsvgr_opacity', 07:50:23 INFO - 'tart', 07:50:23 INFO - 'tscrollx', 07:50:23 INFO - 'cart']}, 07:50:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:50:23 INFO - 'tsvgr_opacity', 07:50:23 INFO - 'tart', 07:50:23 INFO - 'tscrollx', 07:50:23 INFO - 'cart']}, 07:50:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'talos_options': ['--disable-e10s'], 07:50:23 INFO - 'tests': ['tp5o']}, 07:50:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'tests': ['tp5o']}, 07:50:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'talos_options': ['--disable-e10s', 07:50:23 INFO - '--xperf_path', 07:50:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:23 INFO - 'tests': ['tp5n']}, 07:50:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:50:23 INFO - 'talos_options': ['--xperf_path', 07:50:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:50:23 INFO - 'tests': ['tp5n']}}, 07:50:23 INFO - 'talos.zip': {'path': '', 07:50:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:50:23 INFO - Running post-action listener: _resource_record_post_action 07:50:23 INFO - [mozharness: 2016-10-05 14:50:23.363121Z] Finished populate-webroot step (success) 07:50:23 INFO - [mozharness: 2016-10-05 14:50:23.363213Z] Running create-virtualenv step. 07:50:23 INFO - Running pre-action listener: _resource_record_pre_action 07:50:23 INFO - Running main action method: create_virtualenv 07:50:23 INFO - Creating virtualenv /builds/slave/test/build/venv 07:50: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:50:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:50:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:50:23 INFO - Using real prefix '/usr' 07:50:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:50:23 INFO - Installing distribute.............................................................................................................................................................................................done. 07:50:25 INFO - Installing pip.................done. 07:50:25 INFO - Return code: 0 07:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:50:26 INFO - Reading from file tmpfile_stdout 07:50:26 INFO - Output received: 07:50: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:50:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:50: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:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:26 INFO - Using env: {'DISPLAY': ':0', 07:50:26 INFO - 'HOME': '/home/cltbld', 07:50:26 INFO - 'LANG': 'en_US.UTF-8', 07:50:26 INFO - 'LANGUAGE': 'en_US:en', 07:50:26 INFO - 'LOGNAME': 'cltbld', 07:50:26 INFO - 'MAIL': '/var/mail/cltbld', 07:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:26 INFO - 'MOZ_NO_REMOTE': '1', 07:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:26 INFO - 'NO_EM_RESTART': '1', 07:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:26 INFO - 'PWD': '/builds/slave/test', 07:50:26 INFO - 'SHELL': '/bin/bash', 07:50:26 INFO - 'SHLVL': '1', 07:50:26 INFO - 'TERM': 'linux', 07:50:26 INFO - 'TMOUT': '86400', 07:50:26 INFO - 'USER': 'cltbld', 07:50:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:26 INFO - '_': '/tools/buildbot/bin/python'} 07:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50: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:50:26 INFO - Cleaning up... 07:50:26 INFO - Return code: 0 07:50:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:50: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:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:26 INFO - Using env: {'DISPLAY': ':0', 07:50:26 INFO - 'HOME': '/home/cltbld', 07:50:26 INFO - 'LANG': 'en_US.UTF-8', 07:50:26 INFO - 'LANGUAGE': 'en_US:en', 07:50:26 INFO - 'LOGNAME': 'cltbld', 07:50:26 INFO - 'MAIL': '/var/mail/cltbld', 07:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:26 INFO - 'MOZ_NO_REMOTE': '1', 07:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:26 INFO - 'NO_EM_RESTART': '1', 07:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:26 INFO - 'PWD': '/builds/slave/test', 07:50:26 INFO - 'SHELL': '/bin/bash', 07:50:26 INFO - 'SHLVL': '1', 07:50:26 INFO - 'TERM': 'linux', 07:50:26 INFO - 'TMOUT': '86400', 07:50:26 INFO - 'USER': 'cltbld', 07:50:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:26 INFO - '_': '/tools/buildbot/bin/python'} 07:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:26 INFO - Downloading/unpacking psutil>=3.1.1 07:50: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:50: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:50: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:50: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:50: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:50: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:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:50:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:28 INFO - Installing collected packages: psutil 07:50:28 INFO - Running setup.py install for psutil 07:50:28 INFO - building 'psutil._psutil_linux' extension 07:50:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:50:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:50:28 INFO - building 'psutil._psutil_posix' extension 07:50:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:50:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:50:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:50:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:50:29 INFO - Successfully installed psutil 07:50:29 INFO - Cleaning up... 07:50:29 INFO - Return code: 0 07:50:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:50: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:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:29 INFO - Using env: {'DISPLAY': ':0', 07:50:29 INFO - 'HOME': '/home/cltbld', 07:50:29 INFO - 'LANG': 'en_US.UTF-8', 07:50:29 INFO - 'LANGUAGE': 'en_US:en', 07:50:29 INFO - 'LOGNAME': 'cltbld', 07:50:29 INFO - 'MAIL': '/var/mail/cltbld', 07:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:29 INFO - 'MOZ_NO_REMOTE': '1', 07:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:29 INFO - 'NO_EM_RESTART': '1', 07:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:29 INFO - 'PWD': '/builds/slave/test', 07:50:29 INFO - 'SHELL': '/bin/bash', 07:50:29 INFO - 'SHLVL': '1', 07:50:29 INFO - 'TERM': 'linux', 07:50:29 INFO - 'TMOUT': '86400', 07:50:29 INFO - 'USER': 'cltbld', 07:50:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:29 INFO - '_': '/tools/buildbot/bin/python'} 07:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:50: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:50: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:50: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:50: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:50: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:50: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:50:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:50: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:50:31 INFO - Installing collected packages: mozsystemmonitor 07:50:31 INFO - Running setup.py install for mozsystemmonitor 07:50:31 INFO - Successfully installed mozsystemmonitor 07:50:31 INFO - Cleaning up... 07:50:31 INFO - Return code: 0 07:50:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:50: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:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:31 INFO - Using env: {'DISPLAY': ':0', 07:50:31 INFO - 'HOME': '/home/cltbld', 07:50:31 INFO - 'LANG': 'en_US.UTF-8', 07:50:31 INFO - 'LANGUAGE': 'en_US:en', 07:50:31 INFO - 'LOGNAME': 'cltbld', 07:50:31 INFO - 'MAIL': '/var/mail/cltbld', 07:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:31 INFO - 'MOZ_NO_REMOTE': '1', 07:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:31 INFO - 'NO_EM_RESTART': '1', 07:50:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:31 INFO - 'PWD': '/builds/slave/test', 07:50:31 INFO - 'SHELL': '/bin/bash', 07:50:31 INFO - 'SHLVL': '1', 07:50:31 INFO - 'TERM': 'linux', 07:50:31 INFO - 'TMOUT': '86400', 07:50:31 INFO - 'USER': 'cltbld', 07:50:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:31 INFO - '_': '/tools/buildbot/bin/python'} 07:50:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:31 INFO - Downloading/unpacking jsonschema==2.5.1 07:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:50:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:50:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:50:33 INFO - warning: no files found matching '*.txt' 07:50:33 INFO - no previously-included directories found matching 'build' 07:50:33 INFO - no previously-included directories found matching 'dist' 07:50:33 INFO - no previously-included directories found matching '.git*' 07:50:33 INFO - Installing collected packages: jsonschema, functools32 07:50:33 INFO - Running setup.py install for functools32 07:50:33 INFO - warning: no files found matching '*.txt' 07:50:33 INFO - no previously-included directories found matching 'build' 07:50:33 INFO - no previously-included directories found matching 'dist' 07:50:33 INFO - no previously-included directories found matching '.git*' 07:50:33 INFO - Successfully installed jsonschema functools32 07:50:33 INFO - Cleaning up... 07:50:34 INFO - Return code: 0 07:50:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:50: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:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:34 INFO - Using env: {'DISPLAY': ':0', 07:50:34 INFO - 'HOME': '/home/cltbld', 07:50:34 INFO - 'LANG': 'en_US.UTF-8', 07:50:34 INFO - 'LANGUAGE': 'en_US:en', 07:50:34 INFO - 'LOGNAME': 'cltbld', 07:50:34 INFO - 'MAIL': '/var/mail/cltbld', 07:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:34 INFO - 'MOZ_NO_REMOTE': '1', 07:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:34 INFO - 'NO_EM_RESTART': '1', 07:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:34 INFO - 'PWD': '/builds/slave/test', 07:50:34 INFO - 'SHELL': '/bin/bash', 07:50:34 INFO - 'SHLVL': '1', 07:50:34 INFO - 'TERM': 'linux', 07:50:34 INFO - 'TMOUT': '86400', 07:50:34 INFO - 'USER': 'cltbld', 07:50:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:34 INFO - '_': '/tools/buildbot/bin/python'} 07:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:50:34 INFO - Cleaning up... 07:50:34 INFO - Return code: 0 07:50:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:50: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:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:34 INFO - Using env: {'DISPLAY': ':0', 07:50:34 INFO - 'HOME': '/home/cltbld', 07:50:34 INFO - 'LANG': 'en_US.UTF-8', 07:50:34 INFO - 'LANGUAGE': 'en_US:en', 07:50:34 INFO - 'LOGNAME': 'cltbld', 07:50:34 INFO - 'MAIL': '/var/mail/cltbld', 07:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:34 INFO - 'MOZ_NO_REMOTE': '1', 07:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:34 INFO - 'NO_EM_RESTART': '1', 07:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:34 INFO - 'PWD': '/builds/slave/test', 07:50:34 INFO - 'SHELL': '/bin/bash', 07:50:34 INFO - 'SHLVL': '1', 07:50:34 INFO - 'TERM': 'linux', 07:50:34 INFO - 'TMOUT': '86400', 07:50:34 INFO - 'USER': 'cltbld', 07:50:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:34 INFO - '_': '/tools/buildbot/bin/python'} 07:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:50: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:50: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:50: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:50: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:50: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:50: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:50:36 INFO - Downloading blobuploader-1.2.4.tar.gz 07:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:50:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:50:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:37 INFO - Downloading docopt-0.6.1.tar.gz 07:50:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:50:37 INFO - Installing collected packages: blobuploader, requests, docopt 07:50:37 INFO - Running setup.py install for blobuploader 07:50:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:50:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:50:37 INFO - Running setup.py install for requests 07:50:37 INFO - Running setup.py install for docopt 07:50:37 INFO - Successfully installed blobuploader requests docopt 07:50:37 INFO - Cleaning up... 07:50:37 INFO - Return code: 0 07:50:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:50:37 INFO - Using env: {'DISPLAY': ':0', 07:50:37 INFO - 'HOME': '/home/cltbld', 07:50:37 INFO - 'LANG': 'en_US.UTF-8', 07:50:37 INFO - 'LANGUAGE': 'en_US:en', 07:50:37 INFO - 'LOGNAME': 'cltbld', 07:50:37 INFO - 'MAIL': '/var/mail/cltbld', 07:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:37 INFO - 'MOZ_NO_REMOTE': '1', 07:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:37 INFO - 'NO_EM_RESTART': '1', 07:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:37 INFO - 'PWD': '/builds/slave/test', 07:50:37 INFO - 'SHELL': '/bin/bash', 07:50:37 INFO - 'SHLVL': '1', 07:50:37 INFO - 'TERM': 'linux', 07:50:37 INFO - 'TMOUT': '86400', 07:50:37 INFO - 'USER': 'cltbld', 07:50:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:37 INFO - '_': '/tools/buildbot/bin/python'} 07:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:37 INFO - Running setup.py (path:/tmp/pip-4uZE2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:38 INFO - Running setup.py (path:/tmp/pip-0KUMkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:38 INFO - Running setup.py (path:/tmp/pip-mUEfXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:38 INFO - Running setup.py (path:/tmp/pip-iWTKqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:38 INFO - Running setup.py (path:/tmp/pip-7yt4w5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:38 INFO - Running setup.py (path:/tmp/pip-r5fQpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:38 INFO - Running setup.py (path:/tmp/pip-y2jtRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:38 INFO - Running setup.py (path:/tmp/pip-KZFy8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:38 INFO - Running setup.py (path:/tmp/pip-tZim8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:38 INFO - Running setup.py (path:/tmp/pip-Z_MjrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:38 INFO - Running setup.py (path:/tmp/pip-quIHSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:38 INFO - Running setup.py (path:/tmp/pip-pHXwbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:38 INFO - Running setup.py (path:/tmp/pip-ois69H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:38 INFO - Running setup.py (path:/tmp/pip-RMjwLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:39 INFO - Running setup.py (path:/tmp/pip-mW1JbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:39 INFO - Running setup.py (path:/tmp/pip-_CW5gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:39 INFO - Running setup.py (path:/tmp/pip-pWGi6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:50:39 INFO - Running setup.py install for manifestparser 07:50:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:50:39 INFO - Running setup.py install for mozcrash 07:50:39 INFO - Running setup.py install for mozdebug 07:50:39 INFO - Running setup.py install for mozdevice 07:50:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:50:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:50:39 INFO - Running setup.py install for mozfile 07:50:39 INFO - Running setup.py install for mozhttpd 07:50:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:50:39 INFO - Running setup.py install for mozinfo 07:50:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:50:39 INFO - Running setup.py install for mozInstall 07:50:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Running setup.py install for mozleak 07:50:40 INFO - Running setup.py install for mozlog 07:50:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Running setup.py install for moznetwork 07:50:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Running setup.py install for mozprocess 07:50:40 INFO - Running setup.py install for mozprofile 07:50:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Running setup.py install for mozrunner 07:50:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:50:40 INFO - Running setup.py install for mozscreenshot 07:50:40 INFO - Running setup.py install for moztest 07:50:40 INFO - Running setup.py install for mozversion 07:50:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:50:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:50:41 INFO - Cleaning up... 07:50:41 INFO - Return code: 0 07:50:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50: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:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:41 INFO - Using env: {'DISPLAY': ':0', 07:50:41 INFO - 'HOME': '/home/cltbld', 07:50:41 INFO - 'LANG': 'en_US.UTF-8', 07:50:41 INFO - 'LANGUAGE': 'en_US:en', 07:50:41 INFO - 'LOGNAME': 'cltbld', 07:50:41 INFO - 'MAIL': '/var/mail/cltbld', 07:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:41 INFO - 'MOZ_NO_REMOTE': '1', 07:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:41 INFO - 'NO_EM_RESTART': '1', 07:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:41 INFO - 'PWD': '/builds/slave/test', 07:50:41 INFO - 'SHELL': '/bin/bash', 07:50:41 INFO - 'SHLVL': '1', 07:50:41 INFO - 'TERM': 'linux', 07:50:41 INFO - 'TMOUT': '86400', 07:50:41 INFO - 'USER': 'cltbld', 07:50:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:41 INFO - '_': '/tools/buildbot/bin/python'} 07:50:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:50:41 INFO - Running setup.py (path:/tmp/pip-pO0eNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:50: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:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:50:41 INFO - Running setup.py (path:/tmp/pip-Olf9hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:50:41 INFO - Running setup.py (path:/tmp/pip-Yrqu7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:50:41 INFO - Running setup.py (path:/tmp/pip-uz033q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:50:41 INFO - Running setup.py (path:/tmp/pip-8lZne4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:50:41 INFO - Running setup.py (path:/tmp/pip-g6VbVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:50:41 INFO - Running setup.py (path:/tmp/pip-msVhOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:50:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:50:41 INFO - Running setup.py (path:/tmp/pip-ZXGvLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:50:41 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:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:50:41 INFO - Running setup.py (path:/tmp/pip-_pQ630-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:50:41 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:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:50:41 INFO - Running setup.py (path:/tmp/pip-seEnCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:50:41 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:50:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:50:41 INFO - Running setup.py (path:/tmp/pip-dR1FQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:50: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:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:50:42 INFO - Running setup.py (path:/tmp/pip-FYH_t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:50: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:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:50:42 INFO - Running setup.py (path:/tmp/pip-Pq1ru2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:50: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:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:50:42 INFO - Running setup.py (path:/tmp/pip-uBMOr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:50:42 INFO - Running setup.py (path:/tmp/pip-tKCptg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:50: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:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:50:42 INFO - Running setup.py (path:/tmp/pip-zSLT2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:50:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:50:42 INFO - Running setup.py (path:/tmp/pip-tPgP5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:50:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:50:44 INFO - Downloading blessings-1.6.tar.gz 07:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:50:44 INFO - Installing collected packages: blessings 07:50:44 INFO - Running setup.py install for blessings 07:50:44 INFO - Successfully installed blessings 07:50:44 INFO - Cleaning up... 07:50:44 INFO - Return code: 0 07:50:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:50:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:44 INFO - Reading from file tmpfile_stdout 07:50:44 INFO - Current package versions: 07:50:44 INFO - argparse == 1.2.1 07:50:44 INFO - blessings == 1.6 07:50:44 INFO - blobuploader == 1.2.4 07:50:44 INFO - docopt == 0.6.1 07:50:44 INFO - functools32 == 3.2.3-2 07:50:44 INFO - jsonschema == 2.5.1 07:50:44 INFO - manifestparser == 1.1 07:50:44 INFO - mozInstall == 1.12 07:50:44 INFO - mozcrash == 0.17 07:50:44 INFO - mozdebug == 0.1 07:50:44 INFO - mozdevice == 0.48 07:50:44 INFO - mozfile == 1.2 07:50:44 INFO - mozhttpd == 0.7 07:50:44 INFO - mozinfo == 0.9 07:50:44 INFO - mozleak == 0.1 07:50:44 INFO - mozlog == 3.4 07:50:44 INFO - moznetwork == 0.27 07:50:44 INFO - mozprocess == 0.23 07:50:44 INFO - mozprofile == 0.28 07:50:44 INFO - mozrunner == 6.12 07:50:44 INFO - mozscreenshot == 0.1 07:50:44 INFO - mozsystemmonitor == 0.3 07:50:44 INFO - moztest == 0.7 07:50:44 INFO - mozversion == 1.4 07:50:44 INFO - psutil == 3.1.1 07:50:44 INFO - requests == 1.2.3 07:50:44 INFO - wsgiref == 0.1.2 07:50:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50:44 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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50:44 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:50:44 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:50:44 INFO - Using env: {'DISPLAY': ':0', 07:50:44 INFO - 'HOME': '/home/cltbld', 07:50:44 INFO - 'LANG': 'en_US.UTF-8', 07:50:44 INFO - 'LANGUAGE': 'en_US:en', 07:50:44 INFO - 'LOGNAME': 'cltbld', 07:50:44 INFO - 'MAIL': '/var/mail/cltbld', 07:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:44 INFO - 'MOZ_NO_REMOTE': '1', 07:50:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:44 INFO - 'NO_EM_RESTART': '1', 07:50:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:44 INFO - 'PWD': '/builds/slave/test', 07:50:44 INFO - 'SHELL': '/bin/bash', 07:50:44 INFO - 'SHLVL': '1', 07:50:44 INFO - 'TERM': 'linux', 07:50:44 INFO - 'TMOUT': '86400', 07:50:44 INFO - 'USER': 'cltbld', 07:50:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:44 INFO - '_': '/tools/buildbot/bin/python'} 07:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50: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:50: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:50: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:50: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:50: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:50: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:50: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:50: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:50: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:50: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:50: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:50:45 INFO - Cleaning up... 07:50:45 INFO - Return code: 0 07:50:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:50: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:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:50: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 0x7f7b031ebf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd558a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe22ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, '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': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', '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:50: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:50: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:50:45 INFO - Using env: {'DISPLAY': ':0', 07:50:45 INFO - 'HOME': '/home/cltbld', 07:50:45 INFO - 'LANG': 'en_US.UTF-8', 07:50:45 INFO - 'LANGUAGE': 'en_US:en', 07:50:45 INFO - 'LOGNAME': 'cltbld', 07:50:45 INFO - 'MAIL': '/var/mail/cltbld', 07:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:50:45 INFO - 'MOZ_NO_REMOTE': '1', 07:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:50:45 INFO - 'NO_EM_RESTART': '1', 07:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:50:45 INFO - 'PWD': '/builds/slave/test', 07:50:45 INFO - 'SHELL': '/bin/bash', 07:50:45 INFO - 'SHLVL': '1', 07:50:45 INFO - 'TERM': 'linux', 07:50:45 INFO - 'TMOUT': '86400', 07:50:45 INFO - 'USER': 'cltbld', 07:50:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:50:45 INFO - '_': '/tools/buildbot/bin/python'} 07:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:50:45 INFO - Cleaning up... 07:50:45 INFO - Return code: 0 07:50:45 INFO - Running post-action listener: _resource_record_post_action 07:50:45 INFO - Running post-action listener: _start_resource_monitoring 07:50:45 INFO - Starting resource monitoring. 07:50:45 INFO - [mozharness: 2016-10-05 14:50:45.329165Z] Finished create-virtualenv step (success) 07:50:45 INFO - [mozharness: 2016-10-05 14:50:45.329653Z] Running install step. 07:50:45 INFO - Running pre-action listener: _resource_record_pre_action 07:50:45 INFO - Running main action method: install 07:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:50:45 INFO - Reading from file tmpfile_stdout 07:50:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:50:45 INFO - Reading from file tmpfile_stdout 07:50:45 INFO - Output received: 07:50:45 INFO - Usage: mozinstall [options] installer 07:50:45 INFO - Options: 07:50:45 INFO - -h, --help show this help message and exit 07:50:45 INFO - -d DEST, --destination=DEST 07:50:45 INFO - Directory to install application into. [default: 07:50:45 INFO - "/builds/slave/test"] 07:50:45 INFO - --app=APP Application being installed. [default: firefox] 07:50:45 INFO - mkdir: /builds/slave/test/build/application 07:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:51:01 INFO - Reading from file tmpfile_stdout 07:51:01 INFO - Output received: 07:51:01 INFO - /builds/slave/test/build/application/firefox/firefox 07:51:01 INFO - Running post-action listener: _resource_record_post_action 07:51:01 INFO - [mozharness: 2016-10-05 14:51:01.746755Z] Finished install step (success) 07:51:01 INFO - [mozharness: 2016-10-05 14:51:01.746999Z] Running run-tests step. 07:51:01 INFO - Running pre-action listener: _resource_record_pre_action 07:51:01 INFO - Running main action method: run_tests 07:51:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:51:01 INFO - Python 2.7.3 07:51:01 INFO - Return code: 0 07:51:01 INFO - grabbing minidump binary from tooltool 07:51:01 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:51:01 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 0xe1ff60>, '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 0xe20d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe211d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:51:01 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:51:01 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:51:01 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:51:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:51:01 INFO - Return code: 0 07:51:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:51:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:51:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:51:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:51:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:51:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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:51:01 INFO - Using env: {'DISPLAY': ':0', 07:51:01 INFO - 'HOME': '/home/cltbld', 07:51:01 INFO - 'LANG': 'en_US.UTF-8', 07:51:01 INFO - 'LANGUAGE': 'en_US:en', 07:51:01 INFO - 'LOGNAME': 'cltbld', 07:51:01 INFO - 'MAIL': '/var/mail/cltbld', 07:51:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:51:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:51:01 INFO - 'MOZ_NO_REMOTE': '1', 07:51:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:51:01 INFO - 'NO_EM_RESTART': '1', 07:51:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:51:01 INFO - 'PWD': '/builds/slave/test', 07:51:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:51:01 INFO - 'SHELL': '/bin/bash', 07:51:01 INFO - 'SHLVL': '1', 07:51:01 INFO - 'TERM': 'linux', 07:51:01 INFO - 'TMOUT': '86400', 07:51:01 INFO - 'USER': 'cltbld', 07:51:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615', 07:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:51:01 INFO - '_': '/tools/buildbot/bin/python'} 07:51:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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:51:02 INFO - mozversion application_buildid: 20161005062400 07:51:02 INFO - mozversion application_changeset: bbfb1c7bcc50f7b335d34c65fc54fb3af9584596 07:51:02 INFO - mozversion application_display_name: Nightly 07:51:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:51:02 INFO - mozversion application_name: Firefox 07:51:02 INFO - mozversion application_remotingname: firefox 07:51:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:51:02 INFO - mozversion application_vendor: Mozilla 07:51:02 INFO - mozversion application_version: 52.0a1 07:51:02 INFO - mozversion platform_buildid: 20161005062400 07:51:02 INFO - mozversion platform_changeset: bbfb1c7bcc50f7b335d34c65fc54fb3af9584596 07:51:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:51:02 INFO - mozversion platform_version: 52.0a1 07:51:02 INFO - using testdate: 1475679062 07:51:02 INFO - actual date: 1475679062 07:51:02 INFO - starting webserver on 'localhost:56636' 07:51:02 INFO - SUITE-START | Running 2 tests 07:51:02 INFO - TEST-START | dromaeo_css 07:51:02 INFO - operating with platform_type : linux_ 07:51:02 INFO - Initialising browser for dromaeo_css test... 07:51:02 INFO - TEST-INFO | started process 5060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGntOx/profile http://localhost:56636/getInfo.html) 07:51:07 INFO - PROCESS | 5060 | __metrics Screen width/height:1600/1200 07:51:07 INFO - PROCESS | 5060 | colorDepth:24 07:51:07 INFO - PROCESS | 5060 | Browser inner width/height: 1024/697 07:51:07 INFO - PROCESS | 5060 | __metrics 07:51:08 INFO - PROCESS | 5060 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:51:08 INFO - PROCESS | 5060 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:51:10 INFO - PROCESS | 5060 | console.error: PushService: 07:51:10 INFO - PROCESS | 5060 | stateChangeProcessEnqueue: Error transitioning state 07:51:10 INFO - PROCESS | 5060 | UnknownError 07:51:10 INFO - TEST-INFO | 5060: exit 0 07:51:10 INFO - Browser initialized. 07:51:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:51:10 INFO - TEST-INFO | started process 5146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZGntOx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:51:23 INFO - PROCESS | 5146 | RSS: Main: 179703808 07:51:23 INFO - PROCESS | 5146 | 07:52:14 INFO - PROCESS | 5146 | 1475679134027 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:54:28 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:56636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56636/tests/dromaeo/cssquery-ext.html) 07:54:29 INFO - PROCESS | 5146 | RSS: Main: 285208576 07:54:29 INFO - PROCESS | 5146 | 07:57:32 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:56636/tests/dromaeo/cssquery-ext.html (next: http://localhost:56636/tests/dromaeo/cssquery-jquery.html) 07:57:32 INFO - PROCESS | 5146 | RSS: Main: 275386368 07:57:32 INFO - PROCESS | 5146 | 08:00:35 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:56636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56636/tests/dromaeo/cssquery-mootools.html) 08:00:35 INFO - PROCESS | 5146 | RSS: Main: 219697152 08:00:35 INFO - PROCESS | 5146 | 08:03:38 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:56636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56636/tests/dromaeo/cssquery-prototype.html) 08:03:38 INFO - PROCESS | 5146 | RSS: Main: 221110272 08:03:38 INFO - PROCESS | 5146 | 08:06:41 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:56636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56636/tests/dromaeo/cssquery-yui.html) 08:06:42 INFO - PROCESS | 5146 | RSS: Main: 221081600 08:06:42 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | Cycle 1(1): loaded http://localhost:56636/tests/dromaeo/cssquery-yui.html (next: http://localhost:56636/tests/dromaeo/cssquery-dojo.html) 08:09:45 INFO - PROCESS | 5146 | RSS: Main: 311816192 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | __start_tp_report 08:09:45 INFO - PROCESS | 5146 | _x_x_mozilla_page_load 08:09:45 INFO - PROCESS | 5146 | _x_x_mozilla_page_load_details 08:09:45 INFO - PROCESS | 5146 | |i|pagename|runs| 08:09:45 INFO - PROCESS | 5146 | |0;dojo.html;2572.588385858263;2592.7148013718474;2630.0531808548917;2631.355317947102;2634.1702363755417;4616.469106052805;4689;4703.082898834728;4720.362751028611;4744;4658.953410465894;4699.412573428322;4720.433547974239;4721.197396442604;4743.193657078296;4285.250081235787;4309.612134907858;4329.54539773324;4343.087951530182;4380.737155770648;4362.956370436286;4398.626116780078;4403.955960440387;4405.493368262659;4445.177642136199;4359.760213188273;4396.186705459484;4408.426904502427;4414.381986521889;4451.132029254297;4255.234057869582;4291.849785257532;4302.354646802974;4320;4324.113556720865;4252.510961239466;4270.871873843789;4276.828926842923;4351.651867850596;4370.650347972155;4680.9297860532115;4686.390769199982;4691.695039822401;4718.41019872516;4776.904461910777;4886.560209581119;4948.480409556981;4958.305837182797;5044.319016932704;5059.06407314648;5022.924656130161;5045.41977672565;5049.64652474327;5050.595952323842;5099.107656160194;4696.459907110726;4719.7404142772475;4719.7404142772475;4721.858344249678;4722.929156062662;5011.273365362002;5065.366829146356;5107.361579802525;5193.688378697215;5232.816851410258;4920.6555541111775;4958.429780575208;4964.255361695702;4993.226049962262;5009.198528235464;5031.572316353077;5031.84904452867;5034.521720436553;5041.092603331435;5098.898022039612;4834.129856625771;4891.877703057381;5005;5008.348914641147;5061.848144555669;4911.066897289504;4917.975410122926;4924.704517728947;4934.481879402683;4950.554450099508;4342.5874541918465;4346.65226781863;4350.1734670412525;4354.912901741947;4355.455568053993;3744.7753134811455;3764.3976963685677;3767.0770661188185;3804.619538046173;3807.6002019787525;4280.871573852789;4319.892002699895;4322.373255877943;4326.0050188456835;4378.846740364072;4908.288298196813;4947.901041979212;4948.059868625021;4973.1297023020825;5037.596992240612;4231.428757117811;4231.830726770956;4246.957530424718;4280.6789490788315;4289;4467.7319360838455;4469.173202957463;4471.8434854779925;4478.7088839226;4521.321801729767;4610.031893302444;4640.396748422683;4656.8602941911795;4660.953390466052;4696.92954605688;5008.373953255843;5025.74871256443;5027.120253955616;5068.82259120929;5080.898382032265;4687.5781179693995;4696.8590942271785;4697.741624210565;4722.787474563722;4755.7859896305445;4795.760211989456;4856.150173719656;4943.752812359439;4946.727929963887;5016.272640467185;4999.300097986212;5011.323471331323;5035.269885866602;5043.2687260347775;5117.744112794271;4887.169181239126;4887.291342755351;4893.951060489349;4896.730679812645;4964.652474326763;4732.905341893074;4871.707697538159;4902.093112774148;4916.508349165055;4976.427710813158;4688.2030054890065;4852;4891.559759621508;4895.632827537877;4957.6281778866005;5004.049230646166;5008.974955125201;5014.197728363444;5015.623828212972;5033.5721463676;4684.484706682194;4727.361806156263;4728.267118596623;4758.428988521399;4853.563179313879 08:09:45 INFO - PROCESS | 5146 | |1;ext.html;561.3179986316626;567.6764244380702;575.6431012772082;580.7996241296753;584.5469760935277;28116;37906.43140352897;39050.60949390509;39055;44191.55808441914;41036.896310369026;41393.172136557325;41419.17161656765;41465.585344146624;41501.7924910375;7668.348190403823;7820.335271501929;7825.256600622932;7825.569593672346;7827.7260295889655;7663.770086897402;7697.769066928001;7700.075990881074;7777.766666999999;7785.182555831641;7685.730999415022;7779.533228006309;7780.844383112334;7790.143084260755;7790.9610451947665;7705.653245603961;7729.806754831118;7730.458867879251;7750.34122099625;7773.844523109507;7647;7680.039995000625;7688.730894418669;7691.1924247954275;7692.923070769277;36880.26239475222;37242.4413633793;37462.62537374619;37493.81253093717;37508.24983500342;2899.7390234878962;2915.373194763115;2946.89685860996;2950.498415269388;3009.4733421651345;28438.28904277389;28707;29115.41769164605;29291.707082929322;30769.230769230948;3437.303621836757;3550.3076900004507;3599.7660152090293;3645.489631451599;3654.634536546351;183427;184618;184912;187273;187553;52568.737156313975;53050;53067.20399194015;53077.7346113267;53121;32547.18632034218;33639.49540756891;33668.83165584156;35581.82209088938;56307.71846140825;13363;13454.125481843648;13455.32723363828;13459.990500712485;13467.12463689857;10133.391996480088;10178.592856285666;10181.643642472478;10185.287029907984;10187.643432479976;15539.922300388653;15754.684906301809;15759.212039398213;15781.447649332218;15785.447509337118;6689.514598029667;6725.529212955046;6761.22245941723;6763.222229443579;7135.108111486064;758.6965213914478;772.6214155064091;851.3827475080517;935.4621092871625;954.0602506531061;26265.73734262671;27872;28114.2971425716;28215.71784282131;28231.71768282332;753.4386881773114;909.7498187998353;927.0405130689704;934.8223837470858;974.9707508774748;14308.713825723427;14805.629859253604;14878.404863805326;15041.247937603077;15148.242587870562;383570;385622;385728;385943;386638;48676.26985595219;49068.50931490711;49192.75403622959;49459;49508.75245623749;1054.0882136951482;1109.1514991031868;1116.0290547223967;1167.8131498960126;1196.3420118934725;27499.45001099927;31352.843235783675;31661.963389356995;31761.682383175874;32233.51649725209;47507.52492475031;48306;48434.515654843;48450.5154948446;48490;347892;353173;353661;353710;354563;23792.88103559471;24047.398815029763;24422.633660495463;25379.238622841345;25483.362915926507;40334.79832600818;40716.59283407128;40887.591124089566;41306;41943.161136776485;33722.83138584292;34148.82925585356;34522.65477345194;34640;34934.12664683403;34933.82533087318;35078.29843403168;35255;35491.82254088713;35777.64222357743;34332;34634.307313853074;34902.30195396027;35005;35705.64294357023;29363.412731745673;32024.51963220507;32100.518492222167;32208.83895580507;32233.51649725303;24228.757712422652;24476;24557.87721061383;24743;25093.247202583952 08:09:45 INFO - PROCESS | 5146 | |2;jquery.html;328.810933713115;350.2661923270747;350.7877733970947;353.03541231965016;365.331443458471;12460.56388026418;15410.22948852557;16030.75953860693;16230.188490575469;17029.744553831704;16833.579160520992;17306.82693173068;17354.47936561902;17417.564560885985;17487.300507979664;4276.850310239142;4895.38807649043;5045.192769156935;5100.260462232974;5104.259882317062;3694.722895782827;3869.8839034829;4920.926186107211;5049.974750126263;5645.350784659776;5894.351621321651;5995.100734889779;6001.639901605896;6010.36891126432;6018.939810601882;5708.486236238738;5851.912221316684;5892.734826932756;5894.145348924425;6007.609505382136;5136.537711605936;5141.048905952411;5143.228515722634;5144.922826157611;5146.614003949681;19667.704984425243;20477.07853146612;20524.589508209752;20627.89686051575;20780;1989.990050049755;2028.3205126282712;2046.785087565814;2129.5208578069964;2512.9371765706005;12593.811092833523;13236.073474856765;13459.528916487974;13780.448782048707;13839.584812455643;1697.7623132761423;1744.8865823721417;1756.9912150439293;1780.528160037591;1788.8926664400049;55756.16365754517;67111.328886711;67226.66386668035;67595.66202169006;67837.3216267836;8776;8867.64529418816;9021.097890211058;9850.21198304134;10088.445135517617;13865.306734663227;13876.306184690726;13878.722425551432;13888.930555347159;13897.79153312701;6697.799066027929;6983.95240713897;7109.537880037781;7138.714451421885;7138.964305178441;6429.067785171124;6510.544261901621;6533.477321814244;6646.069550262967;6666.266710661824;4232.830686772556;4285.7000009999;4301.827926882889;4341.196878577473;4435.578620031092;1608.4852847088819;1715.8627309815433;1796.8921864688161;1797.8022417534062;1805.404216608516;715.9534630249017;806.3871457692079;815.2621877201143;837.0666706622194;865.5758678247613;16654.916725416297;16688.499345019667;16889;16923.830761692472;17692.91153544224;840.1640367834044;840.6931470013401;841.3605659698551;843.472829481574;884.3822286033285;9224.584893679801;9956.80086398268;9958.701238962698;9980.500974951223;10003.44981026036;163409;165475.1726241385;165542;353201;367263;78262.6086869562;79368.603156985;80475.59762201269;80916;80982.5950870242;875.7635438431588;877.1929824561435;912.4707669551644;938.6620816506053;951.3673407184283;15491.690166196839;16025.839741602902;16555;16560.420385286456;16706.832931670528;36693.44959825658;36948.815255923546;37208.81395593005;37918.43122353222;38354;50027;51108;53516.73241633767;53544;54897.725511372184;7576.924230757842;7586.203448637813;7648.388128949782;7716.614169291625;7773.961130194313;8713.869291960498;10993.560257589927;11106.833397498882;11704.180707350404;12195.573154939535;9790.608375664893;10307.536160872629;10308;10620.787584248117;10809.243352965217;9643.228541716786;9844.950775246078;9876.160526355341;9876.35803672759;9940.254480913816;10439.743379499194;10572.471376431302;10609.257351985287;10670.679879603624;11053.944730276296;7469.663865125974;7524.699012039458;7582.469227154267;7660.387169026576;7707.961460192663;10201.183905287708;10449.268551201343;10609.89390106089;10897.346159230472;10994.505247264053 08:09:45 INFO - PROCESS | 5146 | |3;mootools.html;1273.7707212701716;1308.7186254955188;1334.9720715049411;1640.5652502086941;1647.1846436014182;7031.71873125075;7591.202923693016;7596.810079748009;7609.315161635452;7614.58119803412;6474.093626892239;6755.797326080213;7098.467614928875;7383.187849336568;7389.741359052434;2057.238821635997;2086.384516567616;2092.550101728128;2093.86389884657;2096.2139197800825;2066.7003284523735;2097.349821555315;2116.1323857218545;2118.819900308468;2119.4065661614773;1776.7423723560075;1833.2025568877514;2022.2214447437768;2080.44868109951;2083.291680828518;2008.2268326694182;2022.4236092713654;2023.8886861222627;2024.8987550622483;2026.8277196438173;2014.597080583889;2056.691496275556;2058.475088852348;2061.865978711379;2066.442060643633;7434.219406962299;7468.178500364956;7489.176190619028;7503.887441688379;7524.887126693104;4271.402003719481;4470;4473;4475.686701930867;4478.081993191388;2628.7896968242494;2669.506141363854;2797.5244208484405;2800.341919648881;2809.761170300527;832.7728765280735;874.7506960516222;879.7756572074144;893.6425429828121;898.380117718772;10192.898071019268;10200;10203.92858749828;10220.642277520325;10227.590896364061;3583.7312201584987;3802.6043592537076;3965.861194858166;3981.9203615927518;3992.880213593539;7562.924370756332;7789.532628042336;8149.103598604149;8688.348373871984;8692.913070869337;4100.835966561363;4241.766702831313;4241.851535196253;4243.639290660267;4243.936340954888;3861.7876016819346;3864.845406183721;3870.3807390817897;3879.2435475082652;3879.3792993120965;3141.4973604223214;3161.2096975756062;3256.397566450214;3291.687289707474;3296.785708928912;1077.138289368502;1077.859878215827;1087.287826473661;1095.7370231144628;1118.0999295566985;780.8165081205912;795.9562224077615;802.6668932393109;816.6814942172557;827.0819390476566;4769.332293478916;4778.092162489185;4817.9036419271415;4933.186024305949;4997.475265097112;350.90350153707936;359.59365916514173;845.2603971524916;906.5829718329642;921.5392303848076;3344.4983252512316;3428.5200071989943;3451.6893479586956;3540.672247907035;3550.822458877046;8783.912160878437;9150.771230719285;9263.073692630684;9320.347575669639;9333.160015598492;9160.725178244664;9220.677276295297;9240.306976976754;9242.861357079515;9251.67619133327;6819.181698196248;6834.453243740489;6885.414739747178;6939.757108501179;6948.096747422803;4846.80612775485;4869.488703686062;4877.170880950318;4931.260310953242;4988.825391111293;8133.552654604054;8193.877091843746;8364.330853531825;8371.539565323723;8385.706500272461;8213.425060245965;8492.280870327497;8513.531755753493;8579.14208579137;8590.527520986405;5657.094864821609;5900.616459930091;6058.454739073504;6205.627662340274;6253.405926436982;6927.1687397510605;7255.56466612005;7258.419326453765;7405.037345145097;7420.146683131509;6446.355364463704;6481.222253329631;6483.967580162069;6582.045603387578;6683.498737594603;6520.9347906520325;6555.246146693001;6561.737530498917;6579.013148027834;6596.8350791230605;5829.59192856496;5909.91135132982;5913.2608423947;5921.881562368814;5922.230110085661;4310.827566897289;4351.564843515623;4428.225060614444;4430.667699922455;4482;4395;4493.460784705856;4511.187986162522;4513.796879140381;4514.864554063383 08:09:45 INFO - PROCESS | 5146 | |4;prototype.html;288.62767030530614;294.5037611624413;297.1412617535323;307.25797199762576;307.8983935301351;4850.029994001201;4889.119958407486;4891.804327826882;4896.779644915974;4917.2378281366355;4749.4063242094735;4776.164171270031;4803.7726800415585;4822.4936381679945;4834.2265237562;3826.387777955528;3832.9425058624142;3845.673242731253;3850.7304488685804;3857.286402015622;3689.2805902848954;3827.4258861170906;3841.34697101492;3857.517810273716;3869.729118961674;3742.925141497182;3753.6434038766274;3761.567419746737;3784.4512545680996;3795.335816232162;3748.7188460865273;3749.850005999757;3753.1930634913624;3763.024412183598;3771.3400154972906;3151.6218053833686;3255.300110476259;3255.332656805373;3364.2934983653463;3364.831758412094;4675.158471475133;4680.321353403738;4680.508546602626;4698.412698412699;4709.199436095838;4278.572142785728;4288.849890253858;4299.333603291495;4303.569643035703;4304.418903448026;4768.976155119237;4839.588634966032;4893.902121957541;4957.677750946177;5021.924671129936;3649.2519033598314;3649.908752281188;3653.3971894637352;3654.14127679995;3673.338799016176;5264.447233040514;5266;5268.1834315681135;5293.285406470077;5301.416844147141;3622.3117607654463;3698.112453011258;3727.7576957497677;3734.495843061152;3747.3254814133174;3800.5059342285326;3804.2581696568905;3806.8286927088348;3807.695384369244;3814.1608846053823;4271.167122411162;4273.1026484438;4309.224339618836;4317.093410383792;4327.394164816928;4772.546608072227;5014;5033.219850923113;5054.418741844662;5063.215201643751;1264.5826877130526;1285.4472576792068;1287.6909541710108;1293.495536740672;1296.6758310422395;779.8206412525151;805.8348038652063;808.6684459371747;812.9430939834155;814.5397850214729;3929.8821035368983;3941.8423263069158;3948.1314110895555;3970.8411663533134;3987.5308481620596;4543.613792827647;4562.88592785183;4577.771111444481;4582.541745825458;4584.4498660161;3951.6443520082757;3954.5649978502342;3966.722329436912;3974.125692347679;3974.741641793274;2361.669366288721;2440.0117952229375;2443.9491018861704;2454.7667971542674;2463.963040554393;4655.837045703384;4727.180035686286;4802.543758342952;4891.584215341664;4900.828471003498;5321.148616221386;5351.331083614548;5353.2237825515085;5353.866153346197;5356.973215133899;4666.876571160046;4885.973945471491;4899.363082799213;4906.950930490721;4908.656394052454;5119.360079990001;5127.179651255781;5145.331106956071;5165.870853228549;5184.9740751296;5100.48995100487;5108.872278193075;5109.386873575195;5118.769655365443;5127.512886275797;4745.240761478147;4868.853934381974;4871.318015477765;4871.90256194867;4906.8959484115785;3619.1133172371883;3646.197836475971;3646.489491471143;3653.506776585233;3653.725970552166;5159.17453207485;5185.507376799198;5231.29377534028;5235.65968212065;5248.685078895279;4831.637627177905;5046.091703493406;5059.949400506095;5069;5100.362454693163;5011.874703132451;5022.146235139962;5029.949700502948;5034.892323688782;5035.697858128524;4905.411350637946;4906.239532872411;4931.630127740362;4939.641044090054;4953.2074868020945;4760.357351757607;4981.402231732215;5002.52476014778;5041;5082;4876.95123048765;4906.55840974314;4907.3620429343955;4918.532739389752;4919.3604831371695 08:09:45 INFO - PROCESS | 5146 | |5;yui.html;573.5784198614018;582.8368056944057;611.9663418511982;615.5977830562155;645.0324513230155;12977.610671679853;13327.200367977928;13917.582472525815;13947.372368243428;13962.790558141623;13310.800337994939;13314.267715275655;13355.265460399674;13384.933075334635;13413.061085723979;601.855554666879;737.6938570493252;753.2392283793381;754.0875540595886;754.7207533212692;614.7172300741641;734.4308161175105;754.7999780058288;757.0990521279687;759.7644730133676;799.312591171592;802.1016461563029;802.1697543042952;805.6817557064985;806.0850934189708;629.364342014564;797.8563858505466;797.9122296547404;798.0104670208957;798.3732769775698;475.18505762617275;562.651156283103;573.3091624592398;575.8963386590412;576.9105788602774;10360.481975901175;10367.896321036844;10369.63706270277;10396.428196449193;10483.318584292072;12168.81746773799;12660.366981650881;12726.936365318206;12767.808482872764;13550.525731599346;11166.888331116666;11407.714807129805;11502.252353596989;11582.884171158265;11605.825912611317;4008.2183974124764;4027.6375126238486;4041.9288888444585;4091.2226676931587;4109.445224894661;60787.13702903757;60890.999999999556;60903.69548152275;60952.63805153134;61050.389496104915;9465.621375145054;9729.270304727173;9762.17021553176;9945.751356216007;10265.435401052864;18842.3405180818;18963.715544266848;19035.143418545922;19036.33372831944;19039.904800476186;6282.371762823681;6319;6359.586626869239;6494.350564943468;6603.7358505660195;3401.234722187488;3476.7913925164066;3483.9129021774656;3500.0899766061007;3534.0811389039036;2686.073304709872;2773.3759904021836;2782.1653503948733;2788;2792.3019245188702;460.9677322587454;473.5785151215421;476.440182785226;478.7862767883468;480.96633235673164;436.9104333611602;467.8152129908667;469.6501106675549;490.9346717622767;523.9554637855749;7937.166597507294;8034.477758945767;8157.46976446541;8440;9642.276829237835;583.2825624481911;619.3125630550086;620.8230654263604;627.3099590450468;627.3914303125961;3743.344914639927;4116.403121547359;4172.958270417318;4256.553061928515;4280.785960702015;55493.16760248599;75296;81533.59233203797;81834;91991;46030.53969460262;47033.5296647036;47666.285005724945;49032;86876.56561717151;71448.64275678588;75092.24907750962;76406;78812;79329;8590.226879580869;9139.725808225498;9373.921998970205;9400.435973841591;9417.199538039069;44862.3270650947;45404.545954541354;45853;46379;46894;60681;60819;64432;66673.33326666671;67267.32732672806;11313.71715707114;11402.429878505876;11482;11580.247283926517;11712.70718232051;12217.69455763613;12483.251004939733;12919.612411627666;13022;13157.934210328887;12014.279143251433;12429.813552796535;12540.811887821508;12717.364131793558;12848.486060557472;11853.170278080452;12622.242665440102;12727.554535591209;12744;13000.609981700563;11879.465424055765;12011;12294;12418.254904705747;12726;9868.506574671093;10650.623443870052;10776.515056822305;11290.717732056764;11332.206745527734;10630.149588033093;10652.786944261226;10733.463326833784;10760.192985526273;10762.139028877828 08:09:45 INFO - PROCESS | 5146 | __end_tp_report 08:09:45 INFO - PROCESS | 5146 | __start_cc_report 08:09:45 INFO - PROCESS | 5146 | _x_x_mozilla_cycle_collect,1091 08:09:45 INFO - PROCESS | 5146 | __end_cc_report 08:09:45 INFO - PROCESS | 5146 | __startTimestamp1475680185569__endTimestamp 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | ------- Summary: start ------- 08:09:45 INFO - PROCESS | 5146 | Number of tests: 6 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | [#0] dojo.html Cycles:165 Average:4641.43 Median:4722.93 stddev:479.54 (10.2%) stddev-sans-first:452.71 08:09:45 INFO - PROCESS | 5146 | Values: 2572.6 2592.7 2630.1 2631.4 2634.2 4616.5 4689.0 4703.1 4720.4 4744.0 4659.0 4699.4 4720.4 4721.2 4743.2 4285.3 4309.6 4329.5 4343.1 4380.7 4363.0 4398.6 4404.0 4405.5 4445.2 4359.8 4396.2 4408.4 4414.4 4451.1 4255.2 4291.8 4302.4 4320.0 4324.1 4252.5 4270.9 4276.8 4351.7 4370.7 4680.9 4686.4 4691.7 4718.4 4776.9 4886.6 4948.5 4958.3 5044.3 5059.1 5022.9 5045.4 5049.6 5050.6 5099.1 4696.5 4719.7 4719.7 4721.9 4722.9 5011.3 5065.4 5107.4 5193.7 5232.8 4920.7 4958.4 4964.3 4993.2 5009.2 5031.6 5031.8 5034.5 5041.1 5098.9 4834.1 4891.9 5005.0 5008.3 5061.8 4911.1 4918.0 4924.7 4934.5 4950.6 4342.6 4346.7 4350.2 4354.9 4355.5 3744.8 3764.4 3767.1 3804.6 3807.6 4280.9 4319.9 4322.4 4326.0 4378.8 4908.3 4947.9 4948.1 4973.1 5037.6 4231.4 4231.8 4247.0 4280.7 4289.0 4467.7 4469.2 4471.8 4478.7 4521.3 4610.0 4640.4 4656.9 4661.0 4696.9 5008.4 5025.7 5027.1 5068.8 5080.9 4687.6 4696.9 4697.7 4722.8 4755.8 4795.8 4856.2 4943.8 4946.7 5016.3 4999.3 5011.3 5035.3 5043.3 5117.7 4887.2 4887.3 4894.0 4896.7 4964.7 4732.9 4871.7 4902.1 4916.5 4976.4 4688.2 4852.0 4891.6 4895.6 4957.6 5004.0 5009.0 5014.2 5015.6 5033.6 4684.5 4727.4 4728.3 4758.4 4853.6 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | [#1] ext.html Cycles:180 Average:45911.31 Median:35741.64 stddev:84629.05 (236.8%) stddev-sans-first:84797.96 08:09:45 INFO - PROCESS | 5146 | Values: 561.3 567.7 575.6 580.8 584.5 28116.0 37906.4 39050.6 39055.0 44191.6 41036.9 41393.2 41419.2 41465.6 41501.8 7668.3 7820.3 7825.3 7825.6 7827.7 7663.8 7697.8 7700.1 7777.8 7785.2 7685.7 7779.5 7780.8 7790.1 7791.0 7705.7 7729.8 7730.5 7750.3 7773.8 7647.0 7680.0 7688.7 7691.2 7692.9 36880.3 37242.4 37462.6 37493.8 37508.2 2899.7 2915.4 2946.9 2950.5 3009.5 28438.3 28707.0 29115.4 29291.7 30769.2 3437.3 3550.3 3599.8 3645.5 3654.6 183427.0 184618.0 184912.0 187273.0 187553.0 52568.7 53050.0 53067.2 53077.7 53121.0 32547.2 33639.5 33668.8 35581.8 56307.7 13363.0 13454.1 13455.3 13460.0 13467.1 10133.4 10178.6 10181.6 10185.3 10187.6 15539.9 15754.7 15759.2 15781.4 15785.4 6689.5 6725.5 6761.2 6763.2 7135.1 758.7 772.6 851.4 935.5 954.1 26265.7 27872.0 28114.3 28215.7 28231.7 753.4 909.7 927.0 934.8 975.0 14308.7 14805.6 14878.4 15041.2 15148.2 383570.0 385622.0 385728.0 385943.0 386638.0 48676.3 49068.5 49192.8 49459.0 49508.8 1054.1 1109.2 1116.0 1167.8 1196.3 27499.5 31352.8 31662.0 31761.7 32233.5 47507.5 48306.0 48434.5 48450.5 48490.0 347892.0 353173.0 353661.0 353710.0 354563.0 23792.9 24047.4 24422.6 25379.2 25483.4 40334.8 40716.6 40887.6 41306.0 41943.2 33722.8 34148.8 34522.7 34640.0 34934.1 34933.8 35078.3 35255.0 35491.8 35777.6 34332.0 34634.3 34902.3 35005.0 35705.6 29363.4 32024.5 32100.5 32208.8 32233.5 24228.8 24476.0 24557.9 24743.0 25093.2 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | [#2] jquery.html Cycles:180 Average:20321.25 Median:4321.51 stddev:44594.15 (1031.9%) stddev-sans-first:44693.99 08:09:45 INFO - PROCESS | 5146 | Values: 328.8 350.3 350.8 353.0 365.3 12460.6 15410.2 16030.8 16230.2 17029.7 16833.6 17306.8 17354.5 17417.6 17487.3 4276.9 4895.4 5045.2 5100.3 5104.3 3694.7 3869.9 4920.9 5050.0 5645.4 5894.4 5995.1 6001.6 6010.4 6018.9 5708.5 5851.9 5892.7 5894.1 6007.6 5136.5 5141.0 5143.2 5144.9 5146.6 19667.7 20477.1 20524.6 20627.9 20780.0 1990.0 2028.3 2046.8 2129.5 2512.9 12593.8 13236.1 13459.5 13780.4 13839.6 1697.8 1744.9 1757.0 1780.5 1788.9 55756.2 67111.3 67226.7 67595.7 67837.3 8776.0 8867.6 9021.1 9850.2 10088.4 13865.3 13876.3 13878.7 13888.9 13897.8 6697.8 6984.0 7109.5 7138.7 7139.0 6429.1 6510.5 6533.5 6646.1 6666.3 4232.8 4285.7 4301.8 4341.2 4435.6 1608.5 1715.9 1796.9 1797.8 1805.4 716.0 806.4 815.3 837.1 865.6 16654.9 16688.5 16889.0 16923.8 17692.9 840.2 840.7 841.4 843.5 884.4 9224.6 9956.8 9958.7 9980.5 10003.4 163409.0 165475.2 165542.0 353201.0 367263.0 78262.6 79368.6 80475.6 80916.0 80982.6 875.8 877.2 912.5 938.7 951.4 15491.7 16025.8 16555.0 16560.4 16706.8 36693.4 36948.8 37208.8 37918.4 38354.0 50027.0 51108.0 53516.7 53544.0 54897.7 7576.9 7586.2 7648.4 7716.6 7774.0 8713.9 10993.6 11106.8 11704.2 12195.6 9790.6 10307.5 10308.0 10620.8 10809.2 9643.2 9845.0 9876.2 9876.4 9940.3 10439.7 10572.5 10609.3 10670.7 11053.9 7469.7 7524.7 7582.5 7660.4 7708.0 10201.2 10449.3 10609.9 10897.3 10994.5 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | [#3] mootools.html Cycles:180 Average:4840.78 Median:4858.15 stddev:2728.93 (56.2%) stddev-sans-first:2723.42 08:09:45 INFO - PROCESS | 5146 | Values: 1273.8 1308.7 1335.0 1640.6 1647.2 7031.7 7591.2 7596.8 7609.3 7614.6 6474.1 6755.8 7098.5 7383.2 7389.7 2057.2 2086.4 2092.6 2093.9 2096.2 2066.7 2097.3 2116.1 2118.8 2119.4 1776.7 1833.2 2022.2 2080.4 2083.3 2008.2 2022.4 2023.9 2024.9 2026.8 2014.6 2056.7 2058.5 2061.9 2066.4 7434.2 7468.2 7489.2 7503.9 7524.9 4271.4 4470.0 4473.0 4475.7 4478.1 2628.8 2669.5 2797.5 2800.3 2809.8 832.8 874.8 879.8 893.6 898.4 10192.9 10200.0 10203.9 10220.6 10227.6 3583.7 3802.6 3965.9 3981.9 3992.9 7562.9 7789.5 8149.1 8688.3 8692.9 4100.8 4241.8 4241.9 4243.6 4243.9 3861.8 3864.8 3870.4 3879.2 3879.4 3141.5 3161.2 3256.4 3291.7 3296.8 1077.1 1077.9 1087.3 1095.7 1118.1 780.8 796.0 802.7 816.7 827.1 4769.3 4778.1 4817.9 4933.2 4997.5 350.9 359.6 845.3 906.6 921.5 3344.5 3428.5 3451.7 3540.7 3550.8 8783.9 9150.8 9263.1 9320.3 9333.2 9160.7 9220.7 9240.3 9242.9 9251.7 6819.2 6834.5 6885.4 6939.8 6948.1 4846.8 4869.5 4877.2 4931.3 4988.8 8133.6 8193.9 8364.3 8371.5 8385.7 8213.4 8492.3 8513.5 8579.1 8590.5 5657.1 5900.6 6058.5 6205.6 6253.4 6927.2 7255.6 7258.4 7405.0 7420.1 6446.4 6481.2 6484.0 6582.0 6683.5 6520.9 6555.2 6561.7 6579.0 6596.8 5829.6 5909.9 5913.3 5921.9 5922.2 4310.8 4351.6 4428.2 4430.7 4482.0 4395.0 4493.5 4511.2 4513.8 4514.9 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | [#4] prototype.html Cycles:180 Average:4136.03 Median:4703.81 stddev:1213.14 (25.8%) stddev-sans-first:1181.67 08:09:45 INFO - PROCESS | 5146 | Values: 288.6 294.5 297.1 307.3 307.9 4850.0 4889.1 4891.8 4896.8 4917.2 4749.4 4776.2 4803.8 4822.5 4834.2 3826.4 3832.9 3845.7 3850.7 3857.3 3689.3 3827.4 3841.3 3857.5 3869.7 3742.9 3753.6 3761.6 3784.5 3795.3 3748.7 3749.9 3753.2 3763.0 3771.3 3151.6 3255.3 3255.3 3364.3 3364.8 4675.2 4680.3 4680.5 4698.4 4709.2 4278.6 4288.8 4299.3 4303.6 4304.4 4769.0 4839.6 4893.9 4957.7 5021.9 3649.3 3649.9 3653.4 3654.1 3673.3 5264.4 5266.0 5268.2 5293.3 5301.4 3622.3 3698.1 3727.8 3734.5 3747.3 3800.5 3804.3 3806.8 3807.7 3814.2 4271.2 4273.1 4309.2 4317.1 4327.4 4772.5 5014.0 5033.2 5054.4 5063.2 1264.6 1285.4 1287.7 1293.5 1296.7 779.8 805.8 808.7 812.9 814.5 3929.9 3941.8 3948.1 3970.8 3987.5 4543.6 4562.9 4577.8 4582.5 4584.4 3951.6 3954.6 3966.7 3974.1 3974.7 2361.7 2440.0 2443.9 2454.8 2464.0 4655.8 4727.2 4802.5 4891.6 4900.8 5321.1 5351.3 5353.2 5353.9 5357.0 4666.9 4886.0 4899.4 4907.0 4908.7 5119.4 5127.2 5145.3 5165.9 5185.0 5100.5 5108.9 5109.4 5118.8 5127.5 4745.2 4868.9 4871.3 4871.9 4906.9 3619.1 3646.2 3646.5 3653.5 3653.7 5159.2 5185.5 5231.3 5235.7 5248.7 4831.6 5046.1 5059.9 5069.0 5100.4 5011.9 5022.1 5029.9 5034.9 5035.7 4905.4 4906.2 4931.6 4939.6 4953.2 4760.4 4981.4 5002.5 5041.0 5082.0 4877.0 4906.6 4907.4 4918.5 4919.4 08:09:45 INFO - PROCESS | 5146 | 08:09:45 INFO - PROCESS | 5146 | [#5] yui.html Cycles:180 Average:16590.91 Median:46204.77 stddev:22246.23 (48.1%) stddev-sans-first:22276.12 08:09:45 INFO - PROCESS | 5146 | Values: 573.6 582.8 612.0 615.6 645.0 12977.6 13327.2 13917.6 13947.4 13962.8 13310.8 13314.3 13355.3 13384.9 13413.1 601.9 737.7 753.2 754.1 754.7 614.7 734.4 754.8 757.1 759.8 799.3 802.1 802.2 805.7 806.1 629.4 797.9 797.9 798.0 798.4 475.2 562.7 573.3 575.9 576.9 10360.5 10367.9 10369.6 10396.4 10483.3 12168.8 12660.4 12726.9 12767.8 13550.5 11166.9 11407.7 11502.3 11582.9 11605.8 4008.2 4027.6 4041.9 4091.2 4109.4 60787.1 60891.0 60903.7 60952.6 61050.4 9465.6 9729.3 9762.2 9945.8 10265.4 18842.3 18963.7 19035.1 19036.3 19039.9 6282.4 6319.0 6359.6 6494.4 6603.7 3401.2 3476.8 3483.9 3500.1 3534.1 2686.1 2773.4 2782.2 2788.0 2792.3 461.0 473.6 476.4 478.8 481.0 436.9 467.8 469.7 490.9 524.0 7937.2 8034.5 8157.5 8440.0 9642.3 583.3 619.3 620.8 627.3 627.4 3743.3 4116.4 4173.0 4256.6 4280.8 55493.2 75296.0 81533.6 81834.0 91991.0 46030.5 47033.5 47666.3 49032.0 86876.6 71448.6 75092.2 76406.0 78812.0 79329.0 8590.2 9139.7 9373.9 9400.4 9417.2 44862.3 45404.5 45853.0 46379.0 46894.0 60681.0 60819.0 64432.0 66673.3 67267.3 11313.7 11402.4 11482.0 11580.2 11712.7 12217.7 12483.3 12919.6 13022.0 13157.9 12014.3 12429.8 12540.8 12717.4 12848.5 11853.2 12622.2 12727.6 12744.0 13000.6 11879.5 12011.0 12294.0 12418.3 12726.0 9868.5 10650.6 10776.5 11290.7 11332.2 10630.1 10652.8 10733.5 10760.2 10762.1 08:09:45 INFO - PROCESS | 5146 | -------- Summary: end -------- 08:09:45 INFO - PROCESS | 5146 | 08:09:46 INFO - TEST-INFO | 5146: exit 0 08:09:46 INFO - TEST-OK | dromaeo_css | took 1124541ms 08:09:46 INFO - TEST-START | kraken 08:09:46 INFO - operating with platform_type : linux_ 08:09:46 INFO - Initialising browser for kraken test... 08:09:46 INFO - TEST-INFO | started process 5456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1OsQHm/profile http://localhost:56636/getInfo.html) 08:09:51 INFO - PROCESS | 5456 | __metrics Screen width/height:1600/1200 08:09:51 INFO - PROCESS | 5456 | colorDepth:24 08:09:51 INFO - PROCESS | 5456 | Browser inner width/height: 1024/697 08:09:51 INFO - PROCESS | 5456 | __metrics 08:09:51 INFO - PROCESS | 5456 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:09:51 INFO - PROCESS | 5456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:52 INFO - PROCESS | 5456 | console.error: PushService: 08:09:52 INFO - PROCESS | 5456 | stateChangeProcessEnqueue: Error transitioning state 08:09:52 INFO - PROCESS | 5456 | UnknownError 08:09:52 INFO - TEST-INFO | 5456: exit 0 08:09:52 INFO - Browser initialized. 08:09:52 INFO - Running cycle 1/1 for kraken test... 08:09:52 INFO - TEST-INFO | started process 5538 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1OsQHm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:05 INFO - PROCESS | 5538 | RSS: Main: 174755840 08:10:05 INFO - PROCESS | 5538 | 08:10:07 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56636/tests/kraken/driver.html?testName=audio-beat-detection) 08:10:08 INFO - PROCESS | 5538 | RSS: Main: 233807872 08:10:08 INFO - PROCESS | 5538 | 08:10:11 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56636/tests/kraken/driver.html?testName=audio-dft) 08:10:12 INFO - PROCESS | 5538 | RSS: Main: 219529216 08:10:12 INFO - PROCESS | 5538 | 08:10:15 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56636/tests/kraken/driver.html?testName=audio-fft) 08:10:16 INFO - PROCESS | 5538 | RSS: Main: 301342720 08:10:16 INFO - PROCESS | 5538 | 08:10:18 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56636/tests/kraken/driver.html?testName=audio-oscillator) 08:10:18 INFO - PROCESS | 5538 | RSS: Main: 211865600 08:10:18 INFO - PROCESS | 5538 | 08:10:21 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:10:21 INFO - PROCESS | 5538 | RSS: Main: 214286336 08:10:21 INFO - PROCESS | 5538 | 08:10:24 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56636/tests/kraken/driver.html?testName=imaging-darkroom) 08:10:25 INFO - PROCESS | 5538 | RSS: Main: 249987072 08:10:25 INFO - PROCESS | 5538 | 08:10:29 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56636/tests/kraken/driver.html?testName=imaging-desaturate) 08:10:29 INFO - PROCESS | 5538 | RSS: Main: 244547584 08:10:29 INFO - PROCESS | 5538 | 08:10:32 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56636/tests/kraken/driver.html?testName=json-parse-financial) 08:10:33 INFO - PROCESS | 5538 | RSS: Main: 247312384 08:10:33 INFO - PROCESS | 5538 | 08:10:34 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:10:35 INFO - PROCESS | 5538 | RSS: Main: 210423808 08:10:35 INFO - PROCESS | 5538 | 08:10:37 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:10:38 INFO - PROCESS | 5538 | RSS: Main: 218963968 08:10:38 INFO - PROCESS | 5538 | 08:10:40 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:10:40 INFO - PROCESS | 5538 | RSS: Main: 227516416 08:10:40 INFO - PROCESS | 5538 | 08:10:43 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:10:44 INFO - PROCESS | 5538 | RSS: Main: 236146688 08:10:44 INFO - PROCESS | 5538 | 08:10:47 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:10:48 INFO - PROCESS | 5538 | RSS: Main: 233377792 08:10:48 INFO - PROCESS | 5538 | 08:10:49 INFO - PROCESS | 5538 | Cycle 1(1): loaded http://localhost:56636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56636/tests/kraken/driver.html?testName=ai-astar) 08:10:50 INFO - PROCESS | 5538 | RSS: Main: 282480640 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | __start_tp_report 08:10:50 INFO - PROCESS | 5538 | _x_x_mozilla_page_load 08:10:50 INFO - PROCESS | 5538 | _x_x_mozilla_page_load_details 08:10:50 INFO - PROCESS | 5538 | |i|pagename|runs| 08:10:50 INFO - PROCESS | 5538 | |0;ai-astar;114;116;116;115;117;117;113;116;114;114 08:10:50 INFO - PROCESS | 5538 | |1;audio-beat-detection;154;130;135;176;129;126;126;127;166;128 08:10:50 INFO - PROCESS | 5538 | |2;audio-dft;160;162;161;160;162;162;162;161;160;160 08:10:50 INFO - PROCESS | 5538 | |3;audio-fft;75;77;78;108;77;77;77;76;111;76 08:10:50 INFO - PROCESS | 5538 | |4;audio-oscillator;84;84;118;85;85;83;121;85;85;119 08:10:50 INFO - PROCESS | 5538 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 08:10:50 INFO - PROCESS | 5538 | |6;imaging-darkroom;146;146;146;145;147;146;146;145;147;146 08:10:50 INFO - PROCESS | 5538 | |7;imaging-desaturate;96;96;96;95;96;96;95;96;103;96 08:10:50 INFO - PROCESS | 5538 | |8;json-parse-financial;66;64;64;62;63;64;64;64;64;64 08:10:50 INFO - PROCESS | 5538 | |9;json-stringify-tinderbox;67;66;67;67;69;67;66;66;67;68 08:10:50 INFO - PROCESS | 5538 | |10;stanford-crypto-aes;90;85;83;83;84;83;92;85;84;91 08:10:50 INFO - PROCESS | 5538 | |11;stanford-crypto-ccm;146;139;140;142;141;140;154;142;188;137 08:10:50 INFO - PROCESS | 5538 | |12;stanford-crypto-pbkdf2;177;174;183;177;173;179;182;177;173;174 08:10:50 INFO - PROCESS | 5538 | |13;stanford-crypto-sha256-iterative;70;70;69;68;72;69;69;69;68;69 08:10:50 INFO - PROCESS | 5538 | __end_tp_report 08:10:50 INFO - PROCESS | 5538 | __start_cc_report 08:10:50 INFO - PROCESS | 5538 | _x_x_mozilla_cycle_collect,1955 08:10:50 INFO - PROCESS | 5538 | __end_cc_report 08:10:50 INFO - PROCESS | 5538 | __startTimestamp1475680250122__endTimestamp 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | ------- Summary: start ------- 08:10:50 INFO - PROCESS | 5538 | Number of tests: 14 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:1.40 (1.2%) stddev-sans-first:1.41 08:10:50 INFO - PROCESS | 5538 | Values: 114.0 116.0 116.0 115.0 117.0 117.0 113.0 116.0 114.0 114.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:132.50 stddev:18.61 (14.0%) stddev-sans-first:19.01 08:10:50 INFO - PROCESS | 5538 | Values: 154.0 130.0 135.0 176.0 129.0 126.0 126.0 127.0 166.0 128.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 08:10:50 INFO - PROCESS | 5538 | Values: 160.0 162.0 161.0 160.0 162.0 162.0 162.0 161.0 160.0 160.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:13.90 (18.1%) stddev-sans-first:14.43 08:10:50 INFO - PROCESS | 5538 | Values: 75.0 77.0 78.0 108.0 77.0 77.0 77.0 76.0 111.0 76.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.50 stddev:16.89 (20.0%) stddev-sans-first:17.45 08:10:50 INFO - PROCESS | 5538 | Values: 84.0 84.0 118.0 85.0 85.0 83.0 121.0 85.0 85.0 119.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:10:50 INFO - PROCESS | 5538 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:10:50 INFO - PROCESS | 5538 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 147.0 146.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:2.32 (2.4%) stddev-sans-first:2.46 08:10:50 INFO - PROCESS | 5538 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 103.0 96.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.99 (1.6%) stddev-sans-first:0.71 08:10:50 INFO - PROCESS | 5538 | Values: 66.0 64.0 64.0 62.0 63.0 64.0 64.0 64.0 64.0 64.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.94 (1.4%) stddev-sans-first:1.00 08:10:50 INFO - PROCESS | 5538 | Values: 67.0 66.0 67.0 67.0 69.0 67.0 66.0 66.0 67.0 68.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:3.56 (4.2%) stddev-sans-first:3.47 08:10:50 INFO - PROCESS | 5538 | Values: 90.0 85.0 83.0 83.0 84.0 83.0 92.0 85.0 84.0 91.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:142.00 stddev:15.20 (10.7%) stddev-sans-first:16.12 08:10:50 INFO - PROCESS | 5538 | Values: 146.0 139.0 140.0 142.0 141.0 140.0 154.0 142.0 188.0 137.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.00 stddev:3.57 (2.0%) stddev-sans-first:3.79 08:10:50 INFO - PROCESS | 5538 | Values: 177.0 174.0 183.0 177.0 173.0 179.0 182.0 177.0 173.0 174.0 08:10:50 INFO - PROCESS | 5538 | 08:10:50 INFO - PROCESS | 5538 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.16 (1.7%) stddev-sans-first:1.20 08:10:50 INFO - PROCESS | 5538 | Values: 70.0 70.0 69.0 68.0 72.0 69.0 69.0 69.0 68.0 69.0 08:10:50 INFO - PROCESS | 5538 | -------- Summary: end -------- 08:10:50 INFO - PROCESS | 5538 | 08:10:51 INFO - TEST-INFO | 5538: exit 0 08:10:51 INFO - TEST-OK | kraken | took 64910ms 08:10:51 INFO - SUITE-END | took 1189s 08:10:51 INFO - Completed test suite (00:19:49) 08:10:51 INFO - javascript benchmark 08:10:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2572.588385858263, 2592.7148013718474, 2630.0531808548917, 2631.355317947102, 2634.1702363755417, 4616.469106052805, 4689.0, 4703.082898834728, 4720.362751028611, 4744.0, 4658.953410465894, 4699.412573428322, 4720.433547974239, 4721.197396442604, 4743.193657078296, 4285.250081235787, 4309.612134907858, 4329.54539773324, 4343.087951530182, 4380.737155770648, 4362.956370436286, 4398.626116780078, 4403.955960440387, 4405.493368262659, 4445.177642136199, 4359.760213188273, 4396.186705459484, 4408.426904502427, 4414.381986521889, 4451.132029254297, 4255.234057869582, 4291.849785257532, 4302.354646802974, 4320.0, 4324.113556720865, 4252.510961239466, 4270.871873843789, 4276.828926842923, 4351.651867850596, 4370.650347972155, 4680.9297860532115, 4686.390769199982, 4691.695039822401, 4718.41019872516, 4776.904461910777, 4886.560209581119, 4948.480409556981, 4958.305837182797, 5044.319016932704, 5059.06407314648, 5022.924656130161, 5045.41977672565, 5049.64652474327, 5050.595952323842, 5099.107656160194, 4696.459907110726, 4719.7404142772475, 4719.7404142772475, 4721.858344249678, 4722.929156062662, 5011.273365362002, 5065.366829146356, 5107.361579802525, 5193.688378697215, 5232.816851410258, 4920.6555541111775, 4958.429780575208, 4964.255361695702, 4993.226049962262, 5009.198528235464, 5031.572316353077, 5031.84904452867, 5034.521720436553, 5041.092603331435, 5098.898022039612, 4834.129856625771, 4891.877703057381, 5005.0, 5008.348914641147, 5061.848144555669, 4911.066897289504, 4917.975410122926, 4924.704517728947, 4934.481879402683, 4950.554450099508, 4342.5874541918465, 4346.65226781863, 4350.1734670412525, 4354.912901741947, 4355.455568053993, 3744.7753134811455, 3764.3976963685677, 3767.0770661188185, 3804.619538046173, 3807.6002019787525, 4280.871573852789, 4319.892002699895, 4322.373255877943, 4326.0050188456835, 4378.846740364072, 4908.288298196813, 4947.901041979212, 4948.059868625021, 4973.1297023020825, 5037.596992240612, 4231.428757117811, 4231.830726770956, 4246.957530424718, 4280.6789490788315, 4289.0, 4467.7319360838455, 4469.173202957463, 4471.8434854779925, 4478.7088839226, 4521.321801729767, 4610.031893302444, 4640.396748422683, 4656.8602941911795, 4660.953390466052, 4696.92954605688, 5008.373953255843, 5025.74871256443, 5027.120253955616, 5068.82259120929, 5080.898382032265, 4687.5781179693995, 4696.8590942271785, 4697.741624210565, 4722.787474563722, 4755.7859896305445, 4795.760211989456, 4856.150173719656, 4943.752812359439, 4946.727929963887, 5016.272640467185, 4999.300097986212, 5011.323471331323, 5035.269885866602, 5043.2687260347775, 5117.744112794271, 4887.169181239126, 4887.291342755351, 4893.951060489349, 4896.730679812645, 4964.652474326763, 4732.905341893074, 4871.707697538159, 4902.093112774148, 4916.508349165055, 4976.427710813158, 4688.2030054890065, 4852.0, 4891.559759621508, 4895.632827537877, 4957.6281778866005, 5004.049230646166, 5008.974955125201, 5014.197728363444, 5015.623828212972, 5033.5721463676, 4684.484706682194, 4727.361806156263, 4728.267118596623, 4758.428988521399, 4853.563179313879], "value": 4611.0240926467, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3179986316626, 567.6764244380702, 575.6431012772082, 580.7996241296753, 584.5469760935277, 28116.0, 37906.43140352897, 39050.60949390509, 39055.0, 44191.55808441914, 41036.896310369026, 41393.172136557325, 41419.17161656765, 41465.585344146624, 41501.7924910375, 7668.348190403823, 7820.335271501929, 7825.256600622932, 7825.569593672346, 7827.7260295889655, 7663.770086897402, 7697.769066928001, 7700.075990881074, 7777.766666999999, 7785.182555831641, 7685.730999415022, 7779.533228006309, 7780.844383112334, 7790.143084260755, 7790.9610451947665, 7705.653245603961, 7729.806754831118, 7730.458867879251, 7750.34122099625, 7773.844523109507, 7647.0, 7680.039995000625, 7688.730894418669, 7691.1924247954275, 7692.923070769277, 36880.26239475222, 37242.4413633793, 37462.62537374619, 37493.81253093717, 37508.24983500342, 2899.7390234878962, 2915.373194763115, 2946.89685860996, 2950.498415269388, 3009.4733421651345, 28438.28904277389, 28707.0, 29115.41769164605, 29291.707082929322, 30769.230769230948, 3437.303621836757, 3550.3076900004507, 3599.7660152090293, 3645.489631451599, 3654.634536546351, 183427.0, 184618.0, 184912.0, 187273.0, 187553.0, 52568.737156313975, 53050.0, 53067.20399194015, 53077.7346113267, 53121.0, 32547.18632034218, 33639.49540756891, 33668.83165584156, 35581.82209088938, 56307.71846140825, 13363.0, 13454.125481843648, 13455.32723363828, 13459.990500712485, 13467.12463689857, 10133.391996480088, 10178.592856285666, 10181.643642472478, 10185.287029907984, 10187.643432479976, 15539.922300388653, 15754.684906301809, 15759.212039398213, 15781.447649332218, 15785.447509337118, 6689.514598029667, 6725.529212955046, 6761.22245941723, 6763.222229443579, 7135.108111486064, 758.6965213914478, 772.6214155064091, 851.3827475080517, 935.4621092871625, 954.0602506531061, 26265.73734262671, 27872.0, 28114.2971425716, 28215.71784282131, 28231.71768282332, 753.4386881773114, 909.7498187998353, 927.0405130689704, 934.8223837470858, 974.9707508774748, 14308.713825723427, 14805.629859253604, 14878.404863805326, 15041.247937603077, 15148.242587870562, 383570.0, 385622.0, 385728.0, 385943.0, 386638.0, 48676.26985595219, 49068.50931490711, 49192.75403622959, 49459.0, 49508.75245623749, 1054.0882136951482, 1109.1514991031868, 1116.0290547223967, 1167.8131498960126, 1196.3420118934725, 27499.45001099927, 31352.843235783675, 31661.963389356995, 31761.682383175874, 32233.51649725209, 47507.52492475031, 48306.0, 48434.515654843, 48450.5154948446, 48490.0, 347892.0, 353173.0, 353661.0, 353710.0, 354563.0, 23792.88103559471, 24047.398815029763, 24422.633660495463, 25379.238622841345, 25483.362915926507, 40334.79832600818, 40716.59283407128, 40887.591124089566, 41306.0, 41943.161136776485, 33722.83138584292, 34148.82925585356, 34522.65477345194, 34640.0, 34934.12664683403, 34933.82533087318, 35078.29843403168, 35255.0, 35491.82254088713, 35777.64222357743, 34332.0, 34634.307313853074, 34902.30195396027, 35005.0, 35705.64294357023, 29363.412731745673, 32024.51963220507, 32100.518492222167, 32208.83895580507, 32233.51649725303, 24228.757712422652, 24476.0, 24557.87721061383, 24743.0, 25093.247202583952], "value": 16976.520025890582, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.810933713115, 350.2661923270747, 350.7877733970947, 353.03541231965016, 365.331443458471, 12460.56388026418, 15410.22948852557, 16030.75953860693, 16230.188490575469, 17029.744553831704, 16833.579160520992, 17306.82693173068, 17354.47936561902, 17417.564560885985, 17487.300507979664, 4276.850310239142, 4895.38807649043, 5045.192769156935, 5100.260462232974, 5104.259882317062, 3694.722895782827, 3869.8839034829, 4920.926186107211, 5049.974750126263, 5645.350784659776, 5894.351621321651, 5995.100734889779, 6001.639901605896, 6010.36891126432, 6018.939810601882, 5708.486236238738, 5851.912221316684, 5892.734826932756, 5894.145348924425, 6007.609505382136, 5136.537711605936, 5141.048905952411, 5143.228515722634, 5144.922826157611, 5146.614003949681, 19667.704984425243, 20477.07853146612, 20524.589508209752, 20627.89686051575, 20780.0, 1989.990050049755, 2028.3205126282712, 2046.785087565814, 2129.5208578069964, 2512.9371765706005, 12593.811092833523, 13236.073474856765, 13459.528916487974, 13780.448782048707, 13839.584812455643, 1697.7623132761423, 1744.8865823721417, 1756.9912150439293, 1780.528160037591, 1788.8926664400049, 55756.16365754517, 67111.328886711, 67226.66386668035, 67595.66202169006, 67837.3216267836, 8776.0, 8867.64529418816, 9021.097890211058, 9850.21198304134, 10088.445135517617, 13865.306734663227, 13876.306184690726, 13878.722425551432, 13888.930555347159, 13897.79153312701, 6697.799066027929, 6983.95240713897, 7109.537880037781, 7138.714451421885, 7138.964305178441, 6429.067785171124, 6510.544261901621, 6533.477321814244, 6646.069550262967, 6666.266710661824, 4232.830686772556, 4285.7000009999, 4301.827926882889, 4341.196878577473, 4435.578620031092, 1608.4852847088819, 1715.8627309815433, 1796.8921864688161, 1797.8022417534062, 1805.404216608516, 715.9534630249017, 806.3871457692079, 815.2621877201143, 837.0666706622194, 865.5758678247613, 16654.916725416297, 16688.499345019667, 16889.0, 16923.830761692472, 17692.91153544224, 840.1640367834044, 840.6931470013401, 841.3605659698551, 843.472829481574, 884.3822286033285, 9224.584893679801, 9956.80086398268, 9958.701238962698, 9980.500974951223, 10003.44981026036, 163409.0, 165475.1726241385, 165542.0, 353201.0, 367263.0, 78262.6086869562, 79368.603156985, 80475.59762201269, 80916.0, 80982.5950870242, 875.7635438431588, 877.1929824561435, 912.4707669551644, 938.6620816506053, 951.3673407184283, 15491.690166196839, 16025.839741602902, 16555.0, 16560.420385286456, 16706.832931670528, 36693.44959825658, 36948.815255923546, 37208.81395593005, 37918.43122353222, 38354.0, 50027.0, 51108.0, 53516.73241633767, 53544.0, 54897.725511372184, 7576.924230757842, 7586.203448637813, 7648.388128949782, 7716.614169291625, 7773.961130194313, 8713.869291960498, 10993.560257589927, 11106.833397498882, 11704.180707350404, 12195.573154939535, 9790.608375664893, 10307.536160872629, 10308.0, 10620.787584248117, 10809.243352965217, 9643.228541716786, 9844.950775246078, 9876.160526355341, 9876.35803672759, 9940.254480913816, 10439.743379499194, 10572.471376431302, 10609.257351985287, 10670.679879603624, 11053.944730276296, 7469.663865125974, 7524.699012039458, 7582.469227154267, 7660.387169026576, 7707.961460192663, 10201.183905287708, 10449.268551201343, 10609.89390106089, 10897.346159230472, 10994.505247264053], "value": 8118.052762458677, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.7707212701716, 1308.7186254955188, 1334.9720715049411, 1640.5652502086941, 1647.1846436014182, 7031.71873125075, 7591.202923693016, 7596.810079748009, 7609.315161635452, 7614.58119803412, 6474.093626892239, 6755.797326080213, 7098.467614928875, 7383.187849336568, 7389.741359052434, 2057.238821635997, 2086.384516567616, 2092.550101728128, 2093.86389884657, 2096.2139197800825, 2066.7003284523735, 2097.349821555315, 2116.1323857218545, 2118.819900308468, 2119.4065661614773, 1776.7423723560075, 1833.2025568877514, 2022.2214447437768, 2080.44868109951, 2083.291680828518, 2008.2268326694182, 2022.4236092713654, 2023.8886861222627, 2024.8987550622483, 2026.8277196438173, 2014.597080583889, 2056.691496275556, 2058.475088852348, 2061.865978711379, 2066.442060643633, 7434.219406962299, 7468.178500364956, 7489.176190619028, 7503.887441688379, 7524.887126693104, 4271.402003719481, 4470.0, 4473.0, 4475.686701930867, 4478.081993191388, 2628.7896968242494, 2669.506141363854, 2797.5244208484405, 2800.341919648881, 2809.761170300527, 832.7728765280735, 874.7506960516222, 879.7756572074144, 893.6425429828121, 898.380117718772, 10192.898071019268, 10200.0, 10203.92858749828, 10220.642277520325, 10227.590896364061, 3583.7312201584987, 3802.6043592537076, 3965.861194858166, 3981.9203615927518, 3992.880213593539, 7562.924370756332, 7789.532628042336, 8149.103598604149, 8688.348373871984, 8692.913070869337, 4100.835966561363, 4241.766702831313, 4241.851535196253, 4243.639290660267, 4243.936340954888, 3861.7876016819346, 3864.845406183721, 3870.3807390817897, 3879.2435475082652, 3879.3792993120965, 3141.4973604223214, 3161.2096975756062, 3256.397566450214, 3291.687289707474, 3296.785708928912, 1077.138289368502, 1077.859878215827, 1087.287826473661, 1095.7370231144628, 1118.0999295566985, 780.8165081205912, 795.9562224077615, 802.6668932393109, 816.6814942172557, 827.0819390476566, 4769.332293478916, 4778.092162489185, 4817.9036419271415, 4933.186024305949, 4997.475265097112, 350.90350153707936, 359.59365916514173, 845.2603971524916, 906.5829718329642, 921.5392303848076, 3344.4983252512316, 3428.5200071989943, 3451.6893479586956, 3540.672247907035, 3550.822458877046, 8783.912160878437, 9150.771230719285, 9263.073692630684, 9320.347575669639, 9333.160015598492, 9160.725178244664, 9220.677276295297, 9240.306976976754, 9242.861357079515, 9251.67619133327, 6819.181698196248, 6834.453243740489, 6885.414739747178, 6939.757108501179, 6948.096747422803, 4846.80612775485, 4869.488703686062, 4877.170880950318, 4931.260310953242, 4988.825391111293, 8133.552654604054, 8193.877091843746, 8364.330853531825, 8371.539565323723, 8385.706500272461, 8213.425060245965, 8492.280870327497, 8513.531755753493, 8579.14208579137, 8590.527520986405, 5657.094864821609, 5900.616459930091, 6058.454739073504, 6205.627662340274, 6253.405926436982, 6927.1687397510605, 7255.56466612005, 7258.419326453765, 7405.037345145097, 7420.146683131509, 6446.355364463704, 6481.222253329631, 6483.967580162069, 6582.045603387578, 6683.498737594603, 6520.9347906520325, 6555.246146693001, 6561.737530498917, 6579.013148027834, 6596.8350791230605, 5829.59192856496, 5909.91135132982, 5913.2608423947, 5921.881562368814, 5922.230110085661, 4310.827566897289, 4351.564843515623, 4428.225060614444, 4430.667699922455, 4482.0, 4395.0, 4493.460784705856, 4511.187986162522, 4513.796879140381, 4514.864554063383], "value": 3881.8380096329515, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.62767030530614, 294.5037611624413, 297.1412617535323, 307.25797199762576, 307.8983935301351, 4850.029994001201, 4889.119958407486, 4891.804327826882, 4896.779644915974, 4917.2378281366355, 4749.4063242094735, 4776.164171270031, 4803.7726800415585, 4822.4936381679945, 4834.2265237562, 3826.387777955528, 3832.9425058624142, 3845.673242731253, 3850.7304488685804, 3857.286402015622, 3689.2805902848954, 3827.4258861170906, 3841.34697101492, 3857.517810273716, 3869.729118961674, 3742.925141497182, 3753.6434038766274, 3761.567419746737, 3784.4512545680996, 3795.335816232162, 3748.7188460865273, 3749.850005999757, 3753.1930634913624, 3763.024412183598, 3771.3400154972906, 3151.6218053833686, 3255.300110476259, 3255.332656805373, 3364.2934983653463, 3364.831758412094, 4675.158471475133, 4680.321353403738, 4680.508546602626, 4698.412698412699, 4709.199436095838, 4278.572142785728, 4288.849890253858, 4299.333603291495, 4303.569643035703, 4304.418903448026, 4768.976155119237, 4839.588634966032, 4893.902121957541, 4957.677750946177, 5021.924671129936, 3649.2519033598314, 3649.908752281188, 3653.3971894637352, 3654.14127679995, 3673.338799016176, 5264.447233040514, 5266.0, 5268.1834315681135, 5293.285406470077, 5301.416844147141, 3622.3117607654463, 3698.112453011258, 3727.7576957497677, 3734.495843061152, 3747.3254814133174, 3800.5059342285326, 3804.2581696568905, 3806.8286927088348, 3807.695384369244, 3814.1608846053823, 4271.167122411162, 4273.1026484438, 4309.224339618836, 4317.093410383792, 4327.394164816928, 4772.546608072227, 5014.0, 5033.219850923113, 5054.418741844662, 5063.215201643751, 1264.5826877130526, 1285.4472576792068, 1287.6909541710108, 1293.495536740672, 1296.6758310422395, 779.8206412525151, 805.8348038652063, 808.6684459371747, 812.9430939834155, 814.5397850214729, 3929.8821035368983, 3941.8423263069158, 3948.1314110895555, 3970.8411663533134, 3987.5308481620596, 4543.613792827647, 4562.88592785183, 4577.771111444481, 4582.541745825458, 4584.4498660161, 3951.6443520082757, 3954.5649978502342, 3966.722329436912, 3974.125692347679, 3974.741641793274, 2361.669366288721, 2440.0117952229375, 2443.9491018861704, 2454.7667971542674, 2463.963040554393, 4655.837045703384, 4727.180035686286, 4802.543758342952, 4891.584215341664, 4900.828471003498, 5321.148616221386, 5351.331083614548, 5353.2237825515085, 5353.866153346197, 5356.973215133899, 4666.876571160046, 4885.973945471491, 4899.363082799213, 4906.950930490721, 4908.656394052454, 5119.360079990001, 5127.179651255781, 5145.331106956071, 5165.870853228549, 5184.9740751296, 5100.48995100487, 5108.872278193075, 5109.386873575195, 5118.769655365443, 5127.512886275797, 4745.240761478147, 4868.853934381974, 4871.318015477765, 4871.90256194867, 4906.8959484115785, 3619.1133172371883, 3646.197836475971, 3646.489491471143, 3653.506776585233, 3653.725970552166, 5159.17453207485, 5185.507376799198, 5231.29377534028, 5235.65968212065, 5248.685078895279, 4831.637627177905, 5046.091703493406, 5059.949400506095, 5069.0, 5100.362454693163, 5011.874703132451, 5022.146235139962, 5029.949700502948, 5034.892323688782, 5035.697858128524, 4905.411350637946, 4906.239532872411, 4931.630127740362, 4939.641044090054, 4953.2074868020945, 4760.357351757607, 4981.402231732215, 5002.52476014778, 5041.0, 5082.0, 4876.95123048765, 4906.55840974314, 4907.3620429343955, 4918.532739389752, 4919.3604831371695], "value": 3748.4477290227414, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.5784198614018, 582.8368056944057, 611.9663418511982, 615.5977830562155, 645.0324513230155, 12977.610671679853, 13327.200367977928, 13917.582472525815, 13947.372368243428, 13962.790558141623, 13310.800337994939, 13314.267715275655, 13355.265460399674, 13384.933075334635, 13413.061085723979, 601.855554666879, 737.6938570493252, 753.2392283793381, 754.0875540595886, 754.7207533212692, 614.7172300741641, 734.4308161175105, 754.7999780058288, 757.0990521279687, 759.7644730133676, 799.312591171592, 802.1016461563029, 802.1697543042952, 805.6817557064985, 806.0850934189708, 629.364342014564, 797.8563858505466, 797.9122296547404, 798.0104670208957, 798.3732769775698, 475.18505762617275, 562.651156283103, 573.3091624592398, 575.8963386590412, 576.9105788602774, 10360.481975901175, 10367.896321036844, 10369.63706270277, 10396.428196449193, 10483.318584292072, 12168.81746773799, 12660.366981650881, 12726.936365318206, 12767.808482872764, 13550.525731599346, 11166.888331116666, 11407.714807129805, 11502.252353596989, 11582.884171158265, 11605.825912611317, 4008.2183974124764, 4027.6375126238486, 4041.9288888444585, 4091.2226676931587, 4109.445224894661, 60787.13702903757, 60890.999999999556, 60903.69548152275, 60952.63805153134, 61050.389496104915, 9465.621375145054, 9729.270304727173, 9762.17021553176, 9945.751356216007, 10265.435401052864, 18842.3405180818, 18963.715544266848, 19035.143418545922, 19036.33372831944, 19039.904800476186, 6282.371762823681, 6319.0, 6359.586626869239, 6494.350564943468, 6603.7358505660195, 3401.234722187488, 3476.7913925164066, 3483.9129021774656, 3500.0899766061007, 3534.0811389039036, 2686.073304709872, 2773.3759904021836, 2782.1653503948733, 2788.0, 2792.3019245188702, 460.9677322587454, 473.5785151215421, 476.440182785226, 478.7862767883468, 480.96633235673164, 436.9104333611602, 467.8152129908667, 469.6501106675549, 490.9346717622767, 523.9554637855749, 7937.166597507294, 8034.477758945767, 8157.46976446541, 8440.0, 9642.276829237835, 583.2825624481911, 619.3125630550086, 620.8230654263604, 627.3099590450468, 627.3914303125961, 3743.344914639927, 4116.403121547359, 4172.958270417318, 4256.553061928515, 4280.785960702015, 55493.16760248599, 75296.0, 81533.59233203797, 81834.0, 91991.0, 46030.53969460262, 47033.5296647036, 47666.285005724945, 49032.0, 86876.56561717151, 71448.64275678588, 75092.24907750962, 76406.0, 78812.0, 79329.0, 8590.226879580869, 9139.725808225498, 9373.921998970205, 9400.435973841591, 9417.199538039069, 44862.3270650947, 45404.545954541354, 45853.0, 46379.0, 46894.0, 60681.0, 60819.0, 64432.0, 66673.33326666671, 67267.32732672806, 11313.71715707114, 11402.429878505876, 11482.0, 11580.247283926517, 11712.70718232051, 12217.69455763613, 12483.251004939733, 12919.612411627666, 13022.0, 13157.934210328887, 12014.279143251433, 12429.813552796535, 12540.811887821508, 12717.364131793558, 12848.486060557472, 11853.170278080452, 12622.242665440102, 12727.554535591209, 12744.0, 13000.609981700563, 11879.465424055765, 12011.0, 12294.0, 12418.254904705747, 12726.0, 9868.506574671093, 10650.623443870052, 10776.515056822305, 11290.717732056764, 11332.206745527734, 10630.149588033093, 10652.786944261226, 10733.463326833784, 10760.192985526273, 10762.139028877828], "value": 6421.587232099423, "unit": "score"}], "name": "dromaeo_css", "value": 6246.164783852523, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 115.0, 117.0, 117.0, 113.0, 116.0, 114.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 135.0, 176.0, 129.0, 126.0, 126.0, 127.0, 166.0, 128.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 108.0, 77.0, 77.0, 77.0, 76.0, 111.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 118.0, 85.0, 85.0, 83.0, 121.0, 85.0, 85.0, 119.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 103.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 62.0, 63.0, 64.0, 64.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 69.0, 67.0, 66.0, 66.0, 67.0, 68.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 83.0, 83.0, 84.0, 83.0, 92.0, 85.0, 84.0, 91.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 140.0, 142.0, 141.0, 140.0, 154.0, 142.0, 188.0, 137.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 183.0, 177.0, 173.0, 179.0, 182.0, 177.0, 173.0, 174.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 68.0, 72.0, 69.0, 69.0, 69.0, 68.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1563.5000000000002, "alertThreshold": 2.0}]} 08:10:51 INFO - Return code: 0 08:10:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:10:51 INFO - # TBPL SUCCESS # 08:10:51 INFO - Running post-action listener: _resource_record_post_action 08:10:51 INFO - [mozharness: 2016-10-05 15:10:51.893141Z] Finished run-tests step (success) 08:10:51 INFO - Running post-run listener: _resource_record_post_run 08:10:51 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 733184; Write bytes: 403644416; Read time: 276; Write time: 284192 08:10:51 INFO - TinderboxPrint: CPU usage
13.0% 08:10:51 INFO - TinderboxPrint: I/O read bytes / time
733,184 / 276 08:10:51 INFO - TinderboxPrint: I/O write bytes / time
403,644,416 / 284,192 08:10:51 INFO - TinderboxPrint: CPU idle
8,366.3 (86.9%) 08:10:51 INFO - TinderboxPrint: CPU user
1,205.7 (12.5%) 08:10:51 INFO - TinderboxPrint: Swap in / out
0 / 0 08:10:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110555136; Read time: 0; Write time: 65696 08:10:51 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 729088; Write bytes: 293089280; Read time: 276; Write time: 218496 08:10:52 INFO - Running post-run listener: _upload_blobber_files 08:10:52 INFO - Blob upload gear active. 08:10:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:10:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:10:52 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:10:52 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:10:52 INFO - (blobuploader) - INFO - Open directory for files ... 08:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:53 INFO - (blobuploader) - INFO - Done attempting. 08:10:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:10:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:10:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:10:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:10:59 INFO - (blobuploader) - INFO - Done attempting. 08:10:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:10:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:10:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:11:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:11:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:11:00 INFO - (blobuploader) - INFO - Done attempting. 08:11:00 INFO - (blobuploader) - INFO - Iteration through files over. 08:11:00 INFO - Return code: 0 08:11:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:11:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:11:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/988e01a004ab9b1294b90d8974b1fb45e700329c169ed04b6cceb5928a3c3ed0cd1eedbedd8e9a8f1331f3b8c1efe40673c833c21df33b51304905bf472dc209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4143a970a8a4bae5776d2656206419609b3dd987d80a5ec73d41fb3b33508238803c78ff69cf9528721d19f50a3889ff3a8b8d3563afa3b6d9a48290e5cbf9f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0cda4ae03dbd7a1a809ce6cd4b17db87b154c1285514b69dc22e5ce491a37992433c19af799e43dadbdb5e8f3406e7979bbfe5e34923dcb882bd858e74bc8d1"} 08:11:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:11:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:11:00 INFO - Contents: 08:11:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/988e01a004ab9b1294b90d8974b1fb45e700329c169ed04b6cceb5928a3c3ed0cd1eedbedd8e9a8f1331f3b8c1efe40673c833c21df33b51304905bf472dc209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4143a970a8a4bae5776d2656206419609b3dd987d80a5ec73d41fb3b33508238803c78ff69cf9528721d19f50a3889ff3a8b8d3563afa3b6d9a48290e5cbf9f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0cda4ae03dbd7a1a809ce6cd4b17db87b154c1285514b69dc22e5ce491a37992433c19af799e43dadbdb5e8f3406e7979bbfe5e34923dcb882bd858e74bc8d1"} 08:11:00 INFO - Running post-run listener: copy_logs_to_upload_dir 08:11:00 INFO - Copying logs to upload dir... 08:11:00 INFO - mkdir: /builds/slave/test/build/upload/logs 08:11:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.200405 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-10-05 08:11:00.465703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 08:11:00.469160) ========= 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=836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615 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-Non-PGO/sha512/988e01a004ab9b1294b90d8974b1fb45e700329c169ed04b6cceb5928a3c3ed0cd1eedbedd8e9a8f1331f3b8c1efe40673c833c21df33b51304905bf472dc209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4143a970a8a4bae5776d2656206419609b3dd987d80a5ec73d41fb3b33508238803c78ff69cf9528721d19f50a3889ff3a8b8d3563afa3b6d9a48290e5cbf9f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0cda4ae03dbd7a1a809ce6cd4b17db87b154c1285514b69dc22e5ce491a37992433c19af799e43dadbdb5e8f3406e7979bbfe5e34923dcb882bd858e74bc8d1"} build_url:https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/NlYGQG8lQSydnLti1FoEyw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/988e01a004ab9b1294b90d8974b1fb45e700329c169ed04b6cceb5928a3c3ed0cd1eedbedd8e9a8f1331f3b8c1efe40673c833c21df33b51304905bf472dc209", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4143a970a8a4bae5776d2656206419609b3dd987d80a5ec73d41fb3b33508238803c78ff69cf9528721d19f50a3889ff3a8b8d3563afa3b6d9a48290e5cbf9f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0cda4ae03dbd7a1a809ce6cd4b17db87b154c1285514b69dc22e5ce491a37992433c19af799e43dadbdb5e8f3406e7979bbfe5e34923dcb882bd858e74bc8d1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 08:11:00.498859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:11:00.499524) ========= 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=836cfdc75598d54cb747368e000001a9-1475678855.36050-1387738615 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 08:11:00.583300) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 08:11:00.584059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 08:11:00.584739) ========= ========= Total master_lag: 0.17 =========