builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1484216855.59 results: success (0) buildid: 20170112004017 builduid: 478b5aa5cf0243f39af9c10f09cd9120 revision: 1abb4b193740653f1161d86f38dbb79287e7d69b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.585508) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.586017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.586327) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.601835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.602114) ========= 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=337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 02:27:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.2M=0s 2017-01-12 02:27:36 (56.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109285 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.725259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.725585) ========= 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=337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:35.775262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 02:27:35.775621) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1abb4b193740653f1161d86f38dbb79287e7d69b --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 1abb4b193740653f1161d86f38dbb79287e7d69b --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=337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 02:27:36,307 truncating revision to first 12 chars 2017-01-12 02:27:36,307 Setting DEBUG logging. 2017-01-12 02:27:36,307 attempt 1/10 2017-01-12 02:27:36,307 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1abb4b193740?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 02:27:37,723 unpacking tar archive at: mozilla-aurora-1abb4b193740/testing/mozharness/ program finished with exit code 0 elapsedTime=1.728812 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-12 02:27:37.517807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:37.518138) ========= script_repo_revision: 1abb4b193740653f1161d86f38dbb79287e7d69b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:37.518570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:37.518844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 02:27:37.527965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 02:27:37.528262) ========= /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=337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:27:38 INFO - MultiFileLogger online at 20170112 02:27:38 in /builds/slave/test 02:27:38 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 02:27:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:27:38 INFO - {'append_to_log': False, 02:27:38 INFO - 'base_work_dir': '/builds/slave/test', 02:27:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:27:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:27:38 INFO - 'branch': 'Mozilla-Aurora', 02:27:38 INFO - 'buildbot_json_path': 'buildprops.json', 02:27:38 INFO - 'config_files': ('talos/linux_config.py',), 02:27:38 INFO - 'default_actions': ('clobber', 02:27:38 INFO - 'read-buildbot-config', 02:27:38 INFO - 'download-and-extract', 02:27:38 INFO - 'populate-webroot', 02:27:38 INFO - 'create-virtualenv', 02:27:38 INFO - 'install', 02:27:38 INFO - 'run-tests'), 02:27:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:27:38 INFO - 'download_minidump_stackwalk': True, 02:27:38 INFO - 'download_symbols': 'ondemand', 02:27:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:27:38 INFO - 'tooltool.py': '/tools/tooltool.py', 02:27:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:27:38 INFO - '/tools/misc-python/virtualenv.py')}, 02:27:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:27:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:27:38 INFO - 'installer_path': 'installer.exe', 02:27:38 INFO - 'log_level': 'info', 02:27:38 INFO - 'log_name': 'talos', 02:27:38 INFO - 'log_to_console': True, 02:27:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:27:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:27:38 INFO - 'opt_config_files': (), 02:27:38 INFO - 'pip_index': False, 02:27:38 INFO - 'sps_profile': False, 02:27:38 INFO - 'sps_profile_interval': 0, 02:27:38 INFO - 'suite': 'dromaeojs', 02:27:38 INFO - 'system_bits': '32', 02:27:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:27:38 INFO - 'title': 'talos-linux64-ix-060', 02:27:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:27:38 INFO - 'use_talos_json': True, 02:27:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:27:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:27:38 INFO - 'work_dir': 'build'} 02:27:38 INFO - [mozharness: 2017-01-12 10:27:38.157752Z] Running clobber step. 02:27:38 INFO - Running pre-action listener: _resource_record_pre_action 02:27:38 INFO - Running main action method: clobber 02:27:38 INFO - rmtree: /builds/slave/test/build 02:27:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:27:39 INFO - Running post-action listener: _resource_record_post_action 02:27:39 INFO - [mozharness: 2017-01-12 10:27:39.140860Z] Finished clobber step (success) 02:27:39 INFO - [mozharness: 2017-01-12 10:27:39.140960Z] Running read-buildbot-config step. 02:27:39 INFO - Running pre-action listener: _resource_record_pre_action 02:27:39 INFO - Running main action method: read_buildbot_config 02:27:39 INFO - Using buildbot properties: 02:27:39 INFO - { 02:27:39 INFO - "project": "", 02:27:39 INFO - "product": "firefox", 02:27:39 INFO - "script_repo_revision": "production", 02:27:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:27:39 INFO - "repository": "", 02:27:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:27:39 INFO - "buildid": "20170112004017", 02:27:39 INFO - "stage_platform": "linux64-pgo", 02:27:39 INFO - "basedir": "/builds/slave/test", 02:27:39 INFO - "nightly_build": "True", 02:27:39 INFO - "buildnumber": 696, 02:27:39 INFO - "slavename": "talos-linux64-ix-060", 02:27:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:27:39 INFO - "platform": "ubuntu64_hw", 02:27:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:27:39 INFO - "branch": "mozilla-aurora", 02:27:39 INFO - "repo_path": "releases/mozilla-aurora", 02:27:39 INFO - "revision": "1abb4b193740653f1161d86f38dbb79287e7d69b", 02:27:39 INFO - "pgo_build": "True", 02:27:39 INFO - "builduid": "478b5aa5cf0243f39af9c10f09cd9120", 02:27:39 INFO - "slavebuilddir": "test" 02:27:39 INFO - } 02:27:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:27:39 INFO - Running post-action listener: _resource_record_post_action 02:27:39 INFO - [mozharness: 2017-01-12 10:27:39.143477Z] Finished read-buildbot-config step (success) 02:27:39 INFO - [mozharness: 2017-01-12 10:27:39.143565Z] Running download-and-extract step. 02:27:39 INFO - Running pre-action listener: _resource_record_pre_action 02:27:39 INFO - Running main action method: download_and_extract 02:27:39 INFO - mkdir: /builds/slave/test/build/tests 02:27:39 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')]} 02:27:39 INFO - trying https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:27:39 INFO - Downloading https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/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 02:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/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 02:27:39 INFO - Downloaded 1361 bytes. 02:27:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:27:39 INFO - Using the following test package requirements: 02:27:39 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:27:39 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:27:39 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:27:39 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'jsshell-linux-x86_64.zip'], 02:27:39 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:27:39 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:27:39 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:27:39 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:27:39 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:27:39 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:27:39 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:27:39 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:27:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:27:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:27:39 INFO - Fetch https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:27:40 INFO - Http code: 200 02:27:40 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 02:27:40 INFO - x-amz-cf-id: qVfqXRVYGxBDDoV1jw1Idplkpbo_OKodoMthMxOQ-28bqxZWg00xfQ== 02:27:40 INFO - x-amz-version-id: Q.B8iMiXoF3SCe559LxtGmq3mijYYT5j 02:27:40 INFO - Expected file size: 21946275 02:27:40 INFO - Obtained file size: 21946275 02:27:44 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 02:27:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:27:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:27:44 INFO - Fetch https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:27:45 INFO - Http code: 200 02:27:45 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 02:27:45 INFO - x-amz-cf-id: XHU0NJDjFJy1jlP_4zQs9rNIO2P_gliYvrQtK_eluAgbnwPA7vw7ig== 02:27:45 INFO - x-amz-version-id: Q.B8iMiXoF3SCe559LxtGmq3mijYYT5j 02:27:45 INFO - Expected file size: 21946275 02:27:45 INFO - Obtained file size: 21946275 02:27:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:27:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:27:49 INFO - Fetch https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:27:50 INFO - Http code: 200 02:27:50 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 02:27:50 INFO - x-amz-cf-id: g5GWKBJGG_GjDNFWzzB5BY1ZXdzKg9Kjllw1JTa8nGRNKPCb1kPHSQ== 02:27:50 INFO - x-amz-version-id: g_CXp2v.LXSFDmL.Q54PPlkKT6Zz7UqR 02:27:50 INFO - Expected file size: 14409038 02:27:50 INFO - Obtained file size: 14409038 02:27:50 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')]} 02:27:50 INFO - trying https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:27:50 INFO - Downloading https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/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 02:27:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/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 02:27:51 INFO - Downloaded 64099067 bytes. 02:27:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:27:51 INFO - mkdir: /builds/slave/test/properties 02:27:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:27:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:27:51 INFO - Contents: 02:27:51 INFO - build_url:https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:27:52 INFO - Running post-action listener: _resource_record_post_action 02:27:52 INFO - Running post-action listener: set_extra_try_arguments 02:27:52 INFO - [mozharness: 2017-01-12 10:27:52.666212Z] Finished download-and-extract step (success) 02:27:52 INFO - [mozharness: 2017-01-12 10:27:52.666440Z] Running populate-webroot step. 02:27:52 INFO - Running pre-action listener: _resource_record_pre_action 02:27:52 INFO - Running main action method: populate_webroot 02:27:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:27:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:27:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:27:52 INFO - '--tppagecycles', 02:27:52 INFO - '7'], 02:27:52 INFO - 'tests': ['tsvgm']}}, 02:27:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:27:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:27:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:27:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:27:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:27:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['damp', 'tps']}, 02:27:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'tests': ['damp', 'tps']}, 02:27:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['dromaeo_dom']}, 02:27:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:27:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['basic_compositor_video']}, 02:27:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:27:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['a11yr', 02:27:52 INFO - 'ts_paint', 02:27:52 INFO - 'tpaint', 02:27:52 INFO - 'sessionrestore', 02:27:52 INFO - 'sessionrestore_no_auto_restore', 02:27:52 INFO - 'tabpaint']}, 02:27:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:27:52 INFO - 'ts_paint', 02:27:52 INFO - 'tpaint', 02:27:52 INFO - 'sessionrestore', 02:27:52 INFO - 'sessionrestore_no_auto_restore', 02:27:52 INFO - 'tabpaint']}, 02:27:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:27:52 INFO - 'ts_paint', 02:27:52 INFO - 'tpaint', 02:27:52 INFO - 'sessionrestore', 02:27:52 INFO - 'sessionrestore_no_auto_restore', 02:27:52 INFO - 'tabpaint']}, 02:27:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:27:52 INFO - 'ts_paint', 02:27:52 INFO - 'tpaint', 02:27:52 INFO - 'sessionrestore', 02:27:52 INFO - 'sessionrestore_no_auto_restore', 02:27:52 INFO - 'tabpaint']}, 02:27:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['a11yr', 02:27:52 INFO - 'ts_paint', 02:27:52 INFO - 'tpaint', 02:27:52 INFO - 'sessionrestore', 02:27:52 INFO - 'sessionrestore_no_auto_restore', 02:27:52 INFO - 'tabpaint']}, 02:27:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['a11yr', 02:27:52 INFO - 'ts_paint', 02:27:52 INFO - 'tpaint', 02:27:52 INFO - 'sessionrestore', 02:27:52 INFO - 'sessionrestore_no_auto_restore', 02:27:52 INFO - 'tabpaint']}, 02:27:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['tsvgx', 02:27:52 INFO - 'tsvgr_opacity', 02:27:52 INFO - 'tart', 02:27:52 INFO - 'tscrollx', 02:27:52 INFO - 'cart']}, 02:27:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:27:52 INFO - 'tsvgr_opacity', 02:27:52 INFO - 'tart', 02:27:52 INFO - 'tscrollx', 02:27:52 INFO - 'cart']}, 02:27:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'talos_options': ['--disable-e10s'], 02:27:52 INFO - 'tests': ['tp5o']}, 02:27:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'tests': ['tp5o']}, 02:27:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'talos_options': ['--disable-e10s', 02:27:52 INFO - '--xperf_path', 02:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:52 INFO - 'tests': ['tp5n']}, 02:27:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:27:52 INFO - 'talos_options': ['--xperf_path', 02:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:27:52 INFO - 'tests': ['tp5n']}}, 02:27:52 INFO - 'talos.zip': {'path': '', 02:27:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:27:52 INFO - Running post-action listener: _resource_record_post_action 02:27:52 INFO - [mozharness: 2017-01-12 10:27:52.686564Z] Finished populate-webroot step (success) 02:27:52 INFO - [mozharness: 2017-01-12 10:27:52.686652Z] Running create-virtualenv step. 02:27:52 INFO - Running pre-action listener: _resource_record_pre_action 02:27:52 INFO - Running main action method: create_virtualenv 02:27:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:27:52 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 02:27:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:27:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:27:52 INFO - Using real prefix '/usr' 02:27:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:27:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:27:55 INFO - Installing pip.................done. 02:27:55 INFO - Return code: 0 02:27:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:27:55 INFO - Reading from file tmpfile_stdout 02:27:55 INFO - Output received: 02:27:55 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) 02:27:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:27:55 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')]} 02:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:55 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')]} 02:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:55 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:27:55 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 02:27:55 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 02:27:55 INFO - Using env: {'DISPLAY': ':0', 02:27:55 INFO - 'HOME': '/home/cltbld', 02:27:55 INFO - 'LANG': 'en_US.UTF-8', 02:27:55 INFO - 'LANGUAGE': 'en_US:en', 02:27:55 INFO - 'LOGNAME': 'cltbld', 02:27:55 INFO - 'MAIL': '/var/mail/cltbld', 02:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:55 INFO - 'MOZ_NO_REMOTE': '1', 02:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:55 INFO - 'NO_EM_RESTART': '1', 02:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:55 INFO - 'PWD': '/builds/slave/test', 02:27:55 INFO - 'SHELL': '/bin/bash', 02:27:55 INFO - 'SHLVL': '1', 02:27:55 INFO - 'TERM': 'linux', 02:27:55 INFO - 'TMOUT': '86400', 02:27:55 INFO - 'USER': 'cltbld', 02:27:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:55 INFO - '_': '/tools/buildbot/bin/python'} 02:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:55 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 02:27:55 INFO - Cleaning up... 02:27:55 INFO - Return code: 0 02:27:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:27:55 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')]} 02:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:55 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')]} 02:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:55 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:27:55 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 02:27:55 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 02:27:55 INFO - Using env: {'DISPLAY': ':0', 02:27:55 INFO - 'HOME': '/home/cltbld', 02:27:55 INFO - 'LANG': 'en_US.UTF-8', 02:27:55 INFO - 'LANGUAGE': 'en_US:en', 02:27:55 INFO - 'LOGNAME': 'cltbld', 02:27:55 INFO - 'MAIL': '/var/mail/cltbld', 02:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:55 INFO - 'MOZ_NO_REMOTE': '1', 02:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:55 INFO - 'NO_EM_RESTART': '1', 02:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:55 INFO - 'PWD': '/builds/slave/test', 02:27:55 INFO - 'SHELL': '/bin/bash', 02:27:55 INFO - 'SHLVL': '1', 02:27:55 INFO - 'TERM': 'linux', 02:27:55 INFO - 'TMOUT': '86400', 02:27:55 INFO - 'USER': 'cltbld', 02:27:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:55 INFO - '_': '/tools/buildbot/bin/python'} 02:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:55 INFO - Downloading/unpacking psutil>=3.1.1 02:27:55 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 02:27:55 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 02:27:55 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 02:27:55 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 02:27:55 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 02:27:55 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 02:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:58 INFO - Installing collected packages: psutil 02:27:58 INFO - Running setup.py install for psutil 02:27:58 INFO - building 'psutil._psutil_linux' extension 02:27:58 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 02:27:58 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 02:27:58 INFO - building 'psutil._psutil_posix' extension 02:27:58 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 02:27:58 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 02:27:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:27:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:27:58 INFO - Successfully installed psutil 02:27:58 INFO - Cleaning up... 02:27:58 INFO - Return code: 0 02:27:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:27:58 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')]} 02:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:58 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')]} 02:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:58 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:27:58 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 02:27:58 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 02:27:58 INFO - Using env: {'DISPLAY': ':0', 02:27:58 INFO - 'HOME': '/home/cltbld', 02:27:58 INFO - 'LANG': 'en_US.UTF-8', 02:27:58 INFO - 'LANGUAGE': 'en_US:en', 02:27:58 INFO - 'LOGNAME': 'cltbld', 02:27:58 INFO - 'MAIL': '/var/mail/cltbld', 02:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:58 INFO - 'MOZ_NO_REMOTE': '1', 02:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:58 INFO - 'NO_EM_RESTART': '1', 02:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:58 INFO - 'PWD': '/builds/slave/test', 02:27:58 INFO - 'SHELL': '/bin/bash', 02:27:58 INFO - 'SHLVL': '1', 02:27:58 INFO - 'TERM': 'linux', 02:27:58 INFO - 'TMOUT': '86400', 02:27:58 INFO - 'USER': 'cltbld', 02:27:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:58 INFO - '_': '/tools/buildbot/bin/python'} 02:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:27:58 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 02:27:58 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 02:27:58 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 02:27:58 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 02:27:58 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 02:27:58 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 02:28:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:28:00 INFO - Installing collected packages: mozsystemmonitor 02:28:00 INFO - Running setup.py install for mozsystemmonitor 02:28:01 INFO - Successfully installed mozsystemmonitor 02:28:01 INFO - Cleaning up... 02:28:01 INFO - Return code: 0 02:28:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:01 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:28:01 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 02:28:01 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 02:28:01 INFO - Using env: {'DISPLAY': ':0', 02:28:01 INFO - 'HOME': '/home/cltbld', 02:28:01 INFO - 'LANG': 'en_US.UTF-8', 02:28:01 INFO - 'LANGUAGE': 'en_US:en', 02:28:01 INFO - 'LOGNAME': 'cltbld', 02:28:01 INFO - 'MAIL': '/var/mail/cltbld', 02:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:01 INFO - 'MOZ_NO_REMOTE': '1', 02:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:01 INFO - 'NO_EM_RESTART': '1', 02:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:01 INFO - 'PWD': '/builds/slave/test', 02:28:01 INFO - 'SHELL': '/bin/bash', 02:28:01 INFO - 'SHLVL': '1', 02:28:01 INFO - 'TERM': 'linux', 02:28:01 INFO - 'TMOUT': '86400', 02:28:01 INFO - 'USER': 'cltbld', 02:28:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:01 INFO - '_': '/tools/buildbot/bin/python'} 02:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:01 INFO - Downloading/unpacking jsonschema==2.5.1 02:28:01 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 02:28:01 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 02:28:01 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 02:28:01 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 02:28:01 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 02:28:01 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 02:28:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:28:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:28:03 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 02:28:03 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 02:28:03 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 02:28:03 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 02:28:03 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 02:28:03 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 02:28:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:28:03 INFO - warning: no files found matching '*.txt' 02:28:03 INFO - no previously-included directories found matching 'build' 02:28:03 INFO - no previously-included directories found matching 'dist' 02:28:03 INFO - no previously-included directories found matching '.git*' 02:28:03 INFO - Installing collected packages: jsonschema, functools32 02:28:03 INFO - Running setup.py install for functools32 02:28:03 INFO - warning: no files found matching '*.txt' 02:28:03 INFO - no previously-included directories found matching 'build' 02:28:03 INFO - no previously-included directories found matching 'dist' 02:28:03 INFO - no previously-included directories found matching '.git*' 02:28:03 INFO - Successfully installed jsonschema functools32 02:28:03 INFO - Cleaning up... 02:28:03 INFO - Return code: 0 02:28:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:03 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:28:03 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 02:28:03 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 02:28:03 INFO - Using env: {'DISPLAY': ':0', 02:28:03 INFO - 'HOME': '/home/cltbld', 02:28:03 INFO - 'LANG': 'en_US.UTF-8', 02:28:03 INFO - 'LANGUAGE': 'en_US:en', 02:28:03 INFO - 'LOGNAME': 'cltbld', 02:28:03 INFO - 'MAIL': '/var/mail/cltbld', 02:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:03 INFO - 'MOZ_NO_REMOTE': '1', 02:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:03 INFO - 'NO_EM_RESTART': '1', 02:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:03 INFO - 'PWD': '/builds/slave/test', 02:28:03 INFO - 'SHELL': '/bin/bash', 02:28:03 INFO - 'SHLVL': '1', 02:28:03 INFO - 'TERM': 'linux', 02:28:03 INFO - 'TMOUT': '86400', 02:28:03 INFO - 'USER': 'cltbld', 02:28:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:03 INFO - '_': '/tools/buildbot/bin/python'} 02:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:28:04 INFO - Cleaning up... 02:28:04 INFO - Return code: 0 02:28:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:28: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')]} 02:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28: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')]} 02:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:04 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:28:04 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 02:28:04 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 02:28:04 INFO - Using env: {'DISPLAY': ':0', 02:28:04 INFO - 'HOME': '/home/cltbld', 02:28:04 INFO - 'LANG': 'en_US.UTF-8', 02:28:04 INFO - 'LANGUAGE': 'en_US:en', 02:28:04 INFO - 'LOGNAME': 'cltbld', 02:28:04 INFO - 'MAIL': '/var/mail/cltbld', 02:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:04 INFO - 'MOZ_NO_REMOTE': '1', 02:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:04 INFO - 'NO_EM_RESTART': '1', 02:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:04 INFO - 'PWD': '/builds/slave/test', 02:28:04 INFO - 'SHELL': '/bin/bash', 02:28:04 INFO - 'SHLVL': '1', 02:28:04 INFO - 'TERM': 'linux', 02:28:04 INFO - 'TMOUT': '86400', 02:28:04 INFO - 'USER': 'cltbld', 02:28:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:04 INFO - '_': '/tools/buildbot/bin/python'} 02:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:28:04 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 02:28:04 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 02:28:04 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 02:28:04 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 02:28:04 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 02:28:04 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 02:28:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:28:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:28:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:06 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 02:28:07 INFO - Downloading docopt-0.6.1.tar.gz 02:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:28:07 INFO - Installing collected packages: blobuploader, requests, docopt 02:28:07 INFO - Running setup.py install for blobuploader 02:28:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:28:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:28:07 INFO - Running setup.py install for requests 02:28:07 INFO - Running setup.py install for docopt 02:28:07 INFO - Successfully installed blobuploader requests docopt 02:28:07 INFO - Cleaning up... 02:28:07 INFO - Return code: 0 02:28:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:07 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')]} 02:28:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:07 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')]} 02:28:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:07 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:28:07 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 02:28:07 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 02:28:07 INFO - Using env: {'DISPLAY': ':0', 02:28:07 INFO - 'HOME': '/home/cltbld', 02:28:07 INFO - 'LANG': 'en_US.UTF-8', 02:28:07 INFO - 'LANGUAGE': 'en_US:en', 02:28:07 INFO - 'LOGNAME': 'cltbld', 02:28:07 INFO - 'MAIL': '/var/mail/cltbld', 02:28:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:07 INFO - 'MOZ_NO_REMOTE': '1', 02:28:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:07 INFO - 'NO_EM_RESTART': '1', 02:28:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:07 INFO - 'PWD': '/builds/slave/test', 02:28:07 INFO - 'SHELL': '/bin/bash', 02:28:07 INFO - 'SHLVL': '1', 02:28:07 INFO - 'TERM': 'linux', 02:28:07 INFO - 'TMOUT': '86400', 02:28:07 INFO - 'USER': 'cltbld', 02:28:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:07 INFO - '_': '/tools/buildbot/bin/python'} 02:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:08 INFO - Running setup.py (path:/tmp/pip-T3Xrg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:08 INFO - Running setup.py (path:/tmp/pip-F170Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:08 INFO - Running setup.py (path:/tmp/pip-UTKVOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:08 INFO - Running setup.py (path:/tmp/pip-X8oS_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:08 INFO - Running setup.py (path:/tmp/pip-MQyK0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:08 INFO - Running setup.py (path:/tmp/pip-RZUcch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:08 INFO - Running setup.py (path:/tmp/pip-HSEnoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:08 INFO - Running setup.py (path:/tmp/pip-JsfQE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:08 INFO - Running setup.py (path:/tmp/pip-YlI_xd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:08 INFO - Running setup.py (path:/tmp/pip-0f2ApC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:08 INFO - Running setup.py (path:/tmp/pip-CtYgBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:08 INFO - Running setup.py (path:/tmp/pip-1vb5fT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:08 INFO - Running setup.py (path:/tmp/pip-ib6KGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:08 INFO - Running setup.py (path:/tmp/pip-85QwUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:09 INFO - Running setup.py (path:/tmp/pip-UIX179-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:09 INFO - Running setup.py (path:/tmp/pip-sbfMTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:09 INFO - Running setup.py (path:/tmp/pip-xRRWKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:28:09 INFO - Running setup.py install for manifestparser 02:28:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:28:09 INFO - Running setup.py install for mozcrash 02:28:09 INFO - Running setup.py install for mozdebug 02:28:09 INFO - Running setup.py install for mozdevice 02:28:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:28:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:28:09 INFO - Running setup.py install for mozfile 02:28:09 INFO - Running setup.py install for mozhttpd 02:28:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:28:09 INFO - Running setup.py install for mozinfo 02:28:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:28:09 INFO - Running setup.py install for mozInstall 02:28:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Running setup.py install for mozleak 02:28:10 INFO - Running setup.py install for mozlog 02:28:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Running setup.py install for moznetwork 02:28:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Running setup.py install for mozprocess 02:28:10 INFO - Running setup.py install for mozprofile 02:28:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Running setup.py install for mozrunner 02:28:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:28:10 INFO - Running setup.py install for mozscreenshot 02:28:10 INFO - Running setup.py install for moztest 02:28:10 INFO - Running setup.py install for mozversion 02:28:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:28:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:28:11 INFO - Cleaning up... 02:28:11 INFO - Return code: 0 02:28:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:11 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')]} 02:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:11 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')]} 02:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:11 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:28:11 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 02:28:11 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 02:28:11 INFO - Using env: {'DISPLAY': ':0', 02:28:11 INFO - 'HOME': '/home/cltbld', 02:28:11 INFO - 'LANG': 'en_US.UTF-8', 02:28:11 INFO - 'LANGUAGE': 'en_US:en', 02:28:11 INFO - 'LOGNAME': 'cltbld', 02:28:11 INFO - 'MAIL': '/var/mail/cltbld', 02:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:11 INFO - 'MOZ_NO_REMOTE': '1', 02:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:11 INFO - 'NO_EM_RESTART': '1', 02:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:11 INFO - 'PWD': '/builds/slave/test', 02:28:11 INFO - 'SHELL': '/bin/bash', 02:28:11 INFO - 'SHLVL': '1', 02:28:11 INFO - 'TERM': 'linux', 02:28:11 INFO - 'TMOUT': '86400', 02:28:11 INFO - 'USER': 'cltbld', 02:28:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:11 INFO - '_': '/tools/buildbot/bin/python'} 02:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:28:11 INFO - Running setup.py (path:/tmp/pip-hh2Y6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:28:11 INFO - Running setup.py (path:/tmp/pip-FQWWEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:28:11 INFO - Running setup.py (path:/tmp/pip-Ff6cJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:28:11 INFO - Running setup.py (path:/tmp/pip-QAcveK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:28:11 INFO - Running setup.py (path:/tmp/pip-4JhUaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:28:11 INFO - Running setup.py (path:/tmp/pip-MSn2Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:28:11 INFO - Running setup.py (path:/tmp/pip-MBkK9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:28:11 INFO - Running setup.py (path:/tmp/pip-7fcivW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:28:11 INFO - Running setup.py (path:/tmp/pip-kEIbwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:28:11 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)) 02:28:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:28:11 INFO - Running setup.py (path:/tmp/pip-OBtmXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:28:12 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)) 02:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:28:12 INFO - Running setup.py (path:/tmp/pip-aLhJPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:28:12 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)) 02:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:28:12 INFO - Running setup.py (path:/tmp/pip-DRmezW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:28:12 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)) 02:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:28:12 INFO - Running setup.py (path:/tmp/pip-jqQktW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:28:12 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)) 02:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:28:12 INFO - Running setup.py (path:/tmp/pip-MH5qcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:28:12 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)) 02:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:12 INFO - Running setup.py (path:/tmp/pip-0_m3uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:28:12 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)) 02:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:28:12 INFO - Running setup.py (path:/tmp/pip-eMjXoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:28:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 02:28:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:28:12 INFO - Running setup.py (path:/tmp/pip-rg7MXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:28:12 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)) 02:28:12 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)) 02:28:12 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)) 02:28:12 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)) 02:28:12 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)) 02:28:12 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)) 02:28:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:28:14 INFO - Downloading blessings-1.6.tar.gz 02:28:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:28:14 INFO - Installing collected packages: blessings 02:28:14 INFO - Running setup.py install for blessings 02:28:14 INFO - Successfully installed blessings 02:28:14 INFO - Cleaning up... 02:28:14 INFO - Return code: 0 02:28:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:28:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:15 INFO - Reading from file tmpfile_stdout 02:28:15 INFO - Current package versions: 02:28:15 INFO - argparse == 1.2.1 02:28:15 INFO - blessings == 1.6 02:28:15 INFO - blobuploader == 1.2.4 02:28:15 INFO - docopt == 0.6.1 02:28:15 INFO - functools32 == 3.2.3-2 02:28:15 INFO - jsonschema == 2.5.1 02:28:15 INFO - manifestparser == 1.1 02:28:15 INFO - mozInstall == 1.12 02:28:15 INFO - mozcrash == 1.0 02:28:15 INFO - mozdebug == 0.1 02:28:15 INFO - mozdevice == 0.48 02:28:15 INFO - mozfile == 1.2 02:28:15 INFO - mozhttpd == 0.7 02:28:15 INFO - mozinfo == 0.9 02:28:15 INFO - mozleak == 0.1 02:28:15 INFO - mozlog == 3.4 02:28:15 INFO - moznetwork == 0.27 02:28:15 INFO - mozprocess == 0.23 02:28:15 INFO - mozprofile == 0.28 02:28:15 INFO - mozrunner == 6.13 02:28:15 INFO - mozscreenshot == 0.1 02:28:15 INFO - mozsystemmonitor == 0.3 02:28:15 INFO - moztest == 0.8 02:28:15 INFO - mozversion == 1.4 02:28:15 INFO - psutil == 3.1.1 02:28:15 INFO - requests == 1.2.3 02:28:15 INFO - wsgiref == 0.1.2 02:28:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:28:15 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')]} 02:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:15 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')]} 02:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:15 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:28:15 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 02:28:15 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 02:28:15 INFO - Using env: {'DISPLAY': ':0', 02:28:15 INFO - 'HOME': '/home/cltbld', 02:28:15 INFO - 'LANG': 'en_US.UTF-8', 02:28:15 INFO - 'LANGUAGE': 'en_US:en', 02:28:15 INFO - 'LOGNAME': 'cltbld', 02:28:15 INFO - 'MAIL': '/var/mail/cltbld', 02:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:15 INFO - 'MOZ_NO_REMOTE': '1', 02:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:15 INFO - 'NO_EM_RESTART': '1', 02:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:15 INFO - 'PWD': '/builds/slave/test', 02:28:15 INFO - 'SHELL': '/bin/bash', 02:28:15 INFO - 'SHLVL': '1', 02:28:15 INFO - 'TERM': 'linux', 02:28:15 INFO - 'TMOUT': '86400', 02:28:15 INFO - 'USER': 'cltbld', 02:28:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:15 INFO - '_': '/tools/buildbot/bin/python'} 02:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 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)) 02:28:15 INFO - Cleaning up... 02:28:15 INFO - Return code: 0 02:28:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:28:15 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')]} 02:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:28:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:15 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')]} 02:28:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:28:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:28:15 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 0x7fbedeeaef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', '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 02:28:15 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 02:28:15 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 02:28:15 INFO - Using env: {'DISPLAY': ':0', 02:28:15 INFO - 'HOME': '/home/cltbld', 02:28:15 INFO - 'LANG': 'en_US.UTF-8', 02:28:15 INFO - 'LANGUAGE': 'en_US:en', 02:28:15 INFO - 'LOGNAME': 'cltbld', 02:28:15 INFO - 'MAIL': '/var/mail/cltbld', 02:28:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:15 INFO - 'MOZ_NO_REMOTE': '1', 02:28:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:15 INFO - 'NO_EM_RESTART': '1', 02:28:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:15 INFO - 'PWD': '/builds/slave/test', 02:28:15 INFO - 'SHELL': '/bin/bash', 02:28:15 INFO - 'SHLVL': '1', 02:28:15 INFO - 'TERM': 'linux', 02:28:15 INFO - 'TMOUT': '86400', 02:28:15 INFO - 'USER': 'cltbld', 02:28:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:15 INFO - '_': '/tools/buildbot/bin/python'} 02:28:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:28:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:28:15 INFO - Cleaning up... 02:28:15 INFO - Return code: 0 02:28:15 INFO - Running post-action listener: _resource_record_post_action 02:28:15 INFO - Running post-action listener: _start_resource_monitoring 02:28:15 INFO - Starting resource monitoring. 02:28:15 INFO - [mozharness: 2017-01-12 10:28:15.528167Z] Finished create-virtualenv step (success) 02:28:15 INFO - [mozharness: 2017-01-12 10:28:15.528667Z] Running install step. 02:28:15 INFO - Running pre-action listener: _resource_record_pre_action 02:28:15 INFO - Running main action method: install 02:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:28:15 INFO - Reading from file tmpfile_stdout 02:28:15 INFO - Detecting whether we're running mozinstall >=1.0... 02:28:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:28:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:28:15 INFO - Reading from file tmpfile_stdout 02:28:15 INFO - Output received: 02:28:15 INFO - Usage: mozinstall [options] installer 02:28:15 INFO - Options: 02:28:15 INFO - -h, --help show this help message and exit 02:28:15 INFO - -d DEST, --destination=DEST 02:28:15 INFO - Directory to install application into. [default: 02:28:15 INFO - "/builds/slave/test"] 02:28:15 INFO - --app=APP Application being installed. [default: firefox] 02:28:15 INFO - mkdir: /builds/slave/test/build/application 02:28:15 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'] 02:28:15 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 02:28:31 INFO - Reading from file tmpfile_stdout 02:28:31 INFO - Output received: 02:28:31 INFO - /builds/slave/test/build/application/firefox/firefox 02:28:31 INFO - Running post-action listener: _resource_record_post_action 02:28:31 INFO - [mozharness: 2017-01-12 10:28:31.847593Z] Finished install step (success) 02:28:31 INFO - [mozharness: 2017-01-12 10:28:31.847837Z] Running run-tests step. 02:28:31 INFO - Running pre-action listener: _resource_record_pre_action 02:28:31 INFO - Running main action method: run_tests 02:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:28:31 INFO - Python 2.7.3 02:28:31 INFO - Return code: 0 02:28:31 INFO - grabbing minidump binary from tooltool 02:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:28:31 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 0x119df60>, '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 0x119ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x119f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:28:31 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 02:28:31 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 02:28:31 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 02:28:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:28:31 INFO - Return code: 0 02:28:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:28:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:28:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:28:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:28:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:28:31 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/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:28:31 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/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 02:28:31 INFO - Using env: {'DISPLAY': ':0', 02:28:31 INFO - 'HOME': '/home/cltbld', 02:28:31 INFO - 'LANG': 'en_US.UTF-8', 02:28:31 INFO - 'LANGUAGE': 'en_US:en', 02:28:31 INFO - 'LOGNAME': 'cltbld', 02:28:31 INFO - 'MAIL': '/var/mail/cltbld', 02:28:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:28:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:28:31 INFO - 'MOZ_NO_REMOTE': '1', 02:28:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:28:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:28:31 INFO - 'NO_EM_RESTART': '1', 02:28:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:28:31 INFO - 'PWD': '/builds/slave/test', 02:28:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:28:31 INFO - 'SHELL': '/bin/bash', 02:28:31 INFO - 'SHLVL': '1', 02:28:31 INFO - 'TERM': 'linux', 02:28:31 INFO - 'TMOUT': '86400', 02:28:31 INFO - 'USER': 'cltbld', 02:28:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363', 02:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:28:31 INFO - '_': '/tools/buildbot/bin/python'} 02:28:31 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/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 02:28:32 INFO - mozversion application_buildid: 20170112004017 02:28:32 INFO - mozversion application_changeset: 1abb4b193740653f1161d86f38dbb79287e7d69b 02:28:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:28:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:28:32 INFO - mozversion application_name: Firefox 02:28:32 INFO - mozversion application_remotingname: firefox-dev 02:28:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:32 INFO - mozversion application_vendor: Mozilla 02:28:32 INFO - mozversion application_version: 52.0a2 02:28:32 INFO - mozversion platform_buildid: 20170112004017 02:28:32 INFO - mozversion platform_changeset: 1abb4b193740653f1161d86f38dbb79287e7d69b 02:28:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:28:32 INFO - mozversion platform_version: 52.0a2 02:28:32 INFO - using testdate: 1484216912 02:28:32 INFO - actual date: 1484216912 02:28:32 INFO - starting webserver on 'localhost:59850' 02:28:32 INFO - SUITE-START | Running 2 tests 02:28:32 INFO - TEST-START | dromaeo_css 02:28:32 INFO - operating with platform_type : linux_ 02:28:32 INFO - Initialising browser for dromaeo_css test... 02:28:32 INFO - TEST-INFO | started process 4526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRo8bzG/profile http://localhost:59850/getInfo.html) 02:28:36 INFO - PROCESS | 4526 | __metrics Screen width/height:1600/1200 02:28:36 INFO - PROCESS | 4526 | colorDepth:24 02:28:36 INFO - PROCESS | 4526 | Browser inner width/height: 1024/697 02:28:36 INFO - PROCESS | 4526 | __metrics 02:28:36 INFO - PROCESS | 4526 | 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" 02:28:36 INFO - PROCESS | 4526 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:28:37 INFO - PROCESS | 4526 | console.error: PushService: 02:28:37 INFO - PROCESS | 4526 | stateChangeProcessEnqueue: Error transitioning state 02:28:37 INFO - PROCESS | 4526 | UnknownError 02:28:37 INFO - TEST-INFO | 4526: exit 0 02:28:37 INFO - Browser initialized. 02:28:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:28:37 INFO - TEST-INFO | started process 4618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRo8bzG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:28:49 INFO - PROCESS | 4618 | RSS: Main: 147214336 02:28:49 INFO - PROCESS | 4618 | 02:31:50 INFO - PROCESS | 4618 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59850/tests/dromaeo/cssquery-ext.html) 02:31:52 INFO - PROCESS | 4618 | RSS: Main: 188092416 02:31:52 INFO - PROCESS | 4618 | 02:34:54 INFO - PROCESS | 4618 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-ext.html (next: http://localhost:59850/tests/dromaeo/cssquery-jquery.html) 02:34:54 INFO - PROCESS | 4618 | RSS: Main: 228098048 02:34:54 INFO - PROCESS | 4618 | 02:37:56 INFO - PROCESS | 4618 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59850/tests/dromaeo/cssquery-mootools.html) 02:37:57 INFO - PROCESS | 4618 | RSS: Main: 202223616 02:37:57 INFO - PROCESS | 4618 | 02:40:59 INFO - PROCESS | 4618 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59850/tests/dromaeo/cssquery-prototype.html) 02:41:00 INFO - PROCESS | 4618 | RSS: Main: 216342528 02:41:00 INFO - PROCESS | 4618 | 02:44:02 INFO - PROCESS | 4618 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59850/tests/dromaeo/cssquery-yui.html) 02:44:03 INFO - PROCESS | 4618 | RSS: Main: 173887488 02:44:03 INFO - PROCESS | 4618 | 02:47:05 INFO - PROCESS | 4618 | Cycle 1(1): loaded http://localhost:59850/tests/dromaeo/cssquery-yui.html (next: http://localhost:59850/tests/dromaeo/cssquery-dojo.html) 02:47:06 INFO - PROCESS | 4618 | RSS: Main: 259661824 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | __start_tp_report 02:47:06 INFO - PROCESS | 4618 | _x_x_mozilla_page_load 02:47:06 INFO - PROCESS | 4618 | _x_x_mozilla_page_load_details 02:47:06 INFO - PROCESS | 4618 | |i|pagename|runs| 02:47:06 INFO - PROCESS | 4618 | |0;dojo.html;3135.5766971458847;3216.630087539933;3266.950995735063;3283.655216202297;3292.621348544918;5621;5691.373948865621;5702.743376548055;5714.571407144465;5721.914171287429;5677.602567820254;5740.225069615601;5754.424557544244;5758.222639943607;5780.161876527901;5127.1027570175165;5151.278820965068;5155.072087024334;5180.1970694542215;5222.7649755760895;5038.067957427887;5050.898982020358;5066.392032956051;5235.607329450307;5257.579393648499;5048.974755126237;5175.948240517584;5196.766145523442;5200.609954253446;5203.375594928595;5182.378114626231;5190.532852043334;5192.532672059495;5196.480351964811;5228.241904923802;4888.804447822083;4971.651984361096;5129.204973229155;5154.613403994716;5207.713575753332;5487.314085739283;5492.176173573956;5586.301712285965;5613.214150019001;5617.325920889479;5920.467157955804;5935.0503919372695;5961.612495187799;6016.1878146450545;6021.458068773788;5956.344802071812;6056.273247210363;6065.2418447694035;6065.969670151621;6067.453929146398;5606;5658.122990936411;5705.486506214461;5728.570357223225;5789.8552536186935;6253.74985000604;6261.342559031327;6263.248410190807;6277.1525844010475;6282.560220784501;5802.187693722883;6016.157737916695;6019.849503762441;6021.57848950578;6024.608400454044;5905.055191169392;5949.613275137102;5985.371535988658;5991;6096.634201947897;5995.850103747442;6035.245594300713;6047.969760151171;6051.606645568024;6058.757649694051;6065.878682426327;6070.787522436782;6071.119687645267;6075.149479072933;6104.328523862371;4568.588827005586;4596.701214421052;4640.512746161672;4667.9766601166775;4683;4177.582241775798;4185.539590645027;4187.099773548702;4193.056562273464;4204.159168166379;5752.338481074647;5765.221695071195;5775.393583673654;5787.88424231513;5788.0739081746715;5958.076498142795;5998.550108741862;6055.576109672281;6082.087686847009;6111.633302001894;5767.336756272998;5769.365369809318;5775.711214439261;5785.450382213683;5805.912911306334;5272.710000949908;5286.259923610698;5286.735663216824;5287.048331300402;5288.68267903927;6134.355892631299;6186.566940314135;6189;6306.873862522724;6362.713677884506;6081.483073938764;6123.069106197319;6137.560853825989;6137.897974673567;6137.9286238596105;6367.013112967497;6379.6810159490915;6383.32975037633;6384.712687928962;6385.616862988236;5812.651240925558;5955.374685657944;6018.458338749533;6019.849503762441;6024.186734790923;5981.850453738692;5982.0727787193055;6029.728662210299;6043.607165534402;6115.755369785159;5889;5928.081147422156;5939.554533409925;5940.316863560746;5943.64338139713;5884.499817515559;5928.3775203603;5932.406759324033;5936.139259807217;5937.495312898452;5756.251687280626;5816.3892791258;5821.126830975219;5846.766129354778;5858.443447872445;5962.4633782959745;5985.880282394415;5986.2517185351835;5995.520358371407;5999.980003399345;5715.799947001835;5762.538996880324;5768.423157684198;5873.794417195378;5887.411258874078 02:47:06 INFO - PROCESS | 4618 | |1;ext.html;579.3337661689058;608.0666177417663;609.9146119543263;664.1399387792811;679.5752654590881;33109.17227069324;43759.78120109403;44602;44845.7757711211;44925;46744;47197.764011179985;47304;47353.52646473534;47389.289160662614;8395.664173433055;8876.55617219138;9008.41445306053;9012.77468063297;9015.053419390968;8448.61981210844;10562.894371056267;10827.296225745302;10847.945760271188;11113.611023614176;10951.233413661046;11001.889981100167;11025.393603351813;11028.613998510054;11029.44852757363;10809;10851.51168197433;10868.891311086945;10877.02106810387;10887.18346124036;10681.771596266373;10706.892931070668;10771.5691372345;10829.83755243672;10841.566337346496;43726.562734372565;44079.559204407866;44095.55904440946;44109.33835992463;44138.11723765507;3589.9820500897326;3760.9247815043545;3777.5089238399105;3818.4463252828464;4030.6372426481757;32936;33443.49834752481;33512.329753404796;33521.77523207198;33688.663113369046;4465;4518.299663552155;4518.661100417449;4527.320901864747;4574.794134263932;345186;346857;348584;350629;350743;62730;63179.6841015792;63188.052179217346;63311;63312.68343658252;40336;41111.383329250086;41368.79315603403;43426.56573434288;65851.67074164694;17108.059056751998;17173.91413042952;17179.914100429418;17210.91394543019;17229.31082756701;12466.81299780504;13099.148555344063;13389.062765606508;13912.791308130387;14007.369668364949;20098.995050247428;20847.166113355295;20865.165393384093;20974.16103355879;21013.579728405653;6343.714532846033;6490.7079181436;6546.410823025951;6616.305287944792;6645.368689974444;857.2899342678357;913.1325241021057;926.2034650200821;940.8823897012874;1034.1261633919326;32203.838980804947;34291;34407.31185376278;34763.8589413647;34808;1110.4059328259343;1138.5445821671233;1158.976820463586;1205.7467931734259;1219.5426714981882;16992.74510882338;17802.821971780115;17904.462866114038;17914.91042544779;18113.275468981356;510508;515011;515042;519197;519736;60808;61448.692756536824;61550;61556;61574;1318.8351456067992;1328.0902581731546;1348.7909374047038;1380.178793617796;1439.294745574661;29284.267893301985;36621.633783661826;36687.63312366842;36757.44863826991;36992.63007369892;56084.15873761815;58432.70783646055;60445.69777151086;60517.394826051175;65120.67439662771;454607;461366;462092;462205;462411;40132.398014029226;40946.59053409428;43178.568214317456;45779;46259.76870115763;49758.50241497539;49967;50106.248406274666;50583.49416505788;50827;42037.898105095235;42069.36895946624;42086.78956605197;42287.577124229596;43751.78124109359;38585.2282954345;41431.37852932148;41515.30150540205;42194.156116878105;42236.57763422449;42208.57791422046;42433.36349954815;42885.1422971545;43073.78463107665;43090.78454607707;35337.29325413426;37356.626433736405;37823.243535129695;38170.809145954096;38249;28578.428431431672;28960.275993100342;29036.854815725786;29335.413291734472;29413 02:47:06 INFO - PROCESS | 4618 | |2;jquery.html;417.6241382755518;422.24418291258667;429.4524481286359;436.1125110400336;437.496878589622;18483;19221.615567688656;19729.309474168407;19923;20013.59972800545;19185.712214316798;19418.70871936922;19521.51196220095;19746.111424985873;19932.70100948487;5600.5799565032585;5873.089671100986;5876.970615146918;5882.088276317178;5887.1463637772495;4336.869893903188;4549.226631472641;4646.581807637312;5735.397783232763;5820.825375238728;6535.150430444036;6565.737370505174;6643.269240383554;6663.433608143314;6671.866562668743;6374.17135772349;6488.967555162218;6525.836854078686;6551.475881929482;6638.103855979453;5832.650040997553;5840.503557197643;5858.033424484955;5860.912086318709;5872.031114866042;14890.404383824634;16185;22085.668714969288;22472.32583022512;22786.544269114525;2263.2983775029793;2420.6006009008493;2432.8905199266073;2866.226118947893;3051.374468234029;10300.89699103007;10374.377537347707;10785.13718902486;14016.859831401658;15535.530176857894;1899.9620007599908;1916.1664675866043;2016.1935225909606;2021.2824447321284;2066.8966551672356;58369;74400;87022.12977870267;89817.10182898153;91839.08160918439;11504.53981840717;11534.846515348567;11757.176997610257;12054.758904821854;12106.63680089581;16959.491215263562;16967.066811325494;16979.575510612332;16980.40568580094;16997.150142492825;8488.363372747068;8665.870011949826;8779.429337093068;8812.118788121137;8813.911860881437;8144.75565733029;8229.177082291722;8367.665293388196;8415.831683366298;8431.367647426467;4977.278294647256;5009.949900500948;5045.41977672565;5130;5208.9739551302;2063.6801295799173;2084.5935042666533;2095.2247668362497;2109.4620871677625;2154.450615093141;967.1054274795786;1016.2327442780801;1058.1111866032415;1102.8786833448314;1125.780472807811;20596.691049634268;21109.78890211109;21126.154953801677;21199.78800212009;21286.680699789515;968.5254225429488;1025.9846102308472;1034.8292531732332;1039.2153923787491;1045.7124290820086;10683.14534837211;11513.88486115145;11536.480858361394;11741.29552226869;11755.294682318918;446148;451226;452820;463800;463945;88106;89480.5525972379;90480;90923.545382274;95023.52488237653;1018.0633816888333;1029.073833549811;1045.8274384726435;1057.613970900631;1063.4895250279908;17794.199261033027;18122;18133.184006719992;18365.173567189777;18659.720104198175;43055;43255.78372108119;43407.782961084995;43615.34576981284;44906;59396;59781;60411.39588604058;60451;60862.08706869312;8861.64553417856;8940.955295223743;9033.954830225806;9069.911610606769;9366.765830854283;10386.48067596602;13456;13688.794668079787;13840.989240660894;14171.716565668423;11464.369459679798;11746.882531174579;11771.23486973344;12182.329971851634;12244.755139887759;11343.546258149581;11432.542698291974;11510.59712910044;11639.243449175776;11855.58505452305;10604.151667866707;11898.821517677068;11904.702382440508;12085;12204.08469364819;8033.799155021171;8382.620959531994;8611.569421528773;8782.956085219534;8972;8737.995130560066;11721.648350549498;12245.632631021084;12250.571230006906;12255.75488490243 02:47:06 INFO - PROCESS | 4618 | |3;mootools.html;1355.9593212203633;1378.6002059402774;1469.5591322603216;1591.6339241974345;1821.8542516598673;7865.803354916123;8518.361122915783;8758.956205218965;8776.034636190023;9037.72886813395;8823.985241697206;8859.114088591137;8884.333674974387;8889.511076890769;8891.377603567753;2392.1986134644917;2418.9758102418928;2427.1990243219784;2428.3200703802963;2429.708434987795;2395.8203134764876;2419.6249581314837;2490.713567939683;2496.7877730392847;2499.0253801017616;2412.1557454890735;2430.7569243075727;2433.6714543536573;2464.2360868130936;2468.062136388179;2368.7157541095094;2370.6918100646976;2393.2580899920995;2396.9760302397012;2402.543516731833;2311.768823117675;2413.263954493879;2430.2587710748217;2431.3070774829266;2435.0381599268367;7918.366530677532;8108.027036755568;8762.474251544863;8919.152680495343;8927.196552310323;5056.317397151374;5262.815801446969;5267.920981185285;5278.419373868871;5349.277847490578;3326.916827079318;3391.2369716813764;3416.197193659488;3432.8798492052906;3510.508528805969;1021.1728499915092;1037.1339931157493;1039.6517166749147;1050.2648146297545;1056.4031322302874;12078.27530348182;12290.569830055994;12323.322217278046;12368.44342004612;12375.62873113808;4684.648651351163;4701.083288758728;4829.468758436569;4852.878678033077;4880.463149053601;10556.47217639115;10558.366498010144;10561.049505544537;10565.366078035342;10567.207459440573;5530.391656917735;5533.667979921218;5536.390996990328;5537.501624853782;5543.52880005204;5025.070361983045;5060.873478163002;5130.615203859726;5159.561437277874;5183.377994640668;4036.4348991141264;4039.111395492987;4130.153318569686;4153.709240353207;4188.518320393194;1321.8281623388898;1366.794980752895;1373.4437552791135;1374.312843578211;1384.764590019699;848.7114381110329;934.6822080492665;1000.7147962830559;1003.4581326083833;1028.141501845952;5644.294463192101;5876.44173803488;5882.764689412461;5983.700814959322;6163.19878415803;954.8854137503405;964.5996911281879;971.3831716859704;987.9012098790207;1002.1331548210745;4049.1294371709637;4107.281225785476;4144.7513149211145;4178.22702799983;4219.704620676584;10019.148372388283;10396.376217426978;10427.009434103747;10690.679279621623;10798.838017429745;10558.788824223473;10914.126869850552;10928.180386471047;10957.616483423042;11075.50160242791;7994.440389172702;8224.465409748347;8244.381671374671;8248.381371397169;8251.422400432033;5999.430054144849;6038.426349496791;6102.931986902186;6129.662868542273;6154.815355539341;9587.520623968634;9784.706458806248;9838.36050656705;9914.30599858003;10107.444090575089;9967.60129594837;10098.798024039625;10099.7475063124;10142.340747851365;10176.592936282466;7327.74352897646;7501.099868015873;7760.068791745027;7927.563983980705;7936.56348900816;8442.915570844458;8602.526861022703;8674;8716;8727.432716873383;7459.142198647225;7608.695652173851;7612.200718924433;7718.53688778675;7785.104712958082;7337;7561.09266887977;7561.697532098875;7665;7689.807754806175;6867.622280774605;6973.267806880407;6974.19796723363;6975.79072627822;6978.651067446709;5113.15632920564;5163.870903227449;5199.4020687621405;5230.320058392384;5318.707471088973;5036.29491871131;5063.974680126576;5089.312942752681;5160.251763494347;5396.325459317585 02:47:06 INFO - PROCESS | 4618 | |4;prototype.html;347.20836492796417;362.31341607653496;362.4020366395447;362.6609120472357;367.1408903166591;5354.250404943311;5406.40529541751;5418.810341638044;5437.32033495813;5457.454254574541;5073.670211436263;5193.584513238941;5196.974015129928;5282.471752824716;5300.814471493499;4235.322348424253;4237.555056719047;4242;4248.34150706641;4266.957330426687;4261.552536983603;4265.978670106645;4267.914641707164;4269.274223382017;4281.486221653406;4084.9183016339657;4162.854300099497;4167.312393455076;4168.687348448863;4187.14163596462;4163.91672166555;4165.75005499668;4172.833086676529;4177.874663760092;4181.142865712522;3710.5176327077306;3712.350338690718;3714.572824125233;3715.9442608360896;3720.6279372062577;5040.621953353477;5239.685618862881;5251.529571719924;5257.474252574751;5270.868228294285;4826.927596086061;4847.587955023827;4848.248521479177;4857.619766314516;4864.246041863482;5599.496045355897;5619.269494965669;5637.210790489335;5646.350669672999;5648.4633959773755;3984.4222587724907;4072.429859819628;4111.198316328318;4115.794210289503;4134.044158426709;5788.594798364116;5808.0252714077415;5822.3886491918165;5833.533317334603;5851.707414629294;4209.221294060609;4209.894752631209;4218.2196293685765;4225.2817021105875;4225.72532785368;3998.2403343364667;4178.412203362764;4210.452641156691;4294.634956028773;4310;4768.213244814636;4768.523147685204;4781.952180478151;4793.1372352976105;4844.685095468853;5665.320161580555;5675.659460432387;5697.572682048863;5697.629654072555;5742.913856292159;1381.6062422209623;1420.7939848721878;1437.8705916467568;1439.4961763382732;1456.1190479759593;942.2132519346422;947.7535840681472;950.9776989736062;961.3991255465335;969.5346233807812;5209.47905209476;5215.973920130375;5226.660267082703;5243.397009343898;5246.632735708464;5479.904019196177;5519.613627046068;5526.854858855858;5531.225628412026;5537.972310138423;5199.752059505691;5210.775467765072;5216.591520289577;5242.868928276824;5498.862528436741;2929.037544844959;2988.596539467144;3002.654694710093;3005.4740420426338;3016.4117996990376;5808.477237048602;5833.591648584643;5848.917950179145;5866.50134738552;5874.800801290803;5446.031912607638;5681.971590142023;5696.857578560486;5733.770649173986;5757.251557297524;5762.9135562966585;5767.423257674283;5779.739911703899;5810.256922923106;5812.912806307909;5394.67830381559;5534.418886016911;5598.412166722435;5599.272094627672;5652.7738890443925;5532.972335138298;5544.311009160635;5547.5007249347755;5548.722563871709;5571.693556854249;5807.477327040587;5810.506106980785;5817.970910145422;5843.561732869966;5846.889091072682;3951.1900060486955;3958.2083583282883;4045.8786236412957;4059.3505039193587;4069.9796501017304;5557.861053473695;5567.24842146305;5594.916076258941;5602.243697101002;5611.186377975252;5614.69119198448;5615.410381909841;5631.183478395692;5634.661920284796;5650.519705825051;5376.489233522809;5586.692731899784;5620.718964051863;5628.324601047737;5630.3525094613005;5575.498205161555;5589.301337332833;5591.672954592012;5593.328800543798;5610.85972850682;5643.181738647791;5650.26546548946;5664.130836823921;5688.800891968761;5693.5160511357;5322.414534401135;5575.581831362583;5606.383297837317;5612.85967850807;5627.43725627434 02:47:06 INFO - PROCESS | 4618 | |5;yui.html;737.5685224143875;743.7136702369589;769.6767357709762;774.24124358129;775.5385545600366;13522.256275904821;14178.574642760734;14185.219812910273;14197.574072777821;14201.715965680705;14051.859481405183;14179.220142892136;14188.787168192486;14192.07751496152;14207.147571145713;712.6401167410451;732.5860888597952;820.5076953827686;847.6185716427601;861.7845538615346;858.3219256787131;866.4281574161055;867.4491697771929;871.2811930157613;871.6861929705333;911.8449863523217;913.3880300198882;913.5067063785548;915.3683958068945;920.6179435534245;750.6847124207818;764.7514557768719;846.826400587881;878.7627340617997;885.6014793342957;655.9639219842907;657.4937298280345;657.6350125680245;657.7467674945133;657.9013148027786;13305.600831975056;13317.467301307935;13322.80015799754;13330.533431329857;13368.33158342079;12171.939140304241;12438.937805311007;12444.128910976235;12675.429605667767;12869.678258043623;12064.577739779153;12120.272783632921;12280.078994075391;12310.13829031968;12453.25280483174;4302.397664326997;4362.541933097011;4373.343998400265;4375.2124617568825;4440.4227450431235;59831.102533462035;62966;63087.369126309066;63362.36637633611;64820;10181.490925453698;10467.790644187073;10554.525046372932;10596.682099537025;10618.960874386168;18046.458606241835;18055.638887222445;18057.27770889176;18060;18078.45764627063;8228.588570571448;8240.093589705128;8308.501489910625;8427.199416055464;8526.957365213259;4638.814447422065;4837.153498137882;4842.370491836039;4888.7311197884455;4902.191138462185;3528.8412021459094;3692.3538380783257;3715.0898029982827;3717.9442308365396;3720.2373513429684;580.7125472890946;590.5924911810837;595.0479233226889;595.3837777899853;596.4751019103162;596.5525855608294;626.4299487466384;628.8710814283061;629.6411045703996;652.5758257132902;8379.664813407517;8471;8509.531975741394;8585.141485851365;8833.64665413389;689.7585844954326;694.583250049966;697.7418355208605;715.2918610575597;719.1693593899055;3898.7465814721954;4051.331530297468;4122.7732474713575;4196.475440569929;4297.05464797744;86688.5665571668;88107.55946220228;90656;91878.54060729654;96955;80385.19614803776;80693.59653201696;81399.18600814034;81649;83397.16602833894;71532;72784.63607681928;73393.6330318345;73591.63204183945;76143.23856761472;7841.294283514511;8027.2775450209765;8057.27484526372;8152.225538573826;8269.503829770232;48756;49364;49481.752591236815;49796.51424400402;50525;61717.38282617116;66173.33826661672;66561;67190.32809672036;68575;10315.432651204255;10462.895371046192;10494.370337779757;10615.363078215332;10662.360258384522;12047.698807529881;12137.817932731192;12299.44652490658;12316.753664926831;12348.81476777831;9947.502624868872;11153.888461115284;11332.886671133512;11428.885711142782;12070.577529786766;11784.823227651763;12007.519699211934;12038.518459261531;12383.876161238271;12626.305553194295;10734.570617175537;10977;11202.383868886964;11411.37237451915;12079.094067945114;9606.423614583147;9994.500274986367;10635.20235982289;10805.729856753644;10902.50938707776;10085;10247.436390998566;10296.536655850654;10327.070563649308;10411.635592754217 02:47:06 INFO - PROCESS | 4618 | __end_tp_report 02:47:06 INFO - PROCESS | 4618 | __start_cc_report 02:47:06 INFO - PROCESS | 4618 | _x_x_mozilla_cycle_collect,1426 02:47:06 INFO - PROCESS | 4618 | __end_cc_report 02:47:06 INFO - PROCESS | 4618 | __startTimestamp1484218026123__endTimestamp 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | ------- Summary: start ------- 02:47:06 INFO - PROCESS | 4618 | Number of tests: 6 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | [#0] dojo.html Cycles:165 Average:5633.76 Median:5821.13 stddev:642.34 (11.0%) stddev-sans-first:613.68 02:47:06 INFO - PROCESS | 4618 | Values: 3135.6 3216.6 3267.0 3283.7 3292.6 5621.0 5691.4 5702.7 5714.6 5721.9 5677.6 5740.2 5754.4 5758.2 5780.2 5127.1 5151.3 5155.1 5180.2 5222.8 5038.1 5050.9 5066.4 5235.6 5257.6 5049.0 5175.9 5196.8 5200.6 5203.4 5182.4 5190.5 5192.5 5196.5 5228.2 4888.8 4971.7 5129.2 5154.6 5207.7 5487.3 5492.2 5586.3 5613.2 5617.3 5920.5 5935.1 5961.6 6016.2 6021.5 5956.3 6056.3 6065.2 6066.0 6067.5 5606.0 5658.1 5705.5 5728.6 5789.9 6253.7 6261.3 6263.2 6277.2 6282.6 5802.2 6016.2 6019.8 6021.6 6024.6 5905.1 5949.6 5985.4 5991.0 6096.6 5995.9 6035.2 6048.0 6051.6 6058.8 6065.9 6070.8 6071.1 6075.1 6104.3 4568.6 4596.7 4640.5 4668.0 4683.0 4177.6 4185.5 4187.1 4193.1 4204.2 5752.3 5765.2 5775.4 5787.9 5788.1 5958.1 5998.6 6055.6 6082.1 6111.6 5767.3 5769.4 5775.7 5785.5 5805.9 5272.7 5286.3 5286.7 5287.0 5288.7 6134.4 6186.6 6189.0 6306.9 6362.7 6081.5 6123.1 6137.6 6137.9 6137.9 6367.0 6379.7 6383.3 6384.7 6385.6 5812.7 5955.4 6018.5 6019.8 6024.2 5981.9 5982.1 6029.7 6043.6 6115.8 5889.0 5928.1 5939.6 5940.3 5943.6 5884.5 5928.4 5932.4 5936.1 5937.5 5756.3 5816.4 5821.1 5846.8 5858.4 5962.5 5985.9 5986.3 5995.5 6000.0 5715.8 5762.5 5768.4 5873.8 5887.4 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | [#1] ext.html Cycles:180 Average:61620.97 Median:41240.09 stddev:118169.01 (286.5%) stddev-sans-first:118411.63 02:47:06 INFO - PROCESS | 4618 | Values: 579.3 608.1 609.9 664.1 679.6 33109.2 43759.8 44602.0 44845.8 44925.0 46744.0 47197.8 47304.0 47353.5 47389.3 8395.7 8876.6 9008.4 9012.8 9015.1 8448.6 10562.9 10827.3 10847.9 11113.6 10951.2 11001.9 11025.4 11028.6 11029.4 10809.0 10851.5 10868.9 10877.0 10887.2 10681.8 10706.9 10771.6 10829.8 10841.6 43726.6 44079.6 44095.6 44109.3 44138.1 3590.0 3760.9 3777.5 3818.4 4030.6 32936.0 33443.5 33512.3 33521.8 33688.7 4465.0 4518.3 4518.7 4527.3 4574.8 345186.0 346857.0 348584.0 350629.0 350743.0 62730.0 63179.7 63188.1 63311.0 63312.7 40336.0 41111.4 41368.8 43426.6 65851.7 17108.1 17173.9 17179.9 17210.9 17229.3 12466.8 13099.1 13389.1 13912.8 14007.4 20099.0 20847.2 20865.2 20974.2 21013.6 6343.7 6490.7 6546.4 6616.3 6645.4 857.3 913.1 926.2 940.9 1034.1 32203.8 34291.0 34407.3 34763.9 34808.0 1110.4 1138.5 1159.0 1205.7 1219.5 16992.7 17802.8 17904.5 17914.9 18113.3 510508.0 515011.0 515042.0 519197.0 519736.0 60808.0 61448.7 61550.0 61556.0 61574.0 1318.8 1328.1 1348.8 1380.2 1439.3 29284.3 36621.6 36687.6 36757.4 36992.6 56084.2 58432.7 60445.7 60517.4 65120.7 454607.0 461366.0 462092.0 462205.0 462411.0 40132.4 40946.6 43178.6 45779.0 46259.8 49758.5 49967.0 50106.2 50583.5 50827.0 42037.9 42069.4 42086.8 42287.6 43751.8 38585.2 41431.4 41515.3 42194.2 42236.6 42208.6 42433.4 42885.1 43073.8 43090.8 35337.3 37356.6 37823.2 38170.8 38249.0 28578.4 28960.3 29036.9 29335.4 29413.0 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | [#2] jquery.html Cycles:180 Average:28345.38 Median:12367.81 stddev:75294.79 (608.8%) stddev-sans-first:75476.81 02:47:06 INFO - PROCESS | 4618 | Values: 417.6 422.2 429.5 436.1 437.5 18483.0 19221.6 19729.3 19923.0 20013.6 19185.7 19418.7 19521.5 19746.1 19932.7 5600.6 5873.1 5877.0 5882.1 5887.1 4336.9 4549.2 4646.6 5735.4 5820.8 6535.2 6565.7 6643.3 6663.4 6671.9 6374.2 6489.0 6525.8 6551.5 6638.1 5832.7 5840.5 5858.0 5860.9 5872.0 14890.4 16185.0 22085.7 22472.3 22786.5 2263.3 2420.6 2432.9 2866.2 3051.4 10300.9 10374.4 10785.1 14016.9 15535.5 1900.0 1916.2 2016.2 2021.3 2066.9 58369.0 74400.0 87022.1 89817.1 91839.1 11504.5 11534.8 11757.2 12054.8 12106.6 16959.5 16967.1 16979.6 16980.4 16997.2 8488.4 8665.9 8779.4 8812.1 8813.9 8144.8 8229.2 8367.7 8415.8 8431.4 4977.3 5009.9 5045.4 5130.0 5209.0 2063.7 2084.6 2095.2 2109.5 2154.5 967.1 1016.2 1058.1 1102.9 1125.8 20596.7 21109.8 21126.2 21199.8 21286.7 968.5 1026.0 1034.8 1039.2 1045.7 10683.1 11513.9 11536.5 11741.3 11755.3 446148.0 451226.0 452820.0 463800.0 463945.0 88106.0 89480.6 90480.0 90923.5 95023.5 1018.1 1029.1 1045.8 1057.6 1063.5 17794.2 18122.0 18133.2 18365.2 18659.7 43055.0 43255.8 43407.8 43615.3 44906.0 59396.0 59781.0 60411.4 60451.0 60862.1 8861.6 8941.0 9034.0 9069.9 9366.8 10386.5 13456.0 13688.8 13841.0 14171.7 11464.4 11746.9 11771.2 12182.3 12244.8 11343.5 11432.5 11510.6 11639.2 11855.6 10604.2 11898.8 11904.7 12085.0 12204.1 8033.8 8382.6 8611.6 8783.0 8972.0 8738.0 11721.6 12245.6 12250.6 12255.8 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | [#3] mootools.html Cycles:180 Average:5818.85 Median:5046.31 stddev:3241.27 (64.2%) stddev-sans-first:3233.01 02:47:06 INFO - PROCESS | 4618 | Values: 1356.0 1378.6 1469.6 1591.6 1821.9 7865.8 8518.4 8759.0 8776.0 9037.7 8824.0 8859.1 8884.3 8889.5 8891.4 2392.2 2419.0 2427.2 2428.3 2429.7 2395.8 2419.6 2490.7 2496.8 2499.0 2412.2 2430.8 2433.7 2464.2 2468.1 2368.7 2370.7 2393.3 2397.0 2402.5 2311.8 2413.3 2430.3 2431.3 2435.0 7918.4 8108.0 8762.5 8919.2 8927.2 5056.3 5262.8 5267.9 5278.4 5349.3 3326.9 3391.2 3416.2 3432.9 3510.5 1021.2 1037.1 1039.7 1050.3 1056.4 12078.3 12290.6 12323.3 12368.4 12375.6 4684.6 4701.1 4829.5 4852.9 4880.5 10556.5 10558.4 10561.0 10565.4 10567.2 5530.4 5533.7 5536.4 5537.5 5543.5 5025.1 5060.9 5130.6 5159.6 5183.4 4036.4 4039.1 4130.2 4153.7 4188.5 1321.8 1366.8 1373.4 1374.3 1384.8 848.7 934.7 1000.7 1003.5 1028.1 5644.3 5876.4 5882.8 5983.7 6163.2 954.9 964.6 971.4 987.9 1002.1 4049.1 4107.3 4144.8 4178.2 4219.7 10019.1 10396.4 10427.0 10690.7 10798.8 10558.8 10914.1 10928.2 10957.6 11075.5 7994.4 8224.5 8244.4 8248.4 8251.4 5999.4 6038.4 6102.9 6129.7 6154.8 9587.5 9784.7 9838.4 9914.3 10107.4 9967.6 10098.8 10099.7 10142.3 10176.6 7327.7 7501.1 7760.1 7927.6 7936.6 8442.9 8602.5 8674.0 8716.0 8727.4 7459.1 7608.7 7612.2 7718.5 7785.1 7337.0 7561.1 7561.7 7665.0 7689.8 6867.6 6973.3 6974.2 6975.8 6978.7 5113.2 5163.9 5199.4 5230.3 5318.7 5036.3 5064.0 5089.3 5160.3 5396.3 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | [#4] prototype.html Cycles:180 Average:4701.90 Median:5365.37 stddev:1361.14 (25.4%) stddev-sans-first:1325.13 02:47:06 INFO - PROCESS | 4618 | Values: 347.2 362.3 362.4 362.7 367.1 5354.3 5406.4 5418.8 5437.3 5457.5 5073.7 5193.6 5197.0 5282.5 5300.8 4235.3 4237.6 4242.0 4248.3 4267.0 4261.6 4266.0 4267.9 4269.3 4281.5 4084.9 4162.9 4167.3 4168.7 4187.1 4163.9 4165.8 4172.8 4177.9 4181.1 3710.5 3712.4 3714.6 3715.9 3720.6 5040.6 5239.7 5251.5 5257.5 5270.9 4826.9 4847.6 4848.2 4857.6 4864.2 5599.5 5619.3 5637.2 5646.4 5648.5 3984.4 4072.4 4111.2 4115.8 4134.0 5788.6 5808.0 5822.4 5833.5 5851.7 4209.2 4209.9 4218.2 4225.3 4225.7 3998.2 4178.4 4210.5 4294.6 4310.0 4768.2 4768.5 4782.0 4793.1 4844.7 5665.3 5675.7 5697.6 5697.6 5742.9 1381.6 1420.8 1437.9 1439.5 1456.1 942.2 947.8 951.0 961.4 969.5 5209.5 5216.0 5226.7 5243.4 5246.6 5479.9 5519.6 5526.9 5531.2 5538.0 5199.8 5210.8 5216.6 5242.9 5498.9 2929.0 2988.6 3002.7 3005.5 3016.4 5808.5 5833.6 5848.9 5866.5 5874.8 5446.0 5682.0 5696.9 5733.8 5757.3 5762.9 5767.4 5779.7 5810.3 5812.9 5394.7 5534.4 5598.4 5599.3 5652.8 5533.0 5544.3 5547.5 5548.7 5571.7 5807.5 5810.5 5818.0 5843.6 5846.9 3951.2 3958.2 4045.9 4059.4 4070.0 5557.9 5567.2 5594.9 5602.2 5611.2 5614.7 5615.4 5631.2 5634.7 5650.5 5376.5 5586.7 5620.7 5628.3 5630.4 5575.5 5589.3 5591.7 5593.3 5610.9 5643.2 5650.3 5664.1 5688.8 5693.5 5322.4 5575.6 5606.4 5612.9 5627.4 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - PROCESS | 4618 | [#5] yui.html Cycles:180 Average:17941.22 Median:50160.76 stddev:24778.85 (49.4%) stddev-sans-first:24814.68 02:47:06 INFO - PROCESS | 4618 | Values: 737.6 743.7 769.7 774.2 775.5 13522.3 14178.6 14185.2 14197.6 14201.7 14051.9 14179.2 14188.8 14192.1 14207.1 712.6 732.6 820.5 847.6 861.8 858.3 866.4 867.4 871.3 871.7 911.8 913.4 913.5 915.4 920.6 750.7 764.8 846.8 878.8 885.6 656.0 657.5 657.6 657.7 657.9 13305.6 13317.5 13322.8 13330.5 13368.3 12171.9 12438.9 12444.1 12675.4 12869.7 12064.6 12120.3 12280.1 12310.1 12453.3 4302.4 4362.5 4373.3 4375.2 4440.4 59831.1 62966.0 63087.4 63362.4 64820.0 10181.5 10467.8 10554.5 10596.7 10619.0 18046.5 18055.6 18057.3 18060.0 18078.5 8228.6 8240.1 8308.5 8427.2 8527.0 4638.8 4837.2 4842.4 4888.7 4902.2 3528.8 3692.4 3715.1 3717.9 3720.2 580.7 590.6 595.0 595.4 596.5 596.6 626.4 628.9 629.6 652.6 8379.7 8471.0 8509.5 8585.1 8833.6 689.8 694.6 697.7 715.3 719.2 3898.7 4051.3 4122.8 4196.5 4297.1 86688.6 88107.6 90656.0 91878.5 96955.0 80385.2 80693.6 81399.2 81649.0 83397.2 71532.0 72784.6 73393.6 73591.6 76143.2 7841.3 8027.3 8057.3 8152.2 8269.5 48756.0 49364.0 49481.8 49796.5 50525.0 61717.4 66173.3 66561.0 67190.3 68575.0 10315.4 10462.9 10494.4 10615.4 10662.4 12047.7 12137.8 12299.4 12316.8 12348.8 9947.5 11153.9 11332.9 11428.9 12070.6 11784.8 12007.5 12038.5 12383.9 12626.3 10734.6 10977.0 11202.4 11411.4 12079.1 9606.4 9994.5 10635.2 10805.7 10902.5 10085.0 10247.4 10296.5 10327.1 10411.6 02:47:06 INFO - PROCESS | 4618 | -------- Summary: end -------- 02:47:06 INFO - PROCESS | 4618 | 02:47:06 INFO - TEST-INFO | 4618: exit 0 02:47:06 INFO - TEST-OK | dromaeo_css | took 1114768ms 02:47:06 INFO - TEST-START | kraken 02:47:06 INFO - operating with platform_type : linux_ 02:47:06 INFO - Initialising browser for kraken test... 02:47:06 INFO - TEST-INFO | started process 4932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzlwucv/profile http://localhost:59850/getInfo.html) 02:47:10 INFO - PROCESS | 4932 | __metrics Screen width/height:1600/1200 02:47:10 INFO - PROCESS | 4932 | colorDepth:24 02:47:10 INFO - PROCESS | 4932 | Browser inner width/height: 1024/697 02:47:10 INFO - PROCESS | 4932 | __metrics 02:47:11 INFO - PROCESS | 4932 | 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" 02:47:11 INFO - PROCESS | 4932 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:47:11 INFO - PROCESS | 4932 | console.error: PushService: 02:47:11 INFO - PROCESS | 4932 | stateChangeProcessEnqueue: Error transitioning state 02:47:11 INFO - PROCESS | 4932 | UnknownError 02:47:12 INFO - TEST-INFO | 4932: exit 0 02:47:12 INFO - Browser initialized. 02:47:12 INFO - Running cycle 1/1 for kraken test... 02:47:12 INFO - TEST-INFO | started process 5026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzlwucv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:47:24 INFO - PROCESS | 5026 | RSS: Main: 147435520 02:47:24 INFO - PROCESS | 5026 | 02:47:26 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-beat-detection) 02:47:27 INFO - PROCESS | 5026 | RSS: Main: 188157952 02:47:27 INFO - PROCESS | 5026 | 02:47:29 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-dft) 02:47:30 INFO - PROCESS | 5026 | RSS: Main: 178180096 02:47:30 INFO - PROCESS | 5026 | 02:47:33 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-fft) 02:47:33 INFO - PROCESS | 5026 | RSS: Main: 269918208 02:47:33 INFO - PROCESS | 5026 | 02:47:36 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59850/tests/kraken/driver.html?testName=audio-oscillator) 02:47:36 INFO - PROCESS | 5026 | RSS: Main: 176365568 02:47:36 INFO - PROCESS | 5026 | 02:47:38 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:47:39 INFO - PROCESS | 5026 | RSS: Main: 178610176 02:47:39 INFO - PROCESS | 5026 | 02:47:42 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59850/tests/kraken/driver.html?testName=imaging-darkroom) 02:47:42 INFO - PROCESS | 5026 | RSS: Main: 217276416 02:47:42 INFO - PROCESS | 5026 | 02:47:46 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59850/tests/kraken/driver.html?testName=imaging-desaturate) 02:47:46 INFO - PROCESS | 5026 | RSS: Main: 216256512 02:47:46 INFO - PROCESS | 5026 | 02:47:49 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59850/tests/kraken/driver.html?testName=json-parse-financial) 02:47:50 INFO - PROCESS | 5026 | RSS: Main: 214470656 02:47:50 INFO - PROCESS | 5026 | 02:47:51 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:47:52 INFO - PROCESS | 5026 | RSS: Main: 177577984 02:47:52 INFO - PROCESS | 5026 | 02:47:53 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:47:54 INFO - PROCESS | 5026 | RSS: Main: 184418304 02:47:54 INFO - PROCESS | 5026 | 02:47:56 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:47:57 INFO - PROCESS | 5026 | RSS: Main: 190050304 02:47:57 INFO - PROCESS | 5026 | 02:47:59 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:48:00 INFO - PROCESS | 5026 | RSS: Main: 198926336 02:48:00 INFO - PROCESS | 5026 | 02:48:02 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:48:03 INFO - PROCESS | 5026 | RSS: Main: 195592192 02:48:03 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | Cycle 1(1): loaded http://localhost:59850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59850/tests/kraken/driver.html?testName=ai-astar) 02:48:05 INFO - PROCESS | 5026 | RSS: Main: 246685696 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | __start_tp_report 02:48:05 INFO - PROCESS | 5026 | _x_x_mozilla_page_load 02:48:05 INFO - PROCESS | 5026 | _x_x_mozilla_page_load_details 02:48:05 INFO - PROCESS | 5026 | |i|pagename|runs| 02:48:05 INFO - PROCESS | 5026 | |0;ai-astar;104;110;111;111;111;112;111;110;109;109 02:48:05 INFO - PROCESS | 5026 | |1;audio-beat-detection;146;121;117;166;118;119;119;124;155;122 02:48:05 INFO - PROCESS | 5026 | |2;audio-dft;162;161;160;162;161;161;163;161;163;161 02:48:05 INFO - PROCESS | 5026 | |3;audio-fft;76;75;76;107;77;76;75;74;98;74 02:48:05 INFO - PROCESS | 5026 | |4;audio-oscillator;82;82;106;82;83;82;119;82;82;118 02:48:05 INFO - PROCESS | 5026 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;118;117 02:48:05 INFO - PROCESS | 5026 | |6;imaging-darkroom;147;146;146;146;146;147;146;146;147;147 02:48:05 INFO - PROCESS | 5026 | |7;imaging-desaturate;85;85;85;86;85;86;85;85;85;84 02:48:05 INFO - PROCESS | 5026 | |8;json-parse-financial;49;51;51;51;50;50;63;54;51;51 02:48:05 INFO - PROCESS | 5026 | |9;json-stringify-tinderbox;60;60;59;61;59;60;59;61;59;59 02:48:05 INFO - PROCESS | 5026 | |10;stanford-crypto-aes;75;74;75;76;75;75;78;75;75;74 02:48:05 INFO - PROCESS | 5026 | |11;stanford-crypto-ccm;133;132;122;122;130;129;121;118;159;138 02:48:05 INFO - PROCESS | 5026 | |12;stanford-crypto-pbkdf2;158;156;155;158;153;153;152;153;156;153 02:48:05 INFO - PROCESS | 5026 | |13;stanford-crypto-sha256-iterative;61;61;63;62;62;62;64;66;62;61 02:48:05 INFO - PROCESS | 5026 | __end_tp_report 02:48:05 INFO - PROCESS | 5026 | __start_cc_report 02:48:05 INFO - PROCESS | 5026 | _x_x_mozilla_cycle_collect,1627 02:48:05 INFO - PROCESS | 5026 | __end_cc_report 02:48:05 INFO - PROCESS | 5026 | __startTimestamp1484218085386__endTimestamp 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | ------- Summary: start ------- 02:48:05 INFO - PROCESS | 5026 | Number of tests: 14 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:2.25 (2.0%) stddev-sans-first:1.01 02:48:05 INFO - PROCESS | 5026 | Values: 104.0 110.0 111.0 111.0 111.0 112.0 111.0 110.0 109.0 109.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:123.00 stddev:17.98 (14.6%) stddev-sans-first:18.19 02:48:05 INFO - PROCESS | 5026 | Values: 146.0 121.0 117.0 166.0 118.0 119.0 119.0 124.0 155.0 122.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 02:48:05 INFO - PROCESS | 5026 | Values: 162.0 161.0 160.0 162.0 161.0 161.0 163.0 161.0 163.0 161.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.67 (15.4%) stddev-sans-first:12.25 02:48:05 INFO - PROCESS | 5026 | Values: 76.0 75.0 76.0 107.0 77.0 76.0 75.0 74.0 98.0 74.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:82.00 stddev:15.92 (19.4%) stddev-sans-first:16.49 02:48:05 INFO - PROCESS | 5026 | Values: 82.0 82.0 106.0 82.0 83.0 82.0 119.0 82.0 82.0 118.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 02:48:05 INFO - PROCESS | 5026 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:48:05 INFO - PROCESS | 5026 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 147.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 02:48:05 INFO - PROCESS | 5026 | Values: 85.0 85.0 85.0 86.0 85.0 86.0 85.0 85.0 85.0 84.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:51.00 stddev:4.04 (7.9%) stddev-sans-first:4.13 02:48:05 INFO - PROCESS | 5026 | Values: 49.0 51.0 51.0 51.0 50.0 50.0 63.0 54.0 51.0 51.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 02:48:05 INFO - PROCESS | 5026 | Values: 60.0 60.0 59.0 61.0 59.0 60.0 59.0 61.0 59.0 59.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.00 stddev:1.14 (1.5%) stddev-sans-first:1.20 02:48:05 INFO - PROCESS | 5026 | Values: 75.0 74.0 75.0 76.0 75.0 75.0 78.0 75.0 75.0 74.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:131.00 stddev:11.88 (9.1%) stddev-sans-first:12.56 02:48:05 INFO - PROCESS | 5026 | Values: 133.0 132.0 122.0 122.0 130.0 129.0 121.0 118.0 159.0 138.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.70 Median:155.50 stddev:2.21 (1.4%) stddev-sans-first:2.00 02:48:05 INFO - PROCESS | 5026 | Values: 158.0 156.0 155.0 158.0 153.0 153.0 152.0 153.0 156.0 153.0 02:48:05 INFO - PROCESS | 5026 | 02:48:05 INFO - PROCESS | 5026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.00 stddev:1.58 (2.5%) stddev-sans-first:1.59 02:48:05 INFO - PROCESS | 5026 | Values: 61.0 61.0 63.0 62.0 62.0 62.0 64.0 66.0 62.0 61.0 02:48:05 INFO - PROCESS | 5026 | -------- Summary: end -------- 02:48:05 INFO - PROCESS | 5026 | 02:48:06 INFO - TEST-INFO | 5026: exit 0 02:48:06 INFO - TEST-OK | kraken | took 59557ms 02:48:06 INFO - SUITE-END | took 1174s 02:48:06 INFO - Completed test suite (00:19:34) 02:48:06 INFO - javascript benchmark 02:48:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3135.5766971458847, 3216.630087539933, 3266.950995735063, 3283.655216202297, 3292.621348544918, 5621.0, 5691.373948865621, 5702.743376548055, 5714.571407144465, 5721.914171287429, 5677.602567820254, 5740.225069615601, 5754.424557544244, 5758.222639943607, 5780.161876527901, 5127.1027570175165, 5151.278820965068, 5155.072087024334, 5180.1970694542215, 5222.7649755760895, 5038.067957427887, 5050.898982020358, 5066.392032956051, 5235.607329450307, 5257.579393648499, 5048.974755126237, 5175.948240517584, 5196.766145523442, 5200.609954253446, 5203.375594928595, 5182.378114626231, 5190.532852043334, 5192.532672059495, 5196.480351964811, 5228.241904923802, 4888.804447822083, 4971.651984361096, 5129.204973229155, 5154.613403994716, 5207.713575753332, 5487.314085739283, 5492.176173573956, 5586.301712285965, 5613.214150019001, 5617.325920889479, 5920.467157955804, 5935.0503919372695, 5961.612495187799, 6016.1878146450545, 6021.458068773788, 5956.344802071812, 6056.273247210363, 6065.2418447694035, 6065.969670151621, 6067.453929146398, 5606.0, 5658.122990936411, 5705.486506214461, 5728.570357223225, 5789.8552536186935, 6253.74985000604, 6261.342559031327, 6263.248410190807, 6277.1525844010475, 6282.560220784501, 5802.187693722883, 6016.157737916695, 6019.849503762441, 6021.57848950578, 6024.608400454044, 5905.055191169392, 5949.613275137102, 5985.371535988658, 5991.0, 6096.634201947897, 5995.850103747442, 6035.245594300713, 6047.969760151171, 6051.606645568024, 6058.757649694051, 6065.878682426327, 6070.787522436782, 6071.119687645267, 6075.149479072933, 6104.328523862371, 4568.588827005586, 4596.701214421052, 4640.512746161672, 4667.9766601166775, 4683.0, 4177.582241775798, 4185.539590645027, 4187.099773548702, 4193.056562273464, 4204.159168166379, 5752.338481074647, 5765.221695071195, 5775.393583673654, 5787.88424231513, 5788.0739081746715, 5958.076498142795, 5998.550108741862, 6055.576109672281, 6082.087686847009, 6111.633302001894, 5767.336756272998, 5769.365369809318, 5775.711214439261, 5785.450382213683, 5805.912911306334, 5272.710000949908, 5286.259923610698, 5286.735663216824, 5287.048331300402, 5288.68267903927, 6134.355892631299, 6186.566940314135, 6189.0, 6306.873862522724, 6362.713677884506, 6081.483073938764, 6123.069106197319, 6137.560853825989, 6137.897974673567, 6137.9286238596105, 6367.013112967497, 6379.6810159490915, 6383.32975037633, 6384.712687928962, 6385.616862988236, 5812.651240925558, 5955.374685657944, 6018.458338749533, 6019.849503762441, 6024.186734790923, 5981.850453738692, 5982.0727787193055, 6029.728662210299, 6043.607165534402, 6115.755369785159, 5889.0, 5928.081147422156, 5939.554533409925, 5940.316863560746, 5943.64338139713, 5884.499817515559, 5928.3775203603, 5932.406759324033, 5936.139259807217, 5937.495312898452, 5756.251687280626, 5816.3892791258, 5821.126830975219, 5846.766129354778, 5858.443447872445, 5962.4633782959745, 5985.880282394415, 5986.2517185351835, 5995.520358371407, 5999.980003399345, 5715.799947001835, 5762.538996880324, 5768.423157684198, 5873.794417195378, 5887.411258874078], "value": 5589.975828031649, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3337661689058, 608.0666177417663, 609.9146119543263, 664.1399387792811, 679.5752654590881, 33109.17227069324, 43759.78120109403, 44602.0, 44845.7757711211, 44925.0, 46744.0, 47197.764011179985, 47304.0, 47353.52646473534, 47389.289160662614, 8395.664173433055, 8876.55617219138, 9008.41445306053, 9012.77468063297, 9015.053419390968, 8448.61981210844, 10562.894371056267, 10827.296225745302, 10847.945760271188, 11113.611023614176, 10951.233413661046, 11001.889981100167, 11025.393603351813, 11028.613998510054, 11029.44852757363, 10809.0, 10851.51168197433, 10868.891311086945, 10877.02106810387, 10887.18346124036, 10681.771596266373, 10706.892931070668, 10771.5691372345, 10829.83755243672, 10841.566337346496, 43726.562734372565, 44079.559204407866, 44095.55904440946, 44109.33835992463, 44138.11723765507, 3589.9820500897326, 3760.9247815043545, 3777.5089238399105, 3818.4463252828464, 4030.6372426481757, 32936.0, 33443.49834752481, 33512.329753404796, 33521.77523207198, 33688.663113369046, 4465.0, 4518.299663552155, 4518.661100417449, 4527.320901864747, 4574.794134263932, 345186.0, 346857.0, 348584.0, 350629.0, 350743.0, 62730.0, 63179.6841015792, 63188.052179217346, 63311.0, 63312.68343658252, 40336.0, 41111.383329250086, 41368.79315603403, 43426.56573434288, 65851.67074164694, 17108.059056751998, 17173.91413042952, 17179.914100429418, 17210.91394543019, 17229.31082756701, 12466.81299780504, 13099.148555344063, 13389.062765606508, 13912.791308130387, 14007.369668364949, 20098.995050247428, 20847.166113355295, 20865.165393384093, 20974.16103355879, 21013.579728405653, 6343.714532846033, 6490.7079181436, 6546.410823025951, 6616.305287944792, 6645.368689974444, 857.2899342678357, 913.1325241021057, 926.2034650200821, 940.8823897012874, 1034.1261633919326, 32203.838980804947, 34291.0, 34407.31185376278, 34763.8589413647, 34808.0, 1110.4059328259343, 1138.5445821671233, 1158.976820463586, 1205.7467931734259, 1219.5426714981882, 16992.74510882338, 17802.821971780115, 17904.462866114038, 17914.91042544779, 18113.275468981356, 510508.0, 515011.0, 515042.0, 519197.0, 519736.0, 60808.0, 61448.692756536824, 61550.0, 61556.0, 61574.0, 1318.8351456067992, 1328.0902581731546, 1348.7909374047038, 1380.178793617796, 1439.294745574661, 29284.267893301985, 36621.633783661826, 36687.63312366842, 36757.44863826991, 36992.63007369892, 56084.15873761815, 58432.70783646055, 60445.69777151086, 60517.394826051175, 65120.67439662771, 454607.0, 461366.0, 462092.0, 462205.0, 462411.0, 40132.398014029226, 40946.59053409428, 43178.568214317456, 45779.0, 46259.76870115763, 49758.50241497539, 49967.0, 50106.248406274666, 50583.49416505788, 50827.0, 42037.898105095235, 42069.36895946624, 42086.78956605197, 42287.577124229596, 43751.78124109359, 38585.2282954345, 41431.37852932148, 41515.30150540205, 42194.156116878105, 42236.57763422449, 42208.57791422046, 42433.36349954815, 42885.1422971545, 43073.78463107665, 43090.78454607707, 35337.29325413426, 37356.626433736405, 37823.243535129695, 38170.809145954096, 38249.0, 28578.428431431672, 28960.275993100342, 29036.854815725786, 29335.413291734472, 29413.0], "value": 21226.53852361488, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.6241382755518, 422.24418291258667, 429.4524481286359, 436.1125110400336, 437.496878589622, 18483.0, 19221.615567688656, 19729.309474168407, 19923.0, 20013.59972800545, 19185.712214316798, 19418.70871936922, 19521.51196220095, 19746.111424985873, 19932.70100948487, 5600.5799565032585, 5873.089671100986, 5876.970615146918, 5882.088276317178, 5887.1463637772495, 4336.869893903188, 4549.226631472641, 4646.581807637312, 5735.397783232763, 5820.825375238728, 6535.150430444036, 6565.737370505174, 6643.269240383554, 6663.433608143314, 6671.866562668743, 6374.17135772349, 6488.967555162218, 6525.836854078686, 6551.475881929482, 6638.103855979453, 5832.650040997553, 5840.503557197643, 5858.033424484955, 5860.912086318709, 5872.031114866042, 14890.404383824634, 16185.0, 22085.668714969288, 22472.32583022512, 22786.544269114525, 2263.2983775029793, 2420.6006009008493, 2432.8905199266073, 2866.226118947893, 3051.374468234029, 10300.89699103007, 10374.377537347707, 10785.13718902486, 14016.859831401658, 15535.530176857894, 1899.9620007599908, 1916.1664675866043, 2016.1935225909606, 2021.2824447321284, 2066.8966551672356, 58369.0, 74400.0, 87022.12977870267, 89817.10182898153, 91839.08160918439, 11504.53981840717, 11534.846515348567, 11757.176997610257, 12054.758904821854, 12106.63680089581, 16959.491215263562, 16967.066811325494, 16979.575510612332, 16980.40568580094, 16997.150142492825, 8488.363372747068, 8665.870011949826, 8779.429337093068, 8812.118788121137, 8813.911860881437, 8144.75565733029, 8229.177082291722, 8367.665293388196, 8415.831683366298, 8431.367647426467, 4977.278294647256, 5009.949900500948, 5045.41977672565, 5130.0, 5208.9739551302, 2063.6801295799173, 2084.5935042666533, 2095.2247668362497, 2109.4620871677625, 2154.450615093141, 967.1054274795786, 1016.2327442780801, 1058.1111866032415, 1102.8786833448314, 1125.780472807811, 20596.691049634268, 21109.78890211109, 21126.154953801677, 21199.78800212009, 21286.680699789515, 968.5254225429488, 1025.9846102308472, 1034.8292531732332, 1039.2153923787491, 1045.7124290820086, 10683.14534837211, 11513.88486115145, 11536.480858361394, 11741.29552226869, 11755.294682318918, 446148.0, 451226.0, 452820.0, 463800.0, 463945.0, 88106.0, 89480.5525972379, 90480.0, 90923.545382274, 95023.52488237653, 1018.0633816888333, 1029.073833549811, 1045.8274384726435, 1057.613970900631, 1063.4895250279908, 17794.199261033027, 18122.0, 18133.184006719992, 18365.173567189777, 18659.720104198175, 43055.0, 43255.78372108119, 43407.782961084995, 43615.34576981284, 44906.0, 59396.0, 59781.0, 60411.39588604058, 60451.0, 60862.08706869312, 8861.64553417856, 8940.955295223743, 9033.954830225806, 9069.911610606769, 9366.765830854283, 10386.48067596602, 13456.0, 13688.794668079787, 13840.989240660894, 14171.716565668423, 11464.369459679798, 11746.882531174579, 11771.23486973344, 12182.329971851634, 12244.755139887759, 11343.546258149581, 11432.542698291974, 11510.59712910044, 11639.243449175776, 11855.58505452305, 10604.151667866707, 11898.821517677068, 11904.702382440508, 12085.0, 12204.08469364819, 8033.799155021171, 8382.620959531994, 8611.569421528773, 8782.956085219534, 8972.0, 8737.995130560066, 11721.648350549498, 12245.632631021084, 12250.571230006906, 12255.75488490243], "value": 9545.893160587933, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.9593212203633, 1378.6002059402774, 1469.5591322603216, 1591.6339241974345, 1821.8542516598673, 7865.803354916123, 8518.361122915783, 8758.956205218965, 8776.034636190023, 9037.72886813395, 8823.985241697206, 8859.114088591137, 8884.333674974387, 8889.511076890769, 8891.377603567753, 2392.1986134644917, 2418.9758102418928, 2427.1990243219784, 2428.3200703802963, 2429.708434987795, 2395.8203134764876, 2419.6249581314837, 2490.713567939683, 2496.7877730392847, 2499.0253801017616, 2412.1557454890735, 2430.7569243075727, 2433.6714543536573, 2464.2360868130936, 2468.062136388179, 2368.7157541095094, 2370.6918100646976, 2393.2580899920995, 2396.9760302397012, 2402.543516731833, 2311.768823117675, 2413.263954493879, 2430.2587710748217, 2431.3070774829266, 2435.0381599268367, 7918.366530677532, 8108.027036755568, 8762.474251544863, 8919.152680495343, 8927.196552310323, 5056.317397151374, 5262.815801446969, 5267.920981185285, 5278.419373868871, 5349.277847490578, 3326.916827079318, 3391.2369716813764, 3416.197193659488, 3432.8798492052906, 3510.508528805969, 1021.1728499915092, 1037.1339931157493, 1039.6517166749147, 1050.2648146297545, 1056.4031322302874, 12078.27530348182, 12290.569830055994, 12323.322217278046, 12368.44342004612, 12375.62873113808, 4684.648651351163, 4701.083288758728, 4829.468758436569, 4852.878678033077, 4880.463149053601, 10556.47217639115, 10558.366498010144, 10561.049505544537, 10565.366078035342, 10567.207459440573, 5530.391656917735, 5533.667979921218, 5536.390996990328, 5537.501624853782, 5543.52880005204, 5025.070361983045, 5060.873478163002, 5130.615203859726, 5159.561437277874, 5183.377994640668, 4036.4348991141264, 4039.111395492987, 4130.153318569686, 4153.709240353207, 4188.518320393194, 1321.8281623388898, 1366.794980752895, 1373.4437552791135, 1374.312843578211, 1384.764590019699, 848.7114381110329, 934.6822080492665, 1000.7147962830559, 1003.4581326083833, 1028.141501845952, 5644.294463192101, 5876.44173803488, 5882.764689412461, 5983.700814959322, 6163.19878415803, 954.8854137503405, 964.5996911281879, 971.3831716859704, 987.9012098790207, 1002.1331548210745, 4049.1294371709637, 4107.281225785476, 4144.7513149211145, 4178.22702799983, 4219.704620676584, 10019.148372388283, 10396.376217426978, 10427.009434103747, 10690.679279621623, 10798.838017429745, 10558.788824223473, 10914.126869850552, 10928.180386471047, 10957.616483423042, 11075.50160242791, 7994.440389172702, 8224.465409748347, 8244.381671374671, 8248.381371397169, 8251.422400432033, 5999.430054144849, 6038.426349496791, 6102.931986902186, 6129.662868542273, 6154.815355539341, 9587.520623968634, 9784.706458806248, 9838.36050656705, 9914.30599858003, 10107.444090575089, 9967.60129594837, 10098.798024039625, 10099.7475063124, 10142.340747851365, 10176.592936282466, 7327.74352897646, 7501.099868015873, 7760.068791745027, 7927.563983980705, 7936.56348900816, 8442.915570844458, 8602.526861022703, 8674.0, 8716.0, 8727.432716873383, 7459.142198647225, 7608.695652173851, 7612.200718924433, 7718.53688778675, 7785.104712958082, 7337.0, 7561.09266887977, 7561.697532098875, 7665.0, 7689.807754806175, 6867.622280774605, 6973.267806880407, 6974.19796723363, 6975.79072627822, 6978.651067446709, 5113.15632920564, 5163.870903227449, 5199.4020687621405, 5230.320058392384, 5318.707471088973, 5036.29491871131, 5063.974680126576, 5089.312942752681, 5160.251763494347, 5396.325459317585], "value": 4686.378652417206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.20836492796417, 362.31341607653496, 362.4020366395447, 362.6609120472357, 367.1408903166591, 5354.250404943311, 5406.40529541751, 5418.810341638044, 5437.32033495813, 5457.454254574541, 5073.670211436263, 5193.584513238941, 5196.974015129928, 5282.471752824716, 5300.814471493499, 4235.322348424253, 4237.555056719047, 4242.0, 4248.34150706641, 4266.957330426687, 4261.552536983603, 4265.978670106645, 4267.914641707164, 4269.274223382017, 4281.486221653406, 4084.9183016339657, 4162.854300099497, 4167.312393455076, 4168.687348448863, 4187.14163596462, 4163.91672166555, 4165.75005499668, 4172.833086676529, 4177.874663760092, 4181.142865712522, 3710.5176327077306, 3712.350338690718, 3714.572824125233, 3715.9442608360896, 3720.6279372062577, 5040.621953353477, 5239.685618862881, 5251.529571719924, 5257.474252574751, 5270.868228294285, 4826.927596086061, 4847.587955023827, 4848.248521479177, 4857.619766314516, 4864.246041863482, 5599.496045355897, 5619.269494965669, 5637.210790489335, 5646.350669672999, 5648.4633959773755, 3984.4222587724907, 4072.429859819628, 4111.198316328318, 4115.794210289503, 4134.044158426709, 5788.594798364116, 5808.0252714077415, 5822.3886491918165, 5833.533317334603, 5851.707414629294, 4209.221294060609, 4209.894752631209, 4218.2196293685765, 4225.2817021105875, 4225.72532785368, 3998.2403343364667, 4178.412203362764, 4210.452641156691, 4294.634956028773, 4310.0, 4768.213244814636, 4768.523147685204, 4781.952180478151, 4793.1372352976105, 4844.685095468853, 5665.320161580555, 5675.659460432387, 5697.572682048863, 5697.629654072555, 5742.913856292159, 1381.6062422209623, 1420.7939848721878, 1437.8705916467568, 1439.4961763382732, 1456.1190479759593, 942.2132519346422, 947.7535840681472, 950.9776989736062, 961.3991255465335, 969.5346233807812, 5209.47905209476, 5215.973920130375, 5226.660267082703, 5243.397009343898, 5246.632735708464, 5479.904019196177, 5519.613627046068, 5526.854858855858, 5531.225628412026, 5537.972310138423, 5199.752059505691, 5210.775467765072, 5216.591520289577, 5242.868928276824, 5498.862528436741, 2929.037544844959, 2988.596539467144, 3002.654694710093, 3005.4740420426338, 3016.4117996990376, 5808.477237048602, 5833.591648584643, 5848.917950179145, 5866.50134738552, 5874.800801290803, 5446.031912607638, 5681.971590142023, 5696.857578560486, 5733.770649173986, 5757.251557297524, 5762.9135562966585, 5767.423257674283, 5779.739911703899, 5810.256922923106, 5812.912806307909, 5394.67830381559, 5534.418886016911, 5598.412166722435, 5599.272094627672, 5652.7738890443925, 5532.972335138298, 5544.311009160635, 5547.5007249347755, 5548.722563871709, 5571.693556854249, 5807.477327040587, 5810.506106980785, 5817.970910145422, 5843.561732869966, 5846.889091072682, 3951.1900060486955, 3958.2083583282883, 4045.8786236412957, 4059.3505039193587, 4069.9796501017304, 5557.861053473695, 5567.24842146305, 5594.916076258941, 5602.243697101002, 5611.186377975252, 5614.69119198448, 5615.410381909841, 5631.183478395692, 5634.661920284796, 5650.519705825051, 5376.489233522809, 5586.692731899784, 5620.718964051863, 5628.324601047737, 5630.3525094613005, 5575.498205161555, 5589.301337332833, 5591.672954592012, 5593.328800543798, 5610.85972850682, 5643.181738647791, 5650.26546548946, 5664.130836823921, 5688.800891968761, 5693.5160511357, 5322.414534401135, 5575.581831362583, 5606.383297837317, 5612.85967850807, 5627.43725627434], "value": 4273.97350207639, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.5685224143875, 743.7136702369589, 769.6767357709762, 774.24124358129, 775.5385545600366, 13522.256275904821, 14178.574642760734, 14185.219812910273, 14197.574072777821, 14201.715965680705, 14051.859481405183, 14179.220142892136, 14188.787168192486, 14192.07751496152, 14207.147571145713, 712.6401167410451, 732.5860888597952, 820.5076953827686, 847.6185716427601, 861.7845538615346, 858.3219256787131, 866.4281574161055, 867.4491697771929, 871.2811930157613, 871.6861929705333, 911.8449863523217, 913.3880300198882, 913.5067063785548, 915.3683958068945, 920.6179435534245, 750.6847124207818, 764.7514557768719, 846.826400587881, 878.7627340617997, 885.6014793342957, 655.9639219842907, 657.4937298280345, 657.6350125680245, 657.7467674945133, 657.9013148027786, 13305.600831975056, 13317.467301307935, 13322.80015799754, 13330.533431329857, 13368.33158342079, 12171.939140304241, 12438.937805311007, 12444.128910976235, 12675.429605667767, 12869.678258043623, 12064.577739779153, 12120.272783632921, 12280.078994075391, 12310.13829031968, 12453.25280483174, 4302.397664326997, 4362.541933097011, 4373.343998400265, 4375.2124617568825, 4440.4227450431235, 59831.102533462035, 62966.0, 63087.369126309066, 63362.36637633611, 64820.0, 10181.490925453698, 10467.790644187073, 10554.525046372932, 10596.682099537025, 10618.960874386168, 18046.458606241835, 18055.638887222445, 18057.27770889176, 18060.0, 18078.45764627063, 8228.588570571448, 8240.093589705128, 8308.501489910625, 8427.199416055464, 8526.957365213259, 4638.814447422065, 4837.153498137882, 4842.370491836039, 4888.7311197884455, 4902.191138462185, 3528.8412021459094, 3692.3538380783257, 3715.0898029982827, 3717.9442308365396, 3720.2373513429684, 580.7125472890946, 590.5924911810837, 595.0479233226889, 595.3837777899853, 596.4751019103162, 596.5525855608294, 626.4299487466384, 628.8710814283061, 629.6411045703996, 652.5758257132902, 8379.664813407517, 8471.0, 8509.531975741394, 8585.141485851365, 8833.64665413389, 689.7585844954326, 694.583250049966, 697.7418355208605, 715.2918610575597, 719.1693593899055, 3898.7465814721954, 4051.331530297468, 4122.7732474713575, 4196.475440569929, 4297.05464797744, 86688.5665571668, 88107.55946220228, 90656.0, 91878.54060729654, 96955.0, 80385.19614803776, 80693.59653201696, 81399.18600814034, 81649.0, 83397.16602833894, 71532.0, 72784.63607681928, 73393.6330318345, 73591.63204183945, 76143.23856761472, 7841.294283514511, 8027.2775450209765, 8057.27484526372, 8152.225538573826, 8269.503829770232, 48756.0, 49364.0, 49481.752591236815, 49796.51424400402, 50525.0, 61717.38282617116, 66173.33826661672, 66561.0, 67190.32809672036, 68575.0, 10315.432651204255, 10462.895371046192, 10494.370337779757, 10615.363078215332, 10662.360258384522, 12047.698807529881, 12137.817932731192, 12299.44652490658, 12316.753664926831, 12348.81476777831, 9947.502624868872, 11153.888461115284, 11332.886671133512, 11428.885711142782, 12070.577529786766, 11784.823227651763, 12007.519699211934, 12038.518459261531, 12383.876161238271, 12626.305553194295, 10734.570617175537, 10977.0, 11202.383868886964, 11411.37237451915, 12079.094067945114, 9606.423614583147, 9994.500274986367, 10635.20235982289, 10805.729856753644, 10902.50938707776, 10085.0, 10247.436390998566, 10296.536655850654, 10327.070563649308, 10411.635592754217], "value": 6971.057548678181, "unit": "score"}], "name": "dromaeo_css", "value": 7353.937001603337, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 111.0, 111.0, 111.0, 112.0, 111.0, 110.0, 109.0, 109.0], "value": 109.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 117.0, 166.0, 118.0, 119.0, 119.0, 124.0, 155.0, 122.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 161.0, 161.0, 163.0, 161.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 107.0, 77.0, 76.0, 75.0, 74.0, 98.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 106.0, 82.0, 83.0, 82.0, 119.0, 82.0, 82.0, 118.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 51.0, 51.0, 50.0, 50.0, 63.0, 54.0, 51.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 61.0, 59.0, 60.0, 59.0, 61.0, 59.0, 59.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 76.0, 75.0, 75.0, 78.0, 75.0, 75.0, 74.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 132.0, 122.0, 122.0, 130.0, 129.0, 121.0, 118.0, 159.0, 138.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 155.0, 158.0, 153.0, 153.0, 152.0, 153.0, 156.0, 153.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 63.0, 62.0, 62.0, 62.0, 64.0, 66.0, 62.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1457.6000000000004, "alertThreshold": 2.0}]} 02:48:06 INFO - Return code: 0 02:48:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:48:06 INFO - # TBPL SUCCESS # 02:48:06 INFO - Running post-action listener: _resource_record_post_action 02:48:06 INFO - [mozharness: 2017-01-12 10:48:06.703447Z] Finished run-tests step (success) 02:48:06 INFO - Running post-run listener: _resource_record_post_run 02:48:06 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 358055936; Read time: 24; Write time: 225352 02:48:06 INFO - TinderboxPrint: CPU usage
13.0% 02:48:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 02:48:06 INFO - TinderboxPrint: I/O write bytes / time
358,055,936 / 225,352 02:48:06 INFO - TinderboxPrint: CPU idle
8,270.8 (87.0%) 02:48:06 INFO - TinderboxPrint: CPU user
1,191.5 (12.5%) 02:48:06 INFO - TinderboxPrint: Swap in / out
0 / 0 02:48:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107503616; Read time: 0; Write time: 85500 02:48:06 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250552320; Read time: 8; Write time: 139852 02:48:07 INFO - Running post-run listener: _upload_blobber_files 02:48:07 INFO - Blob upload gear active. 02:48:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:48:07 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 02:48:07 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'] 02:48:07 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 02:48:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:48:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:48:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:48:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:08 INFO - (blobuploader) - INFO - Done attempting. 02:48:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:48:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:48:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:09 INFO - (blobuploader) - INFO - Done attempting. 02:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:48:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:48:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:48:12 INFO - (blobuploader) - INFO - Done attempting. 02:48:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:48:12 INFO - Return code: 0 02:48:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:48:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:48:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9cccf8500d384a459a273134c52b0d6f50be31f64797308177e81c70f36716741a4c905ddc5976b42cbef6a7aab7e686fe9da322dca4819b20165f10f2ac53ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7592a39e39372fe3cf2ca6cde8916e1e4b3180f3bff8450bbad968e438b19f41c919683ddc07e911fda0518253822773a3673332bc93326ad4881c7f1b4974f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d209eb7fc3ac650298321e3ee907015f5b8e365c7477995fa2b04c18106764ae565358eeb738f78d1aa3fe7bf855b506e9733d9568c1eddf41920cf865e1919"} 02:48:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:48:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:48:12 INFO - Contents: 02:48:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9cccf8500d384a459a273134c52b0d6f50be31f64797308177e81c70f36716741a4c905ddc5976b42cbef6a7aab7e686fe9da322dca4819b20165f10f2ac53ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7592a39e39372fe3cf2ca6cde8916e1e4b3180f3bff8450bbad968e438b19f41c919683ddc07e911fda0518253822773a3673332bc93326ad4881c7f1b4974f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d209eb7fc3ac650298321e3ee907015f5b8e365c7477995fa2b04c18106764ae565358eeb738f78d1aa3fe7bf855b506e9733d9568c1eddf41920cf865e1919"} 02:48:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:48:12 INFO - Copying logs to upload dir... 02:48:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:48:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.751766 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 02:48:12.293201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 02:48:12.296613) ========= 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=337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363 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/9cccf8500d384a459a273134c52b0d6f50be31f64797308177e81c70f36716741a4c905ddc5976b42cbef6a7aab7e686fe9da322dca4819b20165f10f2ac53ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7592a39e39372fe3cf2ca6cde8916e1e4b3180f3bff8450bbad968e438b19f41c919683ddc07e911fda0518253822773a3673332bc93326ad4881c7f1b4974f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d209eb7fc3ac650298321e3ee907015f5b8e365c7477995fa2b04c18106764ae565358eeb738f78d1aa3fe7bf855b506e9733d9568c1eddf41920cf865e1919"} build_url:https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011381 build_url: 'https://queue.taskcluster.net/v1/task/F30n5ScySNWxHqR7WttVGg/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/9cccf8500d384a459a273134c52b0d6f50be31f64797308177e81c70f36716741a4c905ddc5976b42cbef6a7aab7e686fe9da322dca4819b20165f10f2ac53ee", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7592a39e39372fe3cf2ca6cde8916e1e4b3180f3bff8450bbad968e438b19f41c919683ddc07e911fda0518253822773a3673332bc93326ad4881c7f1b4974f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6d209eb7fc3ac650298321e3ee907015f5b8e365c7477995fa2b04c18106764ae565358eeb738f78d1aa3fe7bf855b506e9733d9568c1eddf41920cf865e1919"}' ========= master_lag: 0.59 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 02:48:12.896547) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:48:12.896884) ========= 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=337fe3f4b1febe37b85fccc40000019e-1484216855.313782-340254363 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 02:48:12.916706) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 02:48:12.917060) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 02:48:12.920479) ========= ========= Total master_lag: 0.68 =========