builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-052 starttime: 1476484515.22 results: success (0) buildid: 20161014123004 builduid: 692781faefb34f8181ee014c224d66c8 revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.219219) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.219665) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.219954) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.238030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.238297) ========= 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=826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 15:35:15-- 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% 45.9M=0s 2016-10-14 15:35:15 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.405040 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.656920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.657237) ========= 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=826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019765 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.706520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:15.706877) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e412b386433b8c8ba83a28a1df310d9ad0b20285 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev e412b386433b8c8ba83a28a1df310d9ad0b20285 --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=826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 15:35:16,047 truncating revision to first 12 chars 2016-10-14 15:35:16,047 Setting DEBUG logging. 2016-10-14 15:35:16,047 attempt 1/10 2016-10-14 15:35:16,047 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e412b386433b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 15:35:16,374 unpacking tar archive at: fx-team-e412b386433b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.759768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:16.479950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:16.480260) ========= script_repo_revision: e412b386433b8c8ba83a28a1df310d9ad0b20285 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:16.480661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:16.480966) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 15:35:16.491424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-14 15:35:16.491820) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:35:16 INFO - MultiFileLogger online at 20161014 15:35:16 in /builds/slave/test 15:35:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:35:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:35:16 INFO - {'append_to_log': False, 15:35:16 INFO - 'base_work_dir': '/builds/slave/test', 15:35:16 INFO - 'blob_upload_branch': 'Fx-Team', 15:35:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:35:16 INFO - 'branch': 'Fx-Team', 15:35:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:35:16 INFO - 'config_files': ('talos/linux_config.py',), 15:35:16 INFO - 'default_actions': ('clobber', 15:35:16 INFO - 'read-buildbot-config', 15:35:16 INFO - 'download-and-extract', 15:35:16 INFO - 'populate-webroot', 15:35:16 INFO - 'create-virtualenv', 15:35:16 INFO - 'install', 15:35:16 INFO - 'run-tests'), 15:35:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:35:16 INFO - 'download_minidump_stackwalk': True, 15:35:16 INFO - 'download_symbols': 'ondemand', 15:35:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:35:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:35:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:35:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:35:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:35:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:35:16 INFO - 'installer_path': 'installer.exe', 15:35:16 INFO - 'log_level': 'info', 15:35:16 INFO - 'log_name': 'talos', 15:35:16 INFO - 'log_to_console': True, 15:35:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:35:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:35:16 INFO - 'opt_config_files': (), 15:35:16 INFO - 'pip_index': False, 15:35:16 INFO - 'sps_profile': False, 15:35:16 INFO - 'sps_profile_interval': 0, 15:35:16 INFO - 'suite': 'dromaeojs', 15:35:16 INFO - 'system_bits': '32', 15:35:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:35:16 INFO - 'title': 'talos-linux64-ix-052', 15:35:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:35:16 INFO - 'use_talos_json': True, 15:35:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:35:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:35:16 INFO - 'work_dir': 'build'} 15:35:16 INFO - [mozharness: 2016-10-14 22:35:16.931620Z] Running clobber step. 15:35:16 INFO - Running pre-action listener: _resource_record_pre_action 15:35:16 INFO - Running main action method: clobber 15:35:16 INFO - rmtree: /builds/slave/test/build 15:35:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:35:17 INFO - Running post-action listener: _resource_record_post_action 15:35:17 INFO - [mozharness: 2016-10-14 22:35:17.905152Z] Finished clobber step (success) 15:35:17 INFO - [mozharness: 2016-10-14 22:35:17.905250Z] Running read-buildbot-config step. 15:35:17 INFO - Running pre-action listener: _resource_record_pre_action 15:35:17 INFO - Running main action method: read_buildbot_config 15:35:17 INFO - Using buildbot properties: 15:35:17 INFO - { 15:35:17 INFO - "project": "", 15:35:17 INFO - "product": "firefox", 15:35:17 INFO - "script_repo_revision": "production", 15:35:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:35:17 INFO - "repository": "", 15:35:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:35:17 INFO - "buildid": "20161014123004", 15:35:17 INFO - "pgo_build": "True", 15:35:17 INFO - "basedir": "/builds/slave/test", 15:35:17 INFO - "buildnumber": 1136, 15:35:17 INFO - "slavename": "talos-linux64-ix-052", 15:35:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:35:17 INFO - "platform": "ubuntu64_hw", 15:35:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:35:17 INFO - "branch": "fx-team", 15:35:17 INFO - "repo_path": "integration/fx-team", 15:35:17 INFO - "revision": "e412b386433b8c8ba83a28a1df310d9ad0b20285", 15:35:17 INFO - "stage_platform": "linux64-pgo", 15:35:17 INFO - "builduid": "692781faefb34f8181ee014c224d66c8", 15:35:17 INFO - "slavebuilddir": "test" 15:35:17 INFO - } 15:35:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:35:17 INFO - Running post-action listener: _resource_record_post_action 15:35:17 INFO - [mozharness: 2016-10-14 22:35:17.907661Z] Finished read-buildbot-config step (success) 15:35:17 INFO - [mozharness: 2016-10-14 22:35:17.907749Z] Running download-and-extract step. 15:35:17 INFO - Running pre-action listener: _resource_record_pre_action 15:35:17 INFO - Running main action method: download_and_extract 15:35:17 INFO - mkdir: /builds/slave/test/build/tests 15:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:17 INFO - trying https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:35:17 INFO - Downloading https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:35:18 INFO - Downloaded 1361 bytes. 15:35:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:35:18 INFO - Using the following test package requirements: 15:35:18 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:35:18 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:35:18 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:35:18 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'jsshell-linux-x86_64.zip'], 15:35:18 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:35:18 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:35:18 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:35:18 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:35:18 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:35:18 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:35:18 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:35:18 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:35:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:35:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:35:18 INFO - Fetch https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:35:19 INFO - Http code: 200 15:35:19 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 15:35:19 INFO - x-amz-cf-id: NxCt40ZF96hjmt-tGttQURFFblS1GDoxfjq9FI_a-REUs7rV87gfMA== 15:35:19 INFO - x-amz-version-id: DE6IcgqBuohRJ.K3rVfo54xgZlbm.f18 15:35:19 INFO - Expected file size: 22123341 15:35:19 INFO - Obtained file size: 22123341 15:35:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:35:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:35:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:35:23 INFO - Fetch https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:35:23 INFO - Http code: 200 15:35:23 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 15:35:23 INFO - x-amz-cf-id: ly88bjcG_JVOzDip5R0i1nXv5LzVso9BE8jHOMc7wxYJ5C2enu2WPg== 15:35:23 INFO - x-amz-version-id: DE6IcgqBuohRJ.K3rVfo54xgZlbm.f18 15:35:24 INFO - Expected file size: 22123341 15:35:24 INFO - Obtained file size: 22123341 15:35:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:35:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:35:28 INFO - Fetch https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:35:29 INFO - Http code: 200 15:35:29 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 15:35:29 INFO - x-amz-cf-id: BJxSoh88X1BWSsA6APhSZehqF07BjN2nvQFBlCGTRaMBqBB7vnaAEA== 15:35:29 INFO - x-amz-version-id: a7WoSQGNAK_SksjrmKvdIYV2E2Re.sIR 15:35:29 INFO - Expected file size: 14409006 15:35:29 INFO - Obtained file size: 14409006 15:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:29 INFO - trying https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:35:29 INFO - Downloading https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:35:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:35:31 INFO - Downloaded 59614277 bytes. 15:35:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:35:31 INFO - mkdir: /builds/slave/test/properties 15:35:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:35:31 INFO - Writing to file /builds/slave/test/properties/build_url 15:35:31 INFO - Contents: 15:35:31 INFO - build_url:https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:35:31 INFO - Running post-action listener: _resource_record_post_action 15:35:31 INFO - Running post-action listener: set_extra_try_arguments 15:35:31 INFO - [mozharness: 2016-10-14 22:35:31.717949Z] Finished download-and-extract step (success) 15:35:31 INFO - [mozharness: 2016-10-14 22:35:31.718175Z] Running populate-webroot step. 15:35:31 INFO - Running pre-action listener: _resource_record_pre_action 15:35:31 INFO - Running main action method: populate_webroot 15:35:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:35:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:35:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:35:31 INFO - '--tppagecycles', 15:35:31 INFO - '7'], 15:35:31 INFO - 'tests': ['tsvgm']}}, 15:35:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:35:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:35:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:35:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:35:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:35:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['damp', 'tps']}, 15:35:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'tests': ['damp', 'tps']}, 15:35:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['dromaeo_dom']}, 15:35:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:35:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['basic_compositor_video']}, 15:35:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:35:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['a11yr', 15:35:31 INFO - 'ts_paint', 15:35:31 INFO - 'tpaint', 15:35:31 INFO - 'sessionrestore', 15:35:31 INFO - 'sessionrestore_no_auto_restore', 15:35:31 INFO - 'tabpaint']}, 15:35:31 INFO - 'other-e10s': {'tests': ['a11yr', 15:35:31 INFO - 'ts_paint', 15:35:31 INFO - 'tpaint', 15:35:31 INFO - 'sessionrestore', 15:35:31 INFO - 'sessionrestore_no_auto_restore', 15:35:31 INFO - 'tabpaint']}, 15:35:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:35:31 INFO - 'ts_paint', 15:35:31 INFO - 'tpaint', 15:35:31 INFO - 'sessionrestore', 15:35:31 INFO - 'sessionrestore_no_auto_restore', 15:35:31 INFO - 'tabpaint']}, 15:35:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:35:31 INFO - 'ts_paint', 15:35:31 INFO - 'tpaint', 15:35:31 INFO - 'sessionrestore', 15:35:31 INFO - 'sessionrestore_no_auto_restore', 15:35:31 INFO - 'tabpaint']}, 15:35:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['a11yr', 15:35:31 INFO - 'ts_paint', 15:35:31 INFO - 'tpaint', 15:35:31 INFO - 'sessionrestore', 15:35:31 INFO - 'sessionrestore_no_auto_restore', 15:35:31 INFO - 'tabpaint']}, 15:35:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['a11yr', 15:35:31 INFO - 'ts_paint', 15:35:31 INFO - 'tpaint', 15:35:31 INFO - 'sessionrestore', 15:35:31 INFO - 'sessionrestore_no_auto_restore', 15:35:31 INFO - 'tabpaint']}, 15:35:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['tsvgx', 15:35:31 INFO - 'tsvgr_opacity', 15:35:31 INFO - 'tart', 15:35:31 INFO - 'tscrollx', 15:35:31 INFO - 'cart']}, 15:35:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:35:31 INFO - 'tsvgr_opacity', 15:35:31 INFO - 'tart', 15:35:31 INFO - 'tscrollx', 15:35:31 INFO - 'cart']}, 15:35:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'talos_options': ['--disable-e10s'], 15:35:31 INFO - 'tests': ['tp5o']}, 15:35:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'tests': ['tp5o']}, 15:35:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'talos_options': ['--disable-e10s', 15:35:31 INFO - '--xperf_path', 15:35:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:31 INFO - 'tests': ['tp5n']}, 15:35:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:35:31 INFO - 'talos_options': ['--xperf_path', 15:35:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:35:31 INFO - 'tests': ['tp5n']}}, 15:35:31 INFO - 'talos.zip': {'path': '', 15:35:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:35:31 INFO - Running post-action listener: _resource_record_post_action 15:35:31 INFO - [mozharness: 2016-10-14 22:35:31.740694Z] Finished populate-webroot step (success) 15:35:31 INFO - [mozharness: 2016-10-14 22:35:31.740792Z] Running create-virtualenv step. 15:35:31 INFO - Running pre-action listener: _resource_record_pre_action 15:35:31 INFO - Running main action method: create_virtualenv 15:35:31 INFO - Creating virtualenv /builds/slave/test/build/venv 15:35:31 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 15:35:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:35:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:35:31 INFO - Using real prefix '/usr' 15:35:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:35:32 INFO - Installing distribute.............................................................................................................................................................................................done. 15:35:34 INFO - Installing pip.................done. 15:35:34 INFO - Return code: 0 15:35:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:35:34 INFO - Reading from file tmpfile_stdout 15:35:34 INFO - Output received: 15:35:34 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) 15:35:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:35:34 INFO - Using env: {'DISPLAY': ':0', 15:35:34 INFO - 'HOME': '/home/cltbld', 15:35:34 INFO - 'LANG': 'en_US.UTF-8', 15:35:34 INFO - 'LANGUAGE': 'en_US:en', 15:35:34 INFO - 'LOGNAME': 'cltbld', 15:35:34 INFO - 'MAIL': '/var/mail/cltbld', 15:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:34 INFO - 'MOZ_NO_REMOTE': '1', 15:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:34 INFO - 'NO_EM_RESTART': '1', 15:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:34 INFO - 'PWD': '/builds/slave/test', 15:35:34 INFO - 'SHELL': '/bin/bash', 15:35:34 INFO - 'SHLVL': '1', 15:35:34 INFO - 'TERM': 'linux', 15:35:34 INFO - 'TMOUT': '86400', 15:35:34 INFO - 'USER': 'cltbld', 15:35:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:34 INFO - '_': '/tools/buildbot/bin/python'} 15:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:34 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 15:35:34 INFO - Cleaning up... 15:35:34 INFO - Return code: 0 15:35:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:35:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:35:34 INFO - Using env: {'DISPLAY': ':0', 15:35:34 INFO - 'HOME': '/home/cltbld', 15:35:34 INFO - 'LANG': 'en_US.UTF-8', 15:35:34 INFO - 'LANGUAGE': 'en_US:en', 15:35:34 INFO - 'LOGNAME': 'cltbld', 15:35:34 INFO - 'MAIL': '/var/mail/cltbld', 15:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:34 INFO - 'MOZ_NO_REMOTE': '1', 15:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:34 INFO - 'NO_EM_RESTART': '1', 15:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:34 INFO - 'PWD': '/builds/slave/test', 15:35:34 INFO - 'SHELL': '/bin/bash', 15:35:34 INFO - 'SHLVL': '1', 15:35:34 INFO - 'TERM': 'linux', 15:35:34 INFO - 'TMOUT': '86400', 15:35:34 INFO - 'USER': 'cltbld', 15:35:34 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:34 INFO - '_': '/tools/buildbot/bin/python'} 15:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:34 INFO - Downloading/unpacking psutil>=3.1.1 15:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:35:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:37 INFO - Installing collected packages: psutil 15:35:37 INFO - Running setup.py install for psutil 15:35:37 INFO - building 'psutil._psutil_linux' extension 15:35:37 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 15:35:37 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 15:35:37 INFO - building 'psutil._psutil_posix' extension 15:35:37 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 15:35:37 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 15:35:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:35:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:35:37 INFO - Successfully installed psutil 15:35:37 INFO - Cleaning up... 15:35:37 INFO - Return code: 0 15:35:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:37 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:37 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 15:35:37 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 15:35:37 INFO - Using env: {'DISPLAY': ':0', 15:35:37 INFO - 'HOME': '/home/cltbld', 15:35:37 INFO - 'LANG': 'en_US.UTF-8', 15:35:37 INFO - 'LANGUAGE': 'en_US:en', 15:35:37 INFO - 'LOGNAME': 'cltbld', 15:35:37 INFO - 'MAIL': '/var/mail/cltbld', 15:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:37 INFO - 'MOZ_NO_REMOTE': '1', 15:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:37 INFO - 'NO_EM_RESTART': '1', 15:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:37 INFO - 'PWD': '/builds/slave/test', 15:35:37 INFO - 'SHELL': '/bin/bash', 15:35:37 INFO - 'SHLVL': '1', 15:35:37 INFO - 'TERM': 'linux', 15:35:37 INFO - 'TMOUT': '86400', 15:35:37 INFO - 'USER': 'cltbld', 15:35:37 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:37 INFO - '_': '/tools/buildbot/bin/python'} 15:35:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:35:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:35:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:35:39 INFO - Installing collected packages: mozsystemmonitor 15:35:39 INFO - Running setup.py install for mozsystemmonitor 15:35:39 INFO - Successfully installed mozsystemmonitor 15:35:39 INFO - Cleaning up... 15:35:39 INFO - Return code: 0 15:35:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:35: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')]} 15:35:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35: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')]} 15:35:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:39 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:39 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 15:35:39 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 15:35:39 INFO - Using env: {'DISPLAY': ':0', 15:35:39 INFO - 'HOME': '/home/cltbld', 15:35:39 INFO - 'LANG': 'en_US.UTF-8', 15:35:39 INFO - 'LANGUAGE': 'en_US:en', 15:35:39 INFO - 'LOGNAME': 'cltbld', 15:35:39 INFO - 'MAIL': '/var/mail/cltbld', 15:35:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:39 INFO - 'MOZ_NO_REMOTE': '1', 15:35:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:39 INFO - 'NO_EM_RESTART': '1', 15:35:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:39 INFO - 'PWD': '/builds/slave/test', 15:35:39 INFO - 'SHELL': '/bin/bash', 15:35:39 INFO - 'SHLVL': '1', 15:35:39 INFO - 'TERM': 'linux', 15:35:39 INFO - 'TMOUT': '86400', 15:35:39 INFO - 'USER': 'cltbld', 15:35:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:39 INFO - '_': '/tools/buildbot/bin/python'} 15:35:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:40 INFO - Downloading/unpacking jsonschema==2.5.1 15:35:40 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 15:35:40 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 15:35:40 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 15:35:40 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 15:35:40 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 15:35:40 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 15:35:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:35:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:42 INFO - Downloading functools32-3.2.3-2.tar.gz 15:35:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:35:42 INFO - warning: no files found matching '*.txt' 15:35:42 INFO - no previously-included directories found matching 'build' 15:35:42 INFO - no previously-included directories found matching 'dist' 15:35:42 INFO - no previously-included directories found matching '.git*' 15:35:42 INFO - Installing collected packages: jsonschema, functools32 15:35:42 INFO - Running setup.py install for functools32 15:35:42 INFO - warning: no files found matching '*.txt' 15:35:42 INFO - no previously-included directories found matching 'build' 15:35:42 INFO - no previously-included directories found matching 'dist' 15:35:42 INFO - no previously-included directories found matching '.git*' 15:35:42 INFO - Successfully installed jsonschema functools32 15:35:42 INFO - Cleaning up... 15:35:42 INFO - Return code: 0 15:35:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:42 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:42 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 15:35:42 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 15:35:42 INFO - Using env: {'DISPLAY': ':0', 15:35:42 INFO - 'HOME': '/home/cltbld', 15:35:42 INFO - 'LANG': 'en_US.UTF-8', 15:35:42 INFO - 'LANGUAGE': 'en_US:en', 15:35:42 INFO - 'LOGNAME': 'cltbld', 15:35:42 INFO - 'MAIL': '/var/mail/cltbld', 15:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:42 INFO - 'MOZ_NO_REMOTE': '1', 15:35:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:42 INFO - 'NO_EM_RESTART': '1', 15:35:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:42 INFO - 'PWD': '/builds/slave/test', 15:35:42 INFO - 'SHELL': '/bin/bash', 15:35:42 INFO - 'SHLVL': '1', 15:35:42 INFO - 'TERM': 'linux', 15:35:42 INFO - 'TMOUT': '86400', 15:35:42 INFO - 'USER': 'cltbld', 15:35:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:42 INFO - '_': '/tools/buildbot/bin/python'} 15:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:35:42 INFO - Cleaning up... 15:35:42 INFO - Return code: 0 15:35:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:42 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:42 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 15:35:42 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 15:35:42 INFO - Using env: {'DISPLAY': ':0', 15:35:42 INFO - 'HOME': '/home/cltbld', 15:35:42 INFO - 'LANG': 'en_US.UTF-8', 15:35:42 INFO - 'LANGUAGE': 'en_US:en', 15:35:42 INFO - 'LOGNAME': 'cltbld', 15:35:42 INFO - 'MAIL': '/var/mail/cltbld', 15:35:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:42 INFO - 'MOZ_NO_REMOTE': '1', 15:35:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:42 INFO - 'NO_EM_RESTART': '1', 15:35:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:42 INFO - 'PWD': '/builds/slave/test', 15:35:42 INFO - 'SHELL': '/bin/bash', 15:35:42 INFO - 'SHLVL': '1', 15:35:42 INFO - 'TERM': 'linux', 15:35:42 INFO - 'TMOUT': '86400', 15:35:42 INFO - 'USER': 'cltbld', 15:35:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:42 INFO - '_': '/tools/buildbot/bin/python'} 15:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:42 INFO - Downloading/unpacking blobuploader==1.2.4 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:35:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:35:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:35:44 INFO - Downloading blobuploader-1.2.4.tar.gz 15:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:35:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:35:44 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 15:35:44 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 15:35:44 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 15:35:44 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 15:35:44 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 15:35:44 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 15:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:35:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:35:45 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 15:35:45 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 15:35:45 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 15:35:45 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 15:35:45 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 15:35:45 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 15:35:45 INFO - Downloading docopt-0.6.1.tar.gz 15:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:35:45 INFO - Installing collected packages: blobuploader, requests, docopt 15:35:45 INFO - Running setup.py install for blobuploader 15:35:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:35:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:35:45 INFO - Running setup.py install for requests 15:35:46 INFO - Running setup.py install for docopt 15:35:46 INFO - Successfully installed blobuploader requests docopt 15:35:46 INFO - Cleaning up... 15:35:46 INFO - Return code: 0 15:35:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:46 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')]} 15:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 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')]} 15:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:46 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:46 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 15:35:46 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 15:35:46 INFO - Using env: {'DISPLAY': ':0', 15:35:46 INFO - 'HOME': '/home/cltbld', 15:35:46 INFO - 'LANG': 'en_US.UTF-8', 15:35:46 INFO - 'LANGUAGE': 'en_US:en', 15:35:46 INFO - 'LOGNAME': 'cltbld', 15:35:46 INFO - 'MAIL': '/var/mail/cltbld', 15:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:46 INFO - 'MOZ_NO_REMOTE': '1', 15:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:46 INFO - 'NO_EM_RESTART': '1', 15:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:46 INFO - 'PWD': '/builds/slave/test', 15:35:46 INFO - 'SHELL': '/bin/bash', 15:35:46 INFO - 'SHLVL': '1', 15:35:46 INFO - 'TERM': 'linux', 15:35:46 INFO - 'TMOUT': '86400', 15:35:46 INFO - 'USER': 'cltbld', 15:35:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:46 INFO - '_': '/tools/buildbot/bin/python'} 15:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:46 INFO - Running setup.py (path:/tmp/pip-EuLiyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:46 INFO - Running setup.py (path:/tmp/pip-zq2Toe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:46 INFO - Running setup.py (path:/tmp/pip-k79jen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:46 INFO - Running setup.py (path:/tmp/pip-y8TKQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:46 INFO - Running setup.py (path:/tmp/pip-wX_JgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:46 INFO - Running setup.py (path:/tmp/pip-k03jt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:46 INFO - Running setup.py (path:/tmp/pip-SY3ua8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:46 INFO - Running setup.py (path:/tmp/pip-SnqD_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:47 INFO - Running setup.py (path:/tmp/pip-CzlONG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:47 INFO - Running setup.py (path:/tmp/pip-iJkhiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:47 INFO - Running setup.py (path:/tmp/pip-ZoilKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:47 INFO - Running setup.py (path:/tmp/pip-qB0qEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:47 INFO - Running setup.py (path:/tmp/pip-CEv6gn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:47 INFO - Running setup.py (path:/tmp/pip-Z5WQx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:47 INFO - Running setup.py (path:/tmp/pip-K0pM9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:47 INFO - Running setup.py (path:/tmp/pip-DEisEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:47 INFO - Running setup.py (path:/tmp/pip-3vsOqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:35:47 INFO - Running setup.py install for manifestparser 15:35:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:35:47 INFO - Running setup.py install for mozcrash 15:35:47 INFO - Running setup.py install for mozdebug 15:35:47 INFO - Running setup.py install for mozdevice 15:35:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Running setup.py install for mozfile 15:35:48 INFO - Running setup.py install for mozhttpd 15:35:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Running setup.py install for mozinfo 15:35:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Running setup.py install for mozInstall 15:35:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Running setup.py install for mozleak 15:35:48 INFO - Running setup.py install for mozlog 15:35:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Running setup.py install for moznetwork 15:35:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:35:48 INFO - Running setup.py install for mozprocess 15:35:48 INFO - Running setup.py install for mozprofile 15:35:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:35:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:35:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:35:49 INFO - Running setup.py install for mozrunner 15:35:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:35:49 INFO - Running setup.py install for mozscreenshot 15:35:49 INFO - Running setup.py install for moztest 15:35:49 INFO - Running setup.py install for mozversion 15:35:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:35:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:35:49 INFO - Cleaning up... 15:35:49 INFO - Return code: 0 15:35:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:49 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')]} 15:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:49 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')]} 15:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:49 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:49 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 15:35:49 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 15:35:49 INFO - Using env: {'DISPLAY': ':0', 15:35:49 INFO - 'HOME': '/home/cltbld', 15:35:49 INFO - 'LANG': 'en_US.UTF-8', 15:35:49 INFO - 'LANGUAGE': 'en_US:en', 15:35:49 INFO - 'LOGNAME': 'cltbld', 15:35:49 INFO - 'MAIL': '/var/mail/cltbld', 15:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:49 INFO - 'MOZ_NO_REMOTE': '1', 15:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:49 INFO - 'NO_EM_RESTART': '1', 15:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:49 INFO - 'PWD': '/builds/slave/test', 15:35:49 INFO - 'SHELL': '/bin/bash', 15:35:49 INFO - 'SHLVL': '1', 15:35:49 INFO - 'TERM': 'linux', 15:35:49 INFO - 'TMOUT': '86400', 15:35:49 INFO - 'USER': 'cltbld', 15:35:49 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:49 INFO - '_': '/tools/buildbot/bin/python'} 15:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:35:49 INFO - Running setup.py (path:/tmp/pip-sQgcDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:35:49 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)) 15:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:35:49 INFO - Running setup.py (path:/tmp/pip-N3avL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:35:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:35:49 INFO - Running setup.py (path:/tmp/pip-DbKynv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:35:49 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)) 15:35:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:35:49 INFO - Running setup.py (path:/tmp/pip-1XWXGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:35:50 INFO - Running setup.py (path:/tmp/pip-2V_GLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:35:50 INFO - Running setup.py (path:/tmp/pip-kTJF9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:35:50 INFO - Running setup.py (path:/tmp/pip-6xlIeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:35:50 INFO - Running setup.py (path:/tmp/pip-39XZ3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:35:50 INFO - Running setup.py (path:/tmp/pip-FjJWg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:35:50 INFO - Running setup.py (path:/tmp/pip-aM8hTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:35:50 INFO - Running setup.py (path:/tmp/pip-kDRcic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:35:50 INFO - Running setup.py (path:/tmp/pip-vyceD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:35:50 INFO - Running setup.py (path:/tmp/pip-KPVB9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:35:50 INFO - Running setup.py (path:/tmp/pip-8_8Ns7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:50 INFO - Running setup.py (path:/tmp/pip-cpL11K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:35:50 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)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:35:50 INFO - Running setup.py (path:/tmp/pip-NEjDDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:35:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:35:50 INFO - Running setup.py (path:/tmp/pip-ES0q69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:35:50 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)) 15:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:35:50 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)) 15:35:50 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)) 15:35:50 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)) 15:35:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:35:50 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 15:35:50 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 15:35:50 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 15:35:50 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 15:35:50 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 15:35:50 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 15:35:52 INFO - Downloading blessings-1.6.tar.gz 15:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:35:52 INFO - Installing collected packages: blessings 15:35:52 INFO - Running setup.py install for blessings 15:35:53 INFO - Successfully installed blessings 15:35:53 INFO - Cleaning up... 15:35:53 INFO - Return code: 0 15:35:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:53 INFO - Reading from file tmpfile_stdout 15:35:53 INFO - Current package versions: 15:35:53 INFO - argparse == 1.2.1 15:35:53 INFO - blessings == 1.6 15:35:53 INFO - blobuploader == 1.2.4 15:35:53 INFO - docopt == 0.6.1 15:35:53 INFO - functools32 == 3.2.3-2 15:35:53 INFO - jsonschema == 2.5.1 15:35:53 INFO - manifestparser == 1.1 15:35:53 INFO - mozInstall == 1.12 15:35:53 INFO - mozcrash == 0.17 15:35:53 INFO - mozdebug == 0.1 15:35:53 INFO - mozdevice == 0.48 15:35:53 INFO - mozfile == 1.2 15:35:53 INFO - mozhttpd == 0.7 15:35:53 INFO - mozinfo == 0.9 15:35:53 INFO - mozleak == 0.1 15:35:53 INFO - mozlog == 3.4 15:35:53 INFO - moznetwork == 0.27 15:35:53 INFO - mozprocess == 0.23 15:35:53 INFO - mozprofile == 0.28 15:35:53 INFO - mozrunner == 6.12 15:35:53 INFO - mozscreenshot == 0.1 15:35:53 INFO - mozsystemmonitor == 0.3 15:35:53 INFO - moztest == 0.7 15:35:53 INFO - mozversion == 1.4 15:35:53 INFO - psutil == 3.1.1 15:35:53 INFO - requests == 1.2.3 15:35:53 INFO - wsgiref == 0.1.2 15:35:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:35:53 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')]} 15:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:53 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')]} 15:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:53 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:53 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 15:35:53 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 15:35:53 INFO - Using env: {'DISPLAY': ':0', 15:35:53 INFO - 'HOME': '/home/cltbld', 15:35:53 INFO - 'LANG': 'en_US.UTF-8', 15:35:53 INFO - 'LANGUAGE': 'en_US:en', 15:35:53 INFO - 'LOGNAME': 'cltbld', 15:35:53 INFO - 'MAIL': '/var/mail/cltbld', 15:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:53 INFO - 'MOZ_NO_REMOTE': '1', 15:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:53 INFO - 'NO_EM_RESTART': '1', 15:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:53 INFO - 'PWD': '/builds/slave/test', 15:35:53 INFO - 'SHELL': '/bin/bash', 15:35:53 INFO - 'SHLVL': '1', 15:35:53 INFO - 'TERM': 'linux', 15:35:53 INFO - 'TMOUT': '86400', 15:35:53 INFO - 'USER': 'cltbld', 15:35:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:53 INFO - '_': '/tools/buildbot/bin/python'} 15:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 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)) 15:35:53 INFO - Cleaning up... 15:35:53 INFO - Return code: 0 15:35:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:35:53 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')]} 15:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:53 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')]} 15:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:35:53 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 0x7fbef5aa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18748a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1941790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, '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': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', '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 15:35:53 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 15:35:53 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 15:35:53 INFO - Using env: {'DISPLAY': ':0', 15:35:53 INFO - 'HOME': '/home/cltbld', 15:35:53 INFO - 'LANG': 'en_US.UTF-8', 15:35:53 INFO - 'LANGUAGE': 'en_US:en', 15:35:53 INFO - 'LOGNAME': 'cltbld', 15:35:53 INFO - 'MAIL': '/var/mail/cltbld', 15:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:35:53 INFO - 'MOZ_NO_REMOTE': '1', 15:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:35:53 INFO - 'NO_EM_RESTART': '1', 15:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:35:53 INFO - 'PWD': '/builds/slave/test', 15:35:53 INFO - 'SHELL': '/bin/bash', 15:35:53 INFO - 'SHLVL': '1', 15:35:53 INFO - 'TERM': 'linux', 15:35:53 INFO - 'TMOUT': '86400', 15:35:53 INFO - 'USER': 'cltbld', 15:35:53 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:35:53 INFO - '_': '/tools/buildbot/bin/python'} 15:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:35:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:35:53 INFO - Cleaning up... 15:35:53 INFO - Return code: 0 15:35:53 INFO - Running post-action listener: _resource_record_post_action 15:35:53 INFO - Running post-action listener: _start_resource_monitoring 15:35:53 INFO - Starting resource monitoring. 15:35:53 INFO - [mozharness: 2016-10-14 22:35:53.865898Z] Finished create-virtualenv step (success) 15:35:53 INFO - [mozharness: 2016-10-14 22:35:53.866365Z] Running install step. 15:35:53 INFO - Running pre-action listener: _resource_record_pre_action 15:35:53 INFO - Running main action method: install 15:35:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:35:54 INFO - Reading from file tmpfile_stdout 15:35:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:35:54 INFO - Reading from file tmpfile_stdout 15:35:54 INFO - Output received: 15:35:54 INFO - Usage: mozinstall [options] installer 15:35:54 INFO - Options: 15:35:54 INFO - -h, --help show this help message and exit 15:35:54 INFO - -d DEST, --destination=DEST 15:35:54 INFO - Directory to install application into. [default: 15:35:54 INFO - "/builds/slave/test"] 15:35:54 INFO - --app=APP Application being installed. [default: firefox] 15:35:54 INFO - mkdir: /builds/slave/test/build/application 15:35:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:35:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:36:11 INFO - Reading from file tmpfile_stdout 15:36:11 INFO - Output received: 15:36:11 INFO - /builds/slave/test/build/application/firefox/firefox 15:36:11 INFO - Running post-action listener: _resource_record_post_action 15:36:11 INFO - [mozharness: 2016-10-14 22:36:11.137218Z] Finished install step (success) 15:36:11 INFO - [mozharness: 2016-10-14 22:36:11.137463Z] Running run-tests step. 15:36:11 INFO - Running pre-action listener: _resource_record_pre_action 15:36:11 INFO - Running main action method: run_tests 15:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:36:11 INFO - Python 2.7.3 15:36:11 INFO - Return code: 0 15:36:11 INFO - grabbing minidump binary from tooltool 15:36: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')]} 15:36:11 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 0x193e930>, '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 0x193f830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x193fcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:36:11 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 15:36:11 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 15:36:11 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 15:36:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:36:11 INFO - Return code: 0 15:36:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:36:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:36:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:36:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:36:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:36:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 15:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 15:36:11 INFO - Using env: {'DISPLAY': ':0', 15:36:11 INFO - 'HOME': '/home/cltbld', 15:36:11 INFO - 'LANG': 'en_US.UTF-8', 15:36:11 INFO - 'LANGUAGE': 'en_US:en', 15:36:11 INFO - 'LOGNAME': 'cltbld', 15:36:11 INFO - 'MAIL': '/var/mail/cltbld', 15:36:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:36:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:36:11 INFO - 'MOZ_NO_REMOTE': '1', 15:36:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:36:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:36:11 INFO - 'NO_EM_RESTART': '1', 15:36:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:36:11 INFO - 'PWD': '/builds/slave/test', 15:36:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:36:11 INFO - 'SHELL': '/bin/bash', 15:36:11 INFO - 'SHLVL': '1', 15:36:11 INFO - 'TERM': 'linux', 15:36:11 INFO - 'TMOUT': '86400', 15:36:11 INFO - 'USER': 'cltbld', 15:36:11 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258', 15:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:36:11 INFO - '_': '/tools/buildbot/bin/python'} 15:36:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 15:36:11 INFO - mozversion application_buildid: 20161014123004 15:36:11 INFO - mozversion application_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 15:36:11 INFO - mozversion application_display_name: Nightly 15:36:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:36:11 INFO - mozversion application_name: Firefox 15:36:11 INFO - mozversion application_remotingname: firefox 15:36:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:36:11 INFO - mozversion application_vendor: Mozilla 15:36:11 INFO - mozversion application_version: 52.0a1 15:36:11 INFO - mozversion platform_buildid: 20161014123004 15:36:11 INFO - mozversion platform_changeset: e412b386433b8c8ba83a28a1df310d9ad0b20285 15:36:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:36:11 INFO - mozversion platform_version: 52.0a1 15:36:11 INFO - using testdate: 1476484571 15:36:11 INFO - actual date: 1476484571 15:36:11 INFO - starting webserver on 'localhost:33809' 15:36:11 INFO - SUITE-START | Running 2 tests 15:36:11 INFO - TEST-START | dromaeo_css 15:36:11 INFO - operating with platform_type : linux_ 15:36:11 INFO - Initialising browser for dromaeo_css test... 15:36:11 INFO - TEST-INFO | started process 17202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCirOvc/profile http://localhost:33809/getInfo.html) 15:36:15 INFO - PROCESS | 17202 | __metrics Screen width/height:1600/1200 15:36:15 INFO - PROCESS | 17202 | colorDepth:24 15:36:15 INFO - PROCESS | 17202 | Browser inner width/height: 1024/697 15:36:15 INFO - PROCESS | 17202 | __metrics 15:36:16 INFO - PROCESS | 17202 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:36:16 INFO - PROCESS | 17202 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:36:16 INFO - PROCESS | 17202 | console.error: PushService: 15:36:16 INFO - PROCESS | 17202 | stateChangeProcessEnqueue: Error transitioning state 15:36:16 INFO - PROCESS | 17202 | UnknownError 15:36:17 INFO - TEST-INFO | 17202: exit 0 15:36:17 INFO - Browser initialized. 15:36:17 INFO - Running cycle 1/1 for dromaeo_css test... 15:36:17 INFO - TEST-INFO | started process 17286 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCirOvc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:36:29 INFO - PROCESS | 17286 | RSS: Main: 172335104 15:36:29 INFO - PROCESS | 17286 | 15:37:21 INFO - PROCESS | 17286 | 1476484641022 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:39:30 INFO - PROCESS | 17286 | Cycle 1(1): loaded http://localhost:33809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33809/tests/dromaeo/cssquery-ext.html) 15:39:32 INFO - PROCESS | 17286 | RSS: Main: 384905216 15:39:32 INFO - PROCESS | 17286 | 15:42:35 INFO - PROCESS | 17286 | Cycle 1(1): loaded http://localhost:33809/tests/dromaeo/cssquery-ext.html (next: http://localhost:33809/tests/dromaeo/cssquery-jquery.html) 15:42:36 INFO - PROCESS | 17286 | RSS: Main: 284659712 15:42:36 INFO - PROCESS | 17286 | 15:45:38 INFO - PROCESS | 17286 | Cycle 1(1): loaded http://localhost:33809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33809/tests/dromaeo/cssquery-mootools.html) 15:45:38 INFO - PROCESS | 17286 | RSS: Main: 220381184 15:45:38 INFO - PROCESS | 17286 | 15:48:40 INFO - PROCESS | 17286 | Cycle 1(1): loaded http://localhost:33809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33809/tests/dromaeo/cssquery-prototype.html) 15:48:41 INFO - PROCESS | 17286 | RSS: Main: 245497856 15:48:41 INFO - PROCESS | 17286 | 15:51:44 INFO - PROCESS | 17286 | Cycle 1(1): loaded http://localhost:33809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33809/tests/dromaeo/cssquery-yui.html) 15:51:45 INFO - PROCESS | 17286 | RSS: Main: 217210880 15:51:45 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | Cycle 1(1): loaded http://localhost:33809/tests/dromaeo/cssquery-yui.html (next: http://localhost:33809/tests/dromaeo/cssquery-dojo.html) 15:54:48 INFO - PROCESS | 17286 | RSS: Main: 314560512 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | __start_tp_report 15:54:48 INFO - PROCESS | 17286 | _x_x_mozilla_page_load 15:54:48 INFO - PROCESS | 17286 | _x_x_mozilla_page_load_details 15:54:48 INFO - PROCESS | 17286 | |i|pagename|runs| 15:54:48 INFO - PROCESS | 17286 | |0;dojo.html;2964.377480729047;2990.147807874756;3016.592759977403;3026.4249792539417;3033.84830758462;5153.30430391897;5160.845174644757;5204.115300398932;5227.555657769085;5315.893682126355;5208.114620514512;5219.112750832358;5308.336457942757;5324;5350.170723537848;4742.715437073769;4747.287906813988;4795.496472870351;4803.879903002436;4820.542048505404;4892.168331383673;4924.359833221694;4976.3530741003615;4980.2529620557025;5040.2439634055;4717.976410117962;4753.524647535253;4859.635527335428;4893.143699852511;4917.975410122962;4770.1175282572485;4794.3287939688125;4797.4482934462285;4817.397825271841;4863.19757240055;4771.379720636295;4787.13831510328;4789.2816077588295;4798.616110711135;4832.9275060874115;5191.662541934762;5241.266222728821;5247.580193584504;5259.789608415659;5292.761825717852;5520.861978450531;5564.276644036249;5567.805126820542;5606.187102870061;5643.633163844378;5638.830835074954;5661.037623603997;5661.8584535386535;5662.17898404729;5669;5273.86815329616;5297.947020529784;5319.2287118368;5370.597205209625;5375.838724838261;5667.376588575254;5680.062789639664;5734.16854556087;5742.59801813869;5763.221965034751;5515.972420137874;5516.365617953907;5519.227308176858;5531.529819965348;5536.474034966753;5344.839654810362;5382.273393091961;5390;5449.427810079964;5456.863578410492;5485.61600687956;5493.697846618395;5534.972325138348;5617.578681598897;5619.522340601013;5594.300712410949;5604.775808967677;5620.072688006515;5621.634593751475;5639.0977443609645;4338.696291259582;4343.305071188594;4344.3483477478;4348.760818155032;4390.648748100144;3782.6406491383273;3853.845846166178;3878.5927477614446;3881.3983832506005;3931.1351502669368;5222.92165617516;5243.213517972258;5255.343082114736;5286;5311.681299122065;5478.780848766084;5495.093309603871;5497.47773961473;5501.092319767194;5511.807086751945;5120.1039818031695;5203.089459344676;5216.40011398694;5229.006488767122;5268.78924843002;4695.060987802453;4729.69256998294;4736.644751643572;4747.905041899143;4775.761211939459;5799.82600521985;5841.036229022164;5841.532677385884;5841.678707671119;5895.322037965603;5619.606627536034;5626.774929002794;5634.154876768517;5635.520980716685;5641.37944826077;5572.804951826666;5616.466435688603;5720.6853623049465;5760.855978600569;5832.708364581838;5485.232067510472;5491.148871924858;5492.670439773627;5538.335399752055;5551.805686800943;5529.281193444987;5531.363893152178;5584.972075139598;5585.162225666182;5600;5304.389995150453;5347.812826551052;5353.223782551586;5453.382376459401;5525.834224973257;5379.731013449234;5387.084195686664;5389.622726409114;5389.865253368697;5395.217693434509;5376.462353764592;5377.300950876517;5384.946150538602;5387.811426600207;5388.595855310789;5423.186522021729;5438.945610543844;5443.4284400138995;5445.1832225166545;5446.237526746179;5265.578753699771;5373.167159090347;5374.11327131019;5437.157240627709;5438.265834112344 15:54:48 INFO - PROCESS | 17286 | |1;ext.html;607.6141650052217;631.5484428633528;635.1996484429617;646.4472875691284;649.0750680280602;31622.525662115087;42211.57788422115;43394.78302608483;43416.348754768704;47151.76424117883;44229.115417691624;44496.33255501162;44614.77692611532;44650;44675.77662111685;8829.426087304337;8979.191872731453;8992.415492992966;9000.954995225014;9002.144796244347;7991.840163196733;8114.269715725583;10472.895271047306;10702.625408110718;10703.571857125706;10925.180611454132;10954.34273943562;10980.450977451135;10995.505202265877;11027.17296202784;10706.678799636024;10744.892551074467;10841.67474975752;10842.078423334026;10842.241043126905;10560;10608.15134789215;10637.73405664857;10648.41433721145;10655.360678359246;41756.79121604403;42100.57899420997;42151;42164.57835421637;42187;3356.1777364545596;3448.2758620689683;3647.6534729200685;3688.2070354873563;3750.362438385481;30617.846910765526;30801.38397232043;31405.057848264587;31533.84233078843;32260;4001.799910004488;4012.137390461036;4136.21411931732;4262.403263543107;4263.509696384925;319985;321359;323068;323814;324687;33514.83242583772;52053.7397313011;52115.73942130265;52116.73941630343;52185.7390713044;34021;36094.8195259022;36224.45663315053;36484;36504.81747591298;12971.740565188644;13069.215847049018;13076.738465230643;13081.215127092404;13082.411291491906;9809;10103.949480252699;10881.455927203608;10961.506732197071;10968.835467467994;7946.841063178704;8188.713395031145;8227.794305142299;8281.95859020701;8358.791030224293;3135.4669706150007;3192.0049968769517;3193.824339661341;3214.9196270093435;3231.773775835669;923.8175135826153;977.8973207813077;1028.9691309260734;1029.351508549624;1121.6354684727332;30562.388752225277;31324.216894577818;31495.21261968469;31612.841935790635;31683.683163168535;1062.559037999237;1076.364944682641;1083.3499900060058;1123.4326665034268;1128.8814674459063;15931.283092260875;16872.662546748998;16921.153942302837;16930.830691693172;17161.141942902806;477354;481929;482097;482246;482671;57825;58100.70949645225;58106;58125.418745812;58189.4181058184;1181.6514128332162;1211.6789050901518;1220.5972029230154;1247.1020864977202;1265.3736400481637;28252.293692657848;31560.368792623558;31775.36449271048;32244.35511289808;32591.674083258862;47350.763246183546;47790.283145752146;47928.52071479241;47947.76026119847;47957.280640789715;381701;384772;384787;386026;388238;26381.868090659424;26885;27080.729192707822;27086.1874143776;28870;45616.31575526304;45918.770406147756;46202.306965396216;46269;47506.76246618745;38786.80606596949;39279.41080883732;39498;40675.98310042272;41429.378559322235;39048;39196;39606.80196598999;40268.39597405983;41529;39267.607323927536;40104.19791604093;41176.794116029225;41302.38046429246;41314.79342603268;32495;35151.29697406089;35530.46704299489;36055.81972090123;36195.45706814347;27044;27284.590731139448;27483.997981322267;27564.862175689796;27754.722452775215 15:54:48 INFO - PROCESS | 17286 | |2;jquery.html;367.4818505906672;384.12802937332236;385.9015950932513;392.59954846057025;404.7611908973705;14132.999999999987;18087.18607662655;19414.99999999998;19809.801901980976;19988.300409485633;17255.827441725578;17366.218520166592;17421.738673919903;17716.82283177168;17774.11129443529;5647.632903861257;5939.821805345847;5942.6434413935085;5943.910841337383;5946.70266486674;4143.129942712034;4350.108227813291;4428.180786554498;5832.533397328203;5868.2371291732015;6652.933470665304;6658.633775142365;6663.133792606955;6666.166729158856;6667.033280174372;6380.489560835122;6463.838404039913;6497.9350206498275;6498.1552398188405;6636.568623039487;5634.605577609569;5737.08206686928;5746.25298711169;5754.280714910637;5756.683382413966;22633.09467621293;22829.42926426836;22843.885780571156;23032.7696723034;23156.768432315628;2274.40865375002;2447.547203767309;2729.863506824651;3054.6639869614323;3074.1546074829375;14391.640208994755;14480.855191448056;14528.782068268985;14557.272136393138;15155.848441515554;1888.3202047262973;1901.496103532565;1969.4780883065998;1978.8713733607412;1998.9300374486968;77417.61291193565;77725.83411248893;79043.60478197572;79237.60381198114;80675;10208.846867296996;10267.071805533236;10417.479126043667;10696.304740192018;10793.352398856094;15030.17334046638;15053.623659408602;15057.54827355181;15060.397584096732;15067.698646027018;7388.261173882569;7788.870613760973;7834.529928204326;8039.5176289422825;8070.636821343053;7454.515456495311;7505.211952744992;7545.245475452521;7718.768436946901;7743.612819359009;6368.382320256427;6404.615723056631;6436.324185960407;6436.871262574816;6631.403173714389;1827.269092363039;1886.4434991677488;1895.9146838392305;1913.7607799025122;1921.7344476135568;862.8533149364623;863.4171933944563;897.264243320484;960.4957397366438;1028.681108856257;18527.53681157955;18821.341253056078;19174.64443722343;19891;19925.20299188045;927.6289484206236;962.6438217859297;980.2109302011949;1011.3173607814696;1061.8035663402295;10647.6563042982;11365.829512557319;11429.714257143638;11444.771104577861;11453.656390308304;417801;422724;425838;435983;439481;81794.59102704449;83649.58175209085;83652;83809;84835;1022.4632068164274;1041.0786453988123;1050.9579616815395;1054.6097943760858;1069.7379142110387;16894.49316520506;17277.308907643554;17881.46355609334;17893.642127157123;17937.64124717472;40196.799016004734;40748.38877416782;40941.79529102335;41042.58957410507;43628.56371436372;54760.17859732187;55585;56648.86702266014;57251.71374143269;57633.135502968325;7769.820078356908;8135.633896474555;8362.707305244287;8406.369522285731;8589.484630922165;12252;13271.734565308832;13283.269420181983;13583.796243056164;13601.591952241448;11427.371494567878;11643.41782910834;11647;11816.76366472683;11929.940350298193;10847.240693151403;11116.833247501132;11152.776944461228;11474;11514.481848316678;10955.726106847393;11396.94301528487;11494.94252528732;11606.593769218036;11921.46353414081;8106.432549721699;8156.592170391338;8229.46508476947;8418.148007438354;8504.702335418231;9834.901650983686;11292.830607540729;11810.40947952616;11902.583409580624;11936.940315298369 15:54:48 INFO - PROCESS | 17286 | |3;mootools.html;1437.7052704195642;1468.1264647534717;1577.7081239970607;1744;1762.3391228289393;8755.912440875598;9396.154346108857;9401.388909720872;9402.153806157445;9406.388584741988;8042.798930026752;8348.41561090724;8804.559772011406;9128.224100951411;9242.445453272792;2259.209276753136;2278.2026290798253;2311.919082832101;2319.1535089692225;2328.988355058222;2271.6478945763433;2282.5092605089903;2337.8947947342326;2344.120954642009;2349.729781075181;2307.492351682627;2322.291701031185;2326.2904814031713;2338.4855331827057;2343.1915988983774;2206.415299945516;2242.5963326601286;2242.618754811686;2244.483768733184;2251.763564825694;2230.542738738555;2233.3188377544843;2233.4416395901026;2237.485378362969;2241.529278851443;9210.723678289662;9292.488913109777;9325.487098209596;9340.71977840666;9352.579133938922;5287.629865909388;5432.728363581805;5436.728163591804;5442.265294185274;5445.782168713246;3351.748618853596;3435.2957643682985;3552.307300076486;3571.39286321326;3584.605693373727;1135.6309199510192;1153.7115721069733;2154.4613846538364;2226.8441209115367;2264.6489794081945;12899.742005159844;13040;13091.41088651013;13117.737645247042;13125.2124872507;4461.286194208911;4517;4675.322078298627;4688.4373875134515;4690.530946905282;10134.594616215416;10148.898511014942;10172.237082218864;10174.796504069876;10205.540750666238;5263.6841789492755;5272.630915835932;5275.57795376369;5282.7622756976025;5283.656562323514;4407.537208593116;4554.020885509632;4917.459079501252;4917.58200552957;5040.168372218543;3729.6083911189476;3761.567419746709;3822.885313440546;3877.8254978526033;3892.241013002494;1131.5643477261149;1133.2350663302238;1147.8278258261328;1151.948162332697;1175.518037604578;927.6614035876856;941.7363138321281;942.7454587261401;957.7844984878486;977.5649835823133;5885.823425297248;6006.189164462829;6052.334243233241;6085.117657939574;6288.276848162428;441.7989814634334;450.47519639619475;450.65975188732295;453.3584977257144;460.8548307283262;3964.801759911993;3968.404739289072;4027.476428064333;4101.610347017028;4114.341705327133;11042.889571104346;11348;11463.828042579367;11466.885331146581;11475.942620286845;11318.094552435785;11325.433728313552;11331.716707082389;11367;11391.601293954673;7985.161558036322;8381.119982401882;8449.197326253996;8460.323174146053;8464.941882264717;6066.120412540069;6086.113304875503;6284.74861005573;6301.590396624205;6307.526935479766;10717.464126793473;10729.678109656723;10761.677149685522;10765.89234107649;10965.177611678997;10153.340032897839;10548.367097974146;10578.365298082139;10784.730381740519;10934.015938565568;7757.301842834172;8078.555679437687;8427.494350338999;8668.869966950375;8855.73432797017;8556.229939305493;9067.682631108144;9087.818243634958;9087.909120908706;9090.13643703847;7641.197674244125;7799.961000194962;7808.648610812641;7854.4894581851995;8066.153053929487;7661.731839385595;7681.078270607562;7857.646405911862;7879.172686867796;7897.328727058035;7225.313595208447;7351.926480735124;7352.70589176427;7353.522021068614;7359.742409015659;4999.200127979506;5139.177731562932;5141.5629671476845;5321.600879933943;5388.245645609696;5179.378474583074;5250.291210686509;5255.211718242142;5286.97356513215;5510.366307874646 15:54:48 INFO - PROCESS | 17286 | |4;prototype.html;301.3505894796713;306.1718052667533;310.3219465467953;315.7726436965384;320.7065535035443;5083.822066227683;5284.630075894689;5338.866528336789;5401.756920938553;5413.133898576229;5169.508896654812;5277.340332458442;5285.788568457267;5343.343563495319;5348.946510534894;4168.437260969776;4188.434561334227;4206.095689426773;4207.810648520824;4211.789410529476;3885.630865067814;4024.29574824406;4113.732607380511;4157.835805974332;4202.873913782576;4023.2355852387955;4036.132231570212;4042.7170098093147;4056.1809542368064;4073.6130067643526;4033.838646454138;4034.0519977805047;4047.5345335286524;4048.109415928491;4065.308897487434;3523.9119022024397;3531.9293614127832;3532.929341413183;3535.6464353564693;3535.7524973251884;5021.698698078127;5110.667806592597;5126.871828204287;5130.71781052042;5232.895342093137;4605.654575906787;4611.4005179326805;4620.561046700558;4622.791974361162;4635.142498637762;5517.2551705519645;5522.282103326542;5526.806561770319;5532;5534.944650553523;3784.924301513982;3851.9807400963095;3853.441251018615;3868.6324799144036;3884.6309600587897;5687.488126068673;5698.772049118031;5701.372848986608;5708.315002199721;5745.1669507921115;3934.5081864766903;3996.160806230724;3999.34010888206;3999.8200080996426;4001.099752555652;3788.6969042476535;3956.802159891994;3994.2810294147334;4021;4028.4762980812307;4555.794989225493;4590.403247577793;4597.747123908151;4598.149342371672;4607.746573938399;5521.309836270466;5539.639923405047;5563.248961390242;5569.248151499577;5600.243967064475;1291.2123604601186;1309.5220244610648;1326.2838067443665;1344.361428321559;1363.2570249214202;845.7927807687033;862.895493767978;876.7194497760782;878.613410099567;887.8357503861806;4729.243321068612;4737.541594635935;4751.960833291743;4754.904901901942;4793.257045158006;4967.677100988424;4987.850364489072;4989.975050124726;4994.925076123861;5025.773840177201;4710.24636058229;4719.221328480831;4721.291806229025;4724.551167639069;4753.47711751707;2818.5490321548455;3012.487877060905;3032.5147976323683;3060.342026464321;3060.3726236121543;5928.229330187048;5949.583529152917;5963.95838122552;5966.850828729316;5973.880522389615;5530.7511161997;5830.679312637761;5853.385394533512;5879.676617786063;5912.970435147797;5921.348651648315;5926.762929482858;5953.76184952597;5959.791407300723;5980.730867111078;5554.389017208023;5793.246877905845;5806.82579522615;5853.414658534112;5861.208736820475;5659.886802264014;5665.688387138582;5677.943220567741;5693.345265294544;5703.632992308146;5937.614055086406;5967.940320596912;5977.562901331665;6046.339610571335;6049.848753781191;3948.4274780156143;4005.6995725320135;4008.899777505586;4021.8994525137105;4037.454943582579;5428.212909128233;5717.599768016199;5727.024176659046;5732.656040637575;5738.655680659173;5452.836414907559;5454.863628409322;5605.943940560705;5613.831585052455;5649.519790817826;5550.167474878801;5606.794539174097;5607.635503692247;5608.383077861514;5632.197696737005;5276.788928442973;5485.917711234414;5489.451054894478;5523.861903452445;5612.4387561245185;5565.526930210977;5575;5587.217789509553;5589.80435684749;5598.880223955307;5483;5493.725313734218;5504.4495550444635;5521.944780552143;5530.55755539564 15:54:48 INFO - PROCESS | 17286 | |5;yui.html;671.1040760584619;700.6356694518851;713.9892901606473;726.505975936363;735.0958321264844;15009.774853377194;16018.7597186042;16558.83441165588;16607.75088373674;16641.500754977355;15240.314185861664;15321.08073515587;15345.232738363093;15351.846481535182;15373.615659608515;815.0708192660372;831.2352635575285;833.3000279764996;834.1408349400127;834.2575108153748;675.2066322071571;703.0894990986684;776.6621519638975;823.3495538524559;828.7348048624442;877.8332116897769;877.9990810476063;878.2798105553449;881.184903963831;885.0043700836559;865.1002956924791;865.2213008292524;875.0068672057197;875.6628697951271;876.1720174435161;510.19134671545646;532.5553163108809;533.0298856081932;535.8017533512586;602.3073465514649;13546.864531354757;14091.647708807363;14133.575992720234;14133.78799318011;14156.150630962175;13830.170189788645;14203.573892783234;14251.928740356232;14359.712805743826;14425.334044366466;12524.937375313157;12560.246385216917;12601.558945436956;12701.301428421433;12701.428435720414;4258.714406821916;4312.396264522938;4384.978075109636;4386.210482113218;4449.377087207794;70768.6461567694;75286;80096.59951700263;80249.19750802475;80717;11538.538458461735;12144.271343719405;12246.142770006014;12304.323262220485;12660.81008784869;23306.65040024401;23658;23659.7634023661;23667.526649467258;23680.52638947246;8803.647854085893;9103.362764606547;9323.580438880132;9369.672061477815;9547.856782148274;4712.858614241578;4765.4996225395835;4784.760761961888;4884.218525036048;4894.388201474816;3634.1459756957092;3718.758280711745;3750.343689854319;3753.9061523461587;3764.698824094066;622.8941080016408;636.1443858010967;640.1677818835495;643.8583511627435;655.8229278094888;704.1796307302038;719.3741444942933;740.9962950185322;752.24023736027;755.6788364944877;8789.604467798965;9501.619935202652;9502.762430939143;9654.613815447445;10086.293959422917;740.8555331710372;744.0321390181024;745.4893398022372;749.8650242956211;751.8796992481177;4223.915521689611;4739.146953548326;4761.119192949315;4821.783019764119;4912.214045752662;79986.60006700046;117254.41183822494;118553;119832;124447.37776311241;60464.09303860446;63125.684371577845;78407.60796195983;102476;104066;92092;94715;95637.69796832473;97386.5130674342;98223;8807.603657835285;8894.28845692356;9090.636374544943;9113.589888454902;9161.358704890594;53912.460875390745;53986.01258767141;54455.72772136114;54575.45424545704;54764.726176368866;75887;79520;80512;81694.59152704198;82670;11843.170978031456;12608.117431780054;12611.180273282207;12775.169613975062;12862.614121576367;13325.200487970753;13641.522546710818;13981.300934953415;14222.573322800332;14468.85531144675;12250.816237756262;12643.810342844681;12824;12996.220226786423;13565.86434135646;12345;12512.499500020262;12691.101773065524;13408.128471649312;13422.597322080353;12272.263664180178;12473.189242699196;12478.939290160075;12576.937115314366;12692.555760548337;10185.643502477378;10604.363738175734;10678.229291210442;10780.191485638452;11009.119270458184;10891.346519208555;10900.236983411085;10993.61522346714;11007.61473348429;11021 15:54:48 INFO - PROCESS | 17286 | __end_tp_report 15:54:48 INFO - PROCESS | 17286 | __start_cc_report 15:54:48 INFO - PROCESS | 17286 | _x_x_mozilla_cycle_collect,2160 15:54:48 INFO - PROCESS | 17286 | __end_cc_report 15:54:48 INFO - PROCESS | 17286 | __startTimestamp1476485688366__endTimestamp 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | ------- Summary: start ------- 15:54:48 INFO - PROCESS | 17286 | Number of tests: 6 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | [#0] dojo.html Cycles:165 Average:5195.96 Median:5376.46 stddev:571.99 (10.6%) stddev-sans-first:546.30 15:54:48 INFO - PROCESS | 17286 | Values: 2964.4 2990.1 3016.6 3026.4 3033.8 5153.3 5160.8 5204.1 5227.6 5315.9 5208.1 5219.1 5308.3 5324.0 5350.2 4742.7 4747.3 4795.5 4803.9 4820.5 4892.2 4924.4 4976.4 4980.3 5040.2 4718.0 4753.5 4859.6 4893.1 4918.0 4770.1 4794.3 4797.4 4817.4 4863.2 4771.4 4787.1 4789.3 4798.6 4832.9 5191.7 5241.3 5247.6 5259.8 5292.8 5520.9 5564.3 5567.8 5606.2 5643.6 5638.8 5661.0 5661.9 5662.2 5669.0 5273.9 5297.9 5319.2 5370.6 5375.8 5667.4 5680.1 5734.2 5742.6 5763.2 5516.0 5516.4 5519.2 5531.5 5536.5 5344.8 5382.3 5390.0 5449.4 5456.9 5485.6 5493.7 5535.0 5617.6 5619.5 5594.3 5604.8 5620.1 5621.6 5639.1 4338.7 4343.3 4344.3 4348.8 4390.6 3782.6 3853.8 3878.6 3881.4 3931.1 5222.9 5243.2 5255.3 5286.0 5311.7 5478.8 5495.1 5497.5 5501.1 5511.8 5120.1 5203.1 5216.4 5229.0 5268.8 4695.1 4729.7 4736.6 4747.9 4775.8 5799.8 5841.0 5841.5 5841.7 5895.3 5619.6 5626.8 5634.2 5635.5 5641.4 5572.8 5616.5 5720.7 5760.9 5832.7 5485.2 5491.1 5492.7 5538.3 5551.8 5529.3 5531.4 5585.0 5585.2 5600.0 5304.4 5347.8 5353.2 5453.4 5525.8 5379.7 5387.1 5389.6 5389.9 5395.2 5376.5 5377.3 5384.9 5387.8 5388.6 5423.2 5438.9 5443.4 5445.2 5446.2 5265.6 5373.2 5374.1 5437.2 5438.3 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | [#1] ext.html Cycles:180 Average:54781.94 Median:36209.96 stddev:106316.88 (293.6%) stddev-sans-first:106537.32 15:54:48 INFO - PROCESS | 17286 | Values: 607.6 631.5 635.2 646.4 649.1 31622.5 42211.6 43394.8 43416.3 47151.8 44229.1 44496.3 44614.8 44650.0 44675.8 8829.4 8979.2 8992.4 9001.0 9002.1 7991.8 8114.3 10472.9 10702.6 10703.6 10925.2 10954.3 10980.5 10995.5 11027.2 10706.7 10744.9 10841.7 10842.1 10842.2 10560.0 10608.2 10637.7 10648.4 10655.4 41756.8 42100.6 42151.0 42164.6 42187.0 3356.2 3448.3 3647.7 3688.2 3750.4 30617.8 30801.4 31405.1 31533.8 32260.0 4001.8 4012.1 4136.2 4262.4 4263.5 319985.0 321359.0 323068.0 323814.0 324687.0 33514.8 52053.7 52115.7 52116.7 52185.7 34021.0 36094.8 36224.5 36484.0 36504.8 12971.7 13069.2 13076.7 13081.2 13082.4 9809.0 10103.9 10881.5 10961.5 10968.8 7946.8 8188.7 8227.8 8282.0 8358.8 3135.5 3192.0 3193.8 3214.9 3231.8 923.8 977.9 1029.0 1029.4 1121.6 30562.4 31324.2 31495.2 31612.8 31683.7 1062.6 1076.4 1083.3 1123.4 1128.9 15931.3 16872.7 16921.2 16930.8 17161.1 477354.0 481929.0 482097.0 482246.0 482671.0 57825.0 58100.7 58106.0 58125.4 58189.4 1181.7 1211.7 1220.6 1247.1 1265.4 28252.3 31560.4 31775.4 32244.4 32591.7 47350.8 47790.3 47928.5 47947.8 47957.3 381701.0 384772.0 384787.0 386026.0 388238.0 26381.9 26885.0 27080.7 27086.2 28870.0 45616.3 45918.8 46202.3 46269.0 47506.8 38786.8 39279.4 39498.0 40676.0 41429.4 39048.0 39196.0 39606.8 40268.4 41529.0 39267.6 40104.2 41176.8 41302.4 41314.8 32495.0 35151.3 35530.5 36055.8 36195.5 27044.0 27284.6 27484.0 27564.9 27754.7 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | [#2] jquery.html Cycles:180 Average:27008.95 Median:3064.41 stddev:70731.48 (2308.2%) stddev-sans-first:70901.62 15:54:48 INFO - PROCESS | 17286 | Values: 367.5 384.1 385.9 392.6 404.8 14133.0 18087.2 19415.0 19809.8 19988.3 17255.8 17366.2 17421.7 17716.8 17774.1 5647.6 5939.8 5942.6 5943.9 5946.7 4143.1 4350.1 4428.2 5832.5 5868.2 6652.9 6658.6 6663.1 6666.2 6667.0 6380.5 6463.8 6497.9 6498.2 6636.6 5634.6 5737.1 5746.3 5754.3 5756.7 22633.1 22829.4 22843.9 23032.8 23156.8 2274.4 2447.5 2729.9 3054.7 3074.2 14391.6 14480.9 14528.8 14557.3 15155.8 1888.3 1901.5 1969.5 1978.9 1998.9 77417.6 77725.8 79043.6 79237.6 80675.0 10208.8 10267.1 10417.5 10696.3 10793.4 15030.2 15053.6 15057.5 15060.4 15067.7 7388.3 7788.9 7834.5 8039.5 8070.6 7454.5 7505.2 7545.2 7718.8 7743.6 6368.4 6404.6 6436.3 6436.9 6631.4 1827.3 1886.4 1895.9 1913.8 1921.7 862.9 863.4 897.3 960.5 1028.7 18527.5 18821.3 19174.6 19891.0 19925.2 927.6 962.6 980.2 1011.3 1061.8 10647.7 11365.8 11429.7 11444.8 11453.7 417801.0 422724.0 425838.0 435983.0 439481.0 81794.6 83649.6 83652.0 83809.0 84835.0 1022.5 1041.1 1051.0 1054.6 1069.7 16894.5 17277.3 17881.5 17893.6 17937.6 40196.8 40748.4 40941.8 41042.6 43628.6 54760.2 55585.0 56648.9 57251.7 57633.1 7769.8 8135.6 8362.7 8406.4 8589.5 12252.0 13271.7 13283.3 13583.8 13601.6 11427.4 11643.4 11647.0 11816.8 11929.9 10847.2 11116.8 11152.8 11474.0 11514.5 10955.7 11396.9 11494.9 11606.6 11921.5 8106.4 8156.6 8229.5 8418.1 8504.7 9834.9 11292.8 11810.4 11902.6 11936.9 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | [#3] mootools.html Cycles:180 Average:5966.00 Median:2485.18 stddev:3479.05 (140.0%) stddev-sans-first:3472.17 15:54:48 INFO - PROCESS | 17286 | Values: 1437.7 1468.1 1577.7 1744.0 1762.3 8755.9 9396.2 9401.4 9402.2 9406.4 8042.8 8348.4 8804.6 9128.2 9242.4 2259.2 2278.2 2311.9 2319.2 2329.0 2271.6 2282.5 2337.9 2344.1 2349.7 2307.5 2322.3 2326.3 2338.5 2343.2 2206.4 2242.6 2242.6 2244.5 2251.8 2230.5 2233.3 2233.4 2237.5 2241.5 9210.7 9292.5 9325.5 9340.7 9352.6 5287.6 5432.7 5436.7 5442.3 5445.8 3351.7 3435.3 3552.3 3571.4 3584.6 1135.6 1153.7 2154.5 2226.8 2264.6 12899.7 13040.0 13091.4 13117.7 13125.2 4461.3 4517.0 4675.3 4688.4 4690.5 10134.6 10148.9 10172.2 10174.8 10205.5 5263.7 5272.6 5275.6 5282.8 5283.7 4407.5 4554.0 4917.5 4917.6 5040.2 3729.6 3761.6 3822.9 3877.8 3892.2 1131.6 1133.2 1147.8 1151.9 1175.5 927.7 941.7 942.7 957.8 977.6 5885.8 6006.2 6052.3 6085.1 6288.3 441.8 450.5 450.7 453.4 460.9 3964.8 3968.4 4027.5 4101.6 4114.3 11042.9 11348.0 11463.8 11466.9 11475.9 11318.1 11325.4 11331.7 11367.0 11391.6 7985.2 8381.1 8449.2 8460.3 8464.9 6066.1 6086.1 6284.7 6301.6 6307.5 10717.5 10729.7 10761.7 10765.9 10965.2 10153.3 10548.4 10578.4 10784.7 10934.0 7757.3 8078.6 8427.5 8668.9 8855.7 8556.2 9067.7 9087.8 9087.9 9090.1 7641.2 7800.0 7808.6 7854.5 8066.2 7661.7 7681.1 7857.6 7879.2 7897.3 7225.3 7351.9 7352.7 7353.5 7359.7 4999.2 5139.2 5141.6 5321.6 5388.2 5179.4 5250.3 5255.2 5287.0 5510.4 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | [#4] prototype.html Cycles:180 Average:4609.39 Median:5201.20 stddev:1390.98 (26.7%) stddev-sans-first:1356.78 15:54:48 INFO - PROCESS | 17286 | Values: 301.4 306.2 310.3 315.8 320.7 5083.8 5284.6 5338.9 5401.8 5413.1 5169.5 5277.3 5285.8 5343.3 5348.9 4168.4 4188.4 4206.1 4207.8 4211.8 3885.6 4024.3 4113.7 4157.8 4202.9 4023.2 4036.1 4042.7 4056.2 4073.6 4033.8 4034.1 4047.5 4048.1 4065.3 3523.9 3531.9 3532.9 3535.6 3535.8 5021.7 5110.7 5126.9 5130.7 5232.9 4605.7 4611.4 4620.6 4622.8 4635.1 5517.3 5522.3 5526.8 5532.0 5534.9 3784.9 3852.0 3853.4 3868.6 3884.6 5687.5 5698.8 5701.4 5708.3 5745.2 3934.5 3996.2 3999.3 3999.8 4001.1 3788.7 3956.8 3994.3 4021.0 4028.5 4555.8 4590.4 4597.7 4598.1 4607.7 5521.3 5539.6 5563.2 5569.2 5600.2 1291.2 1309.5 1326.3 1344.4 1363.3 845.8 862.9 876.7 878.6 887.8 4729.2 4737.5 4752.0 4754.9 4793.3 4967.7 4987.9 4990.0 4994.9 5025.8 4710.2 4719.2 4721.3 4724.6 4753.5 2818.5 3012.5 3032.5 3060.3 3060.4 5928.2 5949.6 5964.0 5966.9 5973.9 5530.8 5830.7 5853.4 5879.7 5913.0 5921.3 5926.8 5953.8 5959.8 5980.7 5554.4 5793.2 5806.8 5853.4 5861.2 5659.9 5665.7 5677.9 5693.3 5703.6 5937.6 5967.9 5977.6 6046.3 6049.8 3948.4 4005.7 4008.9 4021.9 4037.5 5428.2 5717.6 5727.0 5732.7 5738.7 5452.8 5454.9 5605.9 5613.8 5649.5 5550.2 5606.8 5607.6 5608.4 5632.2 5276.8 5485.9 5489.5 5523.9 5612.4 5565.5 5575.0 5587.2 5589.8 5598.9 5483.0 5493.7 5504.4 5521.9 5530.6 15:54:48 INFO - PROCESS | 17286 | 15:54:48 INFO - PROCESS | 17286 | [#5] yui.html Cycles:180 Average:20767.37 Median:4763.31 stddev:29898.76 (627.7%) stddev-sans-first:29944.55 15:54:48 INFO - PROCESS | 17286 | Values: 671.1 700.6 714.0 726.5 735.1 15009.8 16018.8 16558.8 16607.8 16641.5 15240.3 15321.1 15345.2 15351.8 15373.6 815.1 831.2 833.3 834.1 834.3 675.2 703.1 776.7 823.3 828.7 877.8 878.0 878.3 881.2 885.0 865.1 865.2 875.0 875.7 876.2 510.2 532.6 533.0 535.8 602.3 13546.9 14091.6 14133.6 14133.8 14156.2 13830.2 14203.6 14251.9 14359.7 14425.3 12524.9 12560.2 12601.6 12701.3 12701.4 4258.7 4312.4 4385.0 4386.2 4449.4 70768.6 75286.0 80096.6 80249.2 80717.0 11538.5 12144.3 12246.1 12304.3 12660.8 23306.7 23658.0 23659.8 23667.5 23680.5 8803.6 9103.4 9323.6 9369.7 9547.9 4712.9 4765.5 4784.8 4884.2 4894.4 3634.1 3718.8 3750.3 3753.9 3764.7 622.9 636.1 640.2 643.9 655.8 704.2 719.4 741.0 752.2 755.7 8789.6 9501.6 9502.8 9654.6 10086.3 740.9 744.0 745.5 749.9 751.9 4223.9 4739.1 4761.1 4821.8 4912.2 79986.6 117254.4 118553.0 119832.0 124447.4 60464.1 63125.7 78407.6 102476.0 104066.0 92092.0 94715.0 95637.7 97386.5 98223.0 8807.6 8894.3 9090.6 9113.6 9161.4 53912.5 53986.0 54455.7 54575.5 54764.7 75887.0 79520.0 80512.0 81694.6 82670.0 11843.2 12608.1 12611.2 12775.2 12862.6 13325.2 13641.5 13981.3 14222.6 14468.9 12250.8 12643.8 12824.0 12996.2 13565.9 12345.0 12512.5 12691.1 13408.1 13422.6 12272.3 12473.2 12478.9 12576.9 12692.6 10185.6 10604.4 10678.2 10780.2 11009.1 10891.3 10900.2 10993.6 11007.6 11021.0 15:54:48 INFO - PROCESS | 17286 | -------- Summary: end -------- 15:54:48 INFO - PROCESS | 17286 | 15:54:49 INFO - TEST-INFO | 17286: exit 0 15:54:49 INFO - TEST-OK | dromaeo_css | took 1117996ms 15:54:49 INFO - TEST-START | kraken 15:54:49 INFO - operating with platform_type : linux_ 15:54:49 INFO - Initialising browser for kraken test... 15:54:49 INFO - TEST-INFO | started process 17597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKogj8d/profile http://localhost:33809/getInfo.html) 15:54:53 INFO - PROCESS | 17597 | __metrics Screen width/height:1600/1200 15:54:53 INFO - PROCESS | 17597 | colorDepth:24 15:54:53 INFO - PROCESS | 17597 | Browser inner width/height: 1024/697 15:54:53 INFO - PROCESS | 17597 | __metrics 15:54:53 INFO - PROCESS | 17597 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:54:53 INFO - PROCESS | 17597 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:54 INFO - TEST-INFO | 17597: exit 0 15:54:54 INFO - Browser initialized. 15:54:54 INFO - Running cycle 1/1 for kraken test... 15:54:54 INFO - TEST-INFO | started process 17680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKogj8d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:07 INFO - PROCESS | 17680 | RSS: Main: 171339776 15:55:07 INFO - PROCESS | 17680 | 15:55:09 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33809/tests/kraken/driver.html?testName=audio-beat-detection) 15:55:10 INFO - PROCESS | 17680 | RSS: Main: 229289984 15:55:10 INFO - PROCESS | 17680 | 15:55:13 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33809/tests/kraken/driver.html?testName=audio-dft) 15:55:13 INFO - PROCESS | 17680 | RSS: Main: 215576576 15:55:13 INFO - PROCESS | 17680 | 15:55:16 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33809/tests/kraken/driver.html?testName=audio-fft) 15:55:17 INFO - PROCESS | 17680 | RSS: Main: 297054208 15:55:17 INFO - PROCESS | 17680 | 15:55:19 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33809/tests/kraken/driver.html?testName=audio-oscillator) 15:55:20 INFO - PROCESS | 17680 | RSS: Main: 206241792 15:55:20 INFO - PROCESS | 17680 | 15:55:22 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:55:22 INFO - PROCESS | 17680 | RSS: Main: 210800640 15:55:22 INFO - PROCESS | 17680 | 15:55:25 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33809/tests/kraken/driver.html?testName=imaging-darkroom) 15:55:26 INFO - PROCESS | 17680 | RSS: Main: 247816192 15:55:26 INFO - PROCESS | 17680 | 15:55:29 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33809/tests/kraken/driver.html?testName=imaging-desaturate) 15:55:30 INFO - PROCESS | 17680 | RSS: Main: 246317056 15:55:30 INFO - PROCESS | 17680 | 15:55:33 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33809/tests/kraken/driver.html?testName=json-parse-financial) 15:55:33 INFO - PROCESS | 17680 | RSS: Main: 246411264 15:55:33 INFO - PROCESS | 17680 | 15:55:35 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:55:35 INFO - PROCESS | 17680 | RSS: Main: 208588800 15:55:35 INFO - PROCESS | 17680 | 15:55:37 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:55:38 INFO - PROCESS | 17680 | RSS: Main: 216481792 15:55:38 INFO - PROCESS | 17680 | 15:55:40 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:55:40 INFO - PROCESS | 17680 | RSS: Main: 225243136 15:55:40 INFO - PROCESS | 17680 | 15:55:43 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:55:44 INFO - PROCESS | 17680 | RSS: Main: 233562112 15:55:44 INFO - PROCESS | 17680 | 15:55:46 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:55:47 INFO - PROCESS | 17680 | RSS: Main: 231227392 15:55:47 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | Cycle 1(1): loaded http://localhost:33809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33809/tests/kraken/driver.html?testName=ai-astar) 15:55:49 INFO - PROCESS | 17680 | RSS: Main: 281923584 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | __start_tp_report 15:55:49 INFO - PROCESS | 17680 | _x_x_mozilla_page_load 15:55:49 INFO - PROCESS | 17680 | _x_x_mozilla_page_load_details 15:55:49 INFO - PROCESS | 17680 | |i|pagename|runs| 15:55:49 INFO - PROCESS | 17680 | |0;ai-astar;101;110;111;111;113;110;110;112;109;112 15:55:49 INFO - PROCESS | 17680 | |1;audio-beat-detection;151;127;122;173;132;125;123;121;153;128 15:55:49 INFO - PROCESS | 17680 | |2;audio-dft;162;162;164;162;162;163;162;162;161;162 15:55:49 INFO - PROCESS | 17680 | |3;audio-fft;75;76;75;122;76;76;76;77;102;77 15:55:49 INFO - PROCESS | 17680 | |4;audio-oscillator;83;83;108;84;84;84;104;83;83;113 15:55:49 INFO - PROCESS | 17680 | |5;imaging-gaussian-blur;117;116;116;116;117;117;116;117;116;116 15:55:49 INFO - PROCESS | 17680 | |6;imaging-darkroom;146;146;147;145;145;145;145;145;145;145 15:55:49 INFO - PROCESS | 17680 | |7;imaging-desaturate;86;85;85;87;86;85;85;85;84;85 15:55:49 INFO - PROCESS | 17680 | |8;json-parse-financial;51;50;50;51;51;52;52;53;53;52 15:55:49 INFO - PROCESS | 17680 | |9;json-stringify-tinderbox;59;59;60;59;59;59;59;59;60;60 15:55:49 INFO - PROCESS | 17680 | |10;stanford-crypto-aes;81;80;79;79;79;82;81;82;86;80 15:55:49 INFO - PROCESS | 17680 | |11;stanford-crypto-ccm;140;133;131;135;128;133;142;136;168;127 15:55:49 INFO - PROCESS | 17680 | |12;stanford-crypto-pbkdf2;169;166;164;162;164;162;163;162;163;162 15:55:49 INFO - PROCESS | 17680 | |13;stanford-crypto-sha256-iterative;67;64;66;70;65;66;65;65;64;64 15:55:49 INFO - PROCESS | 17680 | __end_tp_report 15:55:49 INFO - PROCESS | 17680 | __start_cc_report 15:55:49 INFO - PROCESS | 17680 | _x_x_mozilla_cycle_collect,1673 15:55:49 INFO - PROCESS | 17680 | __end_cc_report 15:55:49 INFO - PROCESS | 17680 | __startTimestamp1476485749313__endTimestamp 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | ------- Summary: start ------- 15:55:49 INFO - PROCESS | 17680 | Number of tests: 14 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:1.27 15:55:49 INFO - PROCESS | 17680 | Values: 101.0 110.0 111.0 111.0 113.0 110.0 110.0 112.0 109.0 112.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:130.00 stddev:17.49 (13.5%) stddev-sans-first:17.63 15:55:49 INFO - PROCESS | 17680 | Values: 151.0 127.0 122.0 173.0 132.0 125.0 123.0 121.0 153.0 128.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 15:55:49 INFO - PROCESS | 17680 | Values: 162.0 162.0 164.0 162.0 162.0 163.0 162.0 162.0 161.0 162.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:15.91 (20.9%) stddev-sans-first:16.59 15:55:49 INFO - PROCESS | 17680 | Values: 75.0 76.0 75.0 122.0 76.0 76.0 76.0 77.0 102.0 77.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:12.22 (14.7%) stddev-sans-first:12.63 15:55:49 INFO - PROCESS | 17680 | Values: 83.0 83.0 108.0 84.0 84.0 84.0 104.0 83.0 83.0 113.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:55:49 INFO - PROCESS | 17680 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 15:55:49 INFO - PROCESS | 17680 | Values: 146.0 146.0 147.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 15:55:49 INFO - PROCESS | 17680 | Values: 86.0 85.0 85.0 87.0 86.0 85.0 85.0 85.0 84.0 85.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.08 (2.1%) stddev-sans-first:1.13 15:55:49 INFO - PROCESS | 17680 | Values: 51.0 50.0 50.0 51.0 51.0 52.0 52.0 53.0 53.0 52.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 15:55:49 INFO - PROCESS | 17680 | Values: 59.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 60.0 60.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:2.13 (2.6%) stddev-sans-first:2.26 15:55:49 INFO - PROCESS | 17680 | Values: 81.0 80.0 79.0 79.0 79.0 82.0 81.0 82.0 86.0 80.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:135.50 stddev:11.78 (8.7%) stddev-sans-first:12.45 15:55:49 INFO - PROCESS | 17680 | Values: 140.0 133.0 131.0 135.0 128.0 133.0 142.0 136.0 168.0 127.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:1.36 15:55:49 INFO - PROCESS | 17680 | Values: 169.0 166.0 164.0 162.0 164.0 162.0 163.0 162.0 163.0 162.0 15:55:49 INFO - PROCESS | 17680 | 15:55:49 INFO - PROCESS | 17680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:1.84 (2.8%) stddev-sans-first:1.88 15:55:49 INFO - PROCESS | 17680 | Values: 67.0 64.0 66.0 70.0 65.0 66.0 65.0 65.0 64.0 64.0 15:55:49 INFO - PROCESS | 17680 | -------- Summary: end -------- 15:55:49 INFO - PROCESS | 17680 | 15:55:50 INFO - TEST-INFO | 17680: exit 0 15:55:50 INFO - TEST-OK | kraken | took 61136ms 15:55:50 INFO - SUITE-END | took 1179s 15:55:50 INFO - Completed test suite (00:19:39) 15:55:50 INFO - javascript benchmark 15:55:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2964.377480729047, 2990.147807874756, 3016.592759977403, 3026.4249792539417, 3033.84830758462, 5153.30430391897, 5160.845174644757, 5204.115300398932, 5227.555657769085, 5315.893682126355, 5208.114620514512, 5219.112750832358, 5308.336457942757, 5324.0, 5350.170723537848, 4742.715437073769, 4747.287906813988, 4795.496472870351, 4803.879903002436, 4820.542048505404, 4892.168331383673, 4924.359833221694, 4976.3530741003615, 4980.2529620557025, 5040.2439634055, 4717.976410117962, 4753.524647535253, 4859.635527335428, 4893.143699852511, 4917.975410122962, 4770.1175282572485, 4794.3287939688125, 4797.4482934462285, 4817.397825271841, 4863.19757240055, 4771.379720636295, 4787.13831510328, 4789.2816077588295, 4798.616110711135, 4832.9275060874115, 5191.662541934762, 5241.266222728821, 5247.580193584504, 5259.789608415659, 5292.761825717852, 5520.861978450531, 5564.276644036249, 5567.805126820542, 5606.187102870061, 5643.633163844378, 5638.830835074954, 5661.037623603997, 5661.8584535386535, 5662.17898404729, 5669.0, 5273.86815329616, 5297.947020529784, 5319.2287118368, 5370.597205209625, 5375.838724838261, 5667.376588575254, 5680.062789639664, 5734.16854556087, 5742.59801813869, 5763.221965034751, 5515.972420137874, 5516.365617953907, 5519.227308176858, 5531.529819965348, 5536.474034966753, 5344.839654810362, 5382.273393091961, 5390.0, 5449.427810079964, 5456.863578410492, 5485.61600687956, 5493.697846618395, 5534.972325138348, 5617.578681598897, 5619.522340601013, 5594.300712410949, 5604.775808967677, 5620.072688006515, 5621.634593751475, 5639.0977443609645, 4338.696291259582, 4343.305071188594, 4344.3483477478, 4348.760818155032, 4390.648748100144, 3782.6406491383273, 3853.845846166178, 3878.5927477614446, 3881.3983832506005, 3931.1351502669368, 5222.92165617516, 5243.213517972258, 5255.343082114736, 5286.0, 5311.681299122065, 5478.780848766084, 5495.093309603871, 5497.47773961473, 5501.092319767194, 5511.807086751945, 5120.1039818031695, 5203.089459344676, 5216.40011398694, 5229.006488767122, 5268.78924843002, 4695.060987802453, 4729.69256998294, 4736.644751643572, 4747.905041899143, 4775.761211939459, 5799.82600521985, 5841.036229022164, 5841.532677385884, 5841.678707671119, 5895.322037965603, 5619.606627536034, 5626.774929002794, 5634.154876768517, 5635.520980716685, 5641.37944826077, 5572.804951826666, 5616.466435688603, 5720.6853623049465, 5760.855978600569, 5832.708364581838, 5485.232067510472, 5491.148871924858, 5492.670439773627, 5538.335399752055, 5551.805686800943, 5529.281193444987, 5531.363893152178, 5584.972075139598, 5585.162225666182, 5600.0, 5304.389995150453, 5347.812826551052, 5353.223782551586, 5453.382376459401, 5525.834224973257, 5379.731013449234, 5387.084195686664, 5389.622726409114, 5389.865253368697, 5395.217693434509, 5376.462353764592, 5377.300950876517, 5384.946150538602, 5387.811426600207, 5388.595855310789, 5423.186522021729, 5438.945610543844, 5443.4284400138995, 5445.1832225166545, 5446.237526746179, 5265.578753699771, 5373.167159090347, 5374.11327131019, 5437.157240627709, 5438.265834112344], "value": 5158.067819748342, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.6141650052217, 631.5484428633528, 635.1996484429617, 646.4472875691284, 649.0750680280602, 31622.525662115087, 42211.57788422115, 43394.78302608483, 43416.348754768704, 47151.76424117883, 44229.115417691624, 44496.33255501162, 44614.77692611532, 44650.0, 44675.77662111685, 8829.426087304337, 8979.191872731453, 8992.415492992966, 9000.954995225014, 9002.144796244347, 7991.840163196733, 8114.269715725583, 10472.895271047306, 10702.625408110718, 10703.571857125706, 10925.180611454132, 10954.34273943562, 10980.450977451135, 10995.505202265877, 11027.17296202784, 10706.678799636024, 10744.892551074467, 10841.67474975752, 10842.078423334026, 10842.241043126905, 10560.0, 10608.15134789215, 10637.73405664857, 10648.41433721145, 10655.360678359246, 41756.79121604403, 42100.57899420997, 42151.0, 42164.57835421637, 42187.0, 3356.1777364545596, 3448.2758620689683, 3647.6534729200685, 3688.2070354873563, 3750.362438385481, 30617.846910765526, 30801.38397232043, 31405.057848264587, 31533.84233078843, 32260.0, 4001.799910004488, 4012.137390461036, 4136.21411931732, 4262.403263543107, 4263.509696384925, 319985.0, 321359.0, 323068.0, 323814.0, 324687.0, 33514.83242583772, 52053.7397313011, 52115.73942130265, 52116.73941630343, 52185.7390713044, 34021.0, 36094.8195259022, 36224.45663315053, 36484.0, 36504.81747591298, 12971.740565188644, 13069.215847049018, 13076.738465230643, 13081.215127092404, 13082.411291491906, 9809.0, 10103.949480252699, 10881.455927203608, 10961.506732197071, 10968.835467467994, 7946.841063178704, 8188.713395031145, 8227.794305142299, 8281.95859020701, 8358.791030224293, 3135.4669706150007, 3192.0049968769517, 3193.824339661341, 3214.9196270093435, 3231.773775835669, 923.8175135826153, 977.8973207813077, 1028.9691309260734, 1029.351508549624, 1121.6354684727332, 30562.388752225277, 31324.216894577818, 31495.21261968469, 31612.841935790635, 31683.683163168535, 1062.559037999237, 1076.364944682641, 1083.3499900060058, 1123.4326665034268, 1128.8814674459063, 15931.283092260875, 16872.662546748998, 16921.153942302837, 16930.830691693172, 17161.141942902806, 477354.0, 481929.0, 482097.0, 482246.0, 482671.0, 57825.0, 58100.70949645225, 58106.0, 58125.418745812, 58189.4181058184, 1181.6514128332162, 1211.6789050901518, 1220.5972029230154, 1247.1020864977202, 1265.3736400481637, 28252.293692657848, 31560.368792623558, 31775.36449271048, 32244.35511289808, 32591.674083258862, 47350.763246183546, 47790.283145752146, 47928.52071479241, 47947.76026119847, 47957.280640789715, 381701.0, 384772.0, 384787.0, 386026.0, 388238.0, 26381.868090659424, 26885.0, 27080.729192707822, 27086.1874143776, 28870.0, 45616.31575526304, 45918.770406147756, 46202.306965396216, 46269.0, 47506.76246618745, 38786.80606596949, 39279.41080883732, 39498.0, 40675.98310042272, 41429.378559322235, 39048.0, 39196.0, 39606.80196598999, 40268.39597405983, 41529.0, 39267.607323927536, 40104.19791604093, 41176.794116029225, 41302.38046429246, 41314.79342603268, 32495.0, 35151.29697406089, 35530.46704299489, 36055.81972090123, 36195.45706814347, 27044.0, 27284.590731139448, 27483.997981322267, 27564.862175689796, 27754.722452775215], "value": 18547.85320898255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.4818505906672, 384.12802937332236, 385.9015950932513, 392.59954846057025, 404.7611908973705, 14132.999999999987, 18087.18607662655, 19414.99999999998, 19809.801901980976, 19988.300409485633, 17255.827441725578, 17366.218520166592, 17421.738673919903, 17716.82283177168, 17774.11129443529, 5647.632903861257, 5939.821805345847, 5942.6434413935085, 5943.910841337383, 5946.70266486674, 4143.129942712034, 4350.108227813291, 4428.180786554498, 5832.533397328203, 5868.2371291732015, 6652.933470665304, 6658.633775142365, 6663.133792606955, 6666.166729158856, 6667.033280174372, 6380.489560835122, 6463.838404039913, 6497.9350206498275, 6498.1552398188405, 6636.568623039487, 5634.605577609569, 5737.08206686928, 5746.25298711169, 5754.280714910637, 5756.683382413966, 22633.09467621293, 22829.42926426836, 22843.885780571156, 23032.7696723034, 23156.768432315628, 2274.40865375002, 2447.547203767309, 2729.863506824651, 3054.6639869614323, 3074.1546074829375, 14391.640208994755, 14480.855191448056, 14528.782068268985, 14557.272136393138, 15155.848441515554, 1888.3202047262973, 1901.496103532565, 1969.4780883065998, 1978.8713733607412, 1998.9300374486968, 77417.61291193565, 77725.83411248893, 79043.60478197572, 79237.60381198114, 80675.0, 10208.846867296996, 10267.071805533236, 10417.479126043667, 10696.304740192018, 10793.352398856094, 15030.17334046638, 15053.623659408602, 15057.54827355181, 15060.397584096732, 15067.698646027018, 7388.261173882569, 7788.870613760973, 7834.529928204326, 8039.5176289422825, 8070.636821343053, 7454.515456495311, 7505.211952744992, 7545.245475452521, 7718.768436946901, 7743.612819359009, 6368.382320256427, 6404.615723056631, 6436.324185960407, 6436.871262574816, 6631.403173714389, 1827.269092363039, 1886.4434991677488, 1895.9146838392305, 1913.7607799025122, 1921.7344476135568, 862.8533149364623, 863.4171933944563, 897.264243320484, 960.4957397366438, 1028.681108856257, 18527.53681157955, 18821.341253056078, 19174.64443722343, 19891.0, 19925.20299188045, 927.6289484206236, 962.6438217859297, 980.2109302011949, 1011.3173607814696, 1061.8035663402295, 10647.6563042982, 11365.829512557319, 11429.714257143638, 11444.771104577861, 11453.656390308304, 417801.0, 422724.0, 425838.0, 435983.0, 439481.0, 81794.59102704449, 83649.58175209085, 83652.0, 83809.0, 84835.0, 1022.4632068164274, 1041.0786453988123, 1050.9579616815395, 1054.6097943760858, 1069.7379142110387, 16894.49316520506, 17277.308907643554, 17881.46355609334, 17893.642127157123, 17937.64124717472, 40196.799016004734, 40748.38877416782, 40941.79529102335, 41042.58957410507, 43628.56371436372, 54760.17859732187, 55585.0, 56648.86702266014, 57251.71374143269, 57633.135502968325, 7769.820078356908, 8135.633896474555, 8362.707305244287, 8406.369522285731, 8589.484630922165, 12252.0, 13271.734565308832, 13283.269420181983, 13583.796243056164, 13601.591952241448, 11427.371494567878, 11643.41782910834, 11647.0, 11816.76366472683, 11929.940350298193, 10847.240693151403, 11116.833247501132, 11152.776944461228, 11474.0, 11514.481848316678, 10955.726106847393, 11396.94301528487, 11494.94252528732, 11606.593769218036, 11921.46353414081, 8106.432549721699, 8156.592170391338, 8229.46508476947, 8418.148007438354, 8504.702335418231, 9834.901650983686, 11292.830607540729, 11810.40947952616, 11902.583409580624, 11936.940315298369], "value": 9276.31792591129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.7052704195642, 1468.1264647534717, 1577.7081239970607, 1744.0, 1762.3391228289393, 8755.912440875598, 9396.154346108857, 9401.388909720872, 9402.153806157445, 9406.388584741988, 8042.798930026752, 8348.41561090724, 8804.559772011406, 9128.224100951411, 9242.445453272792, 2259.209276753136, 2278.2026290798253, 2311.919082832101, 2319.1535089692225, 2328.988355058222, 2271.6478945763433, 2282.5092605089903, 2337.8947947342326, 2344.120954642009, 2349.729781075181, 2307.492351682627, 2322.291701031185, 2326.2904814031713, 2338.4855331827057, 2343.1915988983774, 2206.415299945516, 2242.5963326601286, 2242.618754811686, 2244.483768733184, 2251.763564825694, 2230.542738738555, 2233.3188377544843, 2233.4416395901026, 2237.485378362969, 2241.529278851443, 9210.723678289662, 9292.488913109777, 9325.487098209596, 9340.71977840666, 9352.579133938922, 5287.629865909388, 5432.728363581805, 5436.728163591804, 5442.265294185274, 5445.782168713246, 3351.748618853596, 3435.2957643682985, 3552.307300076486, 3571.39286321326, 3584.605693373727, 1135.6309199510192, 1153.7115721069733, 2154.4613846538364, 2226.8441209115367, 2264.6489794081945, 12899.742005159844, 13040.0, 13091.41088651013, 13117.737645247042, 13125.2124872507, 4461.286194208911, 4517.0, 4675.322078298627, 4688.4373875134515, 4690.530946905282, 10134.594616215416, 10148.898511014942, 10172.237082218864, 10174.796504069876, 10205.540750666238, 5263.6841789492755, 5272.630915835932, 5275.57795376369, 5282.7622756976025, 5283.656562323514, 4407.537208593116, 4554.020885509632, 4917.459079501252, 4917.58200552957, 5040.168372218543, 3729.6083911189476, 3761.567419746709, 3822.885313440546, 3877.8254978526033, 3892.241013002494, 1131.5643477261149, 1133.2350663302238, 1147.8278258261328, 1151.948162332697, 1175.518037604578, 927.6614035876856, 941.7363138321281, 942.7454587261401, 957.7844984878486, 977.5649835823133, 5885.823425297248, 6006.189164462829, 6052.334243233241, 6085.117657939574, 6288.276848162428, 441.7989814634334, 450.47519639619475, 450.65975188732295, 453.3584977257144, 460.8548307283262, 3964.801759911993, 3968.404739289072, 4027.476428064333, 4101.610347017028, 4114.341705327133, 11042.889571104346, 11348.0, 11463.828042579367, 11466.885331146581, 11475.942620286845, 11318.094552435785, 11325.433728313552, 11331.716707082389, 11367.0, 11391.601293954673, 7985.161558036322, 8381.119982401882, 8449.197326253996, 8460.323174146053, 8464.941882264717, 6066.120412540069, 6086.113304875503, 6284.74861005573, 6301.590396624205, 6307.526935479766, 10717.464126793473, 10729.678109656723, 10761.677149685522, 10765.89234107649, 10965.177611678997, 10153.340032897839, 10548.367097974146, 10578.365298082139, 10784.730381740519, 10934.015938565568, 7757.301842834172, 8078.555679437687, 8427.494350338999, 8668.869966950375, 8855.73432797017, 8556.229939305493, 9067.682631108144, 9087.818243634958, 9087.909120908706, 9090.13643703847, 7641.197674244125, 7799.961000194962, 7808.648610812641, 7854.4894581851995, 8066.153053929487, 7661.731839385595, 7681.078270607562, 7857.646405911862, 7879.172686867796, 7897.328727058035, 7225.313595208447, 7351.926480735124, 7352.70589176427, 7353.522021068614, 7359.742409015659, 4999.200127979506, 5139.177731562932, 5141.5629671476845, 5321.600879933943, 5388.245645609696, 5179.378474583074, 5250.291210686509, 5255.211718242142, 5286.97356513215, 5510.366307874646], "value": 4671.7660377490365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.3505894796713, 306.1718052667533, 310.3219465467953, 315.7726436965384, 320.7065535035443, 5083.822066227683, 5284.630075894689, 5338.866528336789, 5401.756920938553, 5413.133898576229, 5169.508896654812, 5277.340332458442, 5285.788568457267, 5343.343563495319, 5348.946510534894, 4168.437260969776, 4188.434561334227, 4206.095689426773, 4207.810648520824, 4211.789410529476, 3885.630865067814, 4024.29574824406, 4113.732607380511, 4157.835805974332, 4202.873913782576, 4023.2355852387955, 4036.132231570212, 4042.7170098093147, 4056.1809542368064, 4073.6130067643526, 4033.838646454138, 4034.0519977805047, 4047.5345335286524, 4048.109415928491, 4065.308897487434, 3523.9119022024397, 3531.9293614127832, 3532.929341413183, 3535.6464353564693, 3535.7524973251884, 5021.698698078127, 5110.667806592597, 5126.871828204287, 5130.71781052042, 5232.895342093137, 4605.654575906787, 4611.4005179326805, 4620.561046700558, 4622.791974361162, 4635.142498637762, 5517.2551705519645, 5522.282103326542, 5526.806561770319, 5532.0, 5534.944650553523, 3784.924301513982, 3851.9807400963095, 3853.441251018615, 3868.6324799144036, 3884.6309600587897, 5687.488126068673, 5698.772049118031, 5701.372848986608, 5708.315002199721, 5745.1669507921115, 3934.5081864766903, 3996.160806230724, 3999.34010888206, 3999.8200080996426, 4001.099752555652, 3788.6969042476535, 3956.802159891994, 3994.2810294147334, 4021.0, 4028.4762980812307, 4555.794989225493, 4590.403247577793, 4597.747123908151, 4598.149342371672, 4607.746573938399, 5521.309836270466, 5539.639923405047, 5563.248961390242, 5569.248151499577, 5600.243967064475, 1291.2123604601186, 1309.5220244610648, 1326.2838067443665, 1344.361428321559, 1363.2570249214202, 845.7927807687033, 862.895493767978, 876.7194497760782, 878.613410099567, 887.8357503861806, 4729.243321068612, 4737.541594635935, 4751.960833291743, 4754.904901901942, 4793.257045158006, 4967.677100988424, 4987.850364489072, 4989.975050124726, 4994.925076123861, 5025.773840177201, 4710.24636058229, 4719.221328480831, 4721.291806229025, 4724.551167639069, 4753.47711751707, 2818.5490321548455, 3012.487877060905, 3032.5147976323683, 3060.342026464321, 3060.3726236121543, 5928.229330187048, 5949.583529152917, 5963.95838122552, 5966.850828729316, 5973.880522389615, 5530.7511161997, 5830.679312637761, 5853.385394533512, 5879.676617786063, 5912.970435147797, 5921.348651648315, 5926.762929482858, 5953.76184952597, 5959.791407300723, 5980.730867111078, 5554.389017208023, 5793.246877905845, 5806.82579522615, 5853.414658534112, 5861.208736820475, 5659.886802264014, 5665.688387138582, 5677.943220567741, 5693.345265294544, 5703.632992308146, 5937.614055086406, 5967.940320596912, 5977.562901331665, 6046.339610571335, 6049.848753781191, 3948.4274780156143, 4005.6995725320135, 4008.899777505586, 4021.8994525137105, 4037.454943582579, 5428.212909128233, 5717.599768016199, 5727.024176659046, 5732.656040637575, 5738.655680659173, 5452.836414907559, 5454.863628409322, 5605.943940560705, 5613.831585052455, 5649.519790817826, 5550.167474878801, 5606.794539174097, 5607.635503692247, 5608.383077861514, 5632.197696737005, 5276.788928442973, 5485.917711234414, 5489.451054894478, 5523.861903452445, 5612.4387561245185, 5565.526930210977, 5575.0, 5587.217789509553, 5589.80435684749, 5598.880223955307, 5483.0, 5493.725313734218, 5504.4495550444635, 5521.944780552143, 5530.55755539564], "value": 4155.753490354832, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.1040760584619, 700.6356694518851, 713.9892901606473, 726.505975936363, 735.0958321264844, 15009.774853377194, 16018.7597186042, 16558.83441165588, 16607.75088373674, 16641.500754977355, 15240.314185861664, 15321.08073515587, 15345.232738363093, 15351.846481535182, 15373.615659608515, 815.0708192660372, 831.2352635575285, 833.3000279764996, 834.1408349400127, 834.2575108153748, 675.2066322071571, 703.0894990986684, 776.6621519638975, 823.3495538524559, 828.7348048624442, 877.8332116897769, 877.9990810476063, 878.2798105553449, 881.184903963831, 885.0043700836559, 865.1002956924791, 865.2213008292524, 875.0068672057197, 875.6628697951271, 876.1720174435161, 510.19134671545646, 532.5553163108809, 533.0298856081932, 535.8017533512586, 602.3073465514649, 13546.864531354757, 14091.647708807363, 14133.575992720234, 14133.78799318011, 14156.150630962175, 13830.170189788645, 14203.573892783234, 14251.928740356232, 14359.712805743826, 14425.334044366466, 12524.937375313157, 12560.246385216917, 12601.558945436956, 12701.301428421433, 12701.428435720414, 4258.714406821916, 4312.396264522938, 4384.978075109636, 4386.210482113218, 4449.377087207794, 70768.6461567694, 75286.0, 80096.59951700263, 80249.19750802475, 80717.0, 11538.538458461735, 12144.271343719405, 12246.142770006014, 12304.323262220485, 12660.81008784869, 23306.65040024401, 23658.0, 23659.7634023661, 23667.526649467258, 23680.52638947246, 8803.647854085893, 9103.362764606547, 9323.580438880132, 9369.672061477815, 9547.856782148274, 4712.858614241578, 4765.4996225395835, 4784.760761961888, 4884.218525036048, 4894.388201474816, 3634.1459756957092, 3718.758280711745, 3750.343689854319, 3753.9061523461587, 3764.698824094066, 622.8941080016408, 636.1443858010967, 640.1677818835495, 643.8583511627435, 655.8229278094888, 704.1796307302038, 719.3741444942933, 740.9962950185322, 752.24023736027, 755.6788364944877, 8789.604467798965, 9501.619935202652, 9502.762430939143, 9654.613815447445, 10086.293959422917, 740.8555331710372, 744.0321390181024, 745.4893398022372, 749.8650242956211, 751.8796992481177, 4223.915521689611, 4739.146953548326, 4761.119192949315, 4821.783019764119, 4912.214045752662, 79986.60006700046, 117254.41183822494, 118553.0, 119832.0, 124447.37776311241, 60464.09303860446, 63125.684371577845, 78407.60796195983, 102476.0, 104066.0, 92092.0, 94715.0, 95637.69796832473, 97386.5130674342, 98223.0, 8807.603657835285, 8894.28845692356, 9090.636374544943, 9113.589888454902, 9161.358704890594, 53912.460875390745, 53986.01258767141, 54455.72772136114, 54575.45424545704, 54764.726176368866, 75887.0, 79520.0, 80512.0, 81694.59152704198, 82670.0, 11843.170978031456, 12608.117431780054, 12611.180273282207, 12775.169613975062, 12862.614121576367, 13325.200487970753, 13641.522546710818, 13981.300934953415, 14222.573322800332, 14468.85531144675, 12250.816237756262, 12643.810342844681, 12824.0, 12996.220226786423, 13565.86434135646, 12345.0, 12512.499500020262, 12691.101773065524, 13408.128471649312, 13422.597322080353, 12272.263664180178, 12473.189242699196, 12478.939290160075, 12576.937115314366, 12692.555760548337, 10185.643502477378, 10604.363738175734, 10678.229291210442, 10780.191485638452, 11009.119270458184, 10891.346519208555, 10900.236983411085, 10993.61522346714, 11007.61473348429, 11021.0], "value": 7561.226101049751, "unit": "score"}], "name": "dromaeo_css", "value": 7120.116940781768, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 111.0, 113.0, 110.0, 110.0, 112.0, 109.0, 112.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 122.0, 173.0, 132.0, 125.0, 123.0, 121.0, 153.0, 128.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 162.0, 162.0, 163.0, 162.0, 162.0, 161.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 122.0, 76.0, 76.0, 76.0, 77.0, 102.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 84.0, 84.0, 104.0, 83.0, 83.0, 113.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 87.0, 86.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 51.0, 51.0, 52.0, 52.0, 53.0, 53.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 79.0, 79.0, 82.0, 81.0, 82.0, 86.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 133.0, 131.0, 135.0, 128.0, 133.0, 142.0, 136.0, 168.0, 127.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 166.0, 164.0, 162.0, 164.0, 162.0, 163.0, 162.0, 163.0, 162.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 66.0, 70.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0], "value": 65.6, "unit": "score"}], "name": "kraken", "value": 1487.1, "alertThreshold": 2.0}]} 15:55:51 INFO - Return code: 0 15:55:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:55:51 INFO - # TBPL SUCCESS # 15:55:51 INFO - Running post-action listener: _resource_record_post_action 15:55:51 INFO - [mozharness: 2016-10-14 22:55:51.128497Z] Finished run-tests step (success) 15:55:51 INFO - Running post-run listener: _resource_record_post_run 15:55:51 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409751552; Read time: 24; Write time: 274244 15:55:51 INFO - TinderboxPrint: CPU usage
13.1% 15:55:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 15:55:51 INFO - TinderboxPrint: I/O write bytes / time
409,751,552 / 274,244 15:55:51 INFO - TinderboxPrint: CPU idle
8,301.7 (86.9%) 15:55:51 INFO - TinderboxPrint: CPU user
1,200.0 (12.6%) 15:55:51 INFO - TinderboxPrint: Swap in / out
0 / 0 15:55:51 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120938496; Read time: 0; Write time: 89976 15:55:51 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288813056; Read time: 0; Write time: 184268 15:55:51 INFO - Running post-run listener: _upload_blobber_files 15:55:51 INFO - Blob upload gear active. 15:55:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:55:51 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 15:55:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:55:52 INFO - (blobuploader) - INFO - Open directory for files ... 15:55:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:55:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:55:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:52 INFO - (blobuploader) - INFO - Done attempting. 15:55:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:55:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:55:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:56 INFO - (blobuploader) - INFO - Done attempting. 15:55:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:55:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:55:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:55:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:55:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:55:57 INFO - (blobuploader) - INFO - Done attempting. 15:55:57 INFO - (blobuploader) - INFO - Iteration through files over. 15:55:57 INFO - Return code: 0 15:55:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:55:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:55:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c93c34584aa119266e5c3acc9656178fffd09af13483ea6dba7eec99c67f0a8d1c5f1531b19b1b638588f6ea9a1b9c452ec9293a2a6253b45cb3edca7fa342a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e45a534d6fdd79719888aeb38f2dc4f9cdf5405a30ffb1f58a18eda7fb8d530a5c1a2c1a367ac5d9f101a77bfae8c7b3f0ec929ba2c006f4b73e5cea9ab113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0167c560f2b075db51d98b6f99a646367a41503f87936529011fbf58d39e9a9c0cb5a30a91358515a0e398f3144ec47144b8c8d9d1c79a48604aedaaeff0cb10"} 15:55:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:55:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:55:57 INFO - Contents: 15:55:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c93c34584aa119266e5c3acc9656178fffd09af13483ea6dba7eec99c67f0a8d1c5f1531b19b1b638588f6ea9a1b9c452ec9293a2a6253b45cb3edca7fa342a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e45a534d6fdd79719888aeb38f2dc4f9cdf5405a30ffb1f58a18eda7fb8d530a5c1a2c1a367ac5d9f101a77bfae8c7b3f0ec929ba2c006f4b73e5cea9ab113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0167c560f2b075db51d98b6f99a646367a41503f87936529011fbf58d39e9a9c0cb5a30a91358515a0e398f3144ec47144b8c8d9d1c79a48604aedaaeff0cb10"} 15:55:57 INFO - Running post-run listener: copy_logs_to_upload_dir 15:55:57 INFO - Copying logs to upload dir... 15:55:57 INFO - mkdir: /builds/slave/test/build/upload/logs 15:55:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.540727 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-14 15:55:57.134989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:55:57.138072) ========= 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=826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c93c34584aa119266e5c3acc9656178fffd09af13483ea6dba7eec99c67f0a8d1c5f1531b19b1b638588f6ea9a1b9c452ec9293a2a6253b45cb3edca7fa342a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e45a534d6fdd79719888aeb38f2dc4f9cdf5405a30ffb1f58a18eda7fb8d530a5c1a2c1a367ac5d9f101a77bfae8c7b3f0ec929ba2c006f4b73e5cea9ab113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0167c560f2b075db51d98b6f99a646367a41503f87936529011fbf58d39e9a9c0cb5a30a91358515a0e398f3144ec47144b8c8d9d1c79a48604aedaaeff0cb10"} build_url:https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/enzNKG0LQc-lUO5Ar31s_w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c93c34584aa119266e5c3acc9656178fffd09af13483ea6dba7eec99c67f0a8d1c5f1531b19b1b638588f6ea9a1b9c452ec9293a2a6253b45cb3edca7fa342a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e45a534d6fdd79719888aeb38f2dc4f9cdf5405a30ffb1f58a18eda7fb8d530a5c1a2c1a367ac5d9f101a77bfae8c7b3f0ec929ba2c006f4b73e5cea9ab113e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0167c560f2b075db51d98b6f99a646367a41503f87936529011fbf58d39e9a9c0cb5a30a91358515a0e398f3144ec47144b8c8d9d1c79a48604aedaaeff0cb10"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:55:57.243351) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:55:57.243664) ========= 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=826874ccc97bd7bf541b4875000001d5-1476481838.736291-1277275258 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:55:57.292518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:55:57.292813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:55:57.293192) ========= ========= Total master_lag: 0.30 =========