builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1485303837.77 results: success (0) buildid: 20170124143847 builduid: e9251fb09062419fad0807e4444c0e9b revision: e46f9da8b7bb59a8865eb885bed0d7f41febf794 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:57.769880) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:57.770331) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:57.770639) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:57.785156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:57.785439) ========= 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=fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-24 16:23:58-- 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% 36.0M=0s 2017-01-24 16:23:58 (36.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:57.963364) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:57.963910) ========= 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=fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015605 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:58.013565) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:58.013926) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e46f9da8b7bb59a8865eb885bed0d7f41febf794 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev e46f9da8b7bb59a8865eb885bed0d7f41febf794 --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=fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-24 16:23:58,621 truncating revision to first 12 chars 2017-01-24 16:23:58,621 Setting DEBUG logging. 2017-01-24 16:23:58,621 attempt 1/10 2017-01-24 16:23:58,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/e46f9da8b7bb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 16:23:58,914 unpacking tar archive at: mozilla-beta-e46f9da8b7bb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.580098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:58.607285) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:58.607630) ========= script_repo_revision: e46f9da8b7bb59a8865eb885bed0d7f41febf794 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:58.608017) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:58.608282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 16:23:58.617717) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-24 16:23:58.618023) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:23:59 INFO - MultiFileLogger online at 20170124 16:23:59 in /builds/slave/test 16:23:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:23:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:23:59 INFO - {'append_to_log': False, 16:23:59 INFO - 'base_work_dir': '/builds/slave/test', 16:23:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:23:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:23:59 INFO - 'branch': 'Mozilla-Beta', 16:23:59 INFO - 'buildbot_json_path': 'buildprops.json', 16:23:59 INFO - 'config_files': ('talos/linux_config.py',), 16:23:59 INFO - 'default_actions': ('clobber', 16:23:59 INFO - 'read-buildbot-config', 16:23:59 INFO - 'download-and-extract', 16:23:59 INFO - 'populate-webroot', 16:23:59 INFO - 'create-virtualenv', 16:23:59 INFO - 'install', 16:23:59 INFO - 'run-tests'), 16:23:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:23:59 INFO - 'download_minidump_stackwalk': True, 16:23:59 INFO - 'download_symbols': 'ondemand', 16:23:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:23:59 INFO - 'tooltool.py': '/tools/tooltool.py', 16:23:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:23:59 INFO - '/tools/misc-python/virtualenv.py')}, 16:23:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:23:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:23:59 INFO - 'installer_path': 'installer.exe', 16:23:59 INFO - 'log_level': 'info', 16:23:59 INFO - 'log_name': 'talos', 16:23:59 INFO - 'log_to_console': True, 16:23:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:23:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:23:59 INFO - 'opt_config_files': (), 16:23:59 INFO - 'pip_index': False, 16:23:59 INFO - 'sps_profile': False, 16:23:59 INFO - 'sps_profile_interval': 0, 16:23:59 INFO - 'suite': 'dromaeojs', 16:23:59 INFO - 'system_bits': '32', 16:23:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:23:59 INFO - 'title': 'talos-linux64-ix-048', 16:23:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:23:59 INFO - 'use_talos_json': True, 16:23:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:23:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:23:59 INFO - 'work_dir': 'build'} 16:23:59 INFO - [mozharness: 2017-01-25 00:23:59.322726Z] Running clobber step. 16:23:59 INFO - Running pre-action listener: _resource_record_pre_action 16:23:59 INFO - Running main action method: clobber 16:23:59 INFO - rmtree: /builds/slave/test/build 16:23:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:23:59 INFO - Running post-action listener: _resource_record_post_action 16:23:59 INFO - [mozharness: 2017-01-25 00:23:59.781695Z] Finished clobber step (success) 16:23:59 INFO - [mozharness: 2017-01-25 00:23:59.781795Z] Running read-buildbot-config step. 16:23:59 INFO - Running pre-action listener: _resource_record_pre_action 16:23:59 INFO - Running main action method: read_buildbot_config 16:23:59 INFO - Using buildbot properties: 16:23:59 INFO - { 16:23:59 INFO - "project": "", 16:23:59 INFO - "product": "firefox", 16:23:59 INFO - "script_repo_revision": "production", 16:23:59 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 16:23:59 INFO - "repository": "", 16:23:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 16:23:59 INFO - "buildid": "20170124143847", 16:23:59 INFO - "pgo_build": "True", 16:23:59 INFO - "basedir": "/builds/slave/test", 16:23:59 INFO - "buildnumber": 107, 16:23:59 INFO - "slavename": "talos-linux64-ix-048", 16:23:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:23:59 INFO - "platform": "ubuntu64_hw", 16:23:59 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 16:23:59 INFO - "branch": "mozilla-beta", 16:23:59 INFO - "repo_path": "releases/mozilla-beta", 16:23:59 INFO - "revision": "e46f9da8b7bb59a8865eb885bed0d7f41febf794", 16:23:59 INFO - "stage_platform": "linux64-pgo", 16:23:59 INFO - "builduid": "e9251fb09062419fad0807e4444c0e9b", 16:23:59 INFO - "slavebuilddir": "test" 16:23:59 INFO - } 16:23:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 16:23:59 INFO - Running post-action listener: _resource_record_post_action 16:23:59 INFO - [mozharness: 2017-01-25 00:23:59.784280Z] Finished read-buildbot-config step (success) 16:23:59 INFO - [mozharness: 2017-01-25 00:23:59.784368Z] Running download-and-extract step. 16:23:59 INFO - Running pre-action listener: _resource_record_pre_action 16:23:59 INFO - Running main action method: download_and_extract 16:23:59 INFO - mkdir: /builds/slave/test/build/tests 16:23:59 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')]} 16:23:59 INFO - trying https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:23:59 INFO - Downloading https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:24:00 INFO - Downloaded 1327 bytes. 16:24:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 16:24:00 INFO - Using the following test package requirements: 16:24:00 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:24:00 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 16:24:00 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 16:24:00 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'jsshell-linux-x86_64.zip'], 16:24:00 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 16:24:00 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 16:24:00 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 16:24:00 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 16:24:00 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 16:24:00 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 16:24:00 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 16:24:00 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:24:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:24:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:24:00 INFO - Fetch https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:24:00 INFO - Http code: 200 16:24:00 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 16:24:00 INFO - x-amz-cf-id: Q2OlXAsTqO3cvWzSwJjdRHizExrqCK3RPyHQIAADH77V7Jlx4WVP_g== 16:24:00 INFO - x-amz-version-id: N6Vxd9Y8AUkukfQxguMFaIwLYmHZ1eFJ 16:24:01 INFO - Expected file size: 21950479 16:24:01 INFO - Obtained file size: 21950479 16:24:05 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:24:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 16:24:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:24:05 INFO - Fetch https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 16:24:05 INFO - Http code: 200 16:24:05 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 16:24:05 INFO - x-amz-cf-id: Seyu5O53m2Zkc0CezeJDzj0IrQeLFvgtETIMTCztg22qBfmFU4z5Yg== 16:24:05 INFO - x-amz-version-id: N6Vxd9Y8AUkukfQxguMFaIwLYmHZ1eFJ 16:24:05 INFO - Expected file size: 21950479 16:24:05 INFO - Obtained file size: 21950479 16:24:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 16:24:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:24:10 INFO - Fetch https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 16:24:11 INFO - Http code: 200 16:24:11 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 16:24:11 INFO - x-amz-cf-id: -v6uDQHZV2C0quYi0_lDeh0z1kI8NZYQhUnEc4ZPMrMS82jaGZyoIQ== 16:24:11 INFO - x-amz-version-id: au3U6TYqQDkrx2BEM4ci2ZK2yQD07XxQ 16:24:11 INFO - Expected file size: 14402992 16:24:11 INFO - Obtained file size: 14402992 16:24: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')]} 16:24:11 INFO - trying https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:24:11 INFO - Downloading https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:24:12 INFO - Downloaded 57685103 bytes. 16:24:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:24:12 INFO - mkdir: /builds/slave/test/properties 16:24:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:24:12 INFO - Writing to file /builds/slave/test/properties/build_url 16:24:12 INFO - Contents: 16:24:12 INFO - build_url:https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 16:24:13 INFO - Running post-action listener: _resource_record_post_action 16:24:13 INFO - Running post-action listener: set_extra_try_arguments 16:24:13 INFO - [mozharness: 2017-01-25 00:24:13.181995Z] Finished download-and-extract step (success) 16:24:13 INFO - [mozharness: 2017-01-25 00:24:13.182220Z] Running populate-webroot step. 16:24:13 INFO - Running pre-action listener: _resource_record_pre_action 16:24:13 INFO - Running main action method: populate_webroot 16:24:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:24:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:24:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:24:13 INFO - '--tppagecycles', 16:24:13 INFO - '7'], 16:24:13 INFO - 'tests': ['tsvgm']}}, 16:24:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:24:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:24:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:24:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:24:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['damp', 'tps']}, 16:24:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'tests': ['damp', 'tps']}, 16:24:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['dromaeo_dom']}, 16:24:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:24:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['basic_compositor_video']}, 16:24:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:24:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other-e10s': {'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['a11yr', 16:24:13 INFO - 'ts_paint', 16:24:13 INFO - 'tpaint', 16:24:13 INFO - 'sessionrestore', 16:24:13 INFO - 'sessionrestore_no_auto_restore', 16:24:13 INFO - 'tabpaint']}, 16:24:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tsvgx', 16:24:13 INFO - 'tsvgr_opacity', 16:24:13 INFO - 'tart', 16:24:13 INFO - 'tscrollx', 16:24:13 INFO - 'cart']}, 16:24:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:24:13 INFO - 'tsvgr_opacity', 16:24:13 INFO - 'tart', 16:24:13 INFO - 'tscrollx', 16:24:13 INFO - 'cart']}, 16:24:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s'], 16:24:13 INFO - 'tests': ['tp5o']}, 16:24:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'tests': ['tp5o']}, 16:24:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--disable-e10s', 16:24:13 INFO - '--xperf_path', 16:24:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:13 INFO - 'tests': ['tp5n']}, 16:24:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:24:13 INFO - 'talos_options': ['--xperf_path', 16:24:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:13 INFO - 'tests': ['tp5n']}}, 16:24:13 INFO - 'talos.zip': {'path': '', 16:24:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:24:13 INFO - Running post-action listener: _resource_record_post_action 16:24:13 INFO - [mozharness: 2017-01-25 00:24:13.201526Z] Finished populate-webroot step (success) 16:24:13 INFO - [mozharness: 2017-01-25 00:24:13.201613Z] Running create-virtualenv step. 16:24:13 INFO - Running pre-action listener: _resource_record_pre_action 16:24:13 INFO - Running main action method: create_virtualenv 16:24:13 INFO - Creating virtualenv /builds/slave/test/build/venv 16:24:13 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 16:24:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:24:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:24:13 INFO - Using real prefix '/usr' 16:24:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:24:13 INFO - Installing distribute.............................................................................................................................................................................................done. 16:24:15 INFO - Installing pip.................done. 16:24:15 INFO - Return code: 0 16:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:24:15 INFO - Reading from file tmpfile_stdout 16:24:15 INFO - Output received: 16:24:15 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) 16:24:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:24:16 INFO - Using env: {'DISPLAY': ':0', 16:24:16 INFO - 'HOME': '/home/cltbld', 16:24:16 INFO - 'LANG': 'en_US.UTF-8', 16:24:16 INFO - 'LANGUAGE': 'en_US:en', 16:24:16 INFO - 'LOGNAME': 'cltbld', 16:24:16 INFO - 'MAIL': '/var/mail/cltbld', 16:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:16 INFO - 'MOZ_NO_REMOTE': '1', 16:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:16 INFO - 'NO_EM_RESTART': '1', 16:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:16 INFO - 'PWD': '/builds/slave/test', 16:24:16 INFO - 'SHELL': '/bin/bash', 16:24:16 INFO - 'SHLVL': '1', 16:24:16 INFO - 'TERM': 'linux', 16:24:16 INFO - 'TMOUT': '86400', 16:24:16 INFO - 'USER': 'cltbld', 16:24:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:16 INFO - '_': '/tools/buildbot/bin/python'} 16:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:16 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 16:24:16 INFO - Cleaning up... 16:24:16 INFO - Return code: 0 16:24:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:16 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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:16 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 16:24:16 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 16:24:16 INFO - Using env: {'DISPLAY': ':0', 16:24:16 INFO - 'HOME': '/home/cltbld', 16:24:16 INFO - 'LANG': 'en_US.UTF-8', 16:24:16 INFO - 'LANGUAGE': 'en_US:en', 16:24:16 INFO - 'LOGNAME': 'cltbld', 16:24:16 INFO - 'MAIL': '/var/mail/cltbld', 16:24:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:16 INFO - 'MOZ_NO_REMOTE': '1', 16:24:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:16 INFO - 'NO_EM_RESTART': '1', 16:24:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:16 INFO - 'PWD': '/builds/slave/test', 16:24:16 INFO - 'SHELL': '/bin/bash', 16:24:16 INFO - 'SHLVL': '1', 16:24:16 INFO - 'TERM': 'linux', 16:24:16 INFO - 'TMOUT': '86400', 16:24:16 INFO - 'USER': 'cltbld', 16:24:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:16 INFO - '_': '/tools/buildbot/bin/python'} 16:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:16 INFO - Downloading/unpacking psutil>=3.1.1 16:24:16 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 16:24:16 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 16:24:16 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 16:24:16 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 16:24:16 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 16:24:16 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 16:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:24:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:18 INFO - Installing collected packages: psutil 16:24:18 INFO - Running setup.py install for psutil 16:24:18 INFO - building 'psutil._psutil_linux' extension 16:24:18 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 16:24:18 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 16:24:18 INFO - building 'psutil._psutil_posix' extension 16:24:18 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 16:24:18 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 16:24:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:19 INFO - Successfully installed psutil 16:24:19 INFO - Cleaning up... 16:24:19 INFO - Return code: 0 16:24:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:24:19 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')]} 16:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:19 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')]} 16:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:19 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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:19 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 16:24:19 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 16:24:19 INFO - Using env: {'DISPLAY': ':0', 16:24:19 INFO - 'HOME': '/home/cltbld', 16:24:19 INFO - 'LANG': 'en_US.UTF-8', 16:24:19 INFO - 'LANGUAGE': 'en_US:en', 16:24:19 INFO - 'LOGNAME': 'cltbld', 16:24:19 INFO - 'MAIL': '/var/mail/cltbld', 16:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:19 INFO - 'MOZ_NO_REMOTE': '1', 16:24:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:19 INFO - 'NO_EM_RESTART': '1', 16:24:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:19 INFO - 'PWD': '/builds/slave/test', 16:24:19 INFO - 'SHELL': '/bin/bash', 16:24:19 INFO - 'SHLVL': '1', 16:24:19 INFO - 'TERM': 'linux', 16:24:19 INFO - 'TMOUT': '86400', 16:24:19 INFO - 'USER': 'cltbld', 16:24:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:19 INFO - '_': '/tools/buildbot/bin/python'} 16:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:24:19 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 16:24:19 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 16:24:19 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 16:24:19 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 16:24:19 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 16:24:19 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 16:24:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:24:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:24:21 INFO - Installing collected packages: mozsystemmonitor 16:24:21 INFO - Running setup.py install for mozsystemmonitor 16:24:21 INFO - Successfully installed mozsystemmonitor 16:24:21 INFO - Cleaning up... 16:24:21 INFO - Return code: 0 16:24:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:24:21 INFO - Using env: {'DISPLAY': ':0', 16:24:21 INFO - 'HOME': '/home/cltbld', 16:24:21 INFO - 'LANG': 'en_US.UTF-8', 16:24:21 INFO - 'LANGUAGE': 'en_US:en', 16:24:21 INFO - 'LOGNAME': 'cltbld', 16:24:21 INFO - 'MAIL': '/var/mail/cltbld', 16:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:21 INFO - 'MOZ_NO_REMOTE': '1', 16:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:21 INFO - 'NO_EM_RESTART': '1', 16:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:21 INFO - 'PWD': '/builds/slave/test', 16:24:21 INFO - 'SHELL': '/bin/bash', 16:24:21 INFO - 'SHLVL': '1', 16:24:21 INFO - 'TERM': 'linux', 16:24:21 INFO - 'TMOUT': '86400', 16:24:21 INFO - 'USER': 'cltbld', 16:24:21 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:21 INFO - '_': '/tools/buildbot/bin/python'} 16:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:21 INFO - Downloading/unpacking jsonschema==2.5.1 16:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:24:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:24:23 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 16:24:23 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 16:24:23 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 16:24:23 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 16:24:23 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 16:24:23 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 16:24:24 INFO - Downloading functools32-3.2.3-2.tar.gz 16:24:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:24:24 INFO - warning: no files found matching '*.txt' 16:24:24 INFO - no previously-included directories found matching 'build' 16:24:24 INFO - no previously-included directories found matching 'dist' 16:24:24 INFO - no previously-included directories found matching '.git*' 16:24:24 INFO - Installing collected packages: jsonschema, functools32 16:24:24 INFO - Running setup.py install for functools32 16:24:24 INFO - warning: no files found matching '*.txt' 16:24:24 INFO - no previously-included directories found matching 'build' 16:24:24 INFO - no previously-included directories found matching 'dist' 16:24:24 INFO - no previously-included directories found matching '.git*' 16:24:24 INFO - Successfully installed jsonschema functools32 16:24:24 INFO - Cleaning up... 16:24:24 INFO - Return code: 0 16:24:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:24:24 INFO - Using env: {'DISPLAY': ':0', 16:24:24 INFO - 'HOME': '/home/cltbld', 16:24:24 INFO - 'LANG': 'en_US.UTF-8', 16:24:24 INFO - 'LANGUAGE': 'en_US:en', 16:24:24 INFO - 'LOGNAME': 'cltbld', 16:24:24 INFO - 'MAIL': '/var/mail/cltbld', 16:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:24 INFO - 'MOZ_NO_REMOTE': '1', 16:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:24 INFO - 'NO_EM_RESTART': '1', 16:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:24 INFO - 'PWD': '/builds/slave/test', 16:24:24 INFO - 'SHELL': '/bin/bash', 16:24:24 INFO - 'SHLVL': '1', 16:24:24 INFO - 'TERM': 'linux', 16:24:24 INFO - 'TMOUT': '86400', 16:24:24 INFO - 'USER': 'cltbld', 16:24:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:24 INFO - '_': '/tools/buildbot/bin/python'} 16:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:24:24 INFO - Cleaning up... 16:24:24 INFO - Return code: 0 16:24:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:24:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:24:24 INFO - Using env: {'DISPLAY': ':0', 16:24:24 INFO - 'HOME': '/home/cltbld', 16:24:24 INFO - 'LANG': 'en_US.UTF-8', 16:24:24 INFO - 'LANGUAGE': 'en_US:en', 16:24:24 INFO - 'LOGNAME': 'cltbld', 16:24:24 INFO - 'MAIL': '/var/mail/cltbld', 16:24:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:24 INFO - 'MOZ_NO_REMOTE': '1', 16:24:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:24 INFO - 'NO_EM_RESTART': '1', 16:24:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:24 INFO - 'PWD': '/builds/slave/test', 16:24:24 INFO - 'SHELL': '/bin/bash', 16:24:24 INFO - 'SHLVL': '1', 16:24:24 INFO - 'TERM': 'linux', 16:24:24 INFO - 'TMOUT': '86400', 16:24:24 INFO - 'USER': 'cltbld', 16:24:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:24 INFO - '_': '/tools/buildbot/bin/python'} 16:24:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:24 INFO - Downloading/unpacking blobuploader==1.2.4 16:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:26 INFO - Downloading blobuploader-1.2.4.tar.gz 16:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:24:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:24:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:24:27 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 16:24:27 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 16:24:27 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 16:24:27 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 16:24:27 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 16:24:27 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 16:24:27 INFO - Downloading docopt-0.6.1.tar.gz 16:24:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:24:27 INFO - Installing collected packages: blobuploader, requests, docopt 16:24:27 INFO - Running setup.py install for blobuploader 16:24:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:24:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:24:27 INFO - Running setup.py install for requests 16:24:28 INFO - Running setup.py install for docopt 16:24:28 INFO - Successfully installed blobuploader requests docopt 16:24:28 INFO - Cleaning up... 16:24:28 INFO - Return code: 0 16:24:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:28 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')]} 16:24:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:28 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')]} 16:24:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:28 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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:28 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 16:24:28 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 16:24:28 INFO - Using env: {'DISPLAY': ':0', 16:24:28 INFO - 'HOME': '/home/cltbld', 16:24:28 INFO - 'LANG': 'en_US.UTF-8', 16:24:28 INFO - 'LANGUAGE': 'en_US:en', 16:24:28 INFO - 'LOGNAME': 'cltbld', 16:24:28 INFO - 'MAIL': '/var/mail/cltbld', 16:24:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:28 INFO - 'MOZ_NO_REMOTE': '1', 16:24:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:28 INFO - 'NO_EM_RESTART': '1', 16:24:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:28 INFO - 'PWD': '/builds/slave/test', 16:24:28 INFO - 'SHELL': '/bin/bash', 16:24:28 INFO - 'SHLVL': '1', 16:24:28 INFO - 'TERM': 'linux', 16:24:28 INFO - 'TMOUT': '86400', 16:24:28 INFO - 'USER': 'cltbld', 16:24:28 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:28 INFO - '_': '/tools/buildbot/bin/python'} 16:24:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:28 INFO - Running setup.py (path:/tmp/pip-sTnkph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:28 INFO - Running setup.py (path:/tmp/pip-mypn8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:28 INFO - Running setup.py (path:/tmp/pip-V5BJc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:28 INFO - Running setup.py (path:/tmp/pip-4dYzme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:28 INFO - Running setup.py (path:/tmp/pip-5LWcgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:28 INFO - Running setup.py (path:/tmp/pip-DehGv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:28 INFO - Running setup.py (path:/tmp/pip-duEVQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:28 INFO - Running setup.py (path:/tmp/pip-L3cOuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:28 INFO - Running setup.py (path:/tmp/pip-LBD9A1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:29 INFO - Running setup.py (path:/tmp/pip-dknlfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:29 INFO - Running setup.py (path:/tmp/pip-yTdFxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:29 INFO - Running setup.py (path:/tmp/pip-xGwYo0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:29 INFO - Running setup.py (path:/tmp/pip-2Z5rRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:29 INFO - Running setup.py (path:/tmp/pip-SdTTq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:29 INFO - Running setup.py (path:/tmp/pip-dFNfx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:29 INFO - Running setup.py (path:/tmp/pip-_bhqbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:29 INFO - Running setup.py (path:/tmp/pip-cCF0Nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:24:29 INFO - Running setup.py install for manifestparser 16:24:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:24:29 INFO - Running setup.py install for mozcrash 16:24:29 INFO - Running setup.py install for mozdebug 16:24:29 INFO - Running setup.py install for mozdevice 16:24:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Running setup.py install for mozfile 16:24:30 INFO - Running setup.py install for mozhttpd 16:24:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Running setup.py install for mozinfo 16:24:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Running setup.py install for mozInstall 16:24:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Running setup.py install for mozleak 16:24:30 INFO - Running setup.py install for mozlog 16:24:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Running setup.py install for moznetwork 16:24:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Running setup.py install for mozprocess 16:24:30 INFO - Running setup.py install for mozprofile 16:24:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:24:30 INFO - Running setup.py install for mozrunner 16:24:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:24:31 INFO - Running setup.py install for mozscreenshot 16:24:31 INFO - Running setup.py install for moztest 16:24:31 INFO - Running setup.py install for mozversion 16:24:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:24:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:24:31 INFO - Cleaning up... 16:24:31 INFO - Return code: 0 16:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:31 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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:31 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 16:24:31 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 16:24:31 INFO - Using env: {'DISPLAY': ':0', 16:24:31 INFO - 'HOME': '/home/cltbld', 16:24:31 INFO - 'LANG': 'en_US.UTF-8', 16:24:31 INFO - 'LANGUAGE': 'en_US:en', 16:24:31 INFO - 'LOGNAME': 'cltbld', 16:24:31 INFO - 'MAIL': '/var/mail/cltbld', 16:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:31 INFO - 'MOZ_NO_REMOTE': '1', 16:24:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:31 INFO - 'NO_EM_RESTART': '1', 16:24:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:31 INFO - 'PWD': '/builds/slave/test', 16:24:31 INFO - 'SHELL': '/bin/bash', 16:24:31 INFO - 'SHLVL': '1', 16:24:31 INFO - 'TERM': 'linux', 16:24:31 INFO - 'TMOUT': '86400', 16:24:31 INFO - 'USER': 'cltbld', 16:24:31 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:31 INFO - '_': '/tools/buildbot/bin/python'} 16:24:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:24:31 INFO - Running setup.py (path:/tmp/pip-HRsIkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:24:31 INFO - Running setup.py (path:/tmp/pip-lGmqt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:24:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:24:31 INFO - Running setup.py (path:/tmp/pip-fGHR3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:24:31 INFO - Running setup.py (path:/tmp/pip-ApLH_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:24:31 INFO - Running setup.py (path:/tmp/pip-BsyUhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:24:31 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)) 16:24:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:24:32 INFO - Running setup.py (path:/tmp/pip-siWkpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:24:32 INFO - Running setup.py (path:/tmp/pip-Z8kSYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:24:32 INFO - Running setup.py (path:/tmp/pip-1XBrTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:24:32 INFO - Running setup.py (path:/tmp/pip-Quxdud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:24:32 INFO - Running setup.py (path:/tmp/pip-LXLcR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:24:32 INFO - Running setup.py (path:/tmp/pip-DICVoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:24:32 INFO - Running setup.py (path:/tmp/pip-SegVju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:24:32 INFO - Running setup.py (path:/tmp/pip-ziKegC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:24:32 INFO - Running setup.py (path:/tmp/pip-PCqpcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:32 INFO - Running setup.py (path:/tmp/pip-Apl1cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:24:32 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)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:24:32 INFO - Running setup.py (path:/tmp/pip-ba__qe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:24:32 INFO - Running setup.py (path:/tmp/pip-U_4lHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:24:32 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)) 16:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:24:32 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)) 16:24:32 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)) 16:24:32 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)) 16:24:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:24:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:34 INFO - Downloading blessings-1.6.tar.gz 16:24:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:24:34 INFO - Installing collected packages: blessings 16:24:34 INFO - Running setup.py install for blessings 16:24:35 INFO - Successfully installed blessings 16:24:35 INFO - Cleaning up... 16:24:35 INFO - Return code: 0 16:24:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:35 INFO - Reading from file tmpfile_stdout 16:24:35 INFO - Current package versions: 16:24:35 INFO - argparse == 1.2.1 16:24:35 INFO - blessings == 1.6 16:24:35 INFO - blobuploader == 1.2.4 16:24:35 INFO - docopt == 0.6.1 16:24:35 INFO - functools32 == 3.2.3-2 16:24:35 INFO - jsonschema == 2.5.1 16:24:35 INFO - manifestparser == 1.1 16:24:35 INFO - mozInstall == 1.12 16:24:35 INFO - mozcrash == 1.0 16:24:35 INFO - mozdebug == 0.1 16:24:35 INFO - mozdevice == 0.48 16:24:35 INFO - mozfile == 1.2 16:24:35 INFO - mozhttpd == 0.7 16:24:35 INFO - mozinfo == 0.9 16:24:35 INFO - mozleak == 0.1 16:24:35 INFO - mozlog == 3.4 16:24:35 INFO - moznetwork == 0.27 16:24:35 INFO - mozprocess == 0.23 16:24:35 INFO - mozprofile == 0.28 16:24:35 INFO - mozrunner == 6.13 16:24:35 INFO - mozscreenshot == 0.1 16:24:35 INFO - mozsystemmonitor == 0.3 16:24:35 INFO - moztest == 0.8 16:24:35 INFO - mozversion == 1.4 16:24:35 INFO - psutil == 3.1.1 16:24:35 INFO - requests == 1.2.3 16:24:35 INFO - wsgiref == 0.1.2 16:24:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:24:35 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')]} 16:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:35 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')]} 16:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:35 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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:35 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 16:24:35 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 16:24:35 INFO - Using env: {'DISPLAY': ':0', 16:24:35 INFO - 'HOME': '/home/cltbld', 16:24:35 INFO - 'LANG': 'en_US.UTF-8', 16:24:35 INFO - 'LANGUAGE': 'en_US:en', 16:24:35 INFO - 'LOGNAME': 'cltbld', 16:24:35 INFO - 'MAIL': '/var/mail/cltbld', 16:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:35 INFO - 'MOZ_NO_REMOTE': '1', 16:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:35 INFO - 'NO_EM_RESTART': '1', 16:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:35 INFO - 'PWD': '/builds/slave/test', 16:24:35 INFO - 'SHELL': '/bin/bash', 16:24:35 INFO - 'SHLVL': '1', 16:24:35 INFO - 'TERM': 'linux', 16:24:35 INFO - 'TMOUT': '86400', 16:24:35 INFO - 'USER': 'cltbld', 16:24:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:35 INFO - '_': '/tools/buildbot/bin/python'} 16:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 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)) 16:24:35 INFO - Cleaning up... 16:24:35 INFO - Return code: 0 16:24:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:24:35 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')]} 16:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:35 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')]} 16:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:24:35 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 0x7fc1cf588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1585ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, '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': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', '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 16:24:35 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 16:24:35 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 16:24:35 INFO - Using env: {'DISPLAY': ':0', 16:24:35 INFO - 'HOME': '/home/cltbld', 16:24:35 INFO - 'LANG': 'en_US.UTF-8', 16:24:35 INFO - 'LANGUAGE': 'en_US:en', 16:24:35 INFO - 'LOGNAME': 'cltbld', 16:24:35 INFO - 'MAIL': '/var/mail/cltbld', 16:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:35 INFO - 'MOZ_NO_REMOTE': '1', 16:24:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:35 INFO - 'NO_EM_RESTART': '1', 16:24:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:35 INFO - 'PWD': '/builds/slave/test', 16:24:35 INFO - 'SHELL': '/bin/bash', 16:24:35 INFO - 'SHLVL': '1', 16:24:35 INFO - 'TERM': 'linux', 16:24:35 INFO - 'TMOUT': '86400', 16:24:35 INFO - 'USER': 'cltbld', 16:24:35 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:35 INFO - '_': '/tools/buildbot/bin/python'} 16:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:24:35 INFO - Cleaning up... 16:24:35 INFO - Return code: 0 16:24:35 INFO - Running post-action listener: _resource_record_post_action 16:24:35 INFO - Running post-action listener: _start_resource_monitoring 16:24:35 INFO - Starting resource monitoring. 16:24:35 INFO - [mozharness: 2017-01-25 00:24:35.850171Z] Finished create-virtualenv step (success) 16:24:35 INFO - [mozharness: 2017-01-25 00:24:35.850670Z] Running install step. 16:24:35 INFO - Running pre-action listener: _resource_record_pre_action 16:24:35 INFO - Running main action method: install 16:24:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:24:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:24:36 INFO - Reading from file tmpfile_stdout 16:24:36 INFO - Detecting whether we're running mozinstall >=1.0... 16:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:24:36 INFO - Reading from file tmpfile_stdout 16:24:36 INFO - Output received: 16:24:36 INFO - Usage: mozinstall [options] installer 16:24:36 INFO - Options: 16:24:36 INFO - -h, --help show this help message and exit 16:24:36 INFO - -d DEST, --destination=DEST 16:24:36 INFO - Directory to install application into. [default: 16:24:36 INFO - "/builds/slave/test"] 16:24:36 INFO - --app=APP Application being installed. [default: firefox] 16:24:36 INFO - mkdir: /builds/slave/test/build/application 16:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:24:49 INFO - Reading from file tmpfile_stdout 16:24:49 INFO - Output received: 16:24:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:24:49 INFO - Running post-action listener: _resource_record_post_action 16:24:49 INFO - [mozharness: 2017-01-25 00:24:49.778863Z] Finished install step (success) 16:24:49 INFO - [mozharness: 2017-01-25 00:24:49.779105Z] Running run-tests step. 16:24:49 INFO - Running pre-action listener: _resource_record_pre_action 16:24:49 INFO - Running main action method: run_tests 16:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:24:49 INFO - Python 2.7.3 16:24:49 INFO - Return code: 0 16:24:49 INFO - grabbing minidump binary from tooltool 16:24: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')]} 16:24:49 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 0x1582f60>, '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 0x1583d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15841d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:24:49 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 16:24:49 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 16:24:49 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 16:24:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:24:49 INFO - Return code: 0 16:24:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:24:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:24:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:24:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:24:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:24:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 16:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 16:24:49 INFO - Using env: {'DISPLAY': ':0', 16:24:49 INFO - 'HOME': '/home/cltbld', 16:24:49 INFO - 'LANG': 'en_US.UTF-8', 16:24:49 INFO - 'LANGUAGE': 'en_US:en', 16:24:49 INFO - 'LOGNAME': 'cltbld', 16:24:49 INFO - 'MAIL': '/var/mail/cltbld', 16:24:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:24:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:49 INFO - 'MOZ_NO_REMOTE': '1', 16:24:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:49 INFO - 'NO_EM_RESTART': '1', 16:24:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:49 INFO - 'PWD': '/builds/slave/test', 16:24:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:24:49 INFO - 'SHELL': '/bin/bash', 16:24:49 INFO - 'SHLVL': '1', 16:24:49 INFO - 'TERM': 'linux', 16:24:49 INFO - 'TMOUT': '86400', 16:24:49 INFO - 'USER': 'cltbld', 16:24:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002', 16:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:49 INFO - '_': '/tools/buildbot/bin/python'} 16:24:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 16:24:50 INFO - mozversion application_buildid: 20170124143847 16:24:50 INFO - mozversion application_changeset: e46f9da8b7bb59a8865eb885bed0d7f41febf794 16:24:50 INFO - mozversion application_display_name: Firefox 16:24:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:24:50 INFO - mozversion application_name: Firefox 16:24:50 INFO - mozversion application_remotingname: firefox 16:24:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:24:50 INFO - mozversion application_vendor: Mozilla 16:24:50 INFO - mozversion application_version: 52.0 16:24:50 INFO - mozversion platform_buildid: 20170124143847 16:24:50 INFO - mozversion platform_changeset: e46f9da8b7bb59a8865eb885bed0d7f41febf794 16:24:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:24:50 INFO - mozversion platform_version: 52.0 16:24:50 INFO - using testdate: 1485303890 16:24:50 INFO - actual date: 1485303890 16:24:50 INFO - starting webserver on 'localhost:49953' 16:24:50 INFO - SUITE-START | Running 2 tests 16:24:50 INFO - TEST-START | dromaeo_css 16:24:50 INFO - operating with platform_type : linux_ 16:24:50 INFO - Initialising browser for dromaeo_css test... 16:24:50 INFO - TEST-INFO | started process 11011 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI3KMFT/profile http://localhost:49953/getInfo.html) 16:24:54 INFO - PROCESS | 11011 | __metrics Screen width/height:1600/1200 16:24:54 INFO - PROCESS | 11011 | colorDepth:24 16:24:54 INFO - PROCESS | 11011 | Browser inner width/height: 1024/697 16:24:54 INFO - PROCESS | 11011 | __metrics 16:24:54 INFO - PROCESS | 11011 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:24:54 INFO - PROCESS | 11011 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:24:55 INFO - PROCESS | 11011 | console.error: PushService: 16:24:55 INFO - PROCESS | 11011 | stateChangeProcessEnqueue: Error transitioning state 16:24:55 INFO - PROCESS | 11011 | UnknownError 16:24:55 INFO - TEST-INFO | 11011: exit 0 16:24:55 INFO - Browser initialized. 16:24:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:24:55 INFO - TEST-INFO | started process 11103 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI3KMFT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:07 INFO - PROCESS | 11103 | RSS: Main: 144814080 16:25:07 INFO - PROCESS | 11103 | 16:28:08 INFO - PROCESS | 11103 | Cycle 1(1): loaded http://localhost:49953/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49953/tests/dromaeo/cssquery-ext.html) 16:28:09 INFO - PROCESS | 11103 | RSS: Main: 250404864 16:28:09 INFO - PROCESS | 11103 | 16:31:11 INFO - PROCESS | 11103 | Cycle 1(1): loaded http://localhost:49953/tests/dromaeo/cssquery-ext.html (next: http://localhost:49953/tests/dromaeo/cssquery-jquery.html) 16:31:12 INFO - PROCESS | 11103 | RSS: Main: 222683136 16:31:12 INFO - PROCESS | 11103 | 16:34:14 INFO - PROCESS | 11103 | Cycle 1(1): loaded http://localhost:49953/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49953/tests/dromaeo/cssquery-mootools.html) 16:34:14 INFO - PROCESS | 11103 | RSS: Main: 213975040 16:34:14 INFO - PROCESS | 11103 | 16:37:16 INFO - PROCESS | 11103 | Cycle 1(1): loaded http://localhost:49953/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49953/tests/dromaeo/cssquery-prototype.html) 16:37:17 INFO - PROCESS | 11103 | RSS: Main: 215863296 16:37:17 INFO - PROCESS | 11103 | 16:40:19 INFO - PROCESS | 11103 | Cycle 1(1): loaded http://localhost:49953/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49953/tests/dromaeo/cssquery-yui.html) 16:40:20 INFO - PROCESS | 11103 | RSS: Main: 179634176 16:40:20 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | Cycle 1(1): loaded http://localhost:49953/tests/dromaeo/cssquery-yui.html (next: http://localhost:49953/tests/dromaeo/cssquery-dojo.html) 16:43:22 INFO - PROCESS | 11103 | RSS: Main: 262991872 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | __start_tp_report 16:43:22 INFO - PROCESS | 11103 | _x_x_mozilla_page_load 16:43:22 INFO - PROCESS | 11103 | _x_x_mozilla_page_load_details 16:43:22 INFO - PROCESS | 11103 | |i|pagename|runs| 16:43:22 INFO - PROCESS | 11103 | |0;dojo.html;3110.440120778259;3118.438681037413;3146.999999999999;3158.7157155855966;3169.1918560767;5306.761195746191;5403.297571315728;5406.297181366422;5411.431799661038;5416.972915135419;5412.242286079952;5427.728613569326;5434.945650543494;5442.8911421771545;5445.401005889349;4909.459959404471;4975.751212439382;5016.924746128792;5039.0425819094435;5052.722100284483;4923.58149557288;4953.133201689708;5004.124278251292;5058.822941197059;5100.489951004907;4976.178930476467;5023.120953833083;5040.974795126038;5042.218456139286;5081.949180508184;5071.518205770446;5108.20822772469;5118.436971933084;5123.846284611468;5154.587632989352;4883.609311255091;4923.138450771101;5003.649744517885;5026.849194524134;5071.771770270347;5345.893082138336;5368.946310536884;5384.0847056000575;5410.431904650034;5414.7834086636485;5804.303483581997;5833.2416785817995;5845.707714614252;5846.561507886926;5848.473637372615;5798.362180160179;5878.706064696748;5906.881862362771;5914.053751399799;5928.525717942597;5446.782128714846;5479.068558345091;5481.808136715196;5535.11438169899;5543.52880005204;6001.5198784097165;6053.122297266872;6053.697315134225;6058.1518587397795;6059.424354686298;5666.34836993751;5821.88356232873;5822.854428639233;5827.3007239131575;5831.854203644943;5781.075027995501;5815;5815.592908496449;5840.766369345263;5948.702564871739;5876.706164691748;5910.172575839386;5914.497267732205;5914.822555323347;5924.763009479572;5931.11033344993;5932.525397968152;5933.199018132497;5934.525237980951;5962.37395073511;4429.069895322018;4471.530489298641;4557.043020965568;4558.361829343895;4593.609543188866;4099.938500922489;4115.588441155861;4125.91748165035;4134.193832202752;4142.420061191436;5657.8019769307875;5662.348829884616;5673.489385955201;5673.687947162945;5676.120201368794;5813.09896965971;5856.59003869725;5936.22829032223;5949.613275137102;5955.106733989936;5764.884702305931;5772.163036359789;5775.884482310415;5778.306603207558;5803.709814509258;5163.948360516347;5185.662931909414;5195.272661827347;5203.8178663746585;5240.633155679066;5984.73068711909;6000.939990600213;6034.275886893601;6252.6873656317;6306.463950564162;5831.562632802472;5938.257717785277;5939.07944268639;5951.672658003851;5975.133605627073;6116.938830611637;6124.265088189446;6129.632222066691;6133.141360209664;6154.969225153845;5652;5709.115087161496;5721.056025755704;5750;5817.970910145422;5880.735366908585;5939.435753603573;5992;5999.5500337473995;6021;5823.767049317979;5837.211976383303;5837.94162058374;5843.503302219359;5844.47399734026;5598.300212473441;5658.122990936411;5826.70866456684;5827.24245848037;5830.679312637845;5714.771409143754;5733.3406658234835;5777.653340799566;5839.532837373085;5859.384764599826;5809.24479817621;5864.530837533072;5869.6771677556435;5879.617824841372;5884.293884733859;5574.414686458026;5576.888462230814;5627.7467513961155;5680.829575112753;5710.600257982068 16:43:22 INFO - PROCESS | 11103 | |1;ext.html;574.893644675735;602.8975074237379;618.5268269773621;660.5772305724337;666.3436515032689;33349.33301333975;47432.762836185815;48302.75848620752;48540;48561.27158092632;48705.756471217595;49275.50724492754;49316;49361;49374.75312623432;8287.337013038972;8946.910530894706;9122.315826313054;9152;9172.220361269267;8329.916700832975;10686.465676716172;10895.182861285435;10925.726856828564;11278.887211127865;11121.165912556591;11181.776364472706;11184.664460066211;11188.944055279753;11196.608118715847;10984.121270298358;11022.063124634416;11032.724181895437;11044.889551104467;11053.392063436508;10840.349579025284;10900.618478353219;10945.726356841144;10951.671449856518;10953.17851161158;46141.53858461406;46562.534374656156;46620.3006954896;46645.30032049522;46659.83350416233;3509.4560343146854;3518.9120271993147;3578.2664553766676;3579.0873327301633;3818.102745854722;33854.49218261728;33889;33965;34007.65992340069;34157;4360.498542667602;4444.355568442557;4480.6191473724775;4486.967997360625;4572.474165470981;362405;364777;365600;365627;366559;39022.609773901895;64290;64639.353606464276;64839.35160648428;64902;39984.800076000014;41681.79159104185;42113.36829947553;42167.789161053995;42252.15495690131;16356.100414477318;16651.91674041622;16687.415940442028;16689.33242670304;16691.08199049064;11681.707957301136;11898.167128300936;13072.150310229805;13423.597292081253;13679.931600342134;9445.574949127305;9556.95221523888;9676.274279429072;9700.6119755209;9720.562574684156;3577.499150118985;3603.2253065591026;3613.1509095362567;3650.2699460108083;3668.4680721295263;1061.0874647802884;1067.1569460126414;1071.1056268016139;1073.7315671082229;1195.9581414650445;33527.832360838525;33585.83207083949;33600.327993440485;33656.49515257273;34002.82998585041;1130.463030060731;1163.1218430085232;1173.4895320535595;1238.448890243833;1256.0265794009715;17465.650686986188;17744.11279436023;17799;17800.55498612545;17816;553541;554918;554964.4503554994;555065;555848;63437;63626.68186659037;63837;63837.680811595645;63943.36056639467;1318.0575888239955;1328.110166188656;1404.7190561887664;1413.4982081361175;1449.543393830961;32592.34815303728;34032.31935361328;34917.825410872785;35288.11779705528;35348.646513534535;54931.45068549423;55378;55503.72248138733;55522.16716749171;55621.44378556324;405019;405123;406233;407285;486217;26436.735632644195;30224.244393890327;30533.847330763205;31122;32241.838790805898;46998.76500617475;47566;47583;47981.280280795116;48326.5167348322;42320.365194522725;42443.7877810609;42465.15069698527;42703;44284.11431771411;40483.79758101191;40939;41536.376954345105;42672;43060.78469607757;42335.576644233166;42436;43661.126777463636;43923.78038109789;44080.77959610181;34366.48450273198;36907;37804.43293350657;37932.94981154489;37934.810325948194;28173;28267.71732282651;28296.944977607793;28646;30769.69230307758 16:43:22 INFO - PROCESS | 11103 | |2;jquery.html;406.84539874847553;420.05906768837815;420.8001199430271;422.7167797575624;432.1076976044468;19233.134508947096;19638.705419418704;20490.692639610417;20528.281510147146;20724.48188795281;18950.336738214166;19000.809991900078;20399.796002040013;21129.894350528226;21280.787192128075;5842.32813226478;6069.089636554508;6073.817785466421;6074.149619053336;6074.271087469509;5794;5926.170336152942;6008.128821320905;6025.3372129065765;6066.969665151668;6135.110408990694;6135.9693201534155;6142.140100385949;6150.84622884427;6155.169052177966;5956.344802071769;6064.3329233784025;6120.602160859575;6124.081387791823;6140.907886381708;5954.821355359303;5962.70186490678;5964.075568286879;5966.343702192756;5970.880582388328;14819.259037048105;15210.771838422432;22648.77351226483;23481.29556113302;23575;2337.8714170720605;2441.8779061046876;2490.8256422050463;2506.2982364937848;2911.010256512796;10611.31026483276;10769.299995500267;10938.043943146447;11183.552657893675;11376.886231137665;1945.9610807783765;1961.6174845905055;2072.89635518225;2073.02567793137;2227.2538699535676;81164;83959;84716.57641711814;86594.56702716509;86926;11293.774124517464;11636.3600001999;11764.70588235301;11797.35114568707;12119.878801212051;16745.246463909152;17176.82823171752;17228.741568876478;17241.82758172402;17488.475345739647;6999.475039372068;7235.782926512213;8230.341572674171;8511.276541493919;8881.866771998426;8085.43401961857;8224.259816616533;8325.583720813935;8481.280834399244;8806.075362087016;4999.350084488993;5102.719350435762;5111.693298402108;5114.261151208607;5253.369595648546;2037.1749441476227;2043.6280137772794;2134.903929323184;2159.762426133124;2173.6304828179245;930.4928813796497;1016.4307987526861;1040.6929955663097;1044.300318786415;1068.2789117345915;19428.708569371473;20117.19531218735;20248.595028099357;20327.085281162384;20518.38444846657;1003.7289931718395;1014.660088870222;1023.3143793658267;1037.7457522906936;1044.8902865199198;10450.662974865498;11158.442077896072;11364.090872730161;11445.198836081561;11595.304281743123;470423;475777;476976;479829;480947;87817;87850;88698;88968;92059.5397023024;1000.5997600959529;1066.3122286125406;1082.8538147350007;1092.404639471474;1101.124605938281;17335.219915103597;17618.15873964001;18011.639767204844;18043.909780451013;18230.17964191641;39855.80072099621;40696.59303406928;41019.58980410277;41103.1779364417;42216.78891605522;56427.435725642215;57320.71339643275;57388.1391779132;58124;59280.40719592749;9059.864102038606;9083.636654533744;9171.128742769426;9533.47565883883;9557.426554406758;7147.714091436284;9879.814422269374;11244.887551124712;12352.938235308766;12488.12583119173;10843.24097313212;10968.396738179477;10980.176486763365;11324.37715925632;11341.092712583139;9932.503374831085;10190.745231369276;10607.575696972035;10608.363498190134;10895.673129806119;6040.516758659384;7468.775936721907;11058.723531911766;11153.442327883735;11455.312681239153;9107.590158442754;9135.680251191443;9195.436775748005;9217.44695318283;9265.814683706154;8743.912560874563;10695.786084278116;10932.617358392417;10992.505337260003;11180.217384782987 16:43:22 INFO - PROCESS | 11103 | |3;mootools.html;1404.6769243074086;1529.9311530981104;1541.506717850288;1737.5048111288277;1822.3894995176606;7763.53418794872;8260.256576908077;8789.2089711926;8949.507777072258;8998.910010899888;8713.782155446117;8747.693830715927;8752.037275899645;8762.299016078714;8763.956180219106;2384.9165279215185;2407.350015495815;2409.265174121892;2409.650600662903;2410.819188560865;2395.3652282145244;2427.9150229741963;2472.2336075816465;2472.3819045238693;2473.332200305916;2413.553492603865;2415.130553000918;2439.3413778279855;2444.1934161726676;2444.4133407982044;2344.812415006795;2377.95244095118;2381.6427535869584;2395.413123784684;2398.64020396941;2370.12305446984;2376.6435034744927;2395.916142934989;2396.065534441569;2396.808255339569;8512.957435212846;8593;8595.742127736177;8599.226069653761;8834.160754728291;5188.558972487343;5256.9474305256845;5293.947060529384;5295.920561191585;5326.307580014612;3280.1799550112473;3383.5263063171174;3483.1988642612087;3498.737594680409;3509.0350153707677;1105.1876870500257;1109.8834622364698;1118.725912151528;1130.2932571816534;1139.8575178102737;12392.31842248676;12394.504219831197;12399.318037507934;12436.067294952914;12459.06557008228;4495.505494395614;4575.839845605455;4636.35091087248;4644.326572646947;4655.138799322136;9885.110340069285;9887.258455615858;9887.45618990948;9888.851667224997;9890.554925028391;5379.704116273642;5394.649347792381;5397.7571009304675;5398.73006349681;5398.757055932492;4209.5579964103945;4408.096340250241;4422.226110430726;4434.933475997863;4924.212126059885;3864.091938394475;3916.138449541096;4014.578469260744;4023.5574086850424;4031.858884939013;1159.2001518951897;1166.585862018988;1180.9173357864868;1181.0728578066178;1182.1724792645182;848.2026894718945;886.5833058462641;903.0969030969031;923.7413524213231;947.5783276441917;5386.676799392049;5608.439156084359;5635.323761148688;5878.353381128072;5904.0553511437965;914.3462424366477;937.1237892570468;938.596403546468;944.40502483435;998.9600415983425;3695.3902606070237;3731.6641502264924;3846.538415390171;3896.8636097736444;3948.151147503243;10531;10910.345379277269;10951.233413660968;10962.561497540168;10981.286216395909;10822.40476773785;10843.83734243987;10867.945660271647;10871.728206794734;10897.891021089847;7957.5225486471;8199.303059240032;8422;8453.577321133918;8465.619047142893;5484.698341591251;5566.443355664401;5693.146028095819;5771.913421298768;5775.48020678141;9833.655822046194;10157.796844063225;10163.89836101659;10193.949030254802;10245.385276883411;9674.322797404115;9844.409335439897;9916.107550320507;10238;10374.58501659925;7558.093028836574;7623.580703061385;7883.84232315362;7987.920120798718;7998.520088794691;8426.325893928348;8479.448835825651;8491.617877195664;8495.74512764618;8500;7643.235676432312;7646.541207527566;7677.808054798675;7796.220377962159;7797.298243158143;7269.7455589054125;7588.203238660082;7608.353289970414;7671.2712292332135;7739.613019349123;6016.308124565731;6184.474319682878;6202.7208775606105;6208;6218.9378106218355;4625.583697467109;4802.375691160127;4860;4880.487548807466;5028.069807085701;4860.1008813369635;4865.440474345495;4949.133901567283;4958.181899986606;4995.650304478797 16:43:22 INFO - PROCESS | 11103 | |4;prototype.html;346.3782510393843;348.4511893767317;353.2131482602268;358.603742864135;362.8167775273487;5218;5381.81163659272;5472.343318801744;5489.835304940853;5517.034518959181;5242.449542798008;5303.204519322104;5318.590573498026;5329.706866122362;5354.839354819362;4221.662267018646;4233.851815186469;4245.554216807237;4258.276093064171;4261.339492378686;4150.294449943517;4196.852360729453;4213.705040647156;4265.360195970598;4276.550962148976;4212.283911735012;4214.6838987075935;4215.662746980234;4224.134052519226;4227.788610569459;4181.916361672765;4205.957940420587;4209.2633789086785;4236.364545318196;4242;3779.5653499847595;3805.162864169878;3807.5240594925635;3814.1608846053823;3817.4464702617965;5013.448520662724;5227.712475813829;5230.529252367267;5230.790768369261;5307.124324486455;4797.448293446263;4831.637627177941;4840.491748366406;4841.474935395339;4849.199882019462;5362.65142765719;5631.887362252773;5635.6618602883955;5636.689982050985;5641;4061.735987160825;4076.7553946763287;4077.408775727503;4077.796110194508;4095.6313931746286;5727.513161381287;5747.827565173052;5774.2782152230975;5789.478946894757;5804.59367844251;4130.194612050621;4202.571125817176;4210.179015092028;4218.978905105455;4221.535631080578;4219.177260434186;4220.472440944882;4227.682923780729;4249.298865687127;4257.340112282601;4778.522147785194;4787.593054590329;4802.831900883452;4807.158747219292;4817.638677099231;5431.321084864392;5594.384617692051;5619.7471113799975;5633.971830140823;5667.263255776723;1406.8944829137652;1419.978700319496;1430.470725831449;1432.8208973878266;1434.6126545832567;954.2223088183108;990.2672022703148;990.6087095597198;1000.1548691355938;1004.3572113847143;5253.238280449314;5256.579473642099;5263.631545791758;5304.602154838402;5314.973425132927;5487.518370040067;5518.668879867221;5531.474509921551;5535.391106978229;5557.277553917965;5113.951639913808;5282.894342113136;5296.523312901857;5342.786288548415;5348.625596208228;2940.853067303753;2948.395578906319;2958.393529326483;2959.5412711029826;2961.955570666442;5749;5758.309002919593;5763.827085187368;5764.510016648548;5776.913346299809;5396.730163491889;5613.8596535086135;5614.887702245932;5634.605577609528;5656.971715141481;5716.914246286309;5721.5136713379825;5721.771129154788;5728.398518155534;5734.197212390269;5417.431169727122;5467.17992301158;5524.281843360498;5544.944550554443;5721.112033029173;5688.975984322696;5689.772409103755;5702.857428564319;5711.771529138788;5730.398308177748;5989.341172470938;6000.969995149996;6003.279606447254;6007.789727359522;6030.969845150747;4088.570700076449;4164.3961625564725;4194.2450358935685;4197.895052623709;4214.683898707548;5739.225204597493;5743.4543718346695;5749.195112684144;5757.675734581154;5772.826815195551;5404.513593776422;5596.776128954796;5628.240187574789;5641.182028605911;5657.349404818498;5595.860103497445;5601.831945041656;5604.215409842707;5614.831555053355;5632.282153943087;5550.69471179089;5571.275734154534;5577.721113944205;5577.776888924398;5591.440855914539;5407.891842163213;5600.551955843442;5617.550595952396;5624.3250809903075;5653.689047102449;5472.288602481652;5480.3971563127225;5526.834194974157;5534.667919924817;5538.335399752055 16:43:22 INFO - PROCESS | 11103 | |5;yui.html;789.1634867040937;791.7545560876125;802.3140215116075;869.9608517616707;900.5137225898015;13662.043656944006;15899.52301430956;16330.83669163308;16523.421680241194;16559.83440165598;15536.922315388407;15768.526944191664;15916.04503729777;16780.160991950383;17004.574885627866;864.2826454043129;885.1679421343948;886.0297973718767;887.2591386192537;888.6845169964666;726.4878260826131;739.6449704142015;853.714005808055;876.548577482597;880.7181701855409;914.4147745442922;918.7657147427396;919.9264058875308;920.995395023024;921;915.1351972386097;915.8855143107112;916.7158180963922;916.9954150229206;917.0783362720457;673.8551211489553;674.1236392689533;678.2742465561851;678.328454829715;679.022208020454;15378.769318460232;15644.687106257925;15664.373425063097;15690.921545392313;15780.526584202493;14206.85793142076;14435.061720988208;14587.635309117357;14660.340284687214;14801.629959250997;12152.57465988695;12192.51229950801;12235.265884046898;12259.69350766229;12331.815022774666;3864.4976153100197;3884.6698030667426;3899.74651647642;3973.4238535412205;3989.3018721723583;64649.353506465275;64908.3509164907;65286.3471365285;65321.34678653248;65834.67082664555;11252.15608829341;11298.209125361145;11449.771004579861;11523.71190720222;11745.412729363497;17644.647107057786;17653;17686.823131768517;17790.644187116442;17823.910880445776;7909.841803163905;8025.438219324591;8147.103818579952;8460.8730869037;8492.617832197566;4491.595756381876;4503;4612.0545288215835;4704;4920.065187614342;3384.983075084609;3502.2295095079044;3503.8948831535095;3504.5794504659602;3512.1746389598425;614.2812908896602;621.9751209951552;622.4366947912147;635.6186288227027;635.9141515895295;689.396777819408;690.9550879192836;691.2914262880588;715.903353047332;720.8089856188114;8995.460272383678;9181.724548263563;9483.762905927408;9642.614295428244;9738;626.962382257066;667.8712975072112;689.6241548356057;692.5636848785233;706.036260504418;4333.1766964276685;4349.608535231844;4424.60178583929;4463;4471.35165401015;90544;93176;94304.52847735854;98194.5090274544;99020.50489747505;80953;82418.58790706008;83854;84245;85178.57410712907;72552;73363.63318183481;73811.63094184495;74367;78299.60850195827;8491.448055876348;8630.956845215986;8654.82690346202;8674;8732.95204575455;50307.74846125746;50421.49578504168;51254.487455126466;51383;52001.739991301314;63539.800103532696;69433.30566694269;70411.64794175996;70749.64625176841;70953.64523177558;10557.419341936267;10800.567977281135;10828.945855270988;10876.728081798019;11182.720431989266;12261.38693065361;12750.553730619384;12828.486860525474;12849.807252891402;13543.390547425586;11469.254498457574;11817.054635628958;11876.821847672465;11877.049836013271;12140.817887731868;11279.718007049889;11305.378204198849;11528.481218345027;11611.6516504505;12221.083418743807;11610.12924030718;11694.649160525198;11732.648020559396;11772.411379430823;12271.631851044483;9880.802383952425;9917.45454000037;10060.39637621745;10426.68719938403;10520.579176832842;9260.259179265508;9969.202463803023;10034.09693127622;10085.899141008496;10094.495275236355 16:43:22 INFO - PROCESS | 11103 | __end_tp_report 16:43:22 INFO - PROCESS | 11103 | __start_cc_report 16:43:22 INFO - PROCESS | 11103 | _x_x_mozilla_cycle_collect,981 16:43:22 INFO - PROCESS | 11103 | __end_cc_report 16:43:22 INFO - PROCESS | 11103 | __startTimestamp1485305002851__endTimestamp 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | ------- Summary: start ------- 16:43:22 INFO - PROCESS | 11103 | Number of tests: 6 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | [#0] dojo.html Cycles:165 Average:5489.67 Median:5733.34 stddev:623.90 (10.9%) stddev-sans-first:597.25 16:43:22 INFO - PROCESS | 11103 | Values: 3110.4 3118.4 3147.0 3158.7 3169.2 5306.8 5403.3 5406.3 5411.4 5417.0 5412.2 5427.7 5434.9 5442.9 5445.4 4909.5 4975.8 5016.9 5039.0 5052.7 4923.6 4953.1 5004.1 5058.8 5100.5 4976.2 5023.1 5041.0 5042.2 5081.9 5071.5 5108.2 5118.4 5123.8 5154.6 4883.6 4923.1 5003.6 5026.8 5071.8 5345.9 5368.9 5384.1 5410.4 5414.8 5804.3 5833.2 5845.7 5846.6 5848.5 5798.4 5878.7 5906.9 5914.1 5928.5 5446.8 5479.1 5481.8 5535.1 5543.5 6001.5 6053.1 6053.7 6058.2 6059.4 5666.3 5821.9 5822.9 5827.3 5831.9 5781.1 5815.0 5815.6 5840.8 5948.7 5876.7 5910.2 5914.5 5914.8 5924.8 5931.1 5932.5 5933.2 5934.5 5962.4 4429.1 4471.5 4557.0 4558.4 4593.6 4099.9 4115.6 4125.9 4134.2 4142.4 5657.8 5662.3 5673.5 5673.7 5676.1 5813.1 5856.6 5936.2 5949.6 5955.1 5764.9 5772.2 5775.9 5778.3 5803.7 5163.9 5185.7 5195.3 5203.8 5240.6 5984.7 6000.9 6034.3 6252.7 6306.5 5831.6 5938.3 5939.1 5951.7 5975.1 6116.9 6124.3 6129.6 6133.1 6155.0 5652.0 5709.1 5721.1 5750.0 5818.0 5880.7 5939.4 5992.0 5999.6 6021.0 5823.8 5837.2 5837.9 5843.5 5844.5 5598.3 5658.1 5826.7 5827.2 5830.7 5714.8 5733.3 5777.7 5839.5 5859.4 5809.2 5864.5 5869.7 5879.6 5884.3 5574.4 5576.9 5627.7 5680.8 5710.6 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | [#1] ext.html Cycles:180 Average:61162.95 Median:37355.72 stddev:120575.39 (322.8%) stddev-sans-first:120827.82 16:43:22 INFO - PROCESS | 11103 | Values: 574.9 602.9 618.5 660.6 666.3 33349.3 47432.8 48302.8 48540.0 48561.3 48705.8 49275.5 49316.0 49361.0 49374.8 8287.3 8946.9 9122.3 9152.0 9172.2 8329.9 10686.5 10895.2 10925.7 11278.9 11121.2 11181.8 11184.7 11188.9 11196.6 10984.1 11022.1 11032.7 11044.9 11053.4 10840.3 10900.6 10945.7 10951.7 10953.2 46141.5 46562.5 46620.3 46645.3 46659.8 3509.5 3518.9 3578.3 3579.1 3818.1 33854.5 33889.0 33965.0 34007.7 34157.0 4360.5 4444.4 4480.6 4487.0 4572.5 362405.0 364777.0 365600.0 365627.0 366559.0 39022.6 64290.0 64639.4 64839.4 64902.0 39984.8 41681.8 42113.4 42167.8 42252.2 16356.1 16651.9 16687.4 16689.3 16691.1 11681.7 11898.2 13072.2 13423.6 13679.9 9445.6 9557.0 9676.3 9700.6 9720.6 3577.5 3603.2 3613.2 3650.3 3668.5 1061.1 1067.2 1071.1 1073.7 1196.0 33527.8 33585.8 33600.3 33656.5 34002.8 1130.5 1163.1 1173.5 1238.4 1256.0 17465.7 17744.1 17799.0 17800.6 17816.0 553541.0 554918.0 554964.5 555065.0 555848.0 63437.0 63626.7 63837.0 63837.7 63943.4 1318.1 1328.1 1404.7 1413.5 1449.5 32592.3 34032.3 34917.8 35288.1 35348.6 54931.5 55378.0 55503.7 55522.2 55621.4 405019.0 405123.0 406233.0 407285.0 486217.0 26436.7 30224.2 30533.8 31122.0 32241.8 46998.8 47566.0 47583.0 47981.3 48326.5 42320.4 42443.8 42465.2 42703.0 44284.1 40483.8 40939.0 41536.4 42672.0 43060.8 42335.6 42436.0 43661.1 43923.8 44080.8 34366.5 36907.0 37804.4 37932.9 37934.8 28173.0 28267.7 28296.9 28646.0 30769.7 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | [#2] jquery.html Cycles:180 Average:28637.88 Median:2498.56 stddev:78686.09 (3149.3%) stddev-sans-first:78878.28 16:43:22 INFO - PROCESS | 11103 | Values: 406.8 420.1 420.8 422.7 432.1 19233.1 19638.7 20490.7 20528.3 20724.5 18950.3 19000.8 20399.8 21129.9 21280.8 5842.3 6069.1 6073.8 6074.1 6074.3 5794.0 5926.2 6008.1 6025.3 6067.0 6135.1 6136.0 6142.1 6150.8 6155.2 5956.3 6064.3 6120.6 6124.1 6140.9 5954.8 5962.7 5964.1 5966.3 5970.9 14819.3 15210.8 22648.8 23481.3 23575.0 2337.9 2441.9 2490.8 2506.3 2911.0 10611.3 10769.3 10938.0 11183.6 11376.9 1946.0 1961.6 2072.9 2073.0 2227.3 81164.0 83959.0 84716.6 86594.6 86926.0 11293.8 11636.4 11764.7 11797.4 12119.9 16745.2 17176.8 17228.7 17241.8 17488.5 6999.5 7235.8 8230.3 8511.3 8881.9 8085.4 8224.3 8325.6 8481.3 8806.1 4999.4 5102.7 5111.7 5114.3 5253.4 2037.2 2043.6 2134.9 2159.8 2173.6 930.5 1016.4 1040.7 1044.3 1068.3 19428.7 20117.2 20248.6 20327.1 20518.4 1003.7 1014.7 1023.3 1037.7 1044.9 10450.7 11158.4 11364.1 11445.2 11595.3 470423.0 475777.0 476976.0 479829.0 480947.0 87817.0 87850.0 88698.0 88968.0 92059.5 1000.6 1066.3 1082.9 1092.4 1101.1 17335.2 17618.2 18011.6 18043.9 18230.2 39855.8 40696.6 41019.6 41103.2 42216.8 56427.4 57320.7 57388.1 58124.0 59280.4 9059.9 9083.6 9171.1 9533.5 9557.4 7147.7 9879.8 11244.9 12352.9 12488.1 10843.2 10968.4 10980.2 11324.4 11341.1 9932.5 10190.7 10607.6 10608.4 10895.7 6040.5 7468.8 11058.7 11153.4 11455.3 9107.6 9135.7 9195.4 9217.4 9265.8 8743.9 10695.8 10932.6 10992.5 11180.2 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | [#3] mootools.html Cycles:180 Average:5722.49 Median:4902.35 stddev:3263.70 (66.6%) stddev-sans-first:3256.72 16:43:22 INFO - PROCESS | 11103 | Values: 1404.7 1529.9 1541.5 1737.5 1822.4 7763.5 8260.3 8789.2 8949.5 8998.9 8713.8 8747.7 8752.0 8762.3 8764.0 2384.9 2407.4 2409.3 2409.7 2410.8 2395.4 2427.9 2472.2 2472.4 2473.3 2413.6 2415.1 2439.3 2444.2 2444.4 2344.8 2378.0 2381.6 2395.4 2398.6 2370.1 2376.6 2395.9 2396.1 2396.8 8513.0 8593.0 8595.7 8599.2 8834.2 5188.6 5256.9 5293.9 5295.9 5326.3 3280.2 3383.5 3483.2 3498.7 3509.0 1105.2 1109.9 1118.7 1130.3 1139.9 12392.3 12394.5 12399.3 12436.1 12459.1 4495.5 4575.8 4636.4 4644.3 4655.1 9885.1 9887.3 9887.5 9888.9 9890.6 5379.7 5394.6 5397.8 5398.7 5398.8 4209.6 4408.1 4422.2 4434.9 4924.2 3864.1 3916.1 4014.6 4023.6 4031.9 1159.2 1166.6 1180.9 1181.1 1182.2 848.2 886.6 903.1 923.7 947.6 5386.7 5608.4 5635.3 5878.4 5904.1 914.3 937.1 938.6 944.4 999.0 3695.4 3731.7 3846.5 3896.9 3948.2 10531.0 10910.3 10951.2 10962.6 10981.3 10822.4 10843.8 10867.9 10871.7 10897.9 7957.5 8199.3 8422.0 8453.6 8465.6 5484.7 5566.4 5693.1 5771.9 5775.5 9833.7 10157.8 10163.9 10193.9 10245.4 9674.3 9844.4 9916.1 10238.0 10374.6 7558.1 7623.6 7883.8 7987.9 7998.5 8426.3 8479.4 8491.6 8495.7 8500.0 7643.2 7646.5 7677.8 7796.2 7797.3 7269.7 7588.2 7608.4 7671.3 7739.6 6016.3 6184.5 6202.7 6208.0 6218.9 4625.6 4802.4 4860.0 4880.5 5028.1 4860.1 4865.4 4949.1 4958.2 4995.7 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | [#4] prototype.html Cycles:180 Average:4711.52 Median:5345.71 stddev:1356.64 (25.4%) stddev-sans-first:1320.29 16:43:22 INFO - PROCESS | 11103 | Values: 346.4 348.5 353.2 358.6 362.8 5218.0 5381.8 5472.3 5489.8 5517.0 5242.4 5303.2 5318.6 5329.7 5354.8 4221.7 4233.9 4245.6 4258.3 4261.3 4150.3 4196.9 4213.7 4265.4 4276.6 4212.3 4214.7 4215.7 4224.1 4227.8 4181.9 4206.0 4209.3 4236.4 4242.0 3779.6 3805.2 3807.5 3814.2 3817.4 5013.4 5227.7 5230.5 5230.8 5307.1 4797.4 4831.6 4840.5 4841.5 4849.2 5362.7 5631.9 5635.7 5636.7 5641.0 4061.7 4076.8 4077.4 4077.8 4095.6 5727.5 5747.8 5774.3 5789.5 5804.6 4130.2 4202.6 4210.2 4219.0 4221.5 4219.2 4220.5 4227.7 4249.3 4257.3 4778.5 4787.6 4802.8 4807.2 4817.6 5431.3 5594.4 5619.7 5634.0 5667.3 1406.9 1420.0 1430.5 1432.8 1434.6 954.2 990.3 990.6 1000.2 1004.4 5253.2 5256.6 5263.6 5304.6 5315.0 5487.5 5518.7 5531.5 5535.4 5557.3 5114.0 5282.9 5296.5 5342.8 5348.6 2940.9 2948.4 2958.4 2959.5 2962.0 5749.0 5758.3 5763.8 5764.5 5776.9 5396.7 5613.9 5614.9 5634.6 5657.0 5716.9 5721.5 5721.8 5728.4 5734.2 5417.4 5467.2 5524.3 5544.9 5721.1 5689.0 5689.8 5702.9 5711.8 5730.4 5989.3 6001.0 6003.3 6007.8 6031.0 4088.6 4164.4 4194.2 4197.9 4214.7 5739.2 5743.5 5749.2 5757.7 5772.8 5404.5 5596.8 5628.2 5641.2 5657.3 5595.9 5601.8 5604.2 5614.8 5632.3 5550.7 5571.3 5577.7 5577.8 5591.4 5407.9 5600.6 5617.6 5624.3 5653.7 5472.3 5480.4 5526.8 5534.7 5538.3 16:43:22 INFO - PROCESS | 11103 | 16:43:22 INFO - PROCESS | 11103 | [#5] yui.html Cycles:180 Average:18624.05 Median:26308.01 stddev:25595.25 (97.3%) stddev-sans-first:25632.02 16:43:22 INFO - PROCESS | 11103 | Values: 789.2 791.8 802.3 870.0 900.5 13662.0 15899.5 16330.8 16523.4 16559.8 15536.9 15768.5 15916.0 16780.2 17004.6 864.3 885.2 886.0 887.3 888.7 726.5 739.6 853.7 876.5 880.7 914.4 918.8 919.9 921.0 921.0 915.1 915.9 916.7 917.0 917.1 673.9 674.1 678.3 678.3 679.0 15378.8 15644.7 15664.4 15690.9 15780.5 14206.9 14435.1 14587.6 14660.3 14801.6 12152.6 12192.5 12235.3 12259.7 12331.8 3864.5 3884.7 3899.7 3973.4 3989.3 64649.4 64908.4 65286.3 65321.3 65834.7 11252.2 11298.2 11449.8 11523.7 11745.4 17644.6 17653.0 17686.8 17790.6 17823.9 7909.8 8025.4 8147.1 8460.9 8492.6 4491.6 4503.0 4612.1 4704.0 4920.1 3385.0 3502.2 3503.9 3504.6 3512.2 614.3 622.0 622.4 635.6 635.9 689.4 691.0 691.3 715.9 720.8 8995.5 9181.7 9483.8 9642.6 9738.0 627.0 667.9 689.6 692.6 706.0 4333.2 4349.6 4424.6 4463.0 4471.4 90544.0 93176.0 94304.5 98194.5 99020.5 80953.0 82418.6 83854.0 84245.0 85178.6 72552.0 73363.6 73811.6 74367.0 78299.6 8491.4 8631.0 8654.8 8674.0 8733.0 50307.7 50421.5 51254.5 51383.0 52001.7 63539.8 69433.3 70411.6 70749.6 70953.6 10557.4 10800.6 10828.9 10876.7 11182.7 12261.4 12750.6 12828.5 12849.8 13543.4 11469.3 11817.1 11876.8 11877.0 12140.8 11279.7 11305.4 11528.5 11611.7 12221.1 11610.1 11694.6 11732.6 11772.4 12271.6 9880.8 9917.5 10060.4 10426.7 10520.6 9260.3 9969.2 10034.1 10085.9 10094.5 16:43:22 INFO - PROCESS | 11103 | -------- Summary: end -------- 16:43:22 INFO - PROCESS | 11103 | 16:43:23 INFO - TEST-INFO | 11103: exit 0 16:43:23 INFO - TEST-OK | dromaeo_css | took 1113569ms 16:43:23 INFO - TEST-START | kraken 16:43:23 INFO - operating with platform_type : linux_ 16:43:23 INFO - Initialising browser for kraken test... 16:43:23 INFO - TEST-INFO | started process 11402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp333KQN/profile http://localhost:49953/getInfo.html) 16:43:27 INFO - PROCESS | 11402 | __metrics Screen width/height:1600/1200 16:43:27 INFO - PROCESS | 11402 | colorDepth:24 16:43:27 INFO - PROCESS | 11402 | Browser inner width/height: 1024/697 16:43:27 INFO - PROCESS | 11402 | __metrics 16:43:28 INFO - PROCESS | 11402 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:43:28 INFO - PROCESS | 11402 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:43:28 INFO - PROCESS | 11402 | console.error: PushService: 16:43:28 INFO - PROCESS | 11402 | stateChangeProcessEnqueue: Error transitioning state 16:43:28 INFO - PROCESS | 11402 | UnknownError 16:43:29 INFO - TEST-INFO | 11402: exit 0 16:43:29 INFO - Browser initialized. 16:43:29 INFO - Running cycle 1/1 for kraken test... 16:43:29 INFO - TEST-INFO | started process 11494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp333KQN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:41 INFO - PROCESS | 11494 | RSS: Main: 141856768 16:43:41 INFO - PROCESS | 11494 | 16:43:43 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49953/tests/kraken/driver.html?testName=audio-beat-detection) 16:43:44 INFO - PROCESS | 11494 | RSS: Main: 183328768 16:43:44 INFO - PROCESS | 11494 | 16:43:47 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49953/tests/kraken/driver.html?testName=audio-dft) 16:43:47 INFO - PROCESS | 11494 | RSS: Main: 173445120 16:43:47 INFO - PROCESS | 11494 | 16:43:50 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49953/tests/kraken/driver.html?testName=audio-fft) 16:43:51 INFO - PROCESS | 11494 | RSS: Main: 265035776 16:43:51 INFO - PROCESS | 11494 | 16:43:53 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49953/tests/kraken/driver.html?testName=audio-oscillator) 16:43:53 INFO - PROCESS | 11494 | RSS: Main: 171188224 16:43:53 INFO - PROCESS | 11494 | 16:43:55 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49953/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:43:56 INFO - PROCESS | 11494 | RSS: Main: 173875200 16:43:56 INFO - PROCESS | 11494 | 16:43:59 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49953/tests/kraken/driver.html?testName=imaging-darkroom) 16:43:59 INFO - PROCESS | 11494 | RSS: Main: 211730432 16:43:59 INFO - PROCESS | 11494 | 16:44:03 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49953/tests/kraken/driver.html?testName=imaging-desaturate) 16:44:03 INFO - PROCESS | 11494 | RSS: Main: 210321408 16:44:03 INFO - PROCESS | 11494 | 16:44:06 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49953/tests/kraken/driver.html?testName=json-parse-financial) 16:44:07 INFO - PROCESS | 11494 | RSS: Main: 208961536 16:44:07 INFO - PROCESS | 11494 | 16:44:08 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49953/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:44:09 INFO - PROCESS | 11494 | RSS: Main: 171102208 16:44:09 INFO - PROCESS | 11494 | 16:44:10 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:44:11 INFO - PROCESS | 11494 | RSS: Main: 177721344 16:44:11 INFO - PROCESS | 11494 | 16:44:13 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:14 INFO - PROCESS | 11494 | RSS: Main: 187711488 16:44:14 INFO - PROCESS | 11494 | 16:44:16 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:17 INFO - PROCESS | 11494 | RSS: Main: 195219456 16:44:17 INFO - PROCESS | 11494 | 16:44:20 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:20 INFO - PROCESS | 11494 | RSS: Main: 192651264 16:44:20 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | Cycle 1(1): loaded http://localhost:49953/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49953/tests/kraken/driver.html?testName=ai-astar) 16:44:22 INFO - PROCESS | 11494 | RSS: Main: 243740672 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | __start_tp_report 16:44:22 INFO - PROCESS | 11494 | _x_x_mozilla_page_load 16:44:22 INFO - PROCESS | 11494 | _x_x_mozilla_page_load_details 16:44:22 INFO - PROCESS | 11494 | |i|pagename|runs| 16:44:22 INFO - PROCESS | 11494 | |0;ai-astar;100;113;111;112;113;111;113;110;111;112 16:44:22 INFO - PROCESS | 11494 | |1;audio-beat-detection;141;118;119;154;127;124;123;119;163;123 16:44:22 INFO - PROCESS | 11494 | |2;audio-dft;161;161;160;161;160;161;159;163;161;160 16:44:22 INFO - PROCESS | 11494 | |3;audio-fft;74;76;76;109;75;75;76;75;97;76 16:44:22 INFO - PROCESS | 11494 | |4;audio-oscillator;82;82;118;82;82;82;97;81;81;103 16:44:22 INFO - PROCESS | 11494 | |5;imaging-gaussian-blur;116;117;117;116;117;116;116;117;117;116 16:44:22 INFO - PROCESS | 11494 | |6;imaging-darkroom;146;146;146;146;147;146;146;147;146;146 16:44:22 INFO - PROCESS | 11494 | |7;imaging-desaturate;84;85;85;85;85;85;84;84;84;84 16:44:22 INFO - PROCESS | 11494 | |8;json-parse-financial;51;52;50;51;51;50;51;53;51;51 16:44:22 INFO - PROCESS | 11494 | |9;json-stringify-tinderbox;60;60;60;69;60;60;59;61;60;60 16:44:22 INFO - PROCESS | 11494 | |10;stanford-crypto-aes;75;75;80;74;80;74;82;77;74;74 16:44:22 INFO - PROCESS | 11494 | |11;stanford-crypto-ccm;126;123;132;129;125;121;124;120;164;122 16:44:22 INFO - PROCESS | 11494 | |12;stanford-crypto-pbkdf2;153;158;158;155;155;153;156;157;156;157 16:44:22 INFO - PROCESS | 11494 | |13;stanford-crypto-sha256-iterative;65;62;62;63;63;64;61;61;62;61 16:44:22 INFO - PROCESS | 11494 | __end_tp_report 16:44:22 INFO - PROCESS | 11494 | __start_cc_report 16:44:22 INFO - PROCESS | 11494 | _x_x_mozilla_cycle_collect,1610 16:44:22 INFO - PROCESS | 11494 | __end_cc_report 16:44:22 INFO - PROCESS | 11494 | __startTimestamp1485305062477__endTimestamp 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | ------- Summary: start ------- 16:44:22 INFO - PROCESS | 11494 | Number of tests: 14 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.86 (3.5%) stddev-sans-first:1.09 16:44:22 INFO - PROCESS | 11494 | Values: 100.0 113.0 111.0 112.0 113.0 111.0 113.0 110.0 111.0 112.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:125.50 stddev:16.00 (12.7%) stddev-sans-first:16.56 16:44:22 INFO - PROCESS | 11494 | Values: 141.0 118.0 119.0 154.0 127.0 124.0 123.0 119.0 163.0 123.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 16:44:22 INFO - PROCESS | 11494 | Values: 161.0 161.0 160.0 161.0 160.0 161.0 159.0 163.0 161.0 160.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:12.00 (15.8%) stddev-sans-first:12.47 16:44:22 INFO - PROCESS | 11494 | Values: 74.0 76.0 76.0 109.0 75.0 75.0 76.0 75.0 97.0 76.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:12.80 (15.6%) stddev-sans-first:13.32 16:44:22 INFO - PROCESS | 11494 | Values: 82.0 82.0 118.0 82.0 82.0 82.0 97.0 81.0 81.0 103.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:44:22 INFO - PROCESS | 11494 | Values: 116.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 116.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 16:44:22 INFO - PROCESS | 11494 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 16:44:22 INFO - PROCESS | 11494 | Values: 84.0 85.0 85.0 85.0 85.0 85.0 84.0 84.0 84.0 84.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.88 (1.7%) stddev-sans-first:0.93 16:44:22 INFO - PROCESS | 11494 | Values: 51.0 52.0 50.0 51.0 51.0 50.0 51.0 53.0 51.0 51.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:60.00 stddev:2.88 (4.8%) stddev-sans-first:3.04 16:44:22 INFO - PROCESS | 11494 | Values: 60.0 60.0 60.0 69.0 60.0 60.0 59.0 61.0 60.0 60.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:3.06 (4.0%) stddev-sans-first:3.20 16:44:22 INFO - PROCESS | 11494 | Values: 75.0 75.0 80.0 74.0 80.0 74.0 82.0 77.0 74.0 74.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:125.50 stddev:12.96 (10.3%) stddev-sans-first:13.72 16:44:22 INFO - PROCESS | 11494 | Values: 126.0 123.0 132.0 129.0 125.0 121.0 124.0 120.0 164.0 122.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.80 Median:156.50 stddev:1.81 (1.2%) stddev-sans-first:1.62 16:44:22 INFO - PROCESS | 11494 | Values: 153.0 158.0 158.0 155.0 155.0 153.0 156.0 157.0 156.0 157.0 16:44:22 INFO - PROCESS | 11494 | 16:44:22 INFO - PROCESS | 11494 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.35 (2.2%) stddev-sans-first:1.05 16:44:22 INFO - PROCESS | 11494 | Values: 65.0 62.0 62.0 63.0 63.0 64.0 61.0 61.0 62.0 61.0 16:44:22 INFO - PROCESS | 11494 | -------- Summary: end -------- 16:44:22 INFO - PROCESS | 11494 | 16:44:23 INFO - TEST-INFO | 11494: exit 0 16:44:23 INFO - TEST-OK | kraken | took 60020ms 16:44:23 INFO - SUITE-END | took 1173s 16:44:24 INFO - Completed test suite (00:19:34) 16:44:24 INFO - javascript benchmark 16:44:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3110.440120778259, 3118.438681037413, 3146.999999999999, 3158.7157155855966, 3169.1918560767, 5306.761195746191, 5403.297571315728, 5406.297181366422, 5411.431799661038, 5416.972915135419, 5412.242286079952, 5427.728613569326, 5434.945650543494, 5442.8911421771545, 5445.401005889349, 4909.459959404471, 4975.751212439382, 5016.924746128792, 5039.0425819094435, 5052.722100284483, 4923.58149557288, 4953.133201689708, 5004.124278251292, 5058.822941197059, 5100.489951004907, 4976.178930476467, 5023.120953833083, 5040.974795126038, 5042.218456139286, 5081.949180508184, 5071.518205770446, 5108.20822772469, 5118.436971933084, 5123.846284611468, 5154.587632989352, 4883.609311255091, 4923.138450771101, 5003.649744517885, 5026.849194524134, 5071.771770270347, 5345.893082138336, 5368.946310536884, 5384.0847056000575, 5410.431904650034, 5414.7834086636485, 5804.303483581997, 5833.2416785817995, 5845.707714614252, 5846.561507886926, 5848.473637372615, 5798.362180160179, 5878.706064696748, 5906.881862362771, 5914.053751399799, 5928.525717942597, 5446.782128714846, 5479.068558345091, 5481.808136715196, 5535.11438169899, 5543.52880005204, 6001.5198784097165, 6053.122297266872, 6053.697315134225, 6058.1518587397795, 6059.424354686298, 5666.34836993751, 5821.88356232873, 5822.854428639233, 5827.3007239131575, 5831.854203644943, 5781.075027995501, 5815.0, 5815.592908496449, 5840.766369345263, 5948.702564871739, 5876.706164691748, 5910.172575839386, 5914.497267732205, 5914.822555323347, 5924.763009479572, 5931.11033344993, 5932.525397968152, 5933.199018132497, 5934.525237980951, 5962.37395073511, 4429.069895322018, 4471.530489298641, 4557.043020965568, 4558.361829343895, 4593.609543188866, 4099.938500922489, 4115.588441155861, 4125.91748165035, 4134.193832202752, 4142.420061191436, 5657.8019769307875, 5662.348829884616, 5673.489385955201, 5673.687947162945, 5676.120201368794, 5813.09896965971, 5856.59003869725, 5936.22829032223, 5949.613275137102, 5955.106733989936, 5764.884702305931, 5772.163036359789, 5775.884482310415, 5778.306603207558, 5803.709814509258, 5163.948360516347, 5185.662931909414, 5195.272661827347, 5203.8178663746585, 5240.633155679066, 5984.73068711909, 6000.939990600213, 6034.275886893601, 6252.6873656317, 6306.463950564162, 5831.562632802472, 5938.257717785277, 5939.07944268639, 5951.672658003851, 5975.133605627073, 6116.938830611637, 6124.265088189446, 6129.632222066691, 6133.141360209664, 6154.969225153845, 5652.0, 5709.115087161496, 5721.056025755704, 5750.0, 5817.970910145422, 5880.735366908585, 5939.435753603573, 5992.0, 5999.5500337473995, 6021.0, 5823.767049317979, 5837.211976383303, 5837.94162058374, 5843.503302219359, 5844.47399734026, 5598.300212473441, 5658.122990936411, 5826.70866456684, 5827.24245848037, 5830.679312637845, 5714.771409143754, 5733.3406658234835, 5777.653340799566, 5839.532837373085, 5859.384764599826, 5809.24479817621, 5864.530837533072, 5869.6771677556435, 5879.617824841372, 5884.293884733859, 5574.414686458026, 5576.888462230814, 5627.7467513961155, 5680.829575112753, 5710.600257982068], "value": 5447.210424892658, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.893644675735, 602.8975074237379, 618.5268269773621, 660.5772305724337, 666.3436515032689, 33349.33301333975, 47432.762836185815, 48302.75848620752, 48540.0, 48561.27158092632, 48705.756471217595, 49275.50724492754, 49316.0, 49361.0, 49374.75312623432, 8287.337013038972, 8946.910530894706, 9122.315826313054, 9152.0, 9172.220361269267, 8329.916700832975, 10686.465676716172, 10895.182861285435, 10925.726856828564, 11278.887211127865, 11121.165912556591, 11181.776364472706, 11184.664460066211, 11188.944055279753, 11196.608118715847, 10984.121270298358, 11022.063124634416, 11032.724181895437, 11044.889551104467, 11053.392063436508, 10840.349579025284, 10900.618478353219, 10945.726356841144, 10951.671449856518, 10953.17851161158, 46141.53858461406, 46562.534374656156, 46620.3006954896, 46645.30032049522, 46659.83350416233, 3509.4560343146854, 3518.9120271993147, 3578.2664553766676, 3579.0873327301633, 3818.102745854722, 33854.49218261728, 33889.0, 33965.0, 34007.65992340069, 34157.0, 4360.498542667602, 4444.355568442557, 4480.6191473724775, 4486.967997360625, 4572.474165470981, 362405.0, 364777.0, 365600.0, 365627.0, 366559.0, 39022.609773901895, 64290.0, 64639.353606464276, 64839.35160648428, 64902.0, 39984.800076000014, 41681.79159104185, 42113.36829947553, 42167.789161053995, 42252.15495690131, 16356.100414477318, 16651.91674041622, 16687.415940442028, 16689.33242670304, 16691.08199049064, 11681.707957301136, 11898.167128300936, 13072.150310229805, 13423.597292081253, 13679.931600342134, 9445.574949127305, 9556.95221523888, 9676.274279429072, 9700.6119755209, 9720.562574684156, 3577.499150118985, 3603.2253065591026, 3613.1509095362567, 3650.2699460108083, 3668.4680721295263, 1061.0874647802884, 1067.1569460126414, 1071.1056268016139, 1073.7315671082229, 1195.9581414650445, 33527.832360838525, 33585.83207083949, 33600.327993440485, 33656.49515257273, 34002.82998585041, 1130.463030060731, 1163.1218430085232, 1173.4895320535595, 1238.448890243833, 1256.0265794009715, 17465.650686986188, 17744.11279436023, 17799.0, 17800.55498612545, 17816.0, 553541.0, 554918.0, 554964.4503554994, 555065.0, 555848.0, 63437.0, 63626.68186659037, 63837.0, 63837.680811595645, 63943.36056639467, 1318.0575888239955, 1328.110166188656, 1404.7190561887664, 1413.4982081361175, 1449.543393830961, 32592.34815303728, 34032.31935361328, 34917.825410872785, 35288.11779705528, 35348.646513534535, 54931.45068549423, 55378.0, 55503.72248138733, 55522.16716749171, 55621.44378556324, 405019.0, 405123.0, 406233.0, 407285.0, 486217.0, 26436.735632644195, 30224.244393890327, 30533.847330763205, 31122.0, 32241.838790805898, 46998.76500617475, 47566.0, 47583.0, 47981.280280795116, 48326.5167348322, 42320.365194522725, 42443.7877810609, 42465.15069698527, 42703.0, 44284.11431771411, 40483.79758101191, 40939.0, 41536.376954345105, 42672.0, 43060.78469607757, 42335.576644233166, 42436.0, 43661.126777463636, 43923.78038109789, 44080.77959610181, 34366.48450273198, 36907.0, 37804.43293350657, 37932.94981154489, 37934.810325948194, 28173.0, 28267.71732282651, 28296.944977607793, 28646.0, 30769.69230307758], "value": 20252.83355626988, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.84539874847553, 420.05906768837815, 420.8001199430271, 422.7167797575624, 432.1076976044468, 19233.134508947096, 19638.705419418704, 20490.692639610417, 20528.281510147146, 20724.48188795281, 18950.336738214166, 19000.809991900078, 20399.796002040013, 21129.894350528226, 21280.787192128075, 5842.32813226478, 6069.089636554508, 6073.817785466421, 6074.149619053336, 6074.271087469509, 5794.0, 5926.170336152942, 6008.128821320905, 6025.3372129065765, 6066.969665151668, 6135.110408990694, 6135.9693201534155, 6142.140100385949, 6150.84622884427, 6155.169052177966, 5956.344802071769, 6064.3329233784025, 6120.602160859575, 6124.081387791823, 6140.907886381708, 5954.821355359303, 5962.70186490678, 5964.075568286879, 5966.343702192756, 5970.880582388328, 14819.259037048105, 15210.771838422432, 22648.77351226483, 23481.29556113302, 23575.0, 2337.8714170720605, 2441.8779061046876, 2490.8256422050463, 2506.2982364937848, 2911.010256512796, 10611.31026483276, 10769.299995500267, 10938.043943146447, 11183.552657893675, 11376.886231137665, 1945.9610807783765, 1961.6174845905055, 2072.89635518225, 2073.02567793137, 2227.2538699535676, 81164.0, 83959.0, 84716.57641711814, 86594.56702716509, 86926.0, 11293.774124517464, 11636.3600001999, 11764.70588235301, 11797.35114568707, 12119.878801212051, 16745.246463909152, 17176.82823171752, 17228.741568876478, 17241.82758172402, 17488.475345739647, 6999.475039372068, 7235.782926512213, 8230.341572674171, 8511.276541493919, 8881.866771998426, 8085.43401961857, 8224.259816616533, 8325.583720813935, 8481.280834399244, 8806.075362087016, 4999.350084488993, 5102.719350435762, 5111.693298402108, 5114.261151208607, 5253.369595648546, 2037.1749441476227, 2043.6280137772794, 2134.903929323184, 2159.762426133124, 2173.6304828179245, 930.4928813796497, 1016.4307987526861, 1040.6929955663097, 1044.300318786415, 1068.2789117345915, 19428.708569371473, 20117.19531218735, 20248.595028099357, 20327.085281162384, 20518.38444846657, 1003.7289931718395, 1014.660088870222, 1023.3143793658267, 1037.7457522906936, 1044.8902865199198, 10450.662974865498, 11158.442077896072, 11364.090872730161, 11445.198836081561, 11595.304281743123, 470423.0, 475777.0, 476976.0, 479829.0, 480947.0, 87817.0, 87850.0, 88698.0, 88968.0, 92059.5397023024, 1000.5997600959529, 1066.3122286125406, 1082.8538147350007, 1092.404639471474, 1101.124605938281, 17335.219915103597, 17618.15873964001, 18011.639767204844, 18043.909780451013, 18230.17964191641, 39855.80072099621, 40696.59303406928, 41019.58980410277, 41103.1779364417, 42216.78891605522, 56427.435725642215, 57320.71339643275, 57388.1391779132, 58124.0, 59280.40719592749, 9059.864102038606, 9083.636654533744, 9171.128742769426, 9533.47565883883, 9557.426554406758, 7147.714091436284, 9879.814422269374, 11244.887551124712, 12352.938235308766, 12488.12583119173, 10843.24097313212, 10968.396738179477, 10980.176486763365, 11324.37715925632, 11341.092712583139, 9932.503374831085, 10190.745231369276, 10607.575696972035, 10608.363498190134, 10895.673129806119, 6040.516758659384, 7468.775936721907, 11058.723531911766, 11153.442327883735, 11455.312681239153, 9107.590158442754, 9135.680251191443, 9195.436775748005, 9217.44695318283, 9265.814683706154, 8743.912560874563, 10695.786084278116, 10932.617358392417, 10992.505337260003, 11180.217384782987], "value": 9354.850968515433, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.6769243074086, 1529.9311530981104, 1541.506717850288, 1737.5048111288277, 1822.3894995176606, 7763.53418794872, 8260.256576908077, 8789.2089711926, 8949.507777072258, 8998.910010899888, 8713.782155446117, 8747.693830715927, 8752.037275899645, 8762.299016078714, 8763.956180219106, 2384.9165279215185, 2407.350015495815, 2409.265174121892, 2409.650600662903, 2410.819188560865, 2395.3652282145244, 2427.9150229741963, 2472.2336075816465, 2472.3819045238693, 2473.332200305916, 2413.553492603865, 2415.130553000918, 2439.3413778279855, 2444.1934161726676, 2444.4133407982044, 2344.812415006795, 2377.95244095118, 2381.6427535869584, 2395.413123784684, 2398.64020396941, 2370.12305446984, 2376.6435034744927, 2395.916142934989, 2396.065534441569, 2396.808255339569, 8512.957435212846, 8593.0, 8595.742127736177, 8599.226069653761, 8834.160754728291, 5188.558972487343, 5256.9474305256845, 5293.947060529384, 5295.920561191585, 5326.307580014612, 3280.1799550112473, 3383.5263063171174, 3483.1988642612087, 3498.737594680409, 3509.0350153707677, 1105.1876870500257, 1109.8834622364698, 1118.725912151528, 1130.2932571816534, 1139.8575178102737, 12392.31842248676, 12394.504219831197, 12399.318037507934, 12436.067294952914, 12459.06557008228, 4495.505494395614, 4575.839845605455, 4636.35091087248, 4644.326572646947, 4655.138799322136, 9885.110340069285, 9887.258455615858, 9887.45618990948, 9888.851667224997, 9890.554925028391, 5379.704116273642, 5394.649347792381, 5397.7571009304675, 5398.73006349681, 5398.757055932492, 4209.5579964103945, 4408.096340250241, 4422.226110430726, 4434.933475997863, 4924.212126059885, 3864.091938394475, 3916.138449541096, 4014.578469260744, 4023.5574086850424, 4031.858884939013, 1159.2001518951897, 1166.585862018988, 1180.9173357864868, 1181.0728578066178, 1182.1724792645182, 848.2026894718945, 886.5833058462641, 903.0969030969031, 923.7413524213231, 947.5783276441917, 5386.676799392049, 5608.439156084359, 5635.323761148688, 5878.353381128072, 5904.0553511437965, 914.3462424366477, 937.1237892570468, 938.596403546468, 944.40502483435, 998.9600415983425, 3695.3902606070237, 3731.6641502264924, 3846.538415390171, 3896.8636097736444, 3948.151147503243, 10531.0, 10910.345379277269, 10951.233413660968, 10962.561497540168, 10981.286216395909, 10822.40476773785, 10843.83734243987, 10867.945660271647, 10871.728206794734, 10897.891021089847, 7957.5225486471, 8199.303059240032, 8422.0, 8453.577321133918, 8465.619047142893, 5484.698341591251, 5566.443355664401, 5693.146028095819, 5771.913421298768, 5775.48020678141, 9833.655822046194, 10157.796844063225, 10163.89836101659, 10193.949030254802, 10245.385276883411, 9674.322797404115, 9844.409335439897, 9916.107550320507, 10238.0, 10374.58501659925, 7558.093028836574, 7623.580703061385, 7883.84232315362, 7987.920120798718, 7998.520088794691, 8426.325893928348, 8479.448835825651, 8491.617877195664, 8495.74512764618, 8500.0, 7643.235676432312, 7646.541207527566, 7677.808054798675, 7796.220377962159, 7797.298243158143, 7269.7455589054125, 7588.203238660082, 7608.353289970414, 7671.2712292332135, 7739.613019349123, 6016.308124565731, 6184.474319682878, 6202.7208775606105, 6208.0, 6218.9378106218355, 4625.583697467109, 4802.375691160127, 4860.0, 4880.487548807466, 5028.069807085701, 4860.1008813369635, 4865.440474345495, 4949.133901567283, 4958.181899986606, 4995.650304478797], "value": 4585.607122761799, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.3782510393843, 348.4511893767317, 353.2131482602268, 358.603742864135, 362.8167775273487, 5218.0, 5381.81163659272, 5472.343318801744, 5489.835304940853, 5517.034518959181, 5242.449542798008, 5303.204519322104, 5318.590573498026, 5329.706866122362, 5354.839354819362, 4221.662267018646, 4233.851815186469, 4245.554216807237, 4258.276093064171, 4261.339492378686, 4150.294449943517, 4196.852360729453, 4213.705040647156, 4265.360195970598, 4276.550962148976, 4212.283911735012, 4214.6838987075935, 4215.662746980234, 4224.134052519226, 4227.788610569459, 4181.916361672765, 4205.957940420587, 4209.2633789086785, 4236.364545318196, 4242.0, 3779.5653499847595, 3805.162864169878, 3807.5240594925635, 3814.1608846053823, 3817.4464702617965, 5013.448520662724, 5227.712475813829, 5230.529252367267, 5230.790768369261, 5307.124324486455, 4797.448293446263, 4831.637627177941, 4840.491748366406, 4841.474935395339, 4849.199882019462, 5362.65142765719, 5631.887362252773, 5635.6618602883955, 5636.689982050985, 5641.0, 4061.735987160825, 4076.7553946763287, 4077.408775727503, 4077.796110194508, 4095.6313931746286, 5727.513161381287, 5747.827565173052, 5774.2782152230975, 5789.478946894757, 5804.59367844251, 4130.194612050621, 4202.571125817176, 4210.179015092028, 4218.978905105455, 4221.535631080578, 4219.177260434186, 4220.472440944882, 4227.682923780729, 4249.298865687127, 4257.340112282601, 4778.522147785194, 4787.593054590329, 4802.831900883452, 4807.158747219292, 4817.638677099231, 5431.321084864392, 5594.384617692051, 5619.7471113799975, 5633.971830140823, 5667.263255776723, 1406.8944829137652, 1419.978700319496, 1430.470725831449, 1432.8208973878266, 1434.6126545832567, 954.2223088183108, 990.2672022703148, 990.6087095597198, 1000.1548691355938, 1004.3572113847143, 5253.238280449314, 5256.579473642099, 5263.631545791758, 5304.602154838402, 5314.973425132927, 5487.518370040067, 5518.668879867221, 5531.474509921551, 5535.391106978229, 5557.277553917965, 5113.951639913808, 5282.894342113136, 5296.523312901857, 5342.786288548415, 5348.625596208228, 2940.853067303753, 2948.395578906319, 2958.393529326483, 2959.5412711029826, 2961.955570666442, 5749.0, 5758.309002919593, 5763.827085187368, 5764.510016648548, 5776.913346299809, 5396.730163491889, 5613.8596535086135, 5614.887702245932, 5634.605577609528, 5656.971715141481, 5716.914246286309, 5721.5136713379825, 5721.771129154788, 5728.398518155534, 5734.197212390269, 5417.431169727122, 5467.17992301158, 5524.281843360498, 5544.944550554443, 5721.112033029173, 5688.975984322696, 5689.772409103755, 5702.857428564319, 5711.771529138788, 5730.398308177748, 5989.341172470938, 6000.969995149996, 6003.279606447254, 6007.789727359522, 6030.969845150747, 4088.570700076449, 4164.3961625564725, 4194.2450358935685, 4197.895052623709, 4214.683898707548, 5739.225204597493, 5743.4543718346695, 5749.195112684144, 5757.675734581154, 5772.826815195551, 5404.513593776422, 5596.776128954796, 5628.240187574789, 5641.182028605911, 5657.349404818498, 5595.860103497445, 5601.831945041656, 5604.215409842707, 5614.831555053355, 5632.282153943087, 5550.69471179089, 5571.275734154534, 5577.721113944205, 5577.776888924398, 5591.440855914539, 5407.891842163213, 5600.551955843442, 5617.550595952396, 5624.3250809903075, 5653.689047102449, 5472.288602481652, 5480.3971563127225, 5526.834194974157, 5534.667919924817, 5538.335399752055], "value": 4284.61770210508, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.1634867040937, 791.7545560876125, 802.3140215116075, 869.9608517616707, 900.5137225898015, 13662.043656944006, 15899.52301430956, 16330.83669163308, 16523.421680241194, 16559.83440165598, 15536.922315388407, 15768.526944191664, 15916.04503729777, 16780.160991950383, 17004.574885627866, 864.2826454043129, 885.1679421343948, 886.0297973718767, 887.2591386192537, 888.6845169964666, 726.4878260826131, 739.6449704142015, 853.714005808055, 876.548577482597, 880.7181701855409, 914.4147745442922, 918.7657147427396, 919.9264058875308, 920.995395023024, 921.0, 915.1351972386097, 915.8855143107112, 916.7158180963922, 916.9954150229206, 917.0783362720457, 673.8551211489553, 674.1236392689533, 678.2742465561851, 678.328454829715, 679.022208020454, 15378.769318460232, 15644.687106257925, 15664.373425063097, 15690.921545392313, 15780.526584202493, 14206.85793142076, 14435.061720988208, 14587.635309117357, 14660.340284687214, 14801.629959250997, 12152.57465988695, 12192.51229950801, 12235.265884046898, 12259.69350766229, 12331.815022774666, 3864.4976153100197, 3884.6698030667426, 3899.74651647642, 3973.4238535412205, 3989.3018721723583, 64649.353506465275, 64908.3509164907, 65286.3471365285, 65321.34678653248, 65834.67082664555, 11252.15608829341, 11298.209125361145, 11449.771004579861, 11523.71190720222, 11745.412729363497, 17644.647107057786, 17653.0, 17686.823131768517, 17790.644187116442, 17823.910880445776, 7909.841803163905, 8025.438219324591, 8147.103818579952, 8460.8730869037, 8492.617832197566, 4491.595756381876, 4503.0, 4612.0545288215835, 4704.0, 4920.065187614342, 3384.983075084609, 3502.2295095079044, 3503.8948831535095, 3504.5794504659602, 3512.1746389598425, 614.2812908896602, 621.9751209951552, 622.4366947912147, 635.6186288227027, 635.9141515895295, 689.396777819408, 690.9550879192836, 691.2914262880588, 715.903353047332, 720.8089856188114, 8995.460272383678, 9181.724548263563, 9483.762905927408, 9642.614295428244, 9738.0, 626.962382257066, 667.8712975072112, 689.6241548356057, 692.5636848785233, 706.036260504418, 4333.1766964276685, 4349.608535231844, 4424.60178583929, 4463.0, 4471.35165401015, 90544.0, 93176.0, 94304.52847735854, 98194.5090274544, 99020.50489747505, 80953.0, 82418.58790706008, 83854.0, 84245.0, 85178.57410712907, 72552.0, 73363.63318183481, 73811.63094184495, 74367.0, 78299.60850195827, 8491.448055876348, 8630.956845215986, 8654.82690346202, 8674.0, 8732.95204575455, 50307.74846125746, 50421.49578504168, 51254.487455126466, 51383.0, 52001.739991301314, 63539.800103532696, 69433.30566694269, 70411.64794175996, 70749.64625176841, 70953.64523177558, 10557.419341936267, 10800.567977281135, 10828.945855270988, 10876.728081798019, 11182.720431989266, 12261.38693065361, 12750.553730619384, 12828.486860525474, 12849.807252891402, 13543.390547425586, 11469.254498457574, 11817.054635628958, 11876.821847672465, 11877.049836013271, 12140.817887731868, 11279.718007049889, 11305.378204198849, 11528.481218345027, 11611.6516504505, 12221.083418743807, 11610.12924030718, 11694.649160525198, 11732.648020559396, 11772.411379430823, 12271.631851044483, 9880.802383952425, 9917.45454000037, 10060.39637621745, 10426.68719938403, 10520.579176832842, 9260.259179265508, 9969.202463803023, 10034.09693127622, 10085.899141008496, 10094.495275236355], "value": 7229.503096443142, "unit": "score"}], "name": "dromaeo_css", "value": 7261.502835099369, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 111.0, 112.0, 113.0, 111.0, 113.0, 110.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 119.0, 154.0, 127.0, 124.0, 123.0, 119.0, 163.0, 123.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 159.0, 163.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 109.0, 75.0, 75.0, 76.0, 75.0, 97.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 118.0, 82.0, 82.0, 82.0, 97.0, 81.0, 81.0, 103.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 50.0, 51.0, 51.0, 50.0, 51.0, 53.0, 51.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 69.0, 60.0, 60.0, 59.0, 61.0, 60.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 80.0, 74.0, 80.0, 74.0, 82.0, 77.0, 74.0, 74.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 123.0, 132.0, 129.0, 125.0, 121.0, 124.0, 120.0, 164.0, 122.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 158.0, 158.0, 155.0, 155.0, 153.0, 156.0, 157.0, 156.0, 157.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 63.0, 63.0, 64.0, 61.0, 61.0, 62.0, 61.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1454.8, "alertThreshold": 2.0}]} 16:44:24 INFO - Return code: 0 16:44:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:44:24 INFO - # TBPL SUCCESS # 16:44:24 INFO - Running post-action listener: _resource_record_post_action 16:44:24 INFO - [mozharness: 2017-01-25 00:44:24.273477Z] Finished run-tests step (success) 16:44:24 INFO - Running post-run listener: _resource_record_post_run 16:44:24 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 330321920; Read time: 0; Write time: 282816 16:44:24 INFO - TinderboxPrint: CPU usage
12.9% 16:44:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:44:24 INFO - TinderboxPrint: I/O write bytes / time
330,321,920 / 282,816 16:44:24 INFO - TinderboxPrint: CPU idle
8,255.4 (87.0%) 16:44:24 INFO - TinderboxPrint: CPU user
1,185.3 (12.5%) 16:44:24 INFO - TinderboxPrint: Swap in / out
0 / 0 16:44:24 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 112590848; Read time: 0; Write time: 80628 16:44:24 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 217731072; Read time: 0; Write time: 202188 16:44:24 INFO - Running post-run listener: _upload_blobber_files 16:44:24 INFO - Blob upload gear active. 16:44:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:44:24 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 16:44:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:44:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:44:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:44:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:44:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:28 INFO - (blobuploader) - INFO - Done attempting. 16:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:29 INFO - (blobuploader) - INFO - Done attempting. 16:44:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:44:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:44:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:44:29 INFO - (blobuploader) - INFO - Done attempting. 16:44:29 INFO - (blobuploader) - INFO - Iteration through files over. 16:44:29 INFO - Return code: 0 16:44:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:44:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:44:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db372f5d9af7ba206ac77cfe6999111ba48beceee5369cc984f3590f853bfe309ce2f4d69b3cadcd36ee7a93ef1427da74c3c67d92aa6350bcb1f61f9d0a4848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec9b7918a345b95712678e5c51e74d76b6d69b6688a37b6d1c20d97b1cd72aeb816c4b88c50a4e86d5f4a2cdb752d093a6b6377c81d8bc4c82c816369d381432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d4d7a49e0409ca52ce723b662f25574c153dcf7ebc8e1df5be864c2ae99c55422a5ebafe52b15a48f3f0f99f6cd07c4149930576273f1670197c402988087d"} 16:44:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:44:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:44:29 INFO - Contents: 16:44:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db372f5d9af7ba206ac77cfe6999111ba48beceee5369cc984f3590f853bfe309ce2f4d69b3cadcd36ee7a93ef1427da74c3c67d92aa6350bcb1f61f9d0a4848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec9b7918a345b95712678e5c51e74d76b6d69b6688a37b6d1c20d97b1cd72aeb816c4b88c50a4e86d5f4a2cdb752d093a6b6377c81d8bc4c82c816369d381432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d4d7a49e0409ca52ce723b662f25574c153dcf7ebc8e1df5be864c2ae99c55422a5ebafe52b15a48f3f0f99f6cd07c4149930576273f1670197c402988087d"} 16:44:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:44:29 INFO - Copying logs to upload dir... 16:44:29 INFO - mkdir: /builds/slave/test/build/upload/logs 16:44:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.764972 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2017-01-24 16:44:29.385892) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 16:44:29.389080) ========= 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=fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db372f5d9af7ba206ac77cfe6999111ba48beceee5369cc984f3590f853bfe309ce2f4d69b3cadcd36ee7a93ef1427da74c3c67d92aa6350bcb1f61f9d0a4848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec9b7918a345b95712678e5c51e74d76b6d69b6688a37b6d1c20d97b1cd72aeb816c4b88c50a4e86d5f4a2cdb752d093a6b6377c81d8bc4c82c816369d381432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d4d7a49e0409ca52ce723b662f25574c153dcf7ebc8e1df5be864c2ae99c55422a5ebafe52b15a48f3f0f99f6cd07c4149930576273f1670197c402988087d"} build_url:https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/UYCbvK1PTM6mrIDIiVsEPw/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/db372f5d9af7ba206ac77cfe6999111ba48beceee5369cc984f3590f853bfe309ce2f4d69b3cadcd36ee7a93ef1427da74c3c67d92aa6350bcb1f61f9d0a4848", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec9b7918a345b95712678e5c51e74d76b6d69b6688a37b6d1c20d97b1cd72aeb816c4b88c50a4e86d5f4a2cdb752d093a6b6377c81d8bc4c82c816369d381432", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/57d4d7a49e0409ca52ce723b662f25574c153dcf7ebc8e1df5be864c2ae99c55422a5ebafe52b15a48f3f0f99f6cd07c4149930576273f1670197c402988087d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 16:44:29.414355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:44:29.414688) ========= 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=fa44defc139c4ba8574fe040000001db-1485303837.720465-1848563002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 16:44:29.498537) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 16:44:29.498867) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 16:44:29.499156) ========= ========= Total master_lag: 0.16 =========