builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1482148621.13 results: success (0) buildid: 20161219021638 builduid: 91dcef4adff74adab3c10c2fdbfdf347 revision: 7a9e103be35066bd7c06e770a73b7401ce1e2620 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.129351) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.129890) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.130198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.145269) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.145553) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-19 03:57:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-12-19 03:57:03 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.301766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.302047) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021812 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.365207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:01.365513) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7a9e103be35066bd7c06e770a73b7401ce1e2620 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7a9e103be35066bd7c06e770a73b7401ce1e2620 --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=82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-19 03:57:03,587 truncating revision to first 12 chars 2016-12-19 03:57:03,588 Setting DEBUG logging. 2016-12-19 03:57:03,588 attempt 1/10 2016-12-19 03:57:03,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7a9e103be350?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-19 03:57:03,965 unpacking tar archive at: mozilla-aurora-7a9e103be350/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671470 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:02.050760) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:02.051076) ========= script_repo_revision: 7a9e103be35066bd7c06e770a73b7401ce1e2620 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:02.051471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:02.051892) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-19 03:57:02.061173) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-19 03:57:02.061453) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:57:04 INFO - MultiFileLogger online at 20161219 03:57:04 in /builds/slave/test 03:57:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:57:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:04 INFO - {'append_to_log': False, 03:57:04 INFO - 'base_work_dir': '/builds/slave/test', 03:57:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:57:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:04 INFO - 'branch': 'Mozilla-Aurora', 03:57:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:04 INFO - 'config_files': ('talos/linux_config.py',), 03:57:04 INFO - 'default_actions': ('clobber', 03:57:04 INFO - 'read-buildbot-config', 03:57:04 INFO - 'download-and-extract', 03:57:04 INFO - 'populate-webroot', 03:57:04 INFO - 'create-virtualenv', 03:57:04 INFO - 'install', 03:57:04 INFO - 'run-tests'), 03:57:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:04 INFO - 'download_minidump_stackwalk': True, 03:57:04 INFO - 'download_symbols': 'ondemand', 03:57:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:04 INFO - 'installer_path': 'installer.exe', 03:57:04 INFO - 'log_level': 'info', 03:57:04 INFO - 'log_name': 'talos', 03:57:04 INFO - 'log_to_console': True, 03:57:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:57:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:57:04 INFO - 'opt_config_files': (), 03:57:04 INFO - 'pip_index': False, 03:57:04 INFO - 'sps_profile': False, 03:57:04 INFO - 'sps_profile_interval': 0, 03:57:04 INFO - 'suite': 'dromaeojs', 03:57:04 INFO - 'system_bits': '32', 03:57:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:04 INFO - 'title': 'talos-linux64-ix-066', 03:57:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:04 INFO - 'use_talos_json': True, 03:57:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:04 INFO - 'work_dir': 'build'} 03:57:04 INFO - [mozharness: 2016-12-19 11:57:04.384894Z] Running clobber step. 03:57:04 INFO - Running pre-action listener: _resource_record_pre_action 03:57:04 INFO - Running main action method: clobber 03:57:04 INFO - rmtree: /builds/slave/test/build 03:57:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:04 INFO - Running post-action listener: _resource_record_post_action 03:57:04 INFO - [mozharness: 2016-12-19 11:57:04.843989Z] Finished clobber step (success) 03:57:04 INFO - [mozharness: 2016-12-19 11:57:04.844088Z] Running read-buildbot-config step. 03:57:04 INFO - Running pre-action listener: _resource_record_pre_action 03:57:04 INFO - Running main action method: read_buildbot_config 03:57:04 INFO - Using buildbot properties: 03:57:04 INFO - { 03:57:04 INFO - "project": "", 03:57:04 INFO - "product": "firefox", 03:57:04 INFO - "script_repo_revision": "production", 03:57:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:57:04 INFO - "repository": "", 03:57:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:57:04 INFO - "buildid": "20161219021638", 03:57:04 INFO - "pgo_build": "True", 03:57:04 INFO - "basedir": "/builds/slave/test", 03:57:04 INFO - "buildnumber": 688, 03:57:04 INFO - "slavename": "talos-linux64-ix-066", 03:57:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:57:04 INFO - "platform": "ubuntu64_hw", 03:57:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:57:04 INFO - "branch": "mozilla-aurora", 03:57:04 INFO - "repo_path": "releases/mozilla-aurora", 03:57:04 INFO - "revision": "7a9e103be35066bd7c06e770a73b7401ce1e2620", 03:57:04 INFO - "stage_platform": "linux64-pgo", 03:57:04 INFO - "builduid": "91dcef4adff74adab3c10c2fdbfdf347", 03:57:04 INFO - "slavebuilddir": "test" 03:57:04 INFO - } 03:57:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:57:04 INFO - Running post-action listener: _resource_record_post_action 03:57:04 INFO - [mozharness: 2016-12-19 11:57:04.846537Z] Finished read-buildbot-config step (success) 03:57:04 INFO - [mozharness: 2016-12-19 11:57:04.846625Z] Running download-and-extract step. 03:57:04 INFO - Running pre-action listener: _resource_record_pre_action 03:57:04 INFO - Running main action method: download_and_extract 03:57:04 INFO - mkdir: /builds/slave/test/build/tests 03:57:04 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')]} 03:57:04 INFO - trying https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:57:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:57:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:57:05 INFO - Downloaded 1361 bytes. 03:57:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:57:05 INFO - Using the following test package requirements: 03:57:05 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:57:05 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:57:05 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:57:05 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'jsshell-linux-x86_64.zip'], 03:57:05 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:57:05 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:57:05 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:57:05 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:57:05 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:57:05 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:57:05 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:57:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:57:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:57:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:57:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:57:06 INFO - Http code: 200 03:57:06 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 03:57:06 INFO - x-amz-cf-id: HgKg7RdZkGz0KLmkejFQ1Sj864Ay5qWBEOQ-Kyag66M-T2WjU3ruzg== 03:57:06 INFO - x-amz-version-id: EFKsSa6SrJfQ4W9BCklpIIQzmjAnmAAl 03:57:06 INFO - Expected file size: 21953750 03:57:06 INFO - Obtained file size: 21953750 03:57:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:57:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:57:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:57:10 INFO - Fetch https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:57:10 INFO - Http code: 200 03:57:10 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 03:57:10 INFO - x-amz-cf-id: kaBLr_RMl-oL0ebJPqLSt43qT_zxR2oL06BHfmChKwsR-zITTafStA== 03:57:10 INFO - x-amz-version-id: EFKsSa6SrJfQ4W9BCklpIIQzmjAnmAAl 03:57:11 INFO - Expected file size: 21953750 03:57:11 INFO - Obtained file size: 21953750 03:57:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:57:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:57:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:57:16 INFO - Http code: 200 03:57:16 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 03:57:16 INFO - x-amz-cf-id: bRTKDpdorYBD-sTrr_XPHGgPWKu1h3vGZ-SN2QrPSZZ6G5vMscZZfA== 03:57:16 INFO - x-amz-version-id: bRVPJHddHg_3KJSIltnGxI0ndUVUID.q 03:57:16 INFO - Expected file size: 14409038 03:57:16 INFO - Obtained file size: 14409038 03:57:16 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')]} 03:57:16 INFO - trying https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:57:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:57:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:57:17 INFO - Downloaded 63947027 bytes. 03:57:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:57:17 INFO - mkdir: /builds/slave/test/properties 03:57:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:57:17 INFO - Writing to file /builds/slave/test/properties/build_url 03:57:17 INFO - Contents: 03:57:17 INFO - build_url:https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:57:18 INFO - Running post-action listener: _resource_record_post_action 03:57:18 INFO - Running post-action listener: set_extra_try_arguments 03:57:18 INFO - [mozharness: 2016-12-19 11:57:18.378021Z] Finished download-and-extract step (success) 03:57:18 INFO - [mozharness: 2016-12-19 11:57:18.378319Z] Running populate-webroot step. 03:57:18 INFO - Running pre-action listener: _resource_record_pre_action 03:57:18 INFO - Running main action method: populate_webroot 03:57:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:57:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:57:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:57:18 INFO - '--tppagecycles', 03:57:18 INFO - '7'], 03:57:18 INFO - 'tests': ['tsvgm']}}, 03:57:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:57:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:57:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:57:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:57:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:57:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['damp', 'tps']}, 03:57:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'tests': ['damp', 'tps']}, 03:57:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['dromaeo_dom']}, 03:57:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:57:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['basic_compositor_video']}, 03:57:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:57:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['a11yr', 03:57:18 INFO - 'ts_paint', 03:57:18 INFO - 'tpaint', 03:57:18 INFO - 'sessionrestore', 03:57:18 INFO - 'sessionrestore_no_auto_restore', 03:57:18 INFO - 'tabpaint']}, 03:57:18 INFO - 'other-e10s': {'tests': ['a11yr', 03:57:18 INFO - 'ts_paint', 03:57:18 INFO - 'tpaint', 03:57:18 INFO - 'sessionrestore', 03:57:18 INFO - 'sessionrestore_no_auto_restore', 03:57:18 INFO - 'tabpaint']}, 03:57:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:57:18 INFO - 'ts_paint', 03:57:18 INFO - 'tpaint', 03:57:18 INFO - 'sessionrestore', 03:57:18 INFO - 'sessionrestore_no_auto_restore', 03:57:18 INFO - 'tabpaint']}, 03:57:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:57:18 INFO - 'ts_paint', 03:57:18 INFO - 'tpaint', 03:57:18 INFO - 'sessionrestore', 03:57:18 INFO - 'sessionrestore_no_auto_restore', 03:57:18 INFO - 'tabpaint']}, 03:57:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['a11yr', 03:57:18 INFO - 'ts_paint', 03:57:18 INFO - 'tpaint', 03:57:18 INFO - 'sessionrestore', 03:57:18 INFO - 'sessionrestore_no_auto_restore', 03:57:18 INFO - 'tabpaint']}, 03:57:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['a11yr', 03:57:18 INFO - 'ts_paint', 03:57:18 INFO - 'tpaint', 03:57:18 INFO - 'sessionrestore', 03:57:18 INFO - 'sessionrestore_no_auto_restore', 03:57:18 INFO - 'tabpaint']}, 03:57:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['tsvgx', 03:57:18 INFO - 'tsvgr_opacity', 03:57:18 INFO - 'tart', 03:57:18 INFO - 'tscrollx', 03:57:18 INFO - 'cart']}, 03:57:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:57:18 INFO - 'tsvgr_opacity', 03:57:18 INFO - 'tart', 03:57:18 INFO - 'tscrollx', 03:57:18 INFO - 'cart']}, 03:57:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'talos_options': ['--disable-e10s'], 03:57:18 INFO - 'tests': ['tp5o']}, 03:57:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'tests': ['tp5o']}, 03:57:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'talos_options': ['--disable-e10s', 03:57:18 INFO - '--xperf_path', 03:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:18 INFO - 'tests': ['tp5n']}, 03:57:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:57:18 INFO - 'talos_options': ['--xperf_path', 03:57:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:57:18 INFO - 'tests': ['tp5n']}}, 03:57:18 INFO - 'talos.zip': {'path': '', 03:57:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:57:18 INFO - Running post-action listener: _resource_record_post_action 03:57:18 INFO - [mozharness: 2016-12-19 11:57:18.398003Z] Finished populate-webroot step (success) 03:57:18 INFO - [mozharness: 2016-12-19 11:57:18.398095Z] Running create-virtualenv step. 03:57:18 INFO - Running pre-action listener: _resource_record_pre_action 03:57:18 INFO - Running main action method: create_virtualenv 03:57:18 INFO - Creating virtualenv /builds/slave/test/build/venv 03:57:18 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 03:57:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:57:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:57:18 INFO - Using real prefix '/usr' 03:57:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:57:18 INFO - Installing distribute.............................................................................................................................................................................................done. 03:57:20 INFO - Installing pip.................done. 03:57:20 INFO - Return code: 0 03:57:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:57:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:57:21 INFO - Reading from file tmpfile_stdout 03:57:21 INFO - Output received: 03:57:21 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) 03:57:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:21 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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57:21 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 03:57:21 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 03:57:21 INFO - Using env: {'DISPLAY': ':0', 03:57:21 INFO - 'HOME': '/home/cltbld', 03:57:21 INFO - 'LANG': 'en_US.UTF-8', 03:57:21 INFO - 'LANGUAGE': 'en_US:en', 03:57:21 INFO - 'LOGNAME': 'cltbld', 03:57:21 INFO - 'MAIL': '/var/mail/cltbld', 03:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:21 INFO - 'MOZ_NO_REMOTE': '1', 03:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:21 INFO - 'NO_EM_RESTART': '1', 03:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:21 INFO - 'PWD': '/builds/slave/test', 03:57:21 INFO - 'SHELL': '/bin/bash', 03:57:21 INFO - 'SHLVL': '1', 03:57:21 INFO - 'TERM': 'linux', 03:57:21 INFO - 'TMOUT': '86400', 03:57:21 INFO - 'USER': 'cltbld', 03:57:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:21 INFO - '_': '/tools/buildbot/bin/python'} 03:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:21 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 03:57:21 INFO - Cleaning up... 03:57:21 INFO - Return code: 0 03:57:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:21 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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57:21 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 03:57:21 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 03:57:21 INFO - Using env: {'DISPLAY': ':0', 03:57:21 INFO - 'HOME': '/home/cltbld', 03:57:21 INFO - 'LANG': 'en_US.UTF-8', 03:57:21 INFO - 'LANGUAGE': 'en_US:en', 03:57:21 INFO - 'LOGNAME': 'cltbld', 03:57:21 INFO - 'MAIL': '/var/mail/cltbld', 03:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:21 INFO - 'MOZ_NO_REMOTE': '1', 03:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:21 INFO - 'NO_EM_RESTART': '1', 03:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:21 INFO - 'PWD': '/builds/slave/test', 03:57:21 INFO - 'SHELL': '/bin/bash', 03:57:21 INFO - 'SHLVL': '1', 03:57:21 INFO - 'TERM': 'linux', 03:57:21 INFO - 'TMOUT': '86400', 03:57:21 INFO - 'USER': 'cltbld', 03:57:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:21 INFO - '_': '/tools/buildbot/bin/python'} 03:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:21 INFO - Downloading/unpacking psutil>=3.1.1 03:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:23 INFO - Installing collected packages: psutil 03:57:23 INFO - Running setup.py install for psutil 03:57:23 INFO - building 'psutil._psutil_linux' extension 03:57:23 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 03:57:23 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 03:57:23 INFO - building 'psutil._psutil_posix' extension 03:57:23 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 03:57:24 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 03:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:57:24 INFO - Successfully installed psutil 03:57:24 INFO - Cleaning up... 03:57:24 INFO - Return code: 0 03:57:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:57:24 INFO - Using env: {'DISPLAY': ':0', 03:57:24 INFO - 'HOME': '/home/cltbld', 03:57:24 INFO - 'LANG': 'en_US.UTF-8', 03:57:24 INFO - 'LANGUAGE': 'en_US:en', 03:57:24 INFO - 'LOGNAME': 'cltbld', 03:57:24 INFO - 'MAIL': '/var/mail/cltbld', 03:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:24 INFO - 'MOZ_NO_REMOTE': '1', 03:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:24 INFO - 'NO_EM_RESTART': '1', 03:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:24 INFO - 'PWD': '/builds/slave/test', 03:57:24 INFO - 'SHELL': '/bin/bash', 03:57:24 INFO - 'SHLVL': '1', 03:57:24 INFO - 'TERM': 'linux', 03:57:24 INFO - 'TMOUT': '86400', 03:57:24 INFO - 'USER': 'cltbld', 03:57:24 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:24 INFO - '_': '/tools/buildbot/bin/python'} 03:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:57:24 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 03:57:24 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 03:57:24 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 03:57:24 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 03:57:24 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 03:57:24 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 03:57:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:57:26 INFO - Installing collected packages: mozsystemmonitor 03:57:26 INFO - Running setup.py install for mozsystemmonitor 03:57:26 INFO - Successfully installed mozsystemmonitor 03:57:26 INFO - Cleaning up... 03:57:26 INFO - Return code: 0 03:57:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', '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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:57: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 jsonschema==2.5.1 03:57:26 INFO - Using env: {'DISPLAY': ':0', 03:57:26 INFO - 'HOME': '/home/cltbld', 03:57:26 INFO - 'LANG': 'en_US.UTF-8', 03:57:26 INFO - 'LANGUAGE': 'en_US:en', 03:57:26 INFO - 'LOGNAME': 'cltbld', 03:57:26 INFO - 'MAIL': '/var/mail/cltbld', 03:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:26 INFO - 'MOZ_NO_REMOTE': '1', 03:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:26 INFO - 'NO_EM_RESTART': '1', 03:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:26 INFO - 'PWD': '/builds/slave/test', 03:57:26 INFO - 'SHELL': '/bin/bash', 03:57:26 INFO - 'SHLVL': '1', 03:57:26 INFO - 'TERM': 'linux', 03:57:26 INFO - 'TMOUT': '86400', 03:57:26 INFO - 'USER': 'cltbld', 03:57:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:26 INFO - '_': '/tools/buildbot/bin/python'} 03:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:26 INFO - Downloading/unpacking jsonschema==2.5.1 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:57:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:57:28 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 03:57:28 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 03:57:28 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 03:57:28 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 03:57:28 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 03:57:28 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 03:57:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:57:29 INFO - warning: no files found matching '*.txt' 03:57:29 INFO - no previously-included directories found matching 'build' 03:57:29 INFO - no previously-included directories found matching 'dist' 03:57:29 INFO - no previously-included directories found matching '.git*' 03:57:29 INFO - Installing collected packages: jsonschema, functools32 03:57:29 INFO - Running setup.py install for functools32 03:57:29 INFO - warning: no files found matching '*.txt' 03:57:29 INFO - no previously-included directories found matching 'build' 03:57:29 INFO - no previously-included directories found matching 'dist' 03:57:29 INFO - no previously-included directories found matching '.git*' 03:57:29 INFO - Successfully installed jsonschema functools32 03:57:29 INFO - Cleaning up... 03:57:29 INFO - Return code: 0 03:57:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', '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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:57: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 functools32==3.2.3-2 03:57:29 INFO - Using env: {'DISPLAY': ':0', 03:57:29 INFO - 'HOME': '/home/cltbld', 03:57:29 INFO - 'LANG': 'en_US.UTF-8', 03:57:29 INFO - 'LANGUAGE': 'en_US:en', 03:57:29 INFO - 'LOGNAME': 'cltbld', 03:57:29 INFO - 'MAIL': '/var/mail/cltbld', 03:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:29 INFO - 'MOZ_NO_REMOTE': '1', 03:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:29 INFO - 'NO_EM_RESTART': '1', 03:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:29 INFO - 'PWD': '/builds/slave/test', 03:57:29 INFO - 'SHELL': '/bin/bash', 03:57:29 INFO - 'SHLVL': '1', 03:57:29 INFO - 'TERM': 'linux', 03:57:29 INFO - 'TMOUT': '86400', 03:57:29 INFO - 'USER': 'cltbld', 03:57:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:29 INFO - '_': '/tools/buildbot/bin/python'} 03:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:57:29 INFO - Cleaning up... 03:57:29 INFO - Return code: 0 03:57:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:57: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')]} 03:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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')]} 03:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57: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', '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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:57: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 blobuploader==1.2.4 03:57:29 INFO - Using env: {'DISPLAY': ':0', 03:57:29 INFO - 'HOME': '/home/cltbld', 03:57:29 INFO - 'LANG': 'en_US.UTF-8', 03:57:29 INFO - 'LANGUAGE': 'en_US:en', 03:57:29 INFO - 'LOGNAME': 'cltbld', 03:57:29 INFO - 'MAIL': '/var/mail/cltbld', 03:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:29 INFO - 'MOZ_NO_REMOTE': '1', 03:57:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:29 INFO - 'NO_EM_RESTART': '1', 03:57:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:29 INFO - 'PWD': '/builds/slave/test', 03:57:29 INFO - 'SHELL': '/bin/bash', 03:57:29 INFO - 'SHLVL': '1', 03:57:29 INFO - 'TERM': 'linux', 03:57:29 INFO - 'TMOUT': '86400', 03:57:29 INFO - 'USER': 'cltbld', 03:57:29 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:29 INFO - '_': '/tools/buildbot/bin/python'} 03:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:57:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57: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 03:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:57:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:32 INFO - Downloading docopt-0.6.1.tar.gz 03:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:57:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:57:32 INFO - Running setup.py install for blobuploader 03:57:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:57:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:57:32 INFO - Running setup.py install for requests 03:57:32 INFO - Running setup.py install for docopt 03:57:33 INFO - Successfully installed blobuploader requests docopt 03:57:33 INFO - Cleaning up... 03:57:33 INFO - Return code: 0 03:57:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:33 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')]} 03:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:33 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')]} 03:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:33 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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57:33 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 03:57:33 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 03:57:33 INFO - Using env: {'DISPLAY': ':0', 03:57:33 INFO - 'HOME': '/home/cltbld', 03:57:33 INFO - 'LANG': 'en_US.UTF-8', 03:57:33 INFO - 'LANGUAGE': 'en_US:en', 03:57:33 INFO - 'LOGNAME': 'cltbld', 03:57:33 INFO - 'MAIL': '/var/mail/cltbld', 03:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:33 INFO - 'MOZ_NO_REMOTE': '1', 03:57:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:33 INFO - 'NO_EM_RESTART': '1', 03:57:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:33 INFO - 'PWD': '/builds/slave/test', 03:57:33 INFO - 'SHELL': '/bin/bash', 03:57:33 INFO - 'SHLVL': '1', 03:57:33 INFO - 'TERM': 'linux', 03:57:33 INFO - 'TMOUT': '86400', 03:57:33 INFO - 'USER': 'cltbld', 03:57:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:33 INFO - '_': '/tools/buildbot/bin/python'} 03:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:33 INFO - Running setup.py (path:/tmp/pip-0eO35G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:33 INFO - Running setup.py (path:/tmp/pip-q7Oayl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:33 INFO - Running setup.py (path:/tmp/pip-scrIkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:33 INFO - Running setup.py (path:/tmp/pip-Naae1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:33 INFO - Running setup.py (path:/tmp/pip-3bLUWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:33 INFO - Running setup.py (path:/tmp/pip-vcLp2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:33 INFO - Running setup.py (path:/tmp/pip-35EY0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:33 INFO - Running setup.py (path:/tmp/pip-VU34KB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:33 INFO - Running setup.py (path:/tmp/pip-iJ2_RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:33 INFO - Running setup.py (path:/tmp/pip-PlDCyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:34 INFO - Running setup.py (path:/tmp/pip-dKA1Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:34 INFO - Running setup.py (path:/tmp/pip-TT0e5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:34 INFO - Running setup.py (path:/tmp/pip-9GF0ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:34 INFO - Running setup.py (path:/tmp/pip-YMYcJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:34 INFO - Running setup.py (path:/tmp/pip-iR45g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:34 INFO - Running setup.py (path:/tmp/pip-IdT0LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:34 INFO - Running setup.py (path:/tmp/pip-q7U2PE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:57:34 INFO - Running setup.py install for manifestparser 03:57:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:57:34 INFO - Running setup.py install for mozcrash 03:57:34 INFO - Running setup.py install for mozdebug 03:57:34 INFO - Running setup.py install for mozdevice 03:57:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:57:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:57:34 INFO - Running setup.py install for mozfile 03:57:35 INFO - Running setup.py install for mozhttpd 03:57:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozinfo 03:57:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozInstall 03:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozleak 03:57:35 INFO - Running setup.py install for mozlog 03:57:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for moznetwork 03:57:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozprocess 03:57:35 INFO - Running setup.py install for mozprofile 03:57:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:57:35 INFO - Running setup.py install for mozrunner 03:57:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:57:36 INFO - Running setup.py install for mozscreenshot 03:57:36 INFO - Running setup.py install for moztest 03:57:36 INFO - Running setup.py install for mozversion 03:57:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:57:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:57:36 INFO - Cleaning up... 03:57:36 INFO - Return code: 0 03:57:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:36 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')]} 03:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:36 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')]} 03:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:36 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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57:36 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 03:57:36 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 03:57:36 INFO - Using env: {'DISPLAY': ':0', 03:57:36 INFO - 'HOME': '/home/cltbld', 03:57:36 INFO - 'LANG': 'en_US.UTF-8', 03:57:36 INFO - 'LANGUAGE': 'en_US:en', 03:57:36 INFO - 'LOGNAME': 'cltbld', 03:57:36 INFO - 'MAIL': '/var/mail/cltbld', 03:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:36 INFO - 'MOZ_NO_REMOTE': '1', 03:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:36 INFO - 'NO_EM_RESTART': '1', 03:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:36 INFO - 'PWD': '/builds/slave/test', 03:57:36 INFO - 'SHELL': '/bin/bash', 03:57:36 INFO - 'SHLVL': '1', 03:57:36 INFO - 'TERM': 'linux', 03:57:36 INFO - 'TMOUT': '86400', 03:57:36 INFO - 'USER': 'cltbld', 03:57:36 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:36 INFO - '_': '/tools/buildbot/bin/python'} 03:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:57:36 INFO - Running setup.py (path:/tmp/pip-d4Ff92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:57:36 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)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:57:36 INFO - Running setup.py (path:/tmp/pip-PqisM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:57:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:57:36 INFO - Running setup.py (path:/tmp/pip-Qs6Wkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:57:36 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)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:57:36 INFO - Running setup.py (path:/tmp/pip-O88NUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:57:36 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)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:57:36 INFO - Running setup.py (path:/tmp/pip-GIgFgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:57:36 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)) 03:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:57:36 INFO - Running setup.py (path:/tmp/pip-TkHraQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:57:37 INFO - Running setup.py (path:/tmp/pip-gVxe9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:57:37 INFO - Running setup.py (path:/tmp/pip-lgLGrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:57:37 INFO - Running setup.py (path:/tmp/pip-eWxF3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:57:37 INFO - Running setup.py (path:/tmp/pip-SQH_gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:57:37 INFO - Running setup.py (path:/tmp/pip-0Un88s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:57:37 INFO - Running setup.py (path:/tmp/pip-1WdrQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:57:37 INFO - Running setup.py (path:/tmp/pip-4nj9nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:57:37 INFO - Running setup.py (path:/tmp/pip-7aq8TU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:37 INFO - Running setup.py (path:/tmp/pip-zTh9Pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:57:37 INFO - Running setup.py (path:/tmp/pip-T5TRCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:57:37 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)) 03:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:57:37 INFO - Running setup.py (path:/tmp/pip-cq53rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:57:37 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)) 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:57:37 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)) 03:57:37 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)) 03:57:37 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)) 03:57:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:57:39 INFO - Downloading blessings-1.6.tar.gz 03:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:57:39 INFO - Installing collected packages: blessings 03:57:39 INFO - Running setup.py install for blessings 03:57:40 INFO - Successfully installed blessings 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:40 INFO - Reading from file tmpfile_stdout 03:57:40 INFO - Current package versions: 03:57:40 INFO - argparse == 1.2.1 03:57:40 INFO - blessings == 1.6 03:57:40 INFO - blobuploader == 1.2.4 03:57:40 INFO - docopt == 0.6.1 03:57:40 INFO - functools32 == 3.2.3-2 03:57:40 INFO - jsonschema == 2.5.1 03:57:40 INFO - manifestparser == 1.1 03:57:40 INFO - mozInstall == 1.12 03:57:40 INFO - mozcrash == 1.0 03:57:40 INFO - mozdebug == 0.1 03:57:40 INFO - mozdevice == 0.48 03:57:40 INFO - mozfile == 1.2 03:57:40 INFO - mozhttpd == 0.7 03:57:40 INFO - mozinfo == 0.9 03:57:40 INFO - mozleak == 0.1 03:57:40 INFO - mozlog == 3.4 03:57:40 INFO - moznetwork == 0.27 03:57:40 INFO - mozprocess == 0.23 03:57:40 INFO - mozprofile == 0.28 03:57:40 INFO - mozrunner == 6.13 03:57:40 INFO - mozscreenshot == 0.1 03:57:40 INFO - mozsystemmonitor == 0.3 03:57:40 INFO - moztest == 0.7 03:57:40 INFO - mozversion == 1.4 03:57:40 INFO - psutil == 3.1.1 03:57:40 INFO - requests == 1.2.3 03:57:40 INFO - wsgiref == 0.1.2 03:57:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:57:40 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')]} 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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')]} 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57:40 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 03:57:40 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 03:57:40 INFO - Using env: {'DISPLAY': ':0', 03:57:40 INFO - 'HOME': '/home/cltbld', 03:57:40 INFO - 'LANG': 'en_US.UTF-8', 03:57:40 INFO - 'LANGUAGE': 'en_US:en', 03:57:40 INFO - 'LOGNAME': 'cltbld', 03:57:40 INFO - 'MAIL': '/var/mail/cltbld', 03:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:40 INFO - 'MOZ_NO_REMOTE': '1', 03:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:40 INFO - 'NO_EM_RESTART': '1', 03:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:40 INFO - 'PWD': '/builds/slave/test', 03:57:40 INFO - 'SHELL': '/bin/bash', 03:57:40 INFO - 'SHLVL': '1', 03:57:40 INFO - 'TERM': 'linux', 03:57:40 INFO - 'TMOUT': '86400', 03:57:40 INFO - 'USER': 'cltbld', 03:57:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:40 INFO - '_': '/tools/buildbot/bin/python'} 03:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 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)) 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:57:40 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')]} 03:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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')]} 03:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:57:40 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 0x7fb7cdfc5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', '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 03:57:40 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 03:57:40 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 03:57:40 INFO - Using env: {'DISPLAY': ':0', 03:57:40 INFO - 'HOME': '/home/cltbld', 03:57:40 INFO - 'LANG': 'en_US.UTF-8', 03:57:40 INFO - 'LANGUAGE': 'en_US:en', 03:57:40 INFO - 'LOGNAME': 'cltbld', 03:57:40 INFO - 'MAIL': '/var/mail/cltbld', 03:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:40 INFO - 'MOZ_NO_REMOTE': '1', 03:57:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:40 INFO - 'NO_EM_RESTART': '1', 03:57:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:40 INFO - 'PWD': '/builds/slave/test', 03:57:40 INFO - 'SHELL': '/bin/bash', 03:57:40 INFO - 'SHLVL': '1', 03:57:40 INFO - 'TERM': 'linux', 03:57:40 INFO - 'TMOUT': '86400', 03:57:40 INFO - 'USER': 'cltbld', 03:57:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:40 INFO - '_': '/tools/buildbot/bin/python'} 03:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:57:40 INFO - Cleaning up... 03:57:40 INFO - Return code: 0 03:57:40 INFO - Running post-action listener: _resource_record_post_action 03:57:40 INFO - Running post-action listener: _start_resource_monitoring 03:57:40 INFO - Starting resource monitoring. 03:57:40 INFO - [mozharness: 2016-12-19 11:57:40.781592Z] Finished create-virtualenv step (success) 03:57:40 INFO - [mozharness: 2016-12-19 11:57:40.782118Z] Running install step. 03:57:40 INFO - Running pre-action listener: _resource_record_pre_action 03:57:40 INFO - Running main action method: install 03:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:57:40 INFO - Reading from file tmpfile_stdout 03:57:40 INFO - Detecting whether we're running mozinstall >=1.0... 03:57:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:57:41 INFO - Reading from file tmpfile_stdout 03:57:41 INFO - Output received: 03:57:41 INFO - Usage: mozinstall [options] installer 03:57:41 INFO - Options: 03:57:41 INFO - -h, --help show this help message and exit 03:57:41 INFO - -d DEST, --destination=DEST 03:57:41 INFO - Directory to install application into. [default: 03:57:41 INFO - "/builds/slave/test"] 03:57:41 INFO - --app=APP Application being installed. [default: firefox] 03:57:41 INFO - mkdir: /builds/slave/test/build/application 03:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:57:57 INFO - Reading from file tmpfile_stdout 03:57:57 INFO - Output received: 03:57:57 INFO - /builds/slave/test/build/application/firefox/firefox 03:57:57 INFO - Running post-action listener: _resource_record_post_action 03:57:57 INFO - [mozharness: 2016-12-19 11:57:57.006883Z] Finished install step (success) 03:57:57 INFO - [mozharness: 2016-12-19 11:57:57.007125Z] Running run-tests step. 03:57:57 INFO - Running pre-action listener: _resource_record_pre_action 03:57:57 INFO - Running main action method: run_tests 03:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:57:57 INFO - Python 2.7.3 03:57:57 INFO - Return code: 0 03:57:57 INFO - grabbing minidump binary from tooltool 03:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:57 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 0x28c0f60>, '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 0x28c1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28c21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:57:57 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 03:57:57 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 03:57:57 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 03:57:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:57:57 INFO - Return code: 0 03:57:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:57:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:57:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:57:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:57:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 03:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 03:57:57 INFO - Using env: {'DISPLAY': ':0', 03:57:57 INFO - 'HOME': '/home/cltbld', 03:57:57 INFO - 'LANG': 'en_US.UTF-8', 03:57:57 INFO - 'LANGUAGE': 'en_US:en', 03:57:57 INFO - 'LOGNAME': 'cltbld', 03:57:57 INFO - 'MAIL': '/var/mail/cltbld', 03:57:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:57:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:57:57 INFO - 'MOZ_NO_REMOTE': '1', 03:57:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:57:57 INFO - 'NO_EM_RESTART': '1', 03:57:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:57:57 INFO - 'PWD': '/builds/slave/test', 03:57:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:57:57 INFO - 'SHELL': '/bin/bash', 03:57:57 INFO - 'SHLVL': '1', 03:57:57 INFO - 'TERM': 'linux', 03:57:57 INFO - 'TMOUT': '86400', 03:57:57 INFO - 'USER': 'cltbld', 03:57:57 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989', 03:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:57:57 INFO - '_': '/tools/buildbot/bin/python'} 03:57:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 03:57:57 INFO - mozversion application_buildid: 20161219021638 03:57:57 INFO - mozversion application_changeset: 7a9e103be35066bd7c06e770a73b7401ce1e2620 03:57:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:57:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:57:57 INFO - mozversion application_name: Firefox 03:57:57 INFO - mozversion application_remotingname: firefox-dev 03:57:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:57 INFO - mozversion application_vendor: Mozilla 03:57:57 INFO - mozversion application_version: 52.0a2 03:57:57 INFO - mozversion platform_buildid: 20161219021638 03:57:57 INFO - mozversion platform_changeset: 7a9e103be35066bd7c06e770a73b7401ce1e2620 03:57:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:57:57 INFO - mozversion platform_version: 52.0a2 03:57:57 INFO - using testdate: 1482148677 03:57:57 INFO - actual date: 1482148677 03:57:57 INFO - starting webserver on 'localhost:38815' 03:57:57 INFO - SUITE-START | Running 2 tests 03:57:57 INFO - TEST-START | dromaeo_css 03:57:57 INFO - operating with platform_type : linux_ 03:57:57 INFO - Initialising browser for dromaeo_css test... 03:57:57 INFO - TEST-INFO | started process 24984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp14mlAO/profile http://localhost:38815/getInfo.html) 03:58:01 INFO - PROCESS | 24984 | __metrics Screen width/height:1600/1200 03:58:01 INFO - PROCESS | 24984 | colorDepth:24 03:58:01 INFO - PROCESS | 24984 | Browser inner width/height: 1024/697 03:58:01 INFO - PROCESS | 24984 | __metrics 03:58:02 INFO - PROCESS | 24984 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:58:02 INFO - PROCESS | 24984 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:58:02 INFO - PROCESS | 24984 | console.error: PushService: 03:58:02 INFO - PROCESS | 24984 | stateChangeProcessEnqueue: Error transitioning state 03:58:02 INFO - PROCESS | 24984 | UnknownError 03:58:03 INFO - TEST-INFO | 24984: exit 0 03:58:03 INFO - Browser initialized. 03:58:03 INFO - Running cycle 1/1 for dromaeo_css test... 03:58:03 INFO - TEST-INFO | started process 25077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp14mlAO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:15 INFO - PROCESS | 25077 | RSS: Main: 144609280 03:58:15 INFO - PROCESS | 25077 | 03:59:06 INFO - PROCESS | 25077 | 1482148746705 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] 04:01:16 INFO - PROCESS | 25077 | Cycle 1(1): loaded http://localhost:38815/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38815/tests/dromaeo/cssquery-ext.html) 04:01:18 INFO - PROCESS | 25077 | RSS: Main: 248819712 04:01:18 INFO - PROCESS | 25077 | 04:04:20 INFO - PROCESS | 25077 | Cycle 1(1): loaded http://localhost:38815/tests/dromaeo/cssquery-ext.html (next: http://localhost:38815/tests/dromaeo/cssquery-jquery.html) 04:04:21 INFO - PROCESS | 25077 | RSS: Main: 226459648 04:04:21 INFO - PROCESS | 25077 | 04:07:23 INFO - PROCESS | 25077 | Cycle 1(1): loaded http://localhost:38815/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38815/tests/dromaeo/cssquery-mootools.html) 04:07:23 INFO - PROCESS | 25077 | RSS: Main: 215130112 04:07:23 INFO - PROCESS | 25077 | 04:10:25 INFO - PROCESS | 25077 | Cycle 1(1): loaded http://localhost:38815/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38815/tests/dromaeo/cssquery-prototype.html) 04:10:26 INFO - PROCESS | 25077 | RSS: Main: 217227264 04:10:26 INFO - PROCESS | 25077 | 04:13:28 INFO - PROCESS | 25077 | Cycle 1(1): loaded http://localhost:38815/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38815/tests/dromaeo/cssquery-yui.html) 04:13:29 INFO - PROCESS | 25077 | RSS: Main: 180297728 04:13:29 INFO - PROCESS | 25077 | 04:16:31 INFO - PROCESS | 25077 | Cycle 1(1): loaded http://localhost:38815/tests/dromaeo/cssquery-yui.html (next: http://localhost:38815/tests/dromaeo/cssquery-dojo.html) 04:16:32 INFO - PROCESS | 25077 | RSS: Main: 267583488 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | __start_tp_report 04:16:32 INFO - PROCESS | 25077 | _x_x_mozilla_page_load 04:16:32 INFO - PROCESS | 25077 | _x_x_mozilla_page_load_details 04:16:32 INFO - PROCESS | 25077 | |i|pagename|runs| 04:16:32 INFO - PROCESS | 25077 | |0;dojo.html;3195.760317976152;3226.709596136347;3241.2707140893303;3264.869405223791;3283.22844131629;5567.220589117522;5646.407127251636;5653.6607803531715;5657.773689052443;5669.121286200645;5612.5229355504725;5676.460736230062;5679.630823996447;5700.572457065727;5712.200291959129;5096.159133742928;5110.412302585213;5128.640995130342;5158.097332966735;5201.297824793661;4954.677945933503;4966.304717339575;5180.818671346504;5181.559567436753;5212;5067.467915868836;5075.720835354054;5085.669431486942;5102.668326558781;5140.126178549637;5160.587153027749;5163.63854530183;5169.043726910533;5170.172772356443;5196.0387328343995;4863.708177509326;5066.113430149746;5084.339035925343;5116.923246151311;5139.8458046258675;5448.91826622601;5478.397376288605;5484.369297530755;5509.256250406184;5548.306461692288;5883.558733095035;5888.146218798251;5998.070299103602;6001.039833626643;6005.369436209223;5833.79581714638;6014.879702405971;6031.095335699636;6041.848953776147;6043.365446628129;5490.6431081979545;5580.832575022756;5593.32880054392;5624.6625202487985;5648.4633959773755;6178.443940045418;6186.10301506288;6186.412290832363;6190.288116866528;6195.628262304276;5774.2782152230975;5923.229980102559;5931.288245410492;5932.614380065282;5936.910946335808;5887.911681324784;5917.881642367214;5964;5969.194158788595;6061.484773794277;5985.730642121115;5987.101934709741;5998.970005149947;5999.970000150059;6029.517638588903;5926.496247818897;5984.31180414258;5985.940140598538;5992.43071908168;6002.309734380515;4564.680472366902;4564.8402305919135;4588.334691469719;4601.608863246662;4611.838585649486;4111.527174374985;4135.234981528427;4145.067359844072;4166.562510936308;4168.583141685807;5774.393688662714;5776.68228247442;5780.826575202751;5782.3639399666;5783.190353350535;5797.768089276466;5851.824445266649;5935.317438494629;6003.8198854034445;6065.6663883486835;5720.542356611461;5743;5758.280214973129;5761.4526619971875;5786.305643322744;5178.093833579109;5184.11869982104;5184.14461613837;5188.040212560688;5213.165893457029;6012.248468941382;6017.368176341509;6092.238470191226;6176.258848938156;6239.032949892774;5946.881062378815;6045.063015232646;6066.575339726177;6086.786962456293;6092.208012958287;6214.751409943552;6240.906386404298;6243.687815609293;6252.937470625236;6265.185525881606;5700.942990570041;5702.401247868914;5951.226340575698;5968.403159683997;5993.041113421831;5960.970195148997;5989.610675306091;6002.789902353396;6065;6103.08453731926;5836.795712150054;5877.35349111606;5885.14665373527;5904.173415721716;5922.200502932049;5611;5882.352941176381;5892.793752218652;5893.2044174035955;5895.734691938959;5639.746211420414;5719.256496655408;5750.309962804323;5798.82603521895;5859.150423188528;5953.642781433128;5954.583179177416;5964.433378829004;5966.910496342472;5981.431763982415;5601.747921343468;5654.660720356792;5660.915086273627;5809.854753631024;5822.970885145716 04:16:32 INFO - PROCESS | 25077 | |1;ext.html;585.6895845202042;599.688162155679;620.5811077522673;648.3646026893645;665.7004348043382;33552.66447335526;43174;44107.55892441075;44214.778926105326;44316.3352549712;45097;45512.54487455125;45573.772131139296;45635.315470267975;45692.3146152808;8272.296854767323;8796.69211577595;8976.281897448189;8980.057094005133;8981.955090224572;8285.50286982783;10393.584256629725;10609.78780424391;10617.309874858109;10972.341659500416;10908.50911708975;10960.506777195005;10972.615958441456;10980.231383803137;10983.725406864813;10717;10739.731506712316;10759.193060520493;10781.62264320749;10781.892181078167;10658.200634952409;10756.085732712729;10761.51573179201;10763.515641796059;10769.676909692722;42329.788351058356;42619;42712;42763;42789.78605106955;3547.875824346161;3651.397519409294;3824.4072168813877;3967.444557761916;4344.348347747831;33119.13540121192;33484.49773253403;33487.16282092943;33649.327013459595;34180.658193418;4371.562843715635;4401.581849724271;4416.6025057744955;4503.347014682885;4549.340345649895;368297;369382;371709;373118;374267.99999999726;57752.71123644355;58146.7092664534;58153.12770308449;58157.70921145367;58216.41783582194;37820.62179378226;38732.2253554933;38980.80509597491;41416.378754318706;60074.699626501584;18420;18784.154713037948;18900.621987560447;18908.527286817665;18933.242670293308;12374.071944604191;12588.937055314665;14312.85687143136;14327.498537551135;14468.638284042983;19146.234150634096;19683.212671493267;19932.70100948487;19945.900270498845;20022.69965950512;7232.276772322831;7274.1634712007735;7284.0428180234;7302.306280903305;7362;990.3612170150357;1064.984025239622;1077.6659235636978;1132.2527132092944;1181.5923506390282;32710.528026238877;33012;33122.17194570155;33330.16674583155;33646;1033.3569624297404;1110.9723505757142;1132.0943245403644;1145.9656210313703;1160.2748282323548;14754.704905901823;17072.146392680315;17508.037057961934;18239;18341;574853;575502;576677;577647;579204;58329;58922.41077589255;58963.11555326673;58973.41026589765;58996.05019748995;1342.2885820578645;1381.7927310903444;1404.7120340330207;1405.5150972914532;1408.253625578445;30419.604831389614;32309.676903230666;32346;32577.67422325841;32764.34471310513;50180.74909625429;50462.74768626133;50647.46762661926;50750.49249507458;50764.492355077455;332869;333034;333082;333543;333976;29584.55623165611;31144.532832007084;31751.84124079365;31874;32144.35711285808;49058.75470622624;49225;49336.50663493319;50258.24612630886;50766.492335076175;40185.39721904232;41119.7944010278;41448.58551414568;41847.790761046;42046;41311.793441033806;41609.58390416178;41780.58219417767;42653.14693706046;43566.782166090234;41754.58245417507;41913.79043104765;42944;42963.140737184454;45879.31181032221;36246.27507449889;38568.77694395594;39033.80483097566;39496.802515987234;39544.40683389809;24942.875285623457;25159.49681006406;25259.74740252574;25520.617190742527;25657.358566035997 04:16:32 INFO - PROCESS | 25077 | |2;jquery.html;405.1633377076339;408.86711818658927;409.44520175162637;414.4529221427715;421.5236782435847;15456.69086618267;19095.713564296548;19272.614547709054;19444.319448819293;19460.026998650083;18928.905355473238;19204;19287.939163346044;19449.31927382542;19482.318118865842;5117.309163262968;5486.643368181076;5734.7419366128415;5739.196512488255;6361.55469117162;6398.360163983611;6475.255345635265;6478.708458119396;6480.351964803529;6481.09264702942;5666.660000399989;5904.143899134623;5943.732532036069;5951.018082016484;6309.495240380758;5699.430056994267;5868.706564671749;5884.852878678024;5924.763009479616;5927.2590926134235;5732.168835518826;5759.078547432433;5764.8847023059725;5766.682832444214;5767.250257466502;14702.603252690977;15143;23152.073917043297;23276.185333513247;23417.648735268984;2350.811935045192;2507.485965377093;2534.8605826679527;2664.9866750666315;2766.640336756209;10705.143588512978;10942.17933654979;11060.723481912935;11072.501737421835;11207.887921120848;1967.2293450819209;1968.4193163016944;1991.7609886813675;2009.1059478532059;2089.1956596710374;83246;87217.56391218067;88874.5556272221;90707.54646226727;90798.09201908029;11326.244432113035;11551.88448115508;11688.240264382957;11710.531578736925;11968.461419236155;16874.578135546708;16884.324627014783;16885.577860553585;16896.155192240338;16908.154592270585;8485.703000394957;8639.438436501607;8697.173768491983;8717.346199034972;8744.781380465412;8075.232852878967;8170;8355.206255405727;8392.496450213006;8467.364947628952;4708.681569160572;4862.100511405401;5016.899662006739;5018.523240292239;5164.535191832678;2049.200811683415;2079.9480012999493;2086.2698055680694;2089.3627443629534;2123.193186589086;478.8228355508484;916.390600250839;962.3023308101571;1003.5383723487278;1008.5763979128784;11750.764984700429;12294.75410491785;12406.689832754253;12665.240085594894;13005.674858128434;501.31069779053803;504.4577079639402;515.9922601160986;517.3326408932435;523.3588853654243;6675.566088204251;6834.829129271709;6878.140232470942;6903.896441553381;6910.136232970879;480263;483725;501028;529349;530703;100078.4996075015;100618.496907515;102803.4859825696;103377.48311258396;106002;512.8794733237686;516.0530426667033;518.4090137243545;520.2612290547431;522.7151202594595;11626.767464650491;11737.413129343327;11751.941240294085;11883.524659013543;12083.939580302042;42073.78963105165;42605.36091958561;43786;44080.338794918745;44770.55229447664;63576.36423635705;65410.672946634964;66199.33800661932;66273.33726662671;67082.32917670762;7867.803304917423;8582.472820019075;8940.86588701183;9036.728898133066;9099.226565741987;11733.823992640288;13488.190708557519;13621.182729035892;13694.52069177574;13708.725825483634;5868.2077919480325;6906.620135892575;11736.70658233551;11805.527778889093;12278.219658149697;11568.942155289169;11778.293302401884;11883.940580297389;11923.582674606347;12106.576269830513;6093.817185484442;9163.862542062008;10944.726381840517;12551.623451296111;12610.432530535965;8311.833763324821;8368.665253389796;8388.822889317034;8526.78683032929;8628.266597339045;9342.95328523353;12197.69505762363;12371.814422783846;12446.06654500898;12546.435410406737 04:16:32 INFO - PROCESS | 25077 | |3;mootools.html;1287.0733072188025;1293.683047653325;1366;1374.8625137486254;1687.4009726547067;7844.666406710859;8192.385571082163;8434.53610051447;8446.619902104398;8619.525926074064;8422.28410585101;8501.23488886;8509.021462531811;8511.531865747382;8514.361422893277;2454.7054353477565;2469.4196863737006;2482.429041320497;2484.428581426273;2484.8260621756485;2423.6364545318165;2531.3418511187133;2534.936626584332;2538.263903467992;2546.363409147713;2441.6703744994466;2446;2459.3359792855917;2468.358226861011;2474.0969546115716;2376.394019525019;2379.4289370551114;2414.4446777241333;2431.8297719159664;2438.085717855804;2376.6435034744754;2385.9522809543714;2432.939176520601;2433.829631925766;2434.561778879801;8324.750257492286;8545.914540854636;8677.088905664941;8681.435706679045;8752.256058234994;5300.681959082467;5409.323834520685;5415.241866138744;5418.187271909245;5462.153366228241;3523.6828685418177;3598.280343931198;3666.7066634669163;3672.2288319452946;3749.1376983293994;1131.6887855839627;1141.760230351619;1150.8791576884473;1151.4645689754304;1170.9917491502115;12289.815652765126;12328.630141095782;12370.505179792797;12377.814332785016;12379.62861114159;4254.276772948544;4559.110973360229;4613.123506533748;4628.421447319085;4655.045715628288;9663.27525435595;9731.172850307803;9733.075357840993;9735.221182305399;9735.367201131903;5392.622516423891;5392.784288628411;5393.6224464287125;5396.83809485716;5399.892002160013;4196.412502249687;4336.978315108404;4452.977735111369;4459.732416055047;5058.544730974157;3893.377059670439;3913.5695073541888;4011.91976160481;4020.4974378202724;4024.678025757932;1217.5936793004093;1217.6773155113901;1227.79127548317;1241.5840693367822;1242.6955395928055;880.1814312689261;935.2050756856753;943.1605870775015;944.8299306124826;946.1248345280588;5514.91727624086;5680.517156041783;5723.8569035774435;5949.8215053548465;5992.820215393545;931.771715929588;948.9478078705599;959.8176346494143;977.3695966101825;992.1814503035025;3984.4023396490757;4179.519355274121;4189.958100419018;4201.243776120266;4265.957340426618;10217.33587316822;10441.477926103664;10468.790624187626;10710.518026688818;10819.67540973772;10663.84004239937;10671.893281067245;10683.83974240387;10693.41186234749;10699.411532365639;7955.602219888982;8116.5941702914615;8175.877361839577;8184.918150818535;8189.79525511867;5771.422857714195;5786.652800831964;5816.360200377871;5839.678817665069;5989.520838332835;9635.181009613982;9664.9033509664;9776.217902567636;9820.754481138028;9823.901760982299;8897;9122.589483473392;9908.752281193028;9914.157296629868;10050.849237261593;7479.139898911477;7600.543967361976;7648.235176482307;7706.344960678405;7801.804954876174;8264.380171487042;8285.83428331418;8349.749507514784;8351.039630442334;8359.205875441823;7350.338469537767;7376.926230737624;7487.251274872469;7510.624468776648;7685.769426917202;7291.234420385783;7397.593132377556;7447.851042979219;7535.623218839146;7649.61751912391;7013.684384202825;7018.227994920657;7081.858362832611;7097.112860892388;7103.538270012433;4942.863141477552;5061.063703214917;5074.162763144188;5113.7187454688865;5190.143626301618;5071.87320316995;5129.307543481731;5215.087359711959;5222.086134926297;5277.076511610529 04:16:32 INFO - PROCESS | 25077 | |4;prototype.html;356.6825525282499;358.23874267182237;361.6744929563392;371.3142333804526;372.2164843005475;5277.920831187535;5338.092524270874;5350.73246337683;5354.357477102753;5362.088444964355;5053.7258233794755;5111.821086261982;5197.246399272103;5201.713905735183;5332.680039197651;4152.97923510382;4157.91684166318;4167.6249137577615;4169.145325208333;4183.3515805050265;4091.4067460218253;4158.313878210091;4194.224068547329;4201.789910504478;4223.239816832969;3838.846446142151;3901.9219615607813;4080;4100.815463304159;4219.894502637428;4158.355454904495;4159.438475805758;4170.416141740159;4188.28799104153;4209.095044565433;3703.3519134151684;3748.3440397930253;3750.6999440044733;3766.303233901737;3772.660460558563;4986.925196122061;5071.18860982241;5100.566451851597;5117.309163262949;5180.533751962342;4778.187708089633;4788.712677239377;4795.448523419816;4815.855524334241;4823.5176482351835;5532.612717109804;5541.722913854291;5543.916841247385;5546.91679624806;5554.50009499147;4020.839166433339;4143.129942712034;4181.770002649853;4185.937210941838;4188.7905604719945;5705.515031222351;5706.572007099484;5707.400722924075;5713.857153571153;5720.914186287209;4244.257254980366;4257.531671516131;4258.382534532476;4266.679999000025;4270.338097594878;4204.516480604709;4231.894202644897;4265.317549192177;4319.935200971988;4335.848245311462;4762.571368576845;4766.404199475066;4767.284907263938;4780.211265141283;4810.350602668595;5462.754176062087;5494.5988772862665;5506.86108917921;5518.66887986714;5523.039321041053;1396.0995158122953;1397.8822084541928;1410.132768347459;1418.7089748328972;1434.5552878607666;964.2093483343731;973.3673112476947;975.068809287129;987.5259875259916;991.5538007896331;5087.923681144712;5093.18509038552;5100;5122.897542049138;5136.512031357015;5404.622111180513;5405.756740946588;5428.701421421781;5436.184572314184;5454.563634909197;4947.35684361038;5078.568321692624;5153.948460515347;5162.92255616166;5173.301604283449;2849.444358350102;2867.6128722622598;2897.884084636633;2898.449294634013;2915.7084291570673;5547.029269877755;5591.161325801081;5596.552275817925;5597.552195824324;5598.748056337475;5365.490278423544;5433.864153396196;5513.283273174542;5519.034169020405;5527.2538207342295;5562.7774889004795;5573.303337082864;5579.7489112990015;5593.496585307342;5598.572364047223;5193.558547523352;5427.6472029317965;5431.782728690808;5465.535429488538;5472.726363681721;5359.571234301325;5367.490088441592;5373.623846330719;5376.73116344189;5395.676259424447;5511.500197374616;5574.554035677055;5579.442055794388;5588.022096133079;5616.85957851057;3988.9202215956097;4097.180563887175;4116.871177904754;4132.966758310423;4134.565870583546;5398.703071331114;5400.675959442446;5407.729613519387;5426.585169599491;5444.373897001896;5303.496167864047;5346.25152478661;5346.679199248058;5348.679079255257;5364.678119312854;5171.172612382001;5302.992431438014;5310.389305229948;5337.386200586982;5378.5966052547;5228.660137091077;5233.502817232356;5249.921251181312;5257.2662215648415;5279.762410691451;5328.520433161034;5329.520343169133;5339.088039004203;5351.1973204019705;5353.598480113929;4954.355933728592;5200.167973124433;5227.849873027928;5232.9738351308;5245.868853278698 04:16:32 INFO - PROCESS | 25077 | |5;yui.html;745.5489428895518;746.7349091072673;777.4518964130285;828.056016141599;830.6760363458252;14861.108333499997;15744.685106297868;15754.13352265625;15756.684866302667;15763.684726305468;14195.92902035491;14367.281635918189;14487.203203823785;14531.273436328167;14546.854531454683;700.5691499727682;718.2279050021222;788.1448628238368;789.3724489031205;809.2352726673296;798.4769975665948;807.2129673568253;807.3016840433041;807.995960020199;808.870580707087;851.259404318244;853.4921721575653;853.8463076646201;854.5556310718423;856.4861083350003;723.7213672736008;743.5092838726415;825.5211977053355;847.4576271186446;847.559269180026;617.8764247150543;620.2092332276338;620.3982137326785;620.4787978098374;620.5997131849977;14291.714165716732;14295.64260893486;14297.928510357382;14345.928270358685;14363;13740.93129534346;13854.376553055137;13864.306784660726;13919.721605567933;14013.299335033309;12686.302253376061;12765.74468510634;12809.340538815852;13069.15050521713;13120.737585248242;4414.271645178542;4449.421575195236;4492.258777301774;4512;4527.298268768346;58204.417955820325;60796.39203607996;60989.69505152446;65546.3445365545;66438;11571.537138514534;11616.593419230456;11648.650540483799;11813.173077884465;11879.821802672966;20447.4888127798;20467.07898144557;20468.488287792625;20471.283505077252;20475.795242047687;8915.643374265086;8922.955385223033;8973.237274831712;9002.189802917768;9357.578908949114;4896.975515122402;4902.166631672624;5016.648834581617;5073.771680274396;5253.343332083489;3637.5816781070516;3755.9671090449797;3762.191128907243;3762.6801721853403;3768.6419790119894;666.9066330713704;724.4168444402306;739.9001134846727;758.1130077808866;759.7227012140639;692.7021380806201;741.8405042915691;748.0686545251089;777.0481160578246;780.8008957715859;9330.253579713606;9775.51122443875;9782.461964592016;9915.603375865028;9980.700578982496;638.9967750631557;676.7901950395295;734.2694019450681;754.2419868032592;767.719782279464;4507.684462087623;4702.600278976257;4802.447718512346;4847.466778654345;4866.245731911559;86315.13684863197;89672.55163724271;90207;91322;92626;64197.67901160464;65556.67221663956;77965.61017194991;79588.20411795808;81205.59397203094;47108.764456178185;50730;65249.347506524326;65757.67121164364;67298;9745.269104817025;9838.212942964403;9857;9970.651027214013;9972.800543988935;47946.76026619845;49056;49121.263181051596;49278.75360623174;49375.753121234164;38815;67150;68020.3197968014;68236.6588167056;70156.64921675563;11619.825702614637;12067.456964436446;12522.123451358317;12963.15739476931;13118.934405327913;14473.276336183359;14527.854721453074;14582.562523124323;14737.263136842901;15562.455314063953;11672.124590655565;12844.614661560168;13432.462701491831;13675.589732308046;14034.157950523002;13695.246761428218;13799.310034498436;13841.100328478617;13928.860711392756;14261;13420.798688019882;13498.257595832323;13542.458301668217;13773.586792396243;13793.10344827583;10712.946435268086;11029.44852757375;11081.944590276997;11235.71910702239;11830.82253766177;11380.43097845121;11931.88350019242;12137.635870923887;12167.209131406431;12192.51229950792 04:16:32 INFO - PROCESS | 25077 | __end_tp_report 04:16:32 INFO - PROCESS | 25077 | __start_cc_report 04:16:32 INFO - PROCESS | 25077 | _x_x_mozilla_cycle_collect,1028 04:16:32 INFO - PROCESS | 25077 | __end_cc_report 04:16:32 INFO - PROCESS | 25077 | __startTimestamp1482149792168__endTimestamp 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | ------- Summary: start ------- 04:16:32 INFO - PROCESS | 25077 | Number of tests: 6 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | [#0] dojo.html Cycles:165 Average:5575.47 Median:5782.36 stddev:627.84 (10.9%) stddev-sans-first:601.37 04:16:32 INFO - PROCESS | 25077 | Values: 3195.8 3226.7 3241.3 3264.9 3283.2 5567.2 5646.4 5653.7 5657.8 5669.1 5612.5 5676.5 5679.6 5700.6 5712.2 5096.2 5110.4 5128.6 5158.1 5201.3 4954.7 4966.3 5180.8 5181.6 5212.0 5067.5 5075.7 5085.7 5102.7 5140.1 5160.6 5163.6 5169.0 5170.2 5196.0 4863.7 5066.1 5084.3 5116.9 5139.8 5448.9 5478.4 5484.4 5509.3 5548.3 5883.6 5888.1 5998.1 6001.0 6005.4 5833.8 6014.9 6031.1 6041.8 6043.4 5490.6 5580.8 5593.3 5624.7 5648.5 6178.4 6186.1 6186.4 6190.3 6195.6 5774.3 5923.2 5931.3 5932.6 5936.9 5887.9 5917.9 5964.0 5969.2 6061.5 5985.7 5987.1 5999.0 6000.0 6029.5 5926.5 5984.3 5985.9 5992.4 6002.3 4564.7 4564.8 4588.3 4601.6 4611.8 4111.5 4135.2 4145.1 4166.6 4168.6 5774.4 5776.7 5780.8 5782.4 5783.2 5797.8 5851.8 5935.3 6003.8 6065.7 5720.5 5743.0 5758.3 5761.5 5786.3 5178.1 5184.1 5184.1 5188.0 5213.2 6012.2 6017.4 6092.2 6176.3 6239.0 5946.9 6045.1 6066.6 6086.8 6092.2 6214.8 6240.9 6243.7 6252.9 6265.2 5700.9 5702.4 5951.2 5968.4 5993.0 5961.0 5989.6 6002.8 6065.0 6103.1 5836.8 5877.4 5885.1 5904.2 5922.2 5611.0 5882.4 5892.8 5893.2 5895.7 5639.7 5719.3 5750.3 5798.8 5859.2 5953.6 5954.6 5964.4 5966.9 5981.4 5601.7 5654.7 5660.9 5809.9 5823.0 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | [#1] ext.html Cycles:180 Average:59257.88 Median:373693.00 stddev:116789.92 (31.3%) stddev-sans-first:117034.47 04:16:32 INFO - PROCESS | 25077 | Values: 585.7 599.7 620.6 648.4 665.7 33552.7 43174.0 44107.6 44214.8 44316.3 45097.0 45512.5 45573.8 45635.3 45692.3 8272.3 8796.7 8976.3 8980.1 8982.0 8285.5 10393.6 10609.8 10617.3 10972.3 10908.5 10960.5 10972.6 10980.2 10983.7 10717.0 10739.7 10759.2 10781.6 10781.9 10658.2 10756.1 10761.5 10763.5 10769.7 42329.8 42619.0 42712.0 42763.0 42789.8 3547.9 3651.4 3824.4 3967.4 4344.3 33119.1 33484.5 33487.2 33649.3 34180.7 4371.6 4401.6 4416.6 4503.3 4549.3 368297.0 369382.0 371709.0 373118.0 374268.0 57752.7 58146.7 58153.1 58157.7 58216.4 37820.6 38732.2 38980.8 41416.4 60074.7 18420.0 18784.2 18900.6 18908.5 18933.2 12374.1 12588.9 14312.9 14327.5 14468.6 19146.2 19683.2 19932.7 19945.9 20022.7 7232.3 7274.2 7284.0 7302.3 7362.0 990.4 1065.0 1077.7 1132.3 1181.6 32710.5 33012.0 33122.2 33330.2 33646.0 1033.4 1111.0 1132.1 1146.0 1160.3 14754.7 17072.1 17508.0 18239.0 18341.0 574853.0 575502.0 576677.0 577647.0 579204.0 58329.0 58922.4 58963.1 58973.4 58996.1 1342.3 1381.8 1404.7 1405.5 1408.3 30419.6 32309.7 32346.0 32577.7 32764.3 50180.7 50462.7 50647.5 50750.5 50764.5 332869.0 333034.0 333082.0 333543.0 333976.0 29584.6 31144.5 31751.8 31874.0 32144.4 49058.8 49225.0 49336.5 50258.2 50766.5 40185.4 41119.8 41448.6 41847.8 42046.0 41311.8 41609.6 41780.6 42653.1 43566.8 41754.6 41913.8 42944.0 42963.1 45879.3 36246.3 38568.8 39033.8 39496.8 39544.4 24942.9 25159.5 25259.7 25520.6 25657.4 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | [#2] jquery.html Cycles:180 Average:29664.66 Median:44425.45 stddev:83822.37 (188.7%) stddev-sans-first:84028.72 04:16:32 INFO - PROCESS | 25077 | Values: 405.2 408.9 409.4 414.5 421.5 15456.7 19095.7 19272.6 19444.3 19460.0 18928.9 19204.0 19287.9 19449.3 19482.3 5117.3 5486.6 5734.7 5739.2 6361.6 6398.4 6475.3 6478.7 6480.4 6481.1 5666.7 5904.1 5943.7 5951.0 6309.5 5699.4 5868.7 5884.9 5924.8 5927.3 5732.2 5759.1 5764.9 5766.7 5767.3 14702.6 15143.0 23152.1 23276.2 23417.6 2350.8 2507.5 2534.9 2665.0 2766.6 10705.1 10942.2 11060.7 11072.5 11207.9 1967.2 1968.4 1991.8 2009.1 2089.2 83246.0 87217.6 88874.6 90707.5 90798.1 11326.2 11551.9 11688.2 11710.5 11968.5 16874.6 16884.3 16885.6 16896.2 16908.2 8485.7 8639.4 8697.2 8717.3 8744.8 8075.2 8170.0 8355.2 8392.5 8467.4 4708.7 4862.1 5016.9 5018.5 5164.5 2049.2 2079.9 2086.3 2089.4 2123.2 478.8 916.4 962.3 1003.5 1008.6 11750.8 12294.8 12406.7 12665.2 13005.7 501.3 504.5 516.0 517.3 523.4 6675.6 6834.8 6878.1 6903.9 6910.1 480263.0 483725.0 501028.0 529349.0 530703.0 100078.5 100618.5 102803.5 103377.5 106002.0 512.9 516.1 518.4 520.3 522.7 11626.8 11737.4 11751.9 11883.5 12083.9 42073.8 42605.4 43786.0 44080.3 44770.6 63576.4 65410.7 66199.3 66273.3 67082.3 7867.8 8582.5 8940.9 9036.7 9099.2 11733.8 13488.2 13621.2 13694.5 13708.7 5868.2 6906.6 11736.7 11805.5 12278.2 11568.9 11778.3 11883.9 11923.6 12106.6 6093.8 9163.9 10944.7 12551.6 12610.4 8311.8 8368.7 8388.8 8526.8 8628.3 9343.0 12197.7 12371.8 12446.1 12546.4 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | [#3] mootools.html Cycles:180 Average:5709.35 Median:5288.88 stddev:3164.61 (59.8%) stddev-sans-first:3156.03 04:16:32 INFO - PROCESS | 25077 | Values: 1287.1 1293.7 1366.0 1374.9 1687.4 7844.7 8192.4 8434.5 8446.6 8619.5 8422.3 8501.2 8509.0 8511.5 8514.4 2454.7 2469.4 2482.4 2484.4 2484.8 2423.6 2531.3 2534.9 2538.3 2546.4 2441.7 2446.0 2459.3 2468.4 2474.1 2376.4 2379.4 2414.4 2431.8 2438.1 2376.6 2386.0 2432.9 2433.8 2434.6 8324.8 8545.9 8677.1 8681.4 8752.3 5300.7 5409.3 5415.2 5418.2 5462.2 3523.7 3598.3 3666.7 3672.2 3749.1 1131.7 1141.8 1150.9 1151.5 1171.0 12289.8 12328.6 12370.5 12377.8 12379.6 4254.3 4559.1 4613.1 4628.4 4655.0 9663.3 9731.2 9733.1 9735.2 9735.4 5392.6 5392.8 5393.6 5396.8 5399.9 4196.4 4337.0 4453.0 4459.7 5058.5 3893.4 3913.6 4011.9 4020.5 4024.7 1217.6 1217.7 1227.8 1241.6 1242.7 880.2 935.2 943.2 944.8 946.1 5514.9 5680.5 5723.9 5949.8 5992.8 931.8 948.9 959.8 977.4 992.2 3984.4 4179.5 4190.0 4201.2 4266.0 10217.3 10441.5 10468.8 10710.5 10819.7 10663.8 10671.9 10683.8 10693.4 10699.4 7955.6 8116.6 8175.9 8184.9 8189.8 5771.4 5786.7 5816.4 5839.7 5989.5 9635.2 9664.9 9776.2 9820.8 9823.9 8897.0 9122.6 9908.8 9914.2 10050.8 7479.1 7600.5 7648.2 7706.3 7801.8 8264.4 8285.8 8349.7 8351.0 8359.2 7350.3 7376.9 7487.3 7510.6 7685.8 7291.2 7397.6 7447.9 7535.6 7649.6 7013.7 7018.2 7081.9 7097.1 7103.5 4942.9 5061.1 5074.2 5113.7 5190.1 5071.9 5129.3 5215.1 5222.1 5277.1 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | [#4] prototype.html Cycles:180 Average:4585.76 Median:5198.71 stddev:1291.84 (24.8%) stddev-sans-first:1255.86 04:16:32 INFO - PROCESS | 25077 | Values: 356.7 358.2 361.7 371.3 372.2 5277.9 5338.1 5350.7 5354.4 5362.1 5053.7 5111.8 5197.2 5201.7 5332.7 4153.0 4157.9 4167.6 4169.1 4183.4 4091.4 4158.3 4194.2 4201.8 4223.2 3838.8 3901.9 4080.0 4100.8 4219.9 4158.4 4159.4 4170.4 4188.3 4209.1 3703.4 3748.3 3750.7 3766.3 3772.7 4986.9 5071.2 5100.6 5117.3 5180.5 4778.2 4788.7 4795.4 4815.9 4823.5 5532.6 5541.7 5543.9 5546.9 5554.5 4020.8 4143.1 4181.8 4185.9 4188.8 5705.5 5706.6 5707.4 5713.9 5720.9 4244.3 4257.5 4258.4 4266.7 4270.3 4204.5 4231.9 4265.3 4319.9 4335.8 4762.6 4766.4 4767.3 4780.2 4810.4 5462.8 5494.6 5506.9 5518.7 5523.0 1396.1 1397.9 1410.1 1418.7 1434.6 964.2 973.4 975.1 987.5 991.6 5087.9 5093.2 5100.0 5122.9 5136.5 5404.6 5405.8 5428.7 5436.2 5454.6 4947.4 5078.6 5153.9 5162.9 5173.3 2849.4 2867.6 2897.9 2898.4 2915.7 5547.0 5591.2 5596.6 5597.6 5598.7 5365.5 5433.9 5513.3 5519.0 5527.3 5562.8 5573.3 5579.7 5593.5 5598.6 5193.6 5427.6 5431.8 5465.5 5472.7 5359.6 5367.5 5373.6 5376.7 5395.7 5511.5 5574.6 5579.4 5588.0 5616.9 3988.9 4097.2 4116.9 4133.0 4134.6 5398.7 5400.7 5407.7 5426.6 5444.4 5303.5 5346.3 5346.7 5348.7 5364.7 5171.2 5303.0 5310.4 5337.4 5378.6 5228.7 5233.5 5249.9 5257.3 5279.8 5328.5 5329.5 5339.1 5351.2 5353.6 4954.4 5200.2 5227.8 5233.0 5245.9 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - PROCESS | 25077 | [#5] yui.html Cycles:180 Average:17903.90 Median:49088.63 stddev:23101.50 (47.1%) stddev-sans-first:23130.37 04:16:32 INFO - PROCESS | 25077 | Values: 745.5 746.7 777.5 828.1 830.7 14861.1 15744.7 15754.1 15756.7 15763.7 14195.9 14367.3 14487.2 14531.3 14546.9 700.6 718.2 788.1 789.4 809.2 798.5 807.2 807.3 808.0 808.9 851.3 853.5 853.8 854.6 856.5 723.7 743.5 825.5 847.5 847.6 617.9 620.2 620.4 620.5 620.6 14291.7 14295.6 14297.9 14345.9 14363.0 13740.9 13854.4 13864.3 13919.7 14013.3 12686.3 12765.7 12809.3 13069.2 13120.7 4414.3 4449.4 4492.3 4512.0 4527.3 58204.4 60796.4 60989.7 65546.3 66438.0 11571.5 11616.6 11648.7 11813.2 11879.8 20447.5 20467.1 20468.5 20471.3 20475.8 8915.6 8923.0 8973.2 9002.2 9357.6 4897.0 4902.2 5016.6 5073.8 5253.3 3637.6 3756.0 3762.2 3762.7 3768.6 666.9 724.4 739.9 758.1 759.7 692.7 741.8 748.1 777.0 780.8 9330.3 9775.5 9782.5 9915.6 9980.7 639.0 676.8 734.3 754.2 767.7 4507.7 4702.6 4802.4 4847.5 4866.2 86315.1 89672.6 90207.0 91322.0 92626.0 64197.7 65556.7 77965.6 79588.2 81205.6 47108.8 50730.0 65249.3 65757.7 67298.0 9745.3 9838.2 9857.0 9970.7 9972.8 47946.8 49056.0 49121.3 49278.8 49375.8 38815.0 67150.0 68020.3 68236.7 70156.6 11619.8 12067.5 12522.1 12963.2 13118.9 14473.3 14527.9 14582.6 14737.3 15562.5 11672.1 12844.6 13432.5 13675.6 14034.2 13695.2 13799.3 13841.1 13928.9 14261.0 13420.8 13498.3 13542.5 13773.6 13793.1 10712.9 11029.4 11081.9 11235.7 11830.8 11380.4 11931.9 12137.6 12167.2 12192.5 04:16:32 INFO - PROCESS | 25077 | -------- Summary: end -------- 04:16:32 INFO - PROCESS | 25077 | 04:16:32 INFO - TEST-INFO | 25077: exit 0 04:16:32 INFO - TEST-OK | dromaeo_css | took 1115702ms 04:16:32 INFO - TEST-START | kraken 04:16:32 INFO - operating with platform_type : linux_ 04:16:32 INFO - Initialising browser for kraken test... 04:16:32 INFO - TEST-INFO | started process 25406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zmyc2/profile http://localhost:38815/getInfo.html) 04:16:37 INFO - PROCESS | 25406 | __metrics Screen width/height:1600/1200 04:16:37 INFO - PROCESS | 25406 | colorDepth:24 04:16:37 INFO - PROCESS | 25406 | Browser inner width/height: 1024/697 04:16:37 INFO - PROCESS | 25406 | __metrics 04:16:37 INFO - PROCESS | 25406 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:16:37 INFO - PROCESS | 25406 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:38 INFO - PROCESS | 25406 | console.error: PushService: 04:16:38 INFO - PROCESS | 25406 | stateChangeProcessEnqueue: Error transitioning state 04:16:38 INFO - PROCESS | 25406 | UnknownError 04:16:38 INFO - TEST-INFO | 25406: exit 0 04:16:38 INFO - Browser initialized. 04:16:38 INFO - Running cycle 1/1 for kraken test... 04:16:38 INFO - TEST-INFO | started process 25497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2zmyc2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:50 INFO - PROCESS | 25497 | RSS: Main: 144654336 04:16:50 INFO - PROCESS | 25497 | 04:16:53 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38815/tests/kraken/driver.html?testName=audio-beat-detection) 04:16:54 INFO - PROCESS | 25497 | RSS: Main: 185847808 04:16:54 INFO - PROCESS | 25497 | 04:16:56 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38815/tests/kraken/driver.html?testName=audio-dft) 04:16:57 INFO - PROCESS | 25497 | RSS: Main: 174682112 04:16:57 INFO - PROCESS | 25497 | 04:16:59 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38815/tests/kraken/driver.html?testName=audio-fft) 04:17:00 INFO - PROCESS | 25497 | RSS: Main: 266571776 04:17:00 INFO - PROCESS | 25497 | 04:17:02 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38815/tests/kraken/driver.html?testName=audio-oscillator) 04:17:03 INFO - PROCESS | 25497 | RSS: Main: 172900352 04:17:03 INFO - PROCESS | 25497 | 04:17:05 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38815/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:17:05 INFO - PROCESS | 25497 | RSS: Main: 175149056 04:17:05 INFO - PROCESS | 25497 | 04:17:08 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38815/tests/kraken/driver.html?testName=imaging-darkroom) 04:17:09 INFO - PROCESS | 25497 | RSS: Main: 214155264 04:17:09 INFO - PROCESS | 25497 | 04:17:12 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38815/tests/kraken/driver.html?testName=imaging-desaturate) 04:17:13 INFO - PROCESS | 25497 | RSS: Main: 212934656 04:17:13 INFO - PROCESS | 25497 | 04:17:15 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38815/tests/kraken/driver.html?testName=json-parse-financial) 04:17:16 INFO - PROCESS | 25497 | RSS: Main: 211898368 04:17:16 INFO - PROCESS | 25497 | 04:17:17 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38815/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:17:18 INFO - PROCESS | 25497 | RSS: Main: 173916160 04:17:18 INFO - PROCESS | 25497 | 04:17:20 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:17:20 INFO - PROCESS | 25497 | RSS: Main: 181141504 04:17:20 INFO - PROCESS | 25497 | 04:17:22 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:17:23 INFO - PROCESS | 25497 | RSS: Main: 189566976 04:17:23 INFO - PROCESS | 25497 | 04:17:26 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:17:26 INFO - PROCESS | 25497 | RSS: Main: 199049216 04:17:26 INFO - PROCESS | 25497 | 04:17:29 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:17:30 INFO - PROCESS | 25497 | RSS: Main: 195354624 04:17:30 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | Cycle 1(1): loaded http://localhost:38815/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38815/tests/kraken/driver.html?testName=ai-astar) 04:17:31 INFO - PROCESS | 25497 | RSS: Main: 246755328 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | __start_tp_report 04:17:31 INFO - PROCESS | 25497 | _x_x_mozilla_page_load 04:17:31 INFO - PROCESS | 25497 | _x_x_mozilla_page_load_details 04:17:31 INFO - PROCESS | 25497 | |i|pagename|runs| 04:17:31 INFO - PROCESS | 25497 | |0;ai-astar;102;112;112;109;110;112;110;109;111;109 04:17:31 INFO - PROCESS | 25497 | |1;audio-beat-detection;147;117;117;153;118;119;117;118;147;122 04:17:31 INFO - PROCESS | 25497 | |2;audio-dft;162;161;161;160;160;160;160;160;161;161 04:17:31 INFO - PROCESS | 25497 | |3;audio-fft;75;75;76;105;74;75;75;75;106;76 04:17:31 INFO - PROCESS | 25497 | |4;audio-oscillator;81;82;109;81;81;82;99;82;83;111 04:17:31 INFO - PROCESS | 25497 | |5;imaging-gaussian-blur;118;117;116;117;117;116;117;117;117;117 04:17:31 INFO - PROCESS | 25497 | |6;imaging-darkroom;152;147;149;146;146;146;147;146;146;146 04:17:31 INFO - PROCESS | 25497 | |7;imaging-desaturate;85;85;84;85;85;85;85;85;84;84 04:17:31 INFO - PROCESS | 25497 | |8;json-parse-financial;50;52;52;53;50;51;51;50;51;50 04:17:31 INFO - PROCESS | 25497 | |9;json-stringify-tinderbox;61;60;59;60;60;61;59;61;59;59 04:17:31 INFO - PROCESS | 25497 | |10;stanford-crypto-aes;81;76;75;76;78;74;74;83;82;77 04:17:31 INFO - PROCESS | 25497 | |11;stanford-crypto-ccm;133;132;122;132;127;120;126;124;166;123 04:17:31 INFO - PROCESS | 25497 | |12;stanford-crypto-pbkdf2;159;155;157;164;160;157;155;154;154;154 04:17:31 INFO - PROCESS | 25497 | |13;stanford-crypto-sha256-iterative;62;63;62;64;63;63;63;64;61;62 04:17:31 INFO - PROCESS | 25497 | __end_tp_report 04:17:31 INFO - PROCESS | 25497 | __start_cc_report 04:17:31 INFO - PROCESS | 25497 | _x_x_mozilla_cycle_collect,1626 04:17:31 INFO - PROCESS | 25497 | __end_cc_report 04:17:31 INFO - PROCESS | 25497 | __startTimestamp1482149851936__endTimestamp 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | ------- Summary: start ------- 04:17:31 INFO - PROCESS | 25497 | Number of tests: 14 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.95 (2.7%) stddev-sans-first:1.33 04:17:31 INFO - PROCESS | 25497 | Values: 102.0 112.0 112.0 109.0 110.0 112.0 110.0 109.0 111.0 109.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#1] audio-beat-detection Cycles:10 Average:127.50 Median:120.50 stddev:15.00 (12.4%) stddev-sans-first:14.15 04:17:31 INFO - PROCESS | 25497 | Values: 147.0 117.0 117.0 153.0 118.0 119.0 117.0 118.0 147.0 122.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.53 04:17:31 INFO - PROCESS | 25497 | Values: 162.0 161.0 161.0 160.0 160.0 160.0 160.0 160.0 161.0 161.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:12.82 (17.1%) stddev-sans-first:13.40 04:17:31 INFO - PROCESS | 25497 | Values: 75.0 75.0 76.0 105.0 74.0 75.0 75.0 75.0 106.0 76.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:82.00 stddev:12.29 (15.0%) stddev-sans-first:12.68 04:17:31 INFO - PROCESS | 25497 | Values: 81.0 82.0 109.0 81.0 81.0 82.0 99.0 82.0 83.0 111.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 04:17:31 INFO - PROCESS | 25497 | Values: 118.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:146.50 stddev:1.97 (1.3%) stddev-sans-first:1.01 04:17:31 INFO - PROCESS | 25497 | Values: 152.0 147.0 149.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 04:17:31 INFO - PROCESS | 25497 | Values: 85.0 85.0 84.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:1.05 (2.1%) stddev-sans-first:1.05 04:17:31 INFO - PROCESS | 25497 | Values: 50.0 52.0 52.0 53.0 50.0 51.0 51.0 50.0 51.0 50.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.88 (1.5%) stddev-sans-first:0.83 04:17:31 INFO - PROCESS | 25497 | Values: 61.0 60.0 59.0 60.0 60.0 61.0 59.0 61.0 59.0 59.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:3.31 (4.3%) stddev-sans-first:3.27 04:17:31 INFO - PROCESS | 25497 | Values: 81.0 76.0 75.0 76.0 78.0 74.0 74.0 83.0 82.0 77.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:129.50 stddev:13.27 (10.2%) stddev-sans-first:14.04 04:17:31 INFO - PROCESS | 25497 | Values: 133.0 132.0 122.0 132.0 127.0 120.0 126.0 124.0 166.0 123.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.00 stddev:3.28 (2.1%) stddev-sans-first:3.39 04:17:31 INFO - PROCESS | 25497 | Values: 159.0 155.0 157.0 164.0 160.0 157.0 155.0 154.0 154.0 154.0 04:17:31 INFO - PROCESS | 25497 | 04:17:31 INFO - PROCESS | 25497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 04:17:31 INFO - PROCESS | 25497 | Values: 62.0 63.0 62.0 64.0 63.0 63.0 63.0 64.0 61.0 62.0 04:17:31 INFO - PROCESS | 25497 | -------- Summary: end -------- 04:17:31 INFO - PROCESS | 25497 | 04:17:32 INFO - TEST-INFO | 25497: exit 0 04:17:33 INFO - TEST-OK | kraken | took 60047ms 04:17:33 INFO - SUITE-END | took 1175s 04:17:33 INFO - Completed test suite (00:19:35) 04:17:33 INFO - javascript benchmark 04:17:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3195.760317976152, 3226.709596136347, 3241.2707140893303, 3264.869405223791, 3283.22844131629, 5567.220589117522, 5646.407127251636, 5653.6607803531715, 5657.773689052443, 5669.121286200645, 5612.5229355504725, 5676.460736230062, 5679.630823996447, 5700.572457065727, 5712.200291959129, 5096.159133742928, 5110.412302585213, 5128.640995130342, 5158.097332966735, 5201.297824793661, 4954.677945933503, 4966.304717339575, 5180.818671346504, 5181.559567436753, 5212.0, 5067.467915868836, 5075.720835354054, 5085.669431486942, 5102.668326558781, 5140.126178549637, 5160.587153027749, 5163.63854530183, 5169.043726910533, 5170.172772356443, 5196.0387328343995, 4863.708177509326, 5066.113430149746, 5084.339035925343, 5116.923246151311, 5139.8458046258675, 5448.91826622601, 5478.397376288605, 5484.369297530755, 5509.256250406184, 5548.306461692288, 5883.558733095035, 5888.146218798251, 5998.070299103602, 6001.039833626643, 6005.369436209223, 5833.79581714638, 6014.879702405971, 6031.095335699636, 6041.848953776147, 6043.365446628129, 5490.6431081979545, 5580.832575022756, 5593.32880054392, 5624.6625202487985, 5648.4633959773755, 6178.443940045418, 6186.10301506288, 6186.412290832363, 6190.288116866528, 6195.628262304276, 5774.2782152230975, 5923.229980102559, 5931.288245410492, 5932.614380065282, 5936.910946335808, 5887.911681324784, 5917.881642367214, 5964.0, 5969.194158788595, 6061.484773794277, 5985.730642121115, 5987.101934709741, 5998.970005149947, 5999.970000150059, 6029.517638588903, 5926.496247818897, 5984.31180414258, 5985.940140598538, 5992.43071908168, 6002.309734380515, 4564.680472366902, 4564.8402305919135, 4588.334691469719, 4601.608863246662, 4611.838585649486, 4111.527174374985, 4135.234981528427, 4145.067359844072, 4166.562510936308, 4168.583141685807, 5774.393688662714, 5776.68228247442, 5780.826575202751, 5782.3639399666, 5783.190353350535, 5797.768089276466, 5851.824445266649, 5935.317438494629, 6003.8198854034445, 6065.6663883486835, 5720.542356611461, 5743.0, 5758.280214973129, 5761.4526619971875, 5786.305643322744, 5178.093833579109, 5184.11869982104, 5184.14461613837, 5188.040212560688, 5213.165893457029, 6012.248468941382, 6017.368176341509, 6092.238470191226, 6176.258848938156, 6239.032949892774, 5946.881062378815, 6045.063015232646, 6066.575339726177, 6086.786962456293, 6092.208012958287, 6214.751409943552, 6240.906386404298, 6243.687815609293, 6252.937470625236, 6265.185525881606, 5700.942990570041, 5702.401247868914, 5951.226340575698, 5968.403159683997, 5993.041113421831, 5960.970195148997, 5989.610675306091, 6002.789902353396, 6065.0, 6103.08453731926, 5836.795712150054, 5877.35349111606, 5885.14665373527, 5904.173415721716, 5922.200502932049, 5611.0, 5882.352941176381, 5892.793752218652, 5893.2044174035955, 5895.734691938959, 5639.746211420414, 5719.256496655408, 5750.309962804323, 5798.82603521895, 5859.150423188528, 5953.642781433128, 5954.583179177416, 5964.433378829004, 5966.910496342472, 5981.431763982415, 5601.747921343468, 5654.660720356792, 5660.915086273627, 5809.854753631024, 5822.970885145716], "value": 5533.429301650089, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.6895845202042, 599.688162155679, 620.5811077522673, 648.3646026893645, 665.7004348043382, 33552.66447335526, 43174.0, 44107.55892441075, 44214.778926105326, 44316.3352549712, 45097.0, 45512.54487455125, 45573.772131139296, 45635.315470267975, 45692.3146152808, 8272.296854767323, 8796.69211577595, 8976.281897448189, 8980.057094005133, 8981.955090224572, 8285.50286982783, 10393.584256629725, 10609.78780424391, 10617.309874858109, 10972.341659500416, 10908.50911708975, 10960.506777195005, 10972.615958441456, 10980.231383803137, 10983.725406864813, 10717.0, 10739.731506712316, 10759.193060520493, 10781.62264320749, 10781.892181078167, 10658.200634952409, 10756.085732712729, 10761.51573179201, 10763.515641796059, 10769.676909692722, 42329.788351058356, 42619.0, 42712.0, 42763.0, 42789.78605106955, 3547.875824346161, 3651.397519409294, 3824.4072168813877, 3967.444557761916, 4344.348347747831, 33119.13540121192, 33484.49773253403, 33487.16282092943, 33649.327013459595, 34180.658193418, 4371.562843715635, 4401.581849724271, 4416.6025057744955, 4503.347014682885, 4549.340345649895, 368297.0, 369382.0, 371709.0, 373118.0, 374267.99999999726, 57752.71123644355, 58146.7092664534, 58153.12770308449, 58157.70921145367, 58216.41783582194, 37820.62179378226, 38732.2253554933, 38980.80509597491, 41416.378754318706, 60074.699626501584, 18420.0, 18784.154713037948, 18900.621987560447, 18908.527286817665, 18933.242670293308, 12374.071944604191, 12588.937055314665, 14312.85687143136, 14327.498537551135, 14468.638284042983, 19146.234150634096, 19683.212671493267, 19932.70100948487, 19945.900270498845, 20022.69965950512, 7232.276772322831, 7274.1634712007735, 7284.0428180234, 7302.306280903305, 7362.0, 990.3612170150357, 1064.984025239622, 1077.6659235636978, 1132.2527132092944, 1181.5923506390282, 32710.528026238877, 33012.0, 33122.17194570155, 33330.16674583155, 33646.0, 1033.3569624297404, 1110.9723505757142, 1132.0943245403644, 1145.9656210313703, 1160.2748282323548, 14754.704905901823, 17072.146392680315, 17508.037057961934, 18239.0, 18341.0, 574853.0, 575502.0, 576677.0, 577647.0, 579204.0, 58329.0, 58922.41077589255, 58963.11555326673, 58973.41026589765, 58996.05019748995, 1342.2885820578645, 1381.7927310903444, 1404.7120340330207, 1405.5150972914532, 1408.253625578445, 30419.604831389614, 32309.676903230666, 32346.0, 32577.67422325841, 32764.34471310513, 50180.74909625429, 50462.74768626133, 50647.46762661926, 50750.49249507458, 50764.492355077455, 332869.0, 333034.0, 333082.0, 333543.0, 333976.0, 29584.55623165611, 31144.532832007084, 31751.84124079365, 31874.0, 32144.35711285808, 49058.75470622624, 49225.0, 49336.50663493319, 50258.24612630886, 50766.492335076175, 40185.39721904232, 41119.7944010278, 41448.58551414568, 41847.790761046, 42046.0, 41311.793441033806, 41609.58390416178, 41780.58219417767, 42653.14693706046, 43566.782166090234, 41754.58245417507, 41913.79043104765, 42944.0, 42963.140737184454, 45879.31181032221, 36246.27507449889, 38568.77694395594, 39033.80483097566, 39496.802515987234, 39544.40683389809, 24942.875285623457, 25159.49681006406, 25259.74740252574, 25520.617190742527, 25657.358566035997], "value": 20687.272277150176, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.1633377076339, 408.86711818658927, 409.44520175162637, 414.4529221427715, 421.5236782435847, 15456.69086618267, 19095.713564296548, 19272.614547709054, 19444.319448819293, 19460.026998650083, 18928.905355473238, 19204.0, 19287.939163346044, 19449.31927382542, 19482.318118865842, 5117.309163262968, 5486.643368181076, 5734.7419366128415, 5739.196512488255, 6361.55469117162, 6398.360163983611, 6475.255345635265, 6478.708458119396, 6480.351964803529, 6481.09264702942, 5666.660000399989, 5904.143899134623, 5943.732532036069, 5951.018082016484, 6309.495240380758, 5699.430056994267, 5868.706564671749, 5884.852878678024, 5924.763009479616, 5927.2590926134235, 5732.168835518826, 5759.078547432433, 5764.8847023059725, 5766.682832444214, 5767.250257466502, 14702.603252690977, 15143.0, 23152.073917043297, 23276.185333513247, 23417.648735268984, 2350.811935045192, 2507.485965377093, 2534.8605826679527, 2664.9866750666315, 2766.640336756209, 10705.143588512978, 10942.17933654979, 11060.723481912935, 11072.501737421835, 11207.887921120848, 1967.2293450819209, 1968.4193163016944, 1991.7609886813675, 2009.1059478532059, 2089.1956596710374, 83246.0, 87217.56391218067, 88874.5556272221, 90707.54646226727, 90798.09201908029, 11326.244432113035, 11551.88448115508, 11688.240264382957, 11710.531578736925, 11968.461419236155, 16874.578135546708, 16884.324627014783, 16885.577860553585, 16896.155192240338, 16908.154592270585, 8485.703000394957, 8639.438436501607, 8697.173768491983, 8717.346199034972, 8744.781380465412, 8075.232852878967, 8170.0, 8355.206255405727, 8392.496450213006, 8467.364947628952, 4708.681569160572, 4862.100511405401, 5016.899662006739, 5018.523240292239, 5164.535191832678, 2049.200811683415, 2079.9480012999493, 2086.2698055680694, 2089.3627443629534, 2123.193186589086, 478.8228355508484, 916.390600250839, 962.3023308101571, 1003.5383723487278, 1008.5763979128784, 11750.764984700429, 12294.75410491785, 12406.689832754253, 12665.240085594894, 13005.674858128434, 501.31069779053803, 504.4577079639402, 515.9922601160986, 517.3326408932435, 523.3588853654243, 6675.566088204251, 6834.829129271709, 6878.140232470942, 6903.896441553381, 6910.136232970879, 480263.0, 483725.0, 501028.0, 529349.0, 530703.0, 100078.4996075015, 100618.496907515, 102803.4859825696, 103377.48311258396, 106002.0, 512.8794733237686, 516.0530426667033, 518.4090137243545, 520.2612290547431, 522.7151202594595, 11626.767464650491, 11737.413129343327, 11751.941240294085, 11883.524659013543, 12083.939580302042, 42073.78963105165, 42605.36091958561, 43786.0, 44080.338794918745, 44770.55229447664, 63576.36423635705, 65410.672946634964, 66199.33800661932, 66273.33726662671, 67082.32917670762, 7867.803304917423, 8582.472820019075, 8940.86588701183, 9036.728898133066, 9099.226565741987, 11733.823992640288, 13488.190708557519, 13621.182729035892, 13694.52069177574, 13708.725825483634, 5868.2077919480325, 6906.620135892575, 11736.70658233551, 11805.527778889093, 12278.219658149697, 11568.942155289169, 11778.293302401884, 11883.940580297389, 11923.582674606347, 12106.576269830513, 6093.817185484442, 9163.862542062008, 10944.726381840517, 12551.623451296111, 12610.432530535965, 8311.833763324821, 8368.665253389796, 8388.822889317034, 8526.78683032929, 8628.266597339045, 9342.95328523353, 12197.69505762363, 12371.814422783846, 12446.06654500898, 12546.435410406737], "value": 8727.304139587679, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.0733072188025, 1293.683047653325, 1366.0, 1374.8625137486254, 1687.4009726547067, 7844.666406710859, 8192.385571082163, 8434.53610051447, 8446.619902104398, 8619.525926074064, 8422.28410585101, 8501.23488886, 8509.021462531811, 8511.531865747382, 8514.361422893277, 2454.7054353477565, 2469.4196863737006, 2482.429041320497, 2484.428581426273, 2484.8260621756485, 2423.6364545318165, 2531.3418511187133, 2534.936626584332, 2538.263903467992, 2546.363409147713, 2441.6703744994466, 2446.0, 2459.3359792855917, 2468.358226861011, 2474.0969546115716, 2376.394019525019, 2379.4289370551114, 2414.4446777241333, 2431.8297719159664, 2438.085717855804, 2376.6435034744754, 2385.9522809543714, 2432.939176520601, 2433.829631925766, 2434.561778879801, 8324.750257492286, 8545.914540854636, 8677.088905664941, 8681.435706679045, 8752.256058234994, 5300.681959082467, 5409.323834520685, 5415.241866138744, 5418.187271909245, 5462.153366228241, 3523.6828685418177, 3598.280343931198, 3666.7066634669163, 3672.2288319452946, 3749.1376983293994, 1131.6887855839627, 1141.760230351619, 1150.8791576884473, 1151.4645689754304, 1170.9917491502115, 12289.815652765126, 12328.630141095782, 12370.505179792797, 12377.814332785016, 12379.62861114159, 4254.276772948544, 4559.110973360229, 4613.123506533748, 4628.421447319085, 4655.045715628288, 9663.27525435595, 9731.172850307803, 9733.075357840993, 9735.221182305399, 9735.367201131903, 5392.622516423891, 5392.784288628411, 5393.6224464287125, 5396.83809485716, 5399.892002160013, 4196.412502249687, 4336.978315108404, 4452.977735111369, 4459.732416055047, 5058.544730974157, 3893.377059670439, 3913.5695073541888, 4011.91976160481, 4020.4974378202724, 4024.678025757932, 1217.5936793004093, 1217.6773155113901, 1227.79127548317, 1241.5840693367822, 1242.6955395928055, 880.1814312689261, 935.2050756856753, 943.1605870775015, 944.8299306124826, 946.1248345280588, 5514.91727624086, 5680.517156041783, 5723.8569035774435, 5949.8215053548465, 5992.820215393545, 931.771715929588, 948.9478078705599, 959.8176346494143, 977.3695966101825, 992.1814503035025, 3984.4023396490757, 4179.519355274121, 4189.958100419018, 4201.243776120266, 4265.957340426618, 10217.33587316822, 10441.477926103664, 10468.790624187626, 10710.518026688818, 10819.67540973772, 10663.84004239937, 10671.893281067245, 10683.83974240387, 10693.41186234749, 10699.411532365639, 7955.602219888982, 8116.5941702914615, 8175.877361839577, 8184.918150818535, 8189.79525511867, 5771.422857714195, 5786.652800831964, 5816.360200377871, 5839.678817665069, 5989.520838332835, 9635.181009613982, 9664.9033509664, 9776.217902567636, 9820.754481138028, 9823.901760982299, 8897.0, 9122.589483473392, 9908.752281193028, 9914.157296629868, 10050.849237261593, 7479.139898911477, 7600.543967361976, 7648.235176482307, 7706.344960678405, 7801.804954876174, 8264.380171487042, 8285.83428331418, 8349.749507514784, 8351.039630442334, 8359.205875441823, 7350.338469537767, 7376.926230737624, 7487.251274872469, 7510.624468776648, 7685.769426917202, 7291.234420385783, 7397.593132377556, 7447.851042979219, 7535.623218839146, 7649.61751912391, 7013.684384202825, 7018.227994920657, 7081.858362832611, 7097.112860892388, 7103.538270012433, 4942.863141477552, 5061.063703214917, 5074.162763144188, 5113.7187454688865, 5190.143626301618, 5071.87320316995, 5129.307543481731, 5215.087359711959, 5222.086134926297, 5277.076511610529], "value": 4610.328624292594, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.6825525282499, 358.23874267182237, 361.6744929563392, 371.3142333804526, 372.2164843005475, 5277.920831187535, 5338.092524270874, 5350.73246337683, 5354.357477102753, 5362.088444964355, 5053.7258233794755, 5111.821086261982, 5197.246399272103, 5201.713905735183, 5332.680039197651, 4152.97923510382, 4157.91684166318, 4167.6249137577615, 4169.145325208333, 4183.3515805050265, 4091.4067460218253, 4158.313878210091, 4194.224068547329, 4201.789910504478, 4223.239816832969, 3838.846446142151, 3901.9219615607813, 4080.0, 4100.815463304159, 4219.894502637428, 4158.355454904495, 4159.438475805758, 4170.416141740159, 4188.28799104153, 4209.095044565433, 3703.3519134151684, 3748.3440397930253, 3750.6999440044733, 3766.303233901737, 3772.660460558563, 4986.925196122061, 5071.18860982241, 5100.566451851597, 5117.309163262949, 5180.533751962342, 4778.187708089633, 4788.712677239377, 4795.448523419816, 4815.855524334241, 4823.5176482351835, 5532.612717109804, 5541.722913854291, 5543.916841247385, 5546.91679624806, 5554.50009499147, 4020.839166433339, 4143.129942712034, 4181.770002649853, 4185.937210941838, 4188.7905604719945, 5705.515031222351, 5706.572007099484, 5707.400722924075, 5713.857153571153, 5720.914186287209, 4244.257254980366, 4257.531671516131, 4258.382534532476, 4266.679999000025, 4270.338097594878, 4204.516480604709, 4231.894202644897, 4265.317549192177, 4319.935200971988, 4335.848245311462, 4762.571368576845, 4766.404199475066, 4767.284907263938, 4780.211265141283, 4810.350602668595, 5462.754176062087, 5494.5988772862665, 5506.86108917921, 5518.66887986714, 5523.039321041053, 1396.0995158122953, 1397.8822084541928, 1410.132768347459, 1418.7089748328972, 1434.5552878607666, 964.2093483343731, 973.3673112476947, 975.068809287129, 987.5259875259916, 991.5538007896331, 5087.923681144712, 5093.18509038552, 5100.0, 5122.897542049138, 5136.512031357015, 5404.622111180513, 5405.756740946588, 5428.701421421781, 5436.184572314184, 5454.563634909197, 4947.35684361038, 5078.568321692624, 5153.948460515347, 5162.92255616166, 5173.301604283449, 2849.444358350102, 2867.6128722622598, 2897.884084636633, 2898.449294634013, 2915.7084291570673, 5547.029269877755, 5591.161325801081, 5596.552275817925, 5597.552195824324, 5598.748056337475, 5365.490278423544, 5433.864153396196, 5513.283273174542, 5519.034169020405, 5527.2538207342295, 5562.7774889004795, 5573.303337082864, 5579.7489112990015, 5593.496585307342, 5598.572364047223, 5193.558547523352, 5427.6472029317965, 5431.782728690808, 5465.535429488538, 5472.726363681721, 5359.571234301325, 5367.490088441592, 5373.623846330719, 5376.73116344189, 5395.676259424447, 5511.500197374616, 5574.554035677055, 5579.442055794388, 5588.022096133079, 5616.85957851057, 3988.9202215956097, 4097.180563887175, 4116.871177904754, 4132.966758310423, 4134.565870583546, 5398.703071331114, 5400.675959442446, 5407.729613519387, 5426.585169599491, 5444.373897001896, 5303.496167864047, 5346.25152478661, 5346.679199248058, 5348.679079255257, 5364.678119312854, 5171.172612382001, 5302.992431438014, 5310.389305229948, 5337.386200586982, 5378.5966052547, 5228.660137091077, 5233.502817232356, 5249.921251181312, 5257.2662215648415, 5279.762410691451, 5328.520433161034, 5329.520343169133, 5339.088039004203, 5351.1973204019705, 5353.598480113929, 4954.355933728592, 5200.167973124433, 5227.849873027928, 5232.9738351308, 5245.868853278698], "value": 4184.87745176023, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.5489428895518, 746.7349091072673, 777.4518964130285, 828.056016141599, 830.6760363458252, 14861.108333499997, 15744.685106297868, 15754.13352265625, 15756.684866302667, 15763.684726305468, 14195.92902035491, 14367.281635918189, 14487.203203823785, 14531.273436328167, 14546.854531454683, 700.5691499727682, 718.2279050021222, 788.1448628238368, 789.3724489031205, 809.2352726673296, 798.4769975665948, 807.2129673568253, 807.3016840433041, 807.995960020199, 808.870580707087, 851.259404318244, 853.4921721575653, 853.8463076646201, 854.5556310718423, 856.4861083350003, 723.7213672736008, 743.5092838726415, 825.5211977053355, 847.4576271186446, 847.559269180026, 617.8764247150543, 620.2092332276338, 620.3982137326785, 620.4787978098374, 620.5997131849977, 14291.714165716732, 14295.64260893486, 14297.928510357382, 14345.928270358685, 14363.0, 13740.93129534346, 13854.376553055137, 13864.306784660726, 13919.721605567933, 14013.299335033309, 12686.302253376061, 12765.74468510634, 12809.340538815852, 13069.15050521713, 13120.737585248242, 4414.271645178542, 4449.421575195236, 4492.258777301774, 4512.0, 4527.298268768346, 58204.417955820325, 60796.39203607996, 60989.69505152446, 65546.3445365545, 66438.0, 11571.537138514534, 11616.593419230456, 11648.650540483799, 11813.173077884465, 11879.821802672966, 20447.4888127798, 20467.07898144557, 20468.488287792625, 20471.283505077252, 20475.795242047687, 8915.643374265086, 8922.955385223033, 8973.237274831712, 9002.189802917768, 9357.578908949114, 4896.975515122402, 4902.166631672624, 5016.648834581617, 5073.771680274396, 5253.343332083489, 3637.5816781070516, 3755.9671090449797, 3762.191128907243, 3762.6801721853403, 3768.6419790119894, 666.9066330713704, 724.4168444402306, 739.9001134846727, 758.1130077808866, 759.7227012140639, 692.7021380806201, 741.8405042915691, 748.0686545251089, 777.0481160578246, 780.8008957715859, 9330.253579713606, 9775.51122443875, 9782.461964592016, 9915.603375865028, 9980.700578982496, 638.9967750631557, 676.7901950395295, 734.2694019450681, 754.2419868032592, 767.719782279464, 4507.684462087623, 4702.600278976257, 4802.447718512346, 4847.466778654345, 4866.245731911559, 86315.13684863197, 89672.55163724271, 90207.0, 91322.0, 92626.0, 64197.67901160464, 65556.67221663956, 77965.61017194991, 79588.20411795808, 81205.59397203094, 47108.764456178185, 50730.0, 65249.347506524326, 65757.67121164364, 67298.0, 9745.269104817025, 9838.212942964403, 9857.0, 9970.651027214013, 9972.800543988935, 47946.76026619845, 49056.0, 49121.263181051596, 49278.75360623174, 49375.753121234164, 38815.0, 67150.0, 68020.3197968014, 68236.6588167056, 70156.64921675563, 11619.825702614637, 12067.456964436446, 12522.123451358317, 12963.15739476931, 13118.934405327913, 14473.276336183359, 14527.854721453074, 14582.562523124323, 14737.263136842901, 15562.455314063953, 11672.124590655565, 12844.614661560168, 13432.462701491831, 13675.589732308046, 14034.157950523002, 13695.246761428218, 13799.310034498436, 13841.100328478617, 13928.860711392756, 14261.0, 13420.798688019882, 13498.257595832323, 13542.458301668217, 13773.586792396243, 13793.10344827583, 10712.946435268086, 11029.44852757375, 11081.944590276997, 11235.71910702239, 11830.82253766177, 11380.43097845121, 11931.88350019242, 12137.635870923887, 12167.209131406431, 12192.51229950792], "value": 7378.12507168445, "unit": "score"}], "name": "dromaeo_css", "value": 7224.879785034767, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 109.0, 110.0, 112.0, 110.0, 109.0, 111.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 117.0, 153.0, 118.0, 119.0, 117.0, 118.0, 147.0, 122.0], "value": 127.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 105.0, 74.0, 75.0, 75.0, 75.0, 106.0, 76.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 109.0, 81.0, 81.0, 82.0, 99.0, 82.0, 83.0, 111.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 147.0, 149.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 52.0, 53.0, 50.0, 51.0, 51.0, 50.0, 51.0, 50.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 59.0, 60.0, 60.0, 61.0, 59.0, 61.0, 59.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 75.0, 76.0, 78.0, 74.0, 74.0, 83.0, 82.0, 77.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 122.0, 132.0, 127.0, 120.0, 126.0, 124.0, 166.0, 123.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 155.0, 157.0, 164.0, 160.0, 157.0, 155.0, 154.0, 154.0, 154.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 64.0, 63.0, 63.0, 63.0, 64.0, 61.0, 62.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1455.3000000000002, "alertThreshold": 2.0}]} 04:17:33 INFO - Return code: 0 04:17:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:17:33 INFO - # TBPL SUCCESS # 04:17:33 INFO - Running post-action listener: _resource_record_post_action 04:17:33 INFO - [mozharness: 2016-12-19 12:17:33.249597Z] Finished run-tests step (success) 04:17:33 INFO - Running post-run listener: _resource_record_post_run 04:17:33 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 270336; Write bytes: 365604864; Read time: 68; Write time: 226448 04:17:33 INFO - TinderboxPrint: CPU usage
13.0% 04:17:33 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 68 04:17:33 INFO - TinderboxPrint: I/O write bytes / time
365,604,864 / 226,448 04:17:33 INFO - TinderboxPrint: CPU idle
8,273.6 (87.0%) 04:17:33 INFO - TinderboxPrint: CPU user
1,194.6 (12.6%) 04:17:33 INFO - TinderboxPrint: Swap in / out
0 / 0 04:17:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107573248; Read time: 0; Write time: 98808 04:17:33 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245784576; Read time: 56; Write time: 126044 04:17:33 INFO - Running post-run listener: _upload_blobber_files 04:17:33 INFO - Blob upload gear active. 04:17:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:17:33 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 04:17:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:17:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:17:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:17:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:17:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:17:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:47 INFO - (blobuploader) - INFO - Done attempting. 04:17:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:17:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:48 INFO - (blobuploader) - INFO - Done attempting. 04:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:17:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:17:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:17:50 INFO - (blobuploader) - INFO - Done attempting. 04:17:50 INFO - (blobuploader) - INFO - Iteration through files over. 04:17:50 INFO - Return code: 0 04:17:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:17:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:17:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/219320e4148cc68c420d52a802908c2e335846f21bcb83b1d63e9d7922999de7f0aae165f7326f0e3750e11184d8f600ab08a84c8a1b8a9efd5bb2a6bea6d905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55c90e0b003ef7ad2764541b8ec18c9312cd54875131fdb98c541e35fe5a6860e699cb30ed419e24e6e466fb4bf20c91fd944c80c9d62a3214c5ba8d5ee4502d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9a28584d74559184ad96354fbba791dd21caedb32892ac1c6e1150cbbeb4305f764304ddcdc0e8580975e1a7b64e56656f8664e3f3b01cdce5f7bbcd8b7de2"} 04:17:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:17:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:17:50 INFO - Contents: 04:17:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/219320e4148cc68c420d52a802908c2e335846f21bcb83b1d63e9d7922999de7f0aae165f7326f0e3750e11184d8f600ab08a84c8a1b8a9efd5bb2a6bea6d905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55c90e0b003ef7ad2764541b8ec18c9312cd54875131fdb98c541e35fe5a6860e699cb30ed419e24e6e466fb4bf20c91fd944c80c9d62a3214c5ba8d5ee4502d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9a28584d74559184ad96354fbba791dd21caedb32892ac1c6e1150cbbeb4305f764304ddcdc0e8580975e1a7b64e56656f8664e3f3b01cdce5f7bbcd8b7de2"} 04:17:50 INFO - Running post-run listener: copy_logs_to_upload_dir 04:17:50 INFO - Copying logs to upload dir... 04:17:50 INFO - mkdir: /builds/slave/test/build/upload/logs 04:17:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.176603 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-12-19 04:17:48.240036) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 04:17:48.243446) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/219320e4148cc68c420d52a802908c2e335846f21bcb83b1d63e9d7922999de7f0aae165f7326f0e3750e11184d8f600ab08a84c8a1b8a9efd5bb2a6bea6d905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55c90e0b003ef7ad2764541b8ec18c9312cd54875131fdb98c541e35fe5a6860e699cb30ed419e24e6e466fb4bf20c91fd944c80c9d62a3214c5ba8d5ee4502d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9a28584d74559184ad96354fbba791dd21caedb32892ac1c6e1150cbbeb4305f764304ddcdc0e8580975e1a7b64e56656f8664e3f3b01cdce5f7bbcd8b7de2"} build_url:https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://queue.taskcluster.net/v1/task/Til4aAhwTfuCGvUGVbDfAw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/219320e4148cc68c420d52a802908c2e335846f21bcb83b1d63e9d7922999de7f0aae165f7326f0e3750e11184d8f600ab08a84c8a1b8a9efd5bb2a6bea6d905", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55c90e0b003ef7ad2764541b8ec18c9312cd54875131fdb98c541e35fe5a6860e699cb30ed419e24e6e466fb4bf20c91fd944c80c9d62a3214c5ba8d5ee4502d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba9a28584d74559184ad96354fbba791dd21caedb32892ac1c6e1150cbbeb4305f764304ddcdc0e8580975e1a7b64e56656f8664e3f3b01cdce5f7bbcd8b7de2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-19 04:17:48.271559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:17:48.272375) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1482145196.102284-1344794989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004397 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-19 04:17:48.353115) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 04:17:48.353429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-19 04:17:48.353712) ========= ========= Total master_lag: 0.17 =========