builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1475814608.79 results: success (0) buildid: 20161006183000 builduid: b56c41ebc0484670880f137d6e4b528e revision: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:08.792289) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:08.792770) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:08.793093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:08.807973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:08.808318) ========= 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=db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 21:30:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-10-06 21:30:09 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155938 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:08.979659) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:08.980020) ========= 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=db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016586 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:09.040216) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 21:30:09.040576) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b5c1f385ee5209796b4808cc9c40c0cb0cb4521a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b5c1f385ee5209796b4808cc9c40c0cb0cb4521a --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=db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 21:30:09,332 truncating revision to first 12 chars 2016-10-06 21:30:09,333 Setting DEBUG logging. 2016-10-06 21:30:09,333 attempt 1/10 2016-10-06 21:30:09,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b5c1f385ee52?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 21:30:10,276 unpacking tar archive at: fx-team-b5c1f385ee52/testing/mozharness/ program finished with exit code 0 elapsedTime=1.276242 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 21:30:10.331057) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:10.331410) ========= script_repo_revision: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:10.331918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:10.332226) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:30:10.339484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-06 21:30:10.339811) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:30:10 INFO - MultiFileLogger online at 20161006 21:30:10 in /builds/slave/test 21:30:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:30:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:30:10 INFO - {'append_to_log': False, 21:30:10 INFO - 'base_work_dir': '/builds/slave/test', 21:30:10 INFO - 'blob_upload_branch': 'Fx-Team', 21:30:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:30:10 INFO - 'branch': 'Fx-Team', 21:30:10 INFO - 'buildbot_json_path': 'buildprops.json', 21:30:10 INFO - 'config_files': ('talos/linux_config.py',), 21:30:10 INFO - 'default_actions': ('clobber', 21:30:10 INFO - 'read-buildbot-config', 21:30:10 INFO - 'download-and-extract', 21:30:10 INFO - 'populate-webroot', 21:30:10 INFO - 'create-virtualenv', 21:30:10 INFO - 'install', 21:30:10 INFO - 'run-tests'), 21:30:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:30:10 INFO - 'download_minidump_stackwalk': True, 21:30:10 INFO - 'download_symbols': 'ondemand', 21:30:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:30:10 INFO - 'tooltool.py': '/tools/tooltool.py', 21:30:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:30:10 INFO - '/tools/misc-python/virtualenv.py')}, 21:30:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:30:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:30:10 INFO - 'installer_path': 'installer.exe', 21:30:10 INFO - 'log_level': 'info', 21:30:10 INFO - 'log_name': 'talos', 21:30:10 INFO - 'log_to_console': True, 21:30:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:30:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:30:10 INFO - 'opt_config_files': (), 21:30:10 INFO - 'pip_index': False, 21:30:10 INFO - 'sps_profile': False, 21:30:10 INFO - 'sps_profile_interval': 0, 21:30:10 INFO - 'suite': 'dromaeojs', 21:30:10 INFO - 'system_bits': '32', 21:30:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:30:10 INFO - 'title': 'talos-linux64-ix-031', 21:30:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:30:10 INFO - 'use_talos_json': True, 21:30:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:30:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:30:10 INFO - 'work_dir': 'build'} 21:30:10 INFO - [mozharness: 2016-10-07 04:30:10.735841Z] Running clobber step. 21:30:10 INFO - Running pre-action listener: _resource_record_pre_action 21:30:10 INFO - Running main action method: clobber 21:30:10 INFO - rmtree: /builds/slave/test/build 21:30:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:30:11 INFO - Running post-action listener: _resource_record_post_action 21:30:11 INFO - [mozharness: 2016-10-07 04:30:11.199029Z] Finished clobber step (success) 21:30:11 INFO - [mozharness: 2016-10-07 04:30:11.199128Z] Running read-buildbot-config step. 21:30:11 INFO - Running pre-action listener: _resource_record_pre_action 21:30:11 INFO - Running main action method: read_buildbot_config 21:30:11 INFO - Using buildbot properties: 21:30:11 INFO - { 21:30:11 INFO - "project": "", 21:30:11 INFO - "product": "firefox", 21:30:11 INFO - "script_repo_revision": "production", 21:30:11 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:30:11 INFO - "repository": "", 21:30:11 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:30:11 INFO - "buildid": "20161006183000", 21:30:11 INFO - "pgo_build": "True", 21:30:11 INFO - "basedir": "/builds/slave/test", 21:30:11 INFO - "buildnumber": 1114, 21:30:11 INFO - "slavename": "talos-linux64-ix-031", 21:30:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:30:11 INFO - "platform": "ubuntu64_hw", 21:30:11 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:30:11 INFO - "branch": "fx-team", 21:30:11 INFO - "repo_path": "integration/fx-team", 21:30:11 INFO - "revision": "b5c1f385ee5209796b4808cc9c40c0cb0cb4521a", 21:30:11 INFO - "stage_platform": "linux64-pgo", 21:30:11 INFO - "builduid": "b56c41ebc0484670880f137d6e4b528e", 21:30:11 INFO - "slavebuilddir": "test" 21:30:11 INFO - } 21:30:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:30:11 INFO - Running post-action listener: _resource_record_post_action 21:30:11 INFO - [mozharness: 2016-10-07 04:30:11.201567Z] Finished read-buildbot-config step (success) 21:30:11 INFO - [mozharness: 2016-10-07 04:30:11.201655Z] Running download-and-extract step. 21:30:11 INFO - Running pre-action listener: _resource_record_pre_action 21:30:11 INFO - Running main action method: download_and_extract 21:30:11 INFO - mkdir: /builds/slave/test/build/tests 21:30: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')]} 21:30:11 INFO - trying https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:30:11 INFO - Downloading https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:30:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:30:11 INFO - Downloaded 1361 bytes. 21:30:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:30:11 INFO - Using the following test package requirements: 21:30:11 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:30:11 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:30:11 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:30:11 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'jsshell-linux-x86_64.zip'], 21:30:11 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:30:11 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:30:11 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:30:11 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:30:11 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:30:11 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:30:11 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:30:11 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:30:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:30:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:30:11 INFO - Fetch https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:30:12 INFO - Http code: 200 21:30:12 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 21:30:12 INFO - x-amz-cf-id: u61_DOBv320Ghct1XyomYOLFzpzqPmQ3GISRda2PmOZKzYE00T1tqw== 21:30:12 INFO - x-amz-version-id: raiaJrGxYNFYjbDqHhwdb4B.hKp_vkNf 21:30:13 INFO - Expected file size: 22018133 21:30:13 INFO - Obtained file size: 22018133 21:30:17 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:30:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:30:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:30:17 INFO - Fetch https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:30:17 INFO - Http code: 200 21:30:17 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 21:30:17 INFO - x-amz-cf-id: yFlqEYV--7rHSvy6-CO-Pcl6bXwJd6osvDPD9Aw4237HKEy1KCQcSA== 21:30:17 INFO - x-amz-version-id: raiaJrGxYNFYjbDqHhwdb4B.hKp_vkNf 21:30:18 INFO - Expected file size: 22018133 21:30:18 INFO - Obtained file size: 22018133 21:30:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:30:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:30:22 INFO - Fetch https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:30:23 INFO - Http code: 200 21:30:23 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 21:30:23 INFO - x-amz-cf-id: OblTOoR4nnapMx1po52mUFJ0cntYZw_KFmmx6Ci8bxQqrpxUvo9ZZg== 21:30:23 INFO - x-amz-version-id: 1s.8q5.p1iu04nHeU.HDeXIpTyikm1M. 21:30:23 INFO - Expected file size: 14409006 21:30:23 INFO - Obtained file size: 14409006 21:30: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')]} 21:30:24 INFO - trying https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:30:24 INFO - Downloading https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:30:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:30:26 INFO - Downloaded 59705489 bytes. 21:30:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:30:26 INFO - mkdir: /builds/slave/test/properties 21:30:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:30:26 INFO - Writing to file /builds/slave/test/properties/build_url 21:30:26 INFO - Contents: 21:30:26 INFO - build_url:https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:30:27 INFO - Running post-action listener: _resource_record_post_action 21:30:27 INFO - Running post-action listener: set_extra_try_arguments 21:30:27 INFO - [mozharness: 2016-10-07 04:30:27.170088Z] Finished download-and-extract step (success) 21:30:27 INFO - [mozharness: 2016-10-07 04:30:27.170315Z] Running populate-webroot step. 21:30:27 INFO - Running pre-action listener: _resource_record_pre_action 21:30:27 INFO - Running main action method: populate_webroot 21:30:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:30:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:30:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:30:27 INFO - '--tppagecycles', 21:30:27 INFO - '7'], 21:30:27 INFO - 'tests': ['tsvgm']}}, 21:30:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:30:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:30:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:30:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:30:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:30:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['damp', 'tps']}, 21:30:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'tests': ['damp', 'tps']}, 21:30:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['dromaeo_dom']}, 21:30:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:30:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['basic_compositor_video']}, 21:30:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:30:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['a11yr', 21:30:27 INFO - 'ts_paint', 21:30:27 INFO - 'tpaint', 21:30:27 INFO - 'sessionrestore', 21:30:27 INFO - 'sessionrestore_no_auto_restore', 21:30:27 INFO - 'tabpaint']}, 21:30:27 INFO - 'other-e10s': {'tests': ['a11yr', 21:30:27 INFO - 'ts_paint', 21:30:27 INFO - 'tpaint', 21:30:27 INFO - 'sessionrestore', 21:30:27 INFO - 'sessionrestore_no_auto_restore', 21:30:27 INFO - 'tabpaint']}, 21:30:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:30:27 INFO - 'ts_paint', 21:30:27 INFO - 'tpaint', 21:30:27 INFO - 'sessionrestore', 21:30:27 INFO - 'sessionrestore_no_auto_restore', 21:30:27 INFO - 'tabpaint']}, 21:30:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:30:27 INFO - 'ts_paint', 21:30:27 INFO - 'tpaint', 21:30:27 INFO - 'sessionrestore', 21:30:27 INFO - 'sessionrestore_no_auto_restore', 21:30:27 INFO - 'tabpaint']}, 21:30:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['a11yr', 21:30:27 INFO - 'ts_paint', 21:30:27 INFO - 'tpaint', 21:30:27 INFO - 'sessionrestore', 21:30:27 INFO - 'sessionrestore_no_auto_restore', 21:30:27 INFO - 'tabpaint']}, 21:30:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['a11yr', 21:30:27 INFO - 'ts_paint', 21:30:27 INFO - 'tpaint', 21:30:27 INFO - 'sessionrestore', 21:30:27 INFO - 'sessionrestore_no_auto_restore', 21:30:27 INFO - 'tabpaint']}, 21:30:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['tsvgx', 21:30:27 INFO - 'tsvgr_opacity', 21:30:27 INFO - 'tart', 21:30:27 INFO - 'tscrollx', 21:30:27 INFO - 'cart']}, 21:30:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:30:27 INFO - 'tsvgr_opacity', 21:30:27 INFO - 'tart', 21:30:27 INFO - 'tscrollx', 21:30:27 INFO - 'cart']}, 21:30:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'talos_options': ['--disable-e10s'], 21:30:27 INFO - 'tests': ['tp5o']}, 21:30:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'tests': ['tp5o']}, 21:30:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'talos_options': ['--disable-e10s', 21:30:27 INFO - '--xperf_path', 21:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:27 INFO - 'tests': ['tp5n']}, 21:30:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:30:27 INFO - 'talos_options': ['--xperf_path', 21:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:30:27 INFO - 'tests': ['tp5n']}}, 21:30:27 INFO - 'talos.zip': {'path': '', 21:30:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:30:27 INFO - Running post-action listener: _resource_record_post_action 21:30:27 INFO - [mozharness: 2016-10-07 04:30:27.187105Z] Finished populate-webroot step (success) 21:30:27 INFO - [mozharness: 2016-10-07 04:30:27.187194Z] Running create-virtualenv step. 21:30:27 INFO - Running pre-action listener: _resource_record_pre_action 21:30:27 INFO - Running main action method: create_virtualenv 21:30:27 INFO - Creating virtualenv /builds/slave/test/build/venv 21:30:27 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 21:30:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:30:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:30:27 INFO - Using real prefix '/usr' 21:30:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:30:27 INFO - Installing distribute.............................................................................................................................................................................................done. 21:30:29 INFO - Installing pip.................done. 21:30:29 INFO - Return code: 0 21:30:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:30:29 INFO - Reading from file tmpfile_stdout 21:30:29 INFO - Output received: 21:30:29 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) 21:30:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:30:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:30:29 INFO - Using env: {'DISPLAY': ':0', 21:30:29 INFO - 'HOME': '/home/cltbld', 21:30:29 INFO - 'LANG': 'en_US.UTF-8', 21:30:29 INFO - 'LANGUAGE': 'en_US:en', 21:30:29 INFO - 'LOGNAME': 'cltbld', 21:30:29 INFO - 'MAIL': '/var/mail/cltbld', 21:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:29 INFO - 'MOZ_NO_REMOTE': '1', 21:30:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:29 INFO - 'NO_EM_RESTART': '1', 21:30:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:29 INFO - 'PWD': '/builds/slave/test', 21:30:29 INFO - 'SHELL': '/bin/bash', 21:30:29 INFO - 'SHLVL': '1', 21:30:29 INFO - 'TERM': 'linux', 21:30:29 INFO - 'TMOUT': '86400', 21:30:29 INFO - 'USER': 'cltbld', 21:30:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:29 INFO - '_': '/tools/buildbot/bin/python'} 21:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:30 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 21:30:30 INFO - Cleaning up... 21:30:30 INFO - Return code: 0 21:30:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:30:30 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')]} 21:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:30 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')]} 21:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:30 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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:30 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 21:30:30 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 21:30:30 INFO - Using env: {'DISPLAY': ':0', 21:30:30 INFO - 'HOME': '/home/cltbld', 21:30:30 INFO - 'LANG': 'en_US.UTF-8', 21:30:30 INFO - 'LANGUAGE': 'en_US:en', 21:30:30 INFO - 'LOGNAME': 'cltbld', 21:30:30 INFO - 'MAIL': '/var/mail/cltbld', 21:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:30 INFO - 'MOZ_NO_REMOTE': '1', 21:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:30 INFO - 'NO_EM_RESTART': '1', 21:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:30 INFO - 'PWD': '/builds/slave/test', 21:30:30 INFO - 'SHELL': '/bin/bash', 21:30:30 INFO - 'SHLVL': '1', 21:30:30 INFO - 'TERM': 'linux', 21:30:30 INFO - 'TMOUT': '86400', 21:30:30 INFO - 'USER': 'cltbld', 21:30:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:30 INFO - '_': '/tools/buildbot/bin/python'} 21:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:30 INFO - Downloading/unpacking psutil>=3.1.1 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:30 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 21:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:32 INFO - Installing collected packages: psutil 21:30:32 INFO - Running setup.py install for psutil 21:30:32 INFO - building 'psutil._psutil_linux' extension 21:30:32 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 21:30:32 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 21:30:32 INFO - building 'psutil._psutil_posix' extension 21:30:32 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 21:30:32 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 21:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:30:32 INFO - Successfully installed psutil 21:30:32 INFO - Cleaning up... 21:30:32 INFO - Return code: 0 21:30:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:30:32 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')]} 21:30:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:33 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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:33 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 21:30:33 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 21:30:33 INFO - Using env: {'DISPLAY': ':0', 21:30:33 INFO - 'HOME': '/home/cltbld', 21:30:33 INFO - 'LANG': 'en_US.UTF-8', 21:30:33 INFO - 'LANGUAGE': 'en_US:en', 21:30:33 INFO - 'LOGNAME': 'cltbld', 21:30:33 INFO - 'MAIL': '/var/mail/cltbld', 21:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:33 INFO - 'MOZ_NO_REMOTE': '1', 21:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:33 INFO - 'NO_EM_RESTART': '1', 21:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:33 INFO - 'PWD': '/builds/slave/test', 21:30:33 INFO - 'SHELL': '/bin/bash', 21:30:33 INFO - 'SHLVL': '1', 21:30:33 INFO - 'TERM': 'linux', 21:30:33 INFO - 'TMOUT': '86400', 21:30:33 INFO - 'USER': 'cltbld', 21:30:33 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:33 INFO - '_': '/tools/buildbot/bin/python'} 21:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:30:35 INFO - Installing collected packages: mozsystemmonitor 21:30:35 INFO - Running setup.py install for mozsystemmonitor 21:30:35 INFO - Successfully installed mozsystemmonitor 21:30:35 INFO - Cleaning up... 21:30:35 INFO - Return code: 0 21:30:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30: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==2.5.1'] in /builds/slave/test/build 21:30: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==2.5.1 21:30:35 INFO - Using env: {'DISPLAY': ':0', 21:30:35 INFO - 'HOME': '/home/cltbld', 21:30:35 INFO - 'LANG': 'en_US.UTF-8', 21:30:35 INFO - 'LANGUAGE': 'en_US:en', 21:30:35 INFO - 'LOGNAME': 'cltbld', 21:30:35 INFO - 'MAIL': '/var/mail/cltbld', 21:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:35 INFO - 'MOZ_NO_REMOTE': '1', 21:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:35 INFO - 'NO_EM_RESTART': '1', 21:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:35 INFO - 'PWD': '/builds/slave/test', 21:30:35 INFO - 'SHELL': '/bin/bash', 21:30:35 INFO - 'SHLVL': '1', 21:30:35 INFO - 'TERM': 'linux', 21:30:35 INFO - 'TMOUT': '86400', 21:30:35 INFO - 'USER': 'cltbld', 21:30:35 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:35 INFO - '_': '/tools/buildbot/bin/python'} 21:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:35 INFO - Downloading/unpacking jsonschema==2.5.1 21:30:35 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 21:30:35 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 21:30:35 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 21:30:35 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 21:30:35 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 21:30:35 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 21:30:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:30:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:37 INFO - Downloading functools32-3.2.3-2.tar.gz 21:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:30:37 INFO - warning: no files found matching '*.txt' 21:30:37 INFO - no previously-included directories found matching 'build' 21:30:37 INFO - no previously-included directories found matching 'dist' 21:30:37 INFO - no previously-included directories found matching '.git*' 21:30:37 INFO - Installing collected packages: jsonschema, functools32 21:30:37 INFO - Running setup.py install for functools32 21:30:37 INFO - warning: no files found matching '*.txt' 21:30:37 INFO - no previously-included directories found matching 'build' 21:30:37 INFO - no previously-included directories found matching 'dist' 21:30:37 INFO - no previously-included directories found matching '.git*' 21:30:37 INFO - Successfully installed jsonschema functools32 21:30:37 INFO - Cleaning up... 21:30:37 INFO - Return code: 0 21:30:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:30:37 INFO - Using env: {'DISPLAY': ':0', 21:30:37 INFO - 'HOME': '/home/cltbld', 21:30:37 INFO - 'LANG': 'en_US.UTF-8', 21:30:37 INFO - 'LANGUAGE': 'en_US:en', 21:30:37 INFO - 'LOGNAME': 'cltbld', 21:30:37 INFO - 'MAIL': '/var/mail/cltbld', 21:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:37 INFO - 'MOZ_NO_REMOTE': '1', 21:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:37 INFO - 'NO_EM_RESTART': '1', 21:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:37 INFO - 'PWD': '/builds/slave/test', 21:30:37 INFO - 'SHELL': '/bin/bash', 21:30:37 INFO - 'SHLVL': '1', 21:30:37 INFO - 'TERM': 'linux', 21:30:37 INFO - 'TMOUT': '86400', 21:30:37 INFO - 'USER': 'cltbld', 21:30:37 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:37 INFO - '_': '/tools/buildbot/bin/python'} 21:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:30:38 INFO - Cleaning up... 21:30:38 INFO - Return code: 0 21:30:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:30:38 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')]} 21:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:38 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')]} 21:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:38 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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:38 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 21:30:38 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 21:30:38 INFO - Using env: {'DISPLAY': ':0', 21:30:38 INFO - 'HOME': '/home/cltbld', 21:30:38 INFO - 'LANG': 'en_US.UTF-8', 21:30:38 INFO - 'LANGUAGE': 'en_US:en', 21:30:38 INFO - 'LOGNAME': 'cltbld', 21:30:38 INFO - 'MAIL': '/var/mail/cltbld', 21:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:38 INFO - 'MOZ_NO_REMOTE': '1', 21:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:38 INFO - 'NO_EM_RESTART': '1', 21:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:38 INFO - 'PWD': '/builds/slave/test', 21:30:38 INFO - 'SHELL': '/bin/bash', 21:30:38 INFO - 'SHLVL': '1', 21:30:38 INFO - 'TERM': 'linux', 21:30:38 INFO - 'TMOUT': '86400', 21:30:38 INFO - 'USER': 'cltbld', 21:30:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:38 INFO - '_': '/tools/buildbot/bin/python'} 21:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 21:30:38 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 21:30:38 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 21:30:38 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 21:30:38 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 21:30:38 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 21:30:38 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 21:30:40 INFO - Downloading blobuploader-1.2.4.tar.gz 21:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:30:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:30:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:30:41 INFO - Downloading docopt-0.6.1.tar.gz 21:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:30:41 INFO - Installing collected packages: blobuploader, requests, docopt 21:30:41 INFO - Running setup.py install for blobuploader 21:30:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:30:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:30:41 INFO - Running setup.py install for requests 21:30:41 INFO - Running setup.py install for docopt 21:30:41 INFO - Successfully installed blobuploader requests docopt 21:30:41 INFO - Cleaning up... 21:30:41 INFO - Return code: 0 21:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:41 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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:41 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 21:30:41 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 21:30:41 INFO - Using env: {'DISPLAY': ':0', 21:30:41 INFO - 'HOME': '/home/cltbld', 21:30:41 INFO - 'LANG': 'en_US.UTF-8', 21:30:41 INFO - 'LANGUAGE': 'en_US:en', 21:30:41 INFO - 'LOGNAME': 'cltbld', 21:30:41 INFO - 'MAIL': '/var/mail/cltbld', 21:30:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:41 INFO - 'MOZ_NO_REMOTE': '1', 21:30:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:41 INFO - 'NO_EM_RESTART': '1', 21:30:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:41 INFO - 'PWD': '/builds/slave/test', 21:30:41 INFO - 'SHELL': '/bin/bash', 21:30:41 INFO - 'SHLVL': '1', 21:30:41 INFO - 'TERM': 'linux', 21:30:41 INFO - 'TMOUT': '86400', 21:30:41 INFO - 'USER': 'cltbld', 21:30:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:41 INFO - '_': '/tools/buildbot/bin/python'} 21:30:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:42 INFO - Running setup.py (path:/tmp/pip-EaFIrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:42 INFO - Running setup.py (path:/tmp/pip-ac6oMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:42 INFO - Running setup.py (path:/tmp/pip-UDRFTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:42 INFO - Running setup.py (path:/tmp/pip-jpqPHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:42 INFO - Running setup.py (path:/tmp/pip-MfOvl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:42 INFO - Running setup.py (path:/tmp/pip-5iId4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:42 INFO - Running setup.py (path:/tmp/pip-2ZX9aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:42 INFO - Running setup.py (path:/tmp/pip-QagXCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:42 INFO - Running setup.py (path:/tmp/pip-PtS54I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:42 INFO - Running setup.py (path:/tmp/pip-f9_z6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:42 INFO - Running setup.py (path:/tmp/pip-zRtYu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:42 INFO - Running setup.py (path:/tmp/pip-jdfxz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:42 INFO - Running setup.py (path:/tmp/pip-3MmWtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:42 INFO - Running setup.py (path:/tmp/pip-G41AQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:43 INFO - Running setup.py (path:/tmp/pip-qICoo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:43 INFO - Running setup.py (path:/tmp/pip-QkKTfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:43 INFO - Running setup.py (path:/tmp/pip-fuqX6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:30:43 INFO - Running setup.py install for manifestparser 21:30:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:30:43 INFO - Running setup.py install for mozcrash 21:30:43 INFO - Running setup.py install for mozdebug 21:30:43 INFO - Running setup.py install for mozdevice 21:30:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:30:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:30:43 INFO - Running setup.py install for mozfile 21:30:43 INFO - Running setup.py install for mozhttpd 21:30:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:30:43 INFO - Running setup.py install for mozinfo 21:30:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:30:43 INFO - Running setup.py install for mozInstall 21:30:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Running setup.py install for mozleak 21:30:44 INFO - Running setup.py install for mozlog 21:30:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Running setup.py install for moznetwork 21:30:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Running setup.py install for mozprocess 21:30:44 INFO - Running setup.py install for mozprofile 21:30:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Running setup.py install for mozrunner 21:30:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:30:44 INFO - Running setup.py install for mozscreenshot 21:30:44 INFO - Running setup.py install for moztest 21:30:44 INFO - Running setup.py install for mozversion 21:30:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:30:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:30:45 INFO - Cleaning up... 21:30:45 INFO - Return code: 0 21:30:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:45 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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:45 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 21:30:45 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 21:30:45 INFO - Using env: {'DISPLAY': ':0', 21:30:45 INFO - 'HOME': '/home/cltbld', 21:30:45 INFO - 'LANG': 'en_US.UTF-8', 21:30:45 INFO - 'LANGUAGE': 'en_US:en', 21:30:45 INFO - 'LOGNAME': 'cltbld', 21:30:45 INFO - 'MAIL': '/var/mail/cltbld', 21:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:45 INFO - 'MOZ_NO_REMOTE': '1', 21:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:45 INFO - 'NO_EM_RESTART': '1', 21:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:45 INFO - 'PWD': '/builds/slave/test', 21:30:45 INFO - 'SHELL': '/bin/bash', 21:30:45 INFO - 'SHLVL': '1', 21:30:45 INFO - 'TERM': 'linux', 21:30:45 INFO - 'TMOUT': '86400', 21:30:45 INFO - 'USER': 'cltbld', 21:30:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:45 INFO - '_': '/tools/buildbot/bin/python'} 21:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:30:45 INFO - Running setup.py (path:/tmp/pip-f5JU_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:30:45 INFO - Running setup.py (path:/tmp/pip-5ZH0kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:30:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:30:45 INFO - Running setup.py (path:/tmp/pip-tbSWRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:30:45 INFO - Running setup.py (path:/tmp/pip-JSWfJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:30:45 INFO - Running setup.py (path:/tmp/pip-fOnyWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:30:45 INFO - Running setup.py (path:/tmp/pip-AJsWnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:30:45 INFO - Running setup.py (path:/tmp/pip-Hyj7HJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:30:45 INFO - Running setup.py (path:/tmp/pip-sJKXGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:30:45 INFO - Running setup.py (path:/tmp/pip-XlmtwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:30:45 INFO - Running setup.py (path:/tmp/pip-4hgG5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:30:45 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)) 21:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:30:45 INFO - Running setup.py (path:/tmp/pip-nU1Pib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:30:46 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)) 21:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:30:46 INFO - Running setup.py (path:/tmp/pip-ugHrkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:30:46 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)) 21:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:30:46 INFO - Running setup.py (path:/tmp/pip-60qZEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:30:46 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)) 21:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:30:46 INFO - Running setup.py (path:/tmp/pip-0yAdvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:46 INFO - Running setup.py (path:/tmp/pip-kwRDIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:30:46 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)) 21:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:30:46 INFO - Running setup.py (path:/tmp/pip-_34MB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:30:46 INFO - Running setup.py (path:/tmp/pip-41OO0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:30:46 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)) 21:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:30:46 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)) 21:30:46 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)) 21:30:46 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)) 21:30:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:30:46 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 21:30:46 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 21:30:46 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 21:30:46 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 21:30:46 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 21:30:46 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 21:30:48 INFO - Downloading blessings-1.6.tar.gz 21:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:30:48 INFO - Installing collected packages: blessings 21:30:48 INFO - Running setup.py install for blessings 21:30:48 INFO - Successfully installed blessings 21:30:48 INFO - Cleaning up... 21:30:48 INFO - Return code: 0 21:30:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:48 INFO - Reading from file tmpfile_stdout 21:30:48 INFO - Current package versions: 21:30:48 INFO - argparse == 1.2.1 21:30:48 INFO - blessings == 1.6 21:30:48 INFO - blobuploader == 1.2.4 21:30:48 INFO - docopt == 0.6.1 21:30:48 INFO - functools32 == 3.2.3-2 21:30:48 INFO - jsonschema == 2.5.1 21:30:48 INFO - manifestparser == 1.1 21:30:48 INFO - mozInstall == 1.12 21:30:48 INFO - mozcrash == 0.17 21:30:48 INFO - mozdebug == 0.1 21:30:48 INFO - mozdevice == 0.48 21:30:48 INFO - mozfile == 1.2 21:30:48 INFO - mozhttpd == 0.7 21:30:48 INFO - mozinfo == 0.9 21:30:48 INFO - mozleak == 0.1 21:30:48 INFO - mozlog == 3.4 21:30:48 INFO - moznetwork == 0.27 21:30:48 INFO - mozprocess == 0.23 21:30:48 INFO - mozprofile == 0.28 21:30:48 INFO - mozrunner == 6.12 21:30:48 INFO - mozscreenshot == 0.1 21:30:48 INFO - mozsystemmonitor == 0.3 21:30:48 INFO - moztest == 0.7 21:30:48 INFO - mozversion == 1.4 21:30:48 INFO - psutil == 3.1.1 21:30:48 INFO - requests == 1.2.3 21:30:48 INFO - wsgiref == 0.1.2 21:30:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:30:48 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')]} 21:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:48 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')]} 21:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:48 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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:48 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 21:30:48 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 21:30:48 INFO - Using env: {'DISPLAY': ':0', 21:30:48 INFO - 'HOME': '/home/cltbld', 21:30:48 INFO - 'LANG': 'en_US.UTF-8', 21:30:48 INFO - 'LANGUAGE': 'en_US:en', 21:30:48 INFO - 'LOGNAME': 'cltbld', 21:30:48 INFO - 'MAIL': '/var/mail/cltbld', 21:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:48 INFO - 'MOZ_NO_REMOTE': '1', 21:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:48 INFO - 'NO_EM_RESTART': '1', 21:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:48 INFO - 'PWD': '/builds/slave/test', 21:30:48 INFO - 'SHELL': '/bin/bash', 21:30:48 INFO - 'SHLVL': '1', 21:30:48 INFO - 'TERM': 'linux', 21:30:48 INFO - 'TMOUT': '86400', 21:30:48 INFO - 'USER': 'cltbld', 21:30:48 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:48 INFO - '_': '/tools/buildbot/bin/python'} 21:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 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)) 21:30:49 INFO - Cleaning up... 21:30:49 INFO - Return code: 0 21:30:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:30: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')]} 21:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30: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')]} 21:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:30:49 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 0x7f4e611f3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2601790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, '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': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', '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 21:30:49 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 21:30:49 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 21:30:49 INFO - Using env: {'DISPLAY': ':0', 21:30:49 INFO - 'HOME': '/home/cltbld', 21:30:49 INFO - 'LANG': 'en_US.UTF-8', 21:30:49 INFO - 'LANGUAGE': 'en_US:en', 21:30:49 INFO - 'LOGNAME': 'cltbld', 21:30:49 INFO - 'MAIL': '/var/mail/cltbld', 21:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:30:49 INFO - 'MOZ_NO_REMOTE': '1', 21:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:30:49 INFO - 'NO_EM_RESTART': '1', 21:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:30:49 INFO - 'PWD': '/builds/slave/test', 21:30:49 INFO - 'SHELL': '/bin/bash', 21:30:49 INFO - 'SHLVL': '1', 21:30:49 INFO - 'TERM': 'linux', 21:30:49 INFO - 'TMOUT': '86400', 21:30:49 INFO - 'USER': 'cltbld', 21:30:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:30:49 INFO - '_': '/tools/buildbot/bin/python'} 21:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:30:49 INFO - Cleaning up... 21:30:49 INFO - Return code: 0 21:30:49 INFO - Running post-action listener: _resource_record_post_action 21:30:49 INFO - Running post-action listener: _start_resource_monitoring 21:30:49 INFO - Starting resource monitoring. 21:30:49 INFO - [mozharness: 2016-10-07 04:30:49.372756Z] Finished create-virtualenv step (success) 21:30:49 INFO - [mozharness: 2016-10-07 04:30:49.373233Z] Running install step. 21:30:49 INFO - Running pre-action listener: _resource_record_pre_action 21:30:49 INFO - Running main action method: install 21:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:30:49 INFO - Reading from file tmpfile_stdout 21:30:49 INFO - Detecting whether we're running mozinstall >=1.0... 21:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:30:49 INFO - Reading from file tmpfile_stdout 21:30:49 INFO - Output received: 21:30:49 INFO - Usage: mozinstall [options] installer 21:30:49 INFO - Options: 21:30:49 INFO - -h, --help show this help message and exit 21:30:49 INFO - -d DEST, --destination=DEST 21:30:49 INFO - Directory to install application into. [default: 21:30:49 INFO - "/builds/slave/test"] 21:30:49 INFO - --app=APP Application being installed. [default: firefox] 21:30:49 INFO - mkdir: /builds/slave/test/build/application 21:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:31:06 INFO - Reading from file tmpfile_stdout 21:31:06 INFO - Output received: 21:31:06 INFO - /builds/slave/test/build/application/firefox/firefox 21:31:06 INFO - Running post-action listener: _resource_record_post_action 21:31:06 INFO - [mozharness: 2016-10-07 04:31:06.779854Z] Finished install step (success) 21:31:06 INFO - [mozharness: 2016-10-07 04:31:06.780101Z] Running run-tests step. 21:31:06 INFO - Running pre-action listener: _resource_record_pre_action 21:31:06 INFO - Running main action method: run_tests 21:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:31:06 INFO - Python 2.7.3 21:31:06 INFO - Return code: 0 21:31:06 INFO - grabbing minidump binary from tooltool 21:31:06 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')]} 21:31:06 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 0x25fe930>, '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 0x25ff830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25ffcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:31:06 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 21:31:06 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 21:31:06 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 21:31:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:31:06 INFO - Return code: 0 21:31:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:31:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:31:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:31:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:31:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:31:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 21:31:06 INFO - Using env: {'DISPLAY': ':0', 21:31:06 INFO - 'HOME': '/home/cltbld', 21:31:06 INFO - 'LANG': 'en_US.UTF-8', 21:31:06 INFO - 'LANGUAGE': 'en_US:en', 21:31:06 INFO - 'LOGNAME': 'cltbld', 21:31:06 INFO - 'MAIL': '/var/mail/cltbld', 21:31:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:31:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:31:06 INFO - 'MOZ_NO_REMOTE': '1', 21:31:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:31:06 INFO - 'NO_EM_RESTART': '1', 21:31:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:31:06 INFO - 'PWD': '/builds/slave/test', 21:31:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:31:06 INFO - 'SHELL': '/bin/bash', 21:31:06 INFO - 'SHLVL': '1', 21:31:06 INFO - 'TERM': 'linux', 21:31:06 INFO - 'TMOUT': '86400', 21:31:06 INFO - 'USER': 'cltbld', 21:31:06 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540', 21:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:31:06 INFO - '_': '/tools/buildbot/bin/python'} 21:31:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:31:07 INFO - mozversion application_buildid: 20161006183000 21:31:07 INFO - mozversion application_changeset: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a 21:31:07 INFO - mozversion application_display_name: Nightly 21:31:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:31:07 INFO - mozversion application_name: Firefox 21:31:07 INFO - mozversion application_remotingname: firefox 21:31:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:31:07 INFO - mozversion application_vendor: Mozilla 21:31:07 INFO - mozversion application_version: 52.0a1 21:31:07 INFO - mozversion platform_buildid: 20161006183000 21:31:07 INFO - mozversion platform_changeset: b5c1f385ee5209796b4808cc9c40c0cb0cb4521a 21:31:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:31:07 INFO - mozversion platform_version: 52.0a1 21:31:07 INFO - using testdate: 1475814667 21:31:07 INFO - actual date: 1475814667 21:31:07 INFO - starting webserver on 'localhost:41275' 21:31:07 INFO - SUITE-START | Running 2 tests 21:31:07 INFO - TEST-START | dromaeo_css 21:31:07 INFO - operating with platform_type : linux_ 21:31:07 INFO - Initialising browser for dromaeo_css test... 21:31:07 INFO - TEST-INFO | started process 2138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9L14i/profile http://localhost:41275/getInfo.html) 21:31:11 INFO - PROCESS | 2138 | __metrics Screen width/height:1600/1200 21:31:11 INFO - PROCESS | 2138 | colorDepth:24 21:31:11 INFO - PROCESS | 2138 | Browser inner width/height: 1024/697 21:31:11 INFO - PROCESS | 2138 | __metrics 21:31:11 INFO - PROCESS | 2138 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:31:11 INFO - PROCESS | 2138 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:31:12 INFO - PROCESS | 2138 | console.error: PushService: 21:31:12 INFO - PROCESS | 2138 | stateChangeProcessEnqueue: Error transitioning state 21:31:12 INFO - PROCESS | 2138 | UnknownError 21:31:13 INFO - TEST-INFO | 2138: exit 0 21:31:13 INFO - Browser initialized. 21:31:13 INFO - Running cycle 1/1 for dromaeo_css test... 21:31:13 INFO - TEST-INFO | started process 2219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9L14i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:31:25 INFO - PROCESS | 2219 | RSS: Main: 173973504 21:31:25 INFO - PROCESS | 2219 | 21:32:16 INFO - PROCESS | 2219 | 1475814736182 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:34:26 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:41275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41275/tests/dromaeo/cssquery-ext.html) 21:34:29 INFO - PROCESS | 2219 | RSS: Main: 492933120 21:34:29 INFO - PROCESS | 2219 | 21:37:32 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:41275/tests/dromaeo/cssquery-ext.html (next: http://localhost:41275/tests/dromaeo/cssquery-jquery.html) 21:37:32 INFO - PROCESS | 2219 | RSS: Main: 295071744 21:37:32 INFO - PROCESS | 2219 | 21:40:34 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:41275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41275/tests/dromaeo/cssquery-mootools.html) 21:40:35 INFO - PROCESS | 2219 | RSS: Main: 265977856 21:40:35 INFO - PROCESS | 2219 | 21:43:37 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:41275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41275/tests/dromaeo/cssquery-prototype.html) 21:43:37 INFO - PROCESS | 2219 | RSS: Main: 222208000 21:43:37 INFO - PROCESS | 2219 | 21:46:40 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:41275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41275/tests/dromaeo/cssquery-yui.html) 21:46:41 INFO - PROCESS | 2219 | RSS: Main: 225792000 21:46:41 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | Cycle 1(1): loaded http://localhost:41275/tests/dromaeo/cssquery-yui.html (next: http://localhost:41275/tests/dromaeo/cssquery-dojo.html) 21:49:44 INFO - PROCESS | 2219 | RSS: Main: 292614144 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | __start_tp_report 21:49:44 INFO - PROCESS | 2219 | _x_x_mozilla_page_load 21:49:44 INFO - PROCESS | 2219 | _x_x_mozilla_page_load_details 21:49:44 INFO - PROCESS | 2219 | |i|pagename|runs| 21:49:44 INFO - PROCESS | 2219 | |0;dojo.html;2982.5227963525836;3013.7890347675657;3019.8037127586717;3041.908742737716;3069.1713237425897;5118.385793704751;5171.250168725537;5212.895742085156;5245.396779370373;5252.684838909663;5207.557357624597;5234.973825130878;5250.396204436491;5296;5355.250264962899;4763.666543341968;4766.73782941938;4817.325574419584;4833.444153922291;4880.341153944225;4872.220444728844;4897.583705385046;4907.582855457291;4941.802327906879;4946.653734238605;4655.045715628288;4697.084068606623;4705.12955103307;4858.4898585648525;4924.975375123137;4732.716037037789;4752.405949256343;4755.358026666425;4757.548032936866;4757.904841903177;4710.293455981596;4720.76396180193;4725.3384526166365;4726.243800991825;4735.526447355272;5108.208227724708;5154.53609175176;5154.819581314673;5162;5168.689878607295;5497.367802702701;5499.560035197174;5501.422350653163;5502.58730595207;5507.834764957058;5595.300587426572;5621.7189140542805;5641.68970706611;5651.660900345993;5654.264945557093;5109.131447653907;5120.539151476385;5123.129068058364;5222.686638801684;5265.315508983807;5560.054790685593;5602.13166959122;5685.147227915763;5688.431156884279;5694.345150307768;5401.027814993339;5472.835814925558;5478.096114141202;5480.808171713971;5538.750756215899;5514.062609356419;5525.281713377235;5591.692456914828;5599.664020158803;5675.091985282335;5572.192032155314;5602.551795856321;5603.411641777636;5604.271444712162;5609.5792815539;5601.7759289628775;5614.747336369873;5616.494515493543;5617.9438205618235;5679.630823996427;4204.705670603028;4228.830846766156;4314.9784251078545;4359.738415695068;4366.126774645084;3885.708571857122;3904.1996390739832;3930.0960779020415;3930.6265904739003;3941.3102707026155;5326.92009619856;5350.250964864922;5362.329708786402;5363.812266570651;5365.1147560652835;5479.013777520085;5487.780488780404;5525.198846167364;5673.319201695823;5687.857803554862;5288.629795914249;5289.523942845085;5289.656172348862;5291.603129765283;5294.576433885357;4803.951960480351;4839.491853355417;4845.733484658307;4848.684835485682;4851.296561998491;5764.538836893039;5770.6249093808765;5770.798022069207;5773.1051686988585;5813.302403711582;5606.803761868315;5612.382637909908;5612.663240205601;5612.971935140298;5615;5816.476517113311;5837.211976383303;5843.065109582616;5843.678597676999;5845.912311315419;5469.589780766538;5477.123660214346;5506.0089183947275;5509.889802203853;5512.779488820403;5630.324361076697;5636.351819540805;5638.464345887134;5641.9435805641415;5644.153376993319;5335.626506144533;5474.3704473986;5480.588955828409;5487.862803429946;5548.029094908456;5364.14173732201;5444.455554444524;5444.754986025718;5446.509814116748;5446.537044351275;5429.6199266051;5434.64674796137;5437.32033495813;5437.646552974044;5438.619296649196;5325.414204437431;5459.535939445192;5467.480589344006;5477.808276710296;5486.039943010037;4860;5293.761780719799;5351.010063138332;5371.4897084776885;5372.516473517402 21:49:44 INFO - PROCESS | 2219 | |1;ext.html;592.4135106244817;602.2592211579757;608.4888693497464;610.4201009041411;613.6716856481781;32782.50826237605;42427;43247.567524324746;43384.78307608461;48399;46597.30104048442;46866.29700554494;46967.651617419164;47070.705050646466;47144.76427617857;8878.600462979166;9023.45859248444;9038.86441703375;9041.593128309241;9043.547822608876;8008.7597372078635;8174;10519.52662130206;10804.5678172873;10810.513526891309;10918.836217456705;11005.779884402347;11011.449427528632;11013.504392302326;11016.339019658806;8080.353571714249;10769.461526923662;10820.080293175011;10829;10841.512131954081;7896.80257993549;10189.133923616502;10510.054095131474;10520.526576304008;10860.076893464066;41607.58392416098;42351.12962009377;42355.57644423578;42363.57636423627;42390.57609423897;3431.157542166741;3503.7197024238;3567.8572857085946;3626.6373362663785;3867.45855580219;32021.519677204862;32125.51811722826;32406.6759332406;33880;33955;4261.850835220753;4413.779311034467;4426.977865110686;4434.4678638563255;4487.708298960557;248368;248377;249891;250480;252647;61873.38126618676;62449.68775156095;62487;62508.68745656333;62523.374766252666;36369;37454.62545374512;37495.62504374921;40077;65208.347916521176;17734;17909.28362865497;17910.462686119437;17910.731339029924;17912.641747164984;12031.157818952765;12259.448324825404;13445.596632101053;13522.25627590492;13544.45822167122;17351.566210844576;17492.300307987793;18792.71810922837;19411.2235510578;19482.318118865773;7002.929970700227;7010.298970102949;7060.6116663584;7248.637568121679;7383.15093764224;930.4231376546585;1025.0127005946872;1046.581367453025;1079.2337440417234;1132.2074547816562;32541.34917301688;34706.709442332125;35041.961782038576;36722;37043;1085.3596378136938;1113.732704150998;1124.5445594534226;1193.254216114928;1201.5554244929433;16862;17231.741523877154;17244.224009919584;17300.913495432695;17375.65248695019;505524;516819;517363.6109111262;518037;521661;59623.10565341523;60450.69774651099;60610;60721;60792.696036519534;1237.5173682263924;1275.5854347337151;1293.5601895355624;1367.5965590150731;1382.62669079348;30161.245968850075;32749.672503275615;33666.12005243447;33980.66019339775;34529.48205776865;52149;52859.471405285454;52955.470445295054;53005.46994530005;53007.734961324946;406623;407026;408652;409932;409936.31082715414;45785.313220302385;45883;47635.04729905452;47979.28031079467;48196.7590162047;48169.518304816505;48501;48868.5113148864;49226.75386623044;49616.04607447129;40729.59270407258;41127.38308925309;41582.584174159085;41601.79199103985;42790.144197116504;41291;41978.580214197464;42004.768507895824;42148.1570368597;42410.57589424066;42591;43086.56913430951;44404.11191776211;45714.54285457103;45790.542094578625;34754;37415;37603.24793504169;37738.62261377461;38539;28212.43575128527;28374.85812570924;28631.856840715664;28694.56958145588;28737.712622873503 21:49:44 INFO - PROCESS | 2219 | |2;jquery.html;368.5632525457332;381.4202412333253;393.23908237560323;396.6033966033967;414.3929143804326;13631.522896698618;15096.396144154234;17032.65934681307;19497.805021949775;19979.50051248716;18590.256389744427;18622.81377186228;19351.709724354147;19904.10431530581;19910.900445497788;5375;5656.377798442168;5882.4705776480105;5884.764609415618;5898.528117750569;5501.394846566875;5725.7995970141055;5742.7415766290615;5742.827715168531;5747.281589801275;5564.387917329091;5710.371859095496;5714.342850572196;5714.742836572344;5717.599768016241;5791.855203619901;5945.702714864239;5951.940480595182;5953.166556682025;5954.255718035246;5586.636868603528;5729.1119876419225;5750.741216645261;5761.481466667978;5777.45114214149;13909.930450347683;14164.645883852987;14168.504102356368;14235.78646320306;14744.410223591043;2225.8948766470844;2293.793558579736;2347.507023525062;2661.4810112028163;2932.8973485928104;10570.788584228349;11039;11689.824652630217;12643.49426022958;14819.036762610504;1930.3050901675385;1974.7334109895123;2003.2087325506343;2023.251396983111;2036.7148599196125;81185;85135;85950;86172;87674.56162719273;10978.725531861768;11179.161562882817;11188.384638844942;11200.495977680861;11232.382218977871;15682.255605269032;15786.921065394828;15810;15819.101707794907;15832.129232892301;7931.2068793120225;8125.212453260391;8332.083470818205;8500.10748871372;8590;7846.254605812439;7849;7877.56673382958;7919.604019799102;8242.793930151674;4814.975925120352;4815.542523460265;4821.251886424704;4825.855224343275;4889.584385327216;1926.730257763914;2013.3154727392464;2024.5423295227413;2026.1085122546033;2035.196097541463;704.1837959047197;927.6196759328643;947.5001489780103;996.6612345482724;1046.4401545173296;19176.904115479334;19261.22955081809;19565.510862228275;19976.90011549933;20206.86851056636;957.4973139101888;969.7672558585889;978.7308490165261;1013.1135256650431;1051.1223128687632;10732.678019659423;11088.611898583511;11139.496168017215;11228.663140105646;11289.887101128883;465521;467310;467469;485349;485728;96007.51996239975;97957;100090.49954750325;101155;104352;1004.753835310339;1025.4411345816548;1052.6736711619421;1059.2214722179192;1060.7878424315168;13267.867321326663;17661.735073973643;18160.636787264444;18236.270549177883;18278.360257390927;41723.37414938839;42522;42714.57285427106;43004.139917202105;45519.54480455153;52019.2197117036;52272.897700856425;54245.18632220441;54351.72824135854;55414.445855542544;8584.871226931476;8679.479231246145;8773.42972706772;8972.057933916845;9151.954240228757;11075.778484430428;12873.935630321788;13427.865721343052;13444.663883402993;13861.930690346484;11138.94430527842;11580.88419115798;11608.071354291806;11684.357360344922;11770.882291176978;11406.714832129263;11568.421578921188;11718.824217636571;11907.880921191023;12090.576829810914;11223.71940701489;11507.942460287644;11571.537138514364;11697.06423486136;11875.346855922662;8489.278411334859;8680.739577812676;8719.258862996716;8914.108589141035;9127.315451341043;9821.558029888529;11156.944215278872;11648.35934023603;11671.474783634927;11819.409029548317 21:49:44 INFO - PROCESS | 2219 | |3;mootools.html;1445.8626430489107;1503.736846051941;1596.6966276407488;1743.9128043597816;1792.838644521992;8098.190180981899;8359.456635318715;8714.825703485927;9430.952845235764;9442.055794420563;8723;8955.149260820212;8960.686375976842;9227.677031303905;9230.353875228737;2305.250793492113;2358.363241924679;2360.3509035015422;2360.44529535559;2361.067378385537;1993.4916596268004;2064.2981386328647;2263.920762773303;2318.6985691860036;2327.359976006595;2102.2431924507164;2132.680097985307;2271.716035495563;2319.8724070176136;2338.5206032763326;2268.432891777056;2274.215395688493;2276.9203077892275;2278.40761402035;2278.453171238907;2256.266713318178;2308.9307320780404;2309.7921187093243;2310.122153581645;2312.595295823241;9169.083091690778;9221.031791661846;9223.400478968846;9226.30802689801;9229.077092290785;5253.52718255355;5438.857839853636;5440.455954404528;5440.646357986758;5444;3231.159898426426;3258.2343149360117;3354.4297469430257;3398.0315610051016;3412.351653185887;1110.3448965110624;1113.5879724501985;1114.0530549033338;1135.4493070860626;1142.1205671632797;12923.289219092947;12940.741185176244;13040.087193896432;13059.934700326437;13068;4559.4072770539615;4593.26507758757;4778.546038126373;4802;4815.855524334275;10877.728056798644;10878.40168790724;10891.891081089088;10898.782024359469;10899.237053406345;5480.287562616914;5480.424555421703;5485.588580856452;5485.917711234335;5488.451154884559;4710.128626204163;4800.279958006327;5030.496950305013;5030.89938201234;5031.496850314939;3586.5158203642172;3608.6210947850623;3636.5454318210222;3714.23858109087;3720.8325625346383;1088.2327958789035;1095.8520599719095;1096.923215374932;1115.0856297835696;1122.9494672739747;718.8598223346397;799.3764863406552;886.3441053620403;942.3686130292721;974.3715303629119;5700.429957004267;5998.520118390518;6044.098832560396;6133.355997620186;6142.539309551801;501.04550830667637;502.2767215210086;505.9342285502861;512.8435827072778;659.9243233529412;4120.62914337711;4179.6238338549065;4218.177455396169;4239.533651298355;4258.467691538558;10992.615258466076;11548.538058477734;11548.653540393801;11549.249298795552;11558.653240402802;10987.725306867393;11434.313941163557;11445.599404020819;11445.713857153638;11454.312741235553;8312.8753068704;8531.701390451304;8539.274161696325;8550.273226775793;8557.657693692307;5896.55775816824;6049.395060494091;6247.5001999840815;6282.842928926813;6527.575707579183;10340.948295258475;10432.269741118353;10645.733856653336;10724.624638137628;10820.080293174853;10863.185261105607;10942.452877355941;10944;10950.34297942126;10957.616483423042;7911.28798408146;8194.139615340542;8322.292605128632;8323.875141872997;8326.6669333226;8853.424527405698;8867.290616750515;8947.373683842328;8948.73153805387;8955.059718729439;7959;7963.522188668699;8016;8024.518528888286;8160.347172226327;7751.224877512203;7772.7668169954995;7852.725154619561;7856.685732570862;7952.6421311039985;7145.821354465972;7147.785566433015;7152;7230.493865429369;7235.746748863765;5362.463753624606;5410.3778065522965;5433.185022246536;5444.537214336826;5509.696966666712;5332.760025798771;5415.702136382537;5436.184572314026;5454.590905682169;5536.474034966672 21:49:44 INFO - PROCESS | 2219 | |4;prototype.html;324.72706988604665;328.2794266584846;337.660651045699;338.6731803809324;341.67711512620554;5115.590752739781;5189.740512974355;5195.922061169081;5203.245529398235;5236.947630523694;5166.844994650157;5179.4561571035065;5180.2229665550185;5182.37811462625;5192.247124166994;4046.4941882264716;4143.129942712019;4145.419641250227;4150.543440221589;4162.4796900387455;4096.467459230311;4132.690048246379;4138.668906487489;4141.378793181017;4154;4052.371882358239;4078.9184216315803;4092.7953602319913;4116.958830411688;4121.835126594932;3865.40086286626;3978.7214894957365;3987;4090.468239128909;4106.548279689232;3632.6185750496084;3640.2719456108885;3642.1258897864586;3644.159699351837;3649.981750091259;5013.423456302536;5014.448410674823;5014.874628134289;5020.974895125538;5023.6985780853265;4365.3451982202605;4456.908057525894;4660.720356778605;4673.906521869578;4681.719096854165;5317.893642127175;5357.4106848246665;5382;5396.163594642837;5406.216098665672;3978.781167035812;3983.900402489961;3987.5613682494904;3991.201759648082;3992.441058251847;5356.91964620531;5568.916466253009;5574.331080270353;5618.410066942953;5620.690862002588;4017.979910100431;4019.718619696593;4020.8592699255387;4029.294873397144;4032.193561287754;4066;4066.3087275163293;4071.206114807584;4079.73481723687;4081.3877918311896;4514.706544074625;4634.119517291704;4634.37435946143;4635.420572428447;4639.582437580567;5397.919031214535;5444.40111587725;5447.4824891635235;5456.454354564512;5493.560515158778;1387.2162228340956;1398.454602704946;1398.923059231752;1417.121384741467;1424.3803945283835;851.9787005324793;900.2392977933636;909.2271569166288;910.2990697163148;924.9260059195249;4685.461171965199;4698.355575548599;4699.906001880012;4700.647451441156;4704.717716936994;4935.654504184745;4937.407511098691;4952.306677065214;4960.379952505937;4983.177775667047;4430.851037246933;4662.461387742037;4682.227432473604;4699.694519856198;4709.434867815816;2657.933551661224;2845.729655682707;2888.407876385336;2899.9275018124717;2969.435807196626;5759.596828222068;5774.566907481872;5776.884462310731;5786.82993877296;5804.564657650609;5578.86052848682;5697.344805347355;5708.343540492813;5722.513586345207;5745.88508229833;5723.941070901897;5760.193572899798;5776;5777.595568310178;5783.768649253982;5577.637453565668;5583.525400341016;5595.76893083521;5601.719914004365;5621.184928185308;5312.442193569774;5490.478404551562;5538.833834984957;5549.889002220014;5559.277293951922;5707.886962042362;5776.595638305278;5783.768649254151;5792.247007888947;5800.477956983892;4014.6386825185873;4023.2154729827403;4028.6906755304058;4032.4152997814567;4040.9595904040584;5401.378841433128;5549;5557.916206339886;5606.878624275243;5618.438156184349;5440.646357986719;5453.336732296688;5456.181572764117;5460.460885688174;5468.535174510212;5306.628536002443;5412.918806217831;5441.918371224514;5454.236406903116;5456.0903683710385;5406.567474602101;5421.83734487966;5441.83674489766;5442.863928401822;5455.263539422127;5470.589705772162;5479.082321187552;5491.862703432286;5495.752691128989;5502.174673798962;5229.163333866563;5309.601779866603;5319.46805319465;5389.919151212656;5395.163749618815 21:49:44 INFO - PROCESS | 2219 | |5;yui.html;728.7667946257199;747.8392145688675;770.8689522781128;804.4730701390583;806.637013343995;15776.763348549766;16484.83515164848;16927.15364231788;17031.914840425798;17056.403025894066;14389.712205755879;14484.130952142852;14514.346854391551;14536.200508972002;14571.927140364283;798.0941631248517;812.979675508114;814.8125931035866;815.5962798414793;816.4978538198994;653.1672118049478;669.8124525132971;789.960501974899;805.0902480197369;810.2019510781876;864.3992425264412;865.3769286113987;865.8398196333699;866.5667166416791;867.8264347130568;863.0075413274722;863.8876945997043;864.2524216552669;864.4424346296666;864.9264812490945;501.6755764780981;512.9358830146232;590.9320428150731;607.9817605471843;624.6751689121631;13757.17456952586;14233.217173055478;14245.501407450793;14250.287485625677;14253;13520.526781562598;14042.719145617031;14135.929320353434;14206.928965355108;14529.183852018497;12950.186973823673;13036.41336139876;13091.86908130916;13235.669108272274;13266.933665331708;4443.577860103285;4457.3091170868565;4517.728936263835;4537.31940208968;4701.435827700664;78754;79950.60024699898;80108;80532;82535.587322063;11579.305241685526;11580.594679186357;11715.707107322214;11838.704032399086;12289.324087175291;21788.34634960922;21803.563928721655;21975.670364944537;22012.779872201394;22107;8173.79565510867;8344.8331033379;8367.748967530984;8400.201980811813;8557.27263182624;4475.753833539122;4509.143262780061;4542.954570454253;4587.4036375271;4690.9765451172525;3454.758166928291;3554.4668299755244;3565.8217089145437;3568.1614820517157;3568.3933731265747;589.9616524925866;606.9484093851984;619.3311223878201;628.3025841316136;640.0303540136697;650.5121159130651;664.4617859533793;683.3303362704578;687.8280429892527;689.4656641103185;8392.881118255227;8813.294936405073;8848.601812918434;9000.684976025808;9067.954660226656;606.6269244414653;648.0473703655618;674.2414783368711;687.4637782529635;692.5117791956659;4160.4591403118;4502.909941801146;4858.6356023298395;5109.821156259513;5132.794688212504;86987.56506217555;116556;117121.41439292749;119078;119684;101241;105119;106273;109081.45459272653;109488;92524;93174.53412732892;95785.52107239558;96993;97630;9115.316351273548;9199.448033118035;9472.810543789223;9482.28882833804;9555.61777528891;51845.22232166596;51944.143072131395;52701.7364913173;53480.73259633677;53805;70844.29155708376;73664.89686134628;79877.60061199658;80093.19906800857;81101.59449202953;13015.934920325337;13193.340332983504;13344.266065366499;13377.66555836112;13575.932120339336;14325.57023289303;14361.497347592784;14395.496157634432;14976.400943962119;15191.164485953379;12504.249745015328;12893.563701532801;13016.088873778745;13054.347282635641;13368.90914178368;13210.339483026002;13225;13289.601311960656;13347.199168049949;13547.187168769906;12287.508499659914;12630.810537841757;13030.609081727564;13149.474021039052;13163.341832908507;10871.565137394417;10890.945545272223;11170.776584468103;11578.826317605412;11742.412879355827;10336.328138670962;10968.890311096788;11103.111751059734;11161.55353785872;11195.552177912792 21:49:44 INFO - PROCESS | 2219 | __end_tp_report 21:49:44 INFO - PROCESS | 2219 | __start_cc_report 21:49:44 INFO - PROCESS | 2219 | _x_x_mozilla_cycle_collect,3104 21:49:44 INFO - PROCESS | 2219 | __end_cc_report 21:49:44 INFO - PROCESS | 2219 | __startTimestamp1475815784300__endTimestamp 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | ------- Summary: start ------- 21:49:44 INFO - PROCESS | 2219 | Number of tests: 6 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | [#0] dojo.html Cycles:165 Average:5196.72 Median:5372.52 stddev:576.76 (10.7%) stddev-sans-first:551.75 21:49:44 INFO - PROCESS | 2219 | Values: 2982.5 3013.8 3019.8 3041.9 3069.2 5118.4 5171.3 5212.9 5245.4 5252.7 5207.6 5235.0 5250.4 5296.0 5355.3 4763.7 4766.7 4817.3 4833.4 4880.3 4872.2 4897.6 4907.6 4941.8 4946.7 4655.0 4697.1 4705.1 4858.5 4925.0 4732.7 4752.4 4755.4 4757.5 4757.9 4710.3 4720.8 4725.3 4726.2 4735.5 5108.2 5154.5 5154.8 5162.0 5168.7 5497.4 5499.6 5501.4 5502.6 5507.8 5595.3 5621.7 5641.7 5651.7 5654.3 5109.1 5120.5 5123.1 5222.7 5265.3 5560.1 5602.1 5685.1 5688.4 5694.3 5401.0 5472.8 5478.1 5480.8 5538.8 5514.1 5525.3 5591.7 5599.7 5675.1 5572.2 5602.6 5603.4 5604.3 5609.6 5601.8 5614.7 5616.5 5617.9 5679.6 4204.7 4228.8 4315.0 4359.7 4366.1 3885.7 3904.2 3930.1 3930.6 3941.3 5326.9 5350.3 5362.3 5363.8 5365.1 5479.0 5487.8 5525.2 5673.3 5687.9 5288.6 5289.5 5289.7 5291.6 5294.6 4804.0 4839.5 4845.7 4848.7 4851.3 5764.5 5770.6 5770.8 5773.1 5813.3 5606.8 5612.4 5612.7 5613.0 5615.0 5816.5 5837.2 5843.1 5843.7 5845.9 5469.6 5477.1 5506.0 5509.9 5512.8 5630.3 5636.4 5638.5 5641.9 5644.2 5335.6 5474.4 5480.6 5487.9 5548.0 5364.1 5444.5 5444.8 5446.5 5446.5 5429.6 5434.6 5437.3 5437.6 5438.6 5325.4 5459.5 5467.5 5477.8 5486.0 4860.0 5293.8 5351.0 5371.5 5372.5 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | [#1] ext.html Cycles:180 Average:56965.85 Median:406824.50 stddev:107556.02 (26.4%) stddev-sans-first:107774.46 21:49:44 INFO - PROCESS | 2219 | Values: 592.4 602.3 608.5 610.4 613.7 32782.5 42427.0 43247.6 43384.8 48399.0 46597.3 46866.3 46967.7 47070.7 47144.8 8878.6 9023.5 9038.9 9041.6 9043.5 8008.8 8174.0 10519.5 10804.6 10810.5 10918.8 11005.8 11011.4 11013.5 11016.3 8080.4 10769.5 10820.1 10829.0 10841.5 7896.8 10189.1 10510.1 10520.5 10860.1 41607.6 42351.1 42355.6 42363.6 42390.6 3431.2 3503.7 3567.9 3626.6 3867.5 32021.5 32125.5 32406.7 33880.0 33955.0 4261.9 4413.8 4427.0 4434.5 4487.7 248368.0 248377.0 249891.0 250480.0 252647.0 61873.4 62449.7 62487.0 62508.7 62523.4 36369.0 37454.6 37495.6 40077.0 65208.3 17734.0 17909.3 17910.5 17910.7 17912.6 12031.2 12259.4 13445.6 13522.3 13544.5 17351.6 17492.3 18792.7 19411.2 19482.3 7002.9 7010.3 7060.6 7248.6 7383.2 930.4 1025.0 1046.6 1079.2 1132.2 32541.3 34706.7 35042.0 36722.0 37043.0 1085.4 1113.7 1124.5 1193.3 1201.6 16862.0 17231.7 17244.2 17300.9 17375.7 505524.0 516819.0 517363.6 518037.0 521661.0 59623.1 60450.7 60610.0 60721.0 60792.7 1237.5 1275.6 1293.6 1367.6 1382.6 30161.2 32749.7 33666.1 33980.7 34529.5 52149.0 52859.5 52955.5 53005.5 53007.7 406623.0 407026.0 408652.0 409932.0 409936.3 45785.3 45883.0 47635.0 47979.3 48196.8 48169.5 48501.0 48868.5 49226.8 49616.0 40729.6 41127.4 41582.6 41601.8 42790.1 41291.0 41978.6 42004.8 42148.2 42410.6 42591.0 43086.6 44404.1 45714.5 45790.5 34754.0 37415.0 37603.2 37738.6 38539.0 28212.4 28374.9 28631.9 28694.6 28737.7 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | [#2] jquery.html Cycles:180 Average:28611.33 Median:2259.84 stddev:78559.95 (3476.3%) stddev-sans-first:78751.71 21:49:44 INFO - PROCESS | 2219 | Values: 368.6 381.4 393.2 396.6 414.4 13631.5 15096.4 17032.7 19497.8 19979.5 18590.3 18622.8 19351.7 19904.1 19910.9 5375.0 5656.4 5882.5 5884.8 5898.5 5501.4 5725.8 5742.7 5742.8 5747.3 5564.4 5710.4 5714.3 5714.7 5717.6 5791.9 5945.7 5951.9 5953.2 5954.3 5586.6 5729.1 5750.7 5761.5 5777.5 13909.9 14164.6 14168.5 14235.8 14744.4 2225.9 2293.8 2347.5 2661.5 2932.9 10570.8 11039.0 11689.8 12643.5 14819.0 1930.3 1974.7 2003.2 2023.3 2036.7 81185.0 85135.0 85950.0 86172.0 87674.6 10978.7 11179.2 11188.4 11200.5 11232.4 15682.3 15786.9 15810.0 15819.1 15832.1 7931.2 8125.2 8332.1 8500.1 8590.0 7846.3 7849.0 7877.6 7919.6 8242.8 4815.0 4815.5 4821.3 4825.9 4889.6 1926.7 2013.3 2024.5 2026.1 2035.2 704.2 927.6 947.5 996.7 1046.4 19176.9 19261.2 19565.5 19976.9 20206.9 957.5 969.8 978.7 1013.1 1051.1 10732.7 11088.6 11139.5 11228.7 11289.9 465521.0 467310.0 467469.0 485349.0 485728.0 96007.5 97957.0 100090.5 101155.0 104352.0 1004.8 1025.4 1052.7 1059.2 1060.8 13267.9 17661.7 18160.6 18236.3 18278.4 41723.4 42522.0 42714.6 43004.1 45519.5 52019.2 52272.9 54245.2 54351.7 55414.4 8584.9 8679.5 8773.4 8972.1 9152.0 11075.8 12873.9 13427.9 13444.7 13861.9 11138.9 11580.9 11608.1 11684.4 11770.9 11406.7 11568.4 11718.8 11907.9 12090.6 11223.7 11507.9 11571.5 11697.1 11875.3 8489.3 8680.7 8719.3 8914.1 9127.3 9821.6 11156.9 11648.4 11671.5 11819.4 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | [#3] mootools.html Cycles:180 Average:5980.55 Median:4808.93 stddev:3529.43 (73.4%) stddev-sans-first:3522.88 21:49:44 INFO - PROCESS | 2219 | Values: 1445.9 1503.7 1596.7 1743.9 1792.8 8098.2 8359.5 8714.8 9431.0 9442.1 8723.0 8955.1 8960.7 9227.7 9230.4 2305.3 2358.4 2360.4 2360.4 2361.1 1993.5 2064.3 2263.9 2318.7 2327.4 2102.2 2132.7 2271.7 2319.9 2338.5 2268.4 2274.2 2276.9 2278.4 2278.5 2256.3 2308.9 2309.8 2310.1 2312.6 9169.1 9221.0 9223.4 9226.3 9229.1 5253.5 5438.9 5440.5 5440.6 5444.0 3231.2 3258.2 3354.4 3398.0 3412.4 1110.3 1113.6 1114.1 1135.4 1142.1 12923.3 12940.7 13040.1 13059.9 13068.0 4559.4 4593.3 4778.5 4802.0 4815.9 10877.7 10878.4 10891.9 10898.8 10899.2 5480.3 5480.4 5485.6 5485.9 5488.5 4710.1 4800.3 5030.5 5030.9 5031.5 3586.5 3608.6 3636.5 3714.2 3720.8 1088.2 1095.9 1096.9 1115.1 1122.9 718.9 799.4 886.3 942.4 974.4 5700.4 5998.5 6044.1 6133.4 6142.5 501.0 502.3 505.9 512.8 659.9 4120.6 4179.6 4218.2 4239.5 4258.5 10992.6 11548.5 11548.7 11549.2 11558.7 10987.7 11434.3 11445.6 11445.7 11454.3 8312.9 8531.7 8539.3 8550.3 8557.7 5896.6 6049.4 6247.5 6282.8 6527.6 10340.9 10432.3 10645.7 10724.6 10820.1 10863.2 10942.5 10944.0 10950.3 10957.6 7911.3 8194.1 8322.3 8323.9 8326.7 8853.4 8867.3 8947.4 8948.7 8955.1 7959.0 7963.5 8016.0 8024.5 8160.3 7751.2 7772.8 7852.7 7856.7 7952.6 7145.8 7147.8 7152.0 7230.5 7235.7 5362.5 5410.4 5433.2 5444.5 5509.7 5332.8 5415.7 5436.2 5454.6 5536.5 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | [#4] prototype.html Cycles:180 Average:4544.10 Median:5141.22 stddev:1326.84 (25.8%) stddev-sans-first:1292.22 21:49:44 INFO - PROCESS | 2219 | Values: 324.7 328.3 337.7 338.7 341.7 5115.6 5189.7 5195.9 5203.2 5236.9 5166.8 5179.5 5180.2 5182.4 5192.2 4046.5 4143.1 4145.4 4150.5 4162.5 4096.5 4132.7 4138.7 4141.4 4154.0 4052.4 4078.9 4092.8 4117.0 4121.8 3865.4 3978.7 3987.0 4090.5 4106.5 3632.6 3640.3 3642.1 3644.2 3650.0 5013.4 5014.4 5014.9 5021.0 5023.7 4365.3 4456.9 4660.7 4673.9 4681.7 5317.9 5357.4 5382.0 5396.2 5406.2 3978.8 3983.9 3987.6 3991.2 3992.4 5356.9 5568.9 5574.3 5618.4 5620.7 4018.0 4019.7 4020.9 4029.3 4032.2 4066.0 4066.3 4071.2 4079.7 4081.4 4514.7 4634.1 4634.4 4635.4 4639.6 5397.9 5444.4 5447.5 5456.5 5493.6 1387.2 1398.5 1398.9 1417.1 1424.4 852.0 900.2 909.2 910.3 924.9 4685.5 4698.4 4699.9 4700.6 4704.7 4935.7 4937.4 4952.3 4960.4 4983.2 4430.9 4662.5 4682.2 4699.7 4709.4 2657.9 2845.7 2888.4 2899.9 2969.4 5759.6 5774.6 5776.9 5786.8 5804.6 5578.9 5697.3 5708.3 5722.5 5745.9 5723.9 5760.2 5776.0 5777.6 5783.8 5577.6 5583.5 5595.8 5601.7 5621.2 5312.4 5490.5 5538.8 5549.9 5559.3 5707.9 5776.6 5783.8 5792.2 5800.5 4014.6 4023.2 4028.7 4032.4 4041.0 5401.4 5549.0 5557.9 5606.9 5618.4 5440.6 5453.3 5456.2 5460.5 5468.5 5306.6 5412.9 5441.9 5454.2 5456.1 5406.6 5421.8 5441.8 5442.9 5455.3 5470.6 5479.1 5491.9 5495.8 5502.2 5229.2 5309.6 5319.5 5389.9 5395.2 21:49:44 INFO - PROCESS | 2219 | 21:49:44 INFO - PROCESS | 2219 | [#5] yui.html Cycles:180 Average:21379.59 Median:4527.52 stddev:31241.61 (690.0%) stddev-sans-first:31290.77 21:49:44 INFO - PROCESS | 2219 | Values: 728.8 747.8 770.9 804.5 806.6 15776.8 16484.8 16927.2 17031.9 17056.4 14389.7 14484.1 14514.3 14536.2 14571.9 798.1 813.0 814.8 815.6 816.5 653.2 669.8 790.0 805.1 810.2 864.4 865.4 865.8 866.6 867.8 863.0 863.9 864.3 864.4 864.9 501.7 512.9 590.9 608.0 624.7 13757.2 14233.2 14245.5 14250.3 14253.0 13520.5 14042.7 14135.9 14206.9 14529.2 12950.2 13036.4 13091.9 13235.7 13266.9 4443.6 4457.3 4517.7 4537.3 4701.4 78754.0 79950.6 80108.0 80532.0 82535.6 11579.3 11580.6 11715.7 11838.7 12289.3 21788.3 21803.6 21975.7 22012.8 22107.0 8173.8 8344.8 8367.7 8400.2 8557.3 4475.8 4509.1 4543.0 4587.4 4691.0 3454.8 3554.5 3565.8 3568.2 3568.4 590.0 606.9 619.3 628.3 640.0 650.5 664.5 683.3 687.8 689.5 8392.9 8813.3 8848.6 9000.7 9068.0 606.6 648.0 674.2 687.5 692.5 4160.5 4502.9 4858.6 5109.8 5132.8 86987.6 116556.0 117121.4 119078.0 119684.0 101241.0 105119.0 106273.0 109081.5 109488.0 92524.0 93174.5 95785.5 96993.0 97630.0 9115.3 9199.4 9472.8 9482.3 9555.6 51845.2 51944.1 52701.7 53480.7 53805.0 70844.3 73664.9 79877.6 80093.2 81101.6 13015.9 13193.3 13344.3 13377.7 13575.9 14325.6 14361.5 14395.5 14976.4 15191.2 12504.2 12893.6 13016.1 13054.3 13368.9 13210.3 13225.0 13289.6 13347.2 13547.2 12287.5 12630.8 13030.6 13149.5 13163.3 10871.6 10890.9 11170.8 11578.8 11742.4 10336.3 10968.9 11103.1 11161.6 11195.6 21:49:44 INFO - PROCESS | 2219 | -------- Summary: end -------- 21:49:44 INFO - PROCESS | 2219 | 21:49:45 INFO - TEST-INFO | 2219: exit 0 21:49:45 INFO - TEST-OK | dromaeo_css | took 1118179ms 21:49:45 INFO - TEST-START | kraken 21:49:45 INFO - operating with platform_type : linux_ 21:49:45 INFO - Initialising browser for kraken test... 21:49:45 INFO - TEST-INFO | started process 2615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphYJ91i/profile http://localhost:41275/getInfo.html) 21:49:49 INFO - PROCESS | 2615 | __metrics Screen width/height:1600/1200 21:49:49 INFO - PROCESS | 2615 | colorDepth:24 21:49:49 INFO - PROCESS | 2615 | Browser inner width/height: 1024/697 21:49:49 INFO - PROCESS | 2615 | __metrics 21:49:50 INFO - PROCESS | 2615 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:49:50 INFO - PROCESS | 2615 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:49:50 INFO - PROCESS | 2615 | console.error: PushService: 21:49:50 INFO - PROCESS | 2615 | stateChangeProcessEnqueue: Error transitioning state 21:49:50 INFO - PROCESS | 2615 | UnknownError 21:49:51 INFO - TEST-INFO | 2615: exit 0 21:49:51 INFO - Browser initialized. 21:49:51 INFO - Running cycle 1/1 for kraken test... 21:49:51 INFO - TEST-INFO | started process 2726 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphYJ91i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:50:03 INFO - PROCESS | 2726 | RSS: Main: 173547520 21:50:03 INFO - PROCESS | 2726 | 21:50:05 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41275/tests/kraken/driver.html?testName=audio-beat-detection) 21:50:06 INFO - PROCESS | 2726 | RSS: Main: 232681472 21:50:06 INFO - PROCESS | 2726 | 21:50:09 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41275/tests/kraken/driver.html?testName=audio-dft) 21:50:09 INFO - PROCESS | 2726 | RSS: Main: 217772032 21:50:09 INFO - PROCESS | 2726 | 21:50:13 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41275/tests/kraken/driver.html?testName=audio-fft) 21:50:13 INFO - PROCESS | 2726 | RSS: Main: 299524096 21:50:13 INFO - PROCESS | 2726 | 21:50:15 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41275/tests/kraken/driver.html?testName=audio-oscillator) 21:50:16 INFO - PROCESS | 2726 | RSS: Main: 210665472 21:50:16 INFO - PROCESS | 2726 | 21:50:18 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:50:19 INFO - PROCESS | 2726 | RSS: Main: 213323776 21:50:19 INFO - PROCESS | 2726 | 21:50:22 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41275/tests/kraken/driver.html?testName=imaging-darkroom) 21:50:22 INFO - PROCESS | 2726 | RSS: Main: 249765888 21:50:22 INFO - PROCESS | 2726 | 21:50:26 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41275/tests/kraken/driver.html?testName=imaging-desaturate) 21:50:26 INFO - PROCESS | 2726 | RSS: Main: 247939072 21:50:26 INFO - PROCESS | 2726 | 21:50:29 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41275/tests/kraken/driver.html?testName=json-parse-financial) 21:50:30 INFO - PROCESS | 2726 | RSS: Main: 248696832 21:50:30 INFO - PROCESS | 2726 | 21:50:31 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:50:32 INFO - PROCESS | 2726 | RSS: Main: 210792448 21:50:32 INFO - PROCESS | 2726 | 21:50:33 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:50:34 INFO - PROCESS | 2726 | RSS: Main: 217092096 21:50:34 INFO - PROCESS | 2726 | 21:50:36 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:50:37 INFO - PROCESS | 2726 | RSS: Main: 226549760 21:50:37 INFO - PROCESS | 2726 | 21:50:39 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:50:40 INFO - PROCESS | 2726 | RSS: Main: 235827200 21:50:40 INFO - PROCESS | 2726 | 21:50:43 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:50:43 INFO - PROCESS | 2726 | RSS: Main: 233226240 21:50:43 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | Cycle 1(1): loaded http://localhost:41275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41275/tests/kraken/driver.html?testName=ai-astar) 21:50:45 INFO - PROCESS | 2726 | RSS: Main: 283860992 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | __start_tp_report 21:50:45 INFO - PROCESS | 2726 | _x_x_mozilla_page_load 21:50:45 INFO - PROCESS | 2726 | _x_x_mozilla_page_load_details 21:50:45 INFO - PROCESS | 2726 | |i|pagename|runs| 21:50:45 INFO - PROCESS | 2726 | |0;ai-astar;110;110;112;111;111;110;111;112;111;110 21:50:45 INFO - PROCESS | 2726 | |1;audio-beat-detection;145;124;122;154;126;127;123;121;155;124 21:50:45 INFO - PROCESS | 2726 | |2;audio-dft;159;162;161;160;159;161;161;161;161;162 21:50:45 INFO - PROCESS | 2726 | |3;audio-fft;75;75;74;119;77;76;75;76;98;76 21:50:45 INFO - PROCESS | 2726 | |4;audio-oscillator;84;83;112;83;83;83;107;82;82;111 21:50:45 INFO - PROCESS | 2726 | |5;imaging-gaussian-blur;116;116;116;116;117;116;117;117;117;117 21:50:45 INFO - PROCESS | 2726 | |6;imaging-darkroom;145;146;146;146;146;146;147;146;145;146 21:50:45 INFO - PROCESS | 2726 | |7;imaging-desaturate;95;96;96;96;95;96;96;95;95;95 21:50:45 INFO - PROCESS | 2726 | |8;json-parse-financial;54;51;49;51;51;52;51;51;50;52 21:50:45 INFO - PROCESS | 2726 | |9;json-stringify-tinderbox;60;61;61;61;62;60;61;61;61;61 21:50:45 INFO - PROCESS | 2726 | |10;stanford-crypto-aes;80;79;82;79;84;80;80;78;85;79 21:50:45 INFO - PROCESS | 2726 | |11;stanford-crypto-ccm;131;146;129;139;132;129;140;131;164;145 21:50:45 INFO - PROCESS | 2726 | |12;stanford-crypto-pbkdf2;170;170;171;172;167;171;166;166;167;170 21:50:45 INFO - PROCESS | 2726 | |13;stanford-crypto-sha256-iterative;66;69;66;67;65;65;67;64;64;68 21:50:45 INFO - PROCESS | 2726 | __end_tp_report 21:50:45 INFO - PROCESS | 2726 | __start_cc_report 21:50:45 INFO - PROCESS | 2726 | _x_x_mozilla_cycle_collect,1682 21:50:45 INFO - PROCESS | 2726 | __end_cc_report 21:50:45 INFO - PROCESS | 2726 | __startTimestamp1475815845958__endTimestamp 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | ------- Summary: start ------- 21:50:45 INFO - PROCESS | 2726 | Number of tests: 14 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 21:50:45 INFO - PROCESS | 2726 | Values: 110.0 110.0 112.0 111.0 111.0 110.0 111.0 112.0 111.0 110.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:126.50 stddev:13.63 (10.8%) stddev-sans-first:13.64 21:50:45 INFO - PROCESS | 2726 | Values: 145.0 124.0 122.0 154.0 126.0 127.0 123.0 121.0 155.0 124.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:0.93 21:50:45 INFO - PROCESS | 2726 | Values: 159.0 162.0 161.0 160.0 159.0 161.0 161.0 161.0 161.0 162.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:14.79 (19.5%) stddev-sans-first:15.46 21:50:45 INFO - PROCESS | 2726 | Values: 75.0 75.0 74.0 119.0 77.0 76.0 75.0 76.0 98.0 76.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.00 stddev:13.18 (15.9%) stddev-sans-first:13.74 21:50:45 INFO - PROCESS | 2726 | Values: 84.0 83.0 112.0 83.0 83.0 83.0 107.0 82.0 82.0 111.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:50:45 INFO - PROCESS | 2726 | Values: 116.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 21:50:45 INFO - PROCESS | 2726 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 146.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:50:45 INFO - PROCESS | 2726 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.32 (2.6%) stddev-sans-first:0.93 21:50:45 INFO - PROCESS | 2726 | Values: 54.0 51.0 49.0 51.0 51.0 52.0 51.0 51.0 50.0 52.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 21:50:45 INFO - PROCESS | 2726 | Values: 60.0 61.0 61.0 61.0 62.0 60.0 61.0 61.0 61.0 61.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:80.00 stddev:2.32 (2.9%) stddev-sans-first:2.45 21:50:45 INFO - PROCESS | 2726 | Values: 80.0 79.0 82.0 79.0 84.0 80.0 80.0 78.0 85.0 79.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:139.50 stddev:10.99 (7.9%) stddev-sans-first:11.30 21:50:45 INFO - PROCESS | 2726 | Values: 131.0 146.0 129.0 139.0 132.0 129.0 140.0 131.0 164.0 145.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:170.00 stddev:2.26 (1.3%) stddev-sans-first:2.37 21:50:45 INFO - PROCESS | 2726 | Values: 170.0 170.0 171.0 172.0 167.0 171.0 166.0 166.0 167.0 170.0 21:50:45 INFO - PROCESS | 2726 | 21:50:45 INFO - PROCESS | 2726 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.66 (2.5%) stddev-sans-first:1.76 21:50:45 INFO - PROCESS | 2726 | Values: 66.0 69.0 66.0 67.0 65.0 65.0 67.0 64.0 64.0 68.0 21:50:45 INFO - PROCESS | 2726 | -------- Summary: end -------- 21:50:45 INFO - PROCESS | 2726 | 21:50:47 INFO - TEST-INFO | 2726: exit 0 21:50:47 INFO - TEST-OK | kraken | took 61991ms 21:50:47 INFO - SUITE-END | took 1180s 21:50:47 INFO - Completed test suite (00:19:40) 21:50:47 INFO - javascript benchmark 21:50:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2982.5227963525836, 3013.7890347675657, 3019.8037127586717, 3041.908742737716, 3069.1713237425897, 5118.385793704751, 5171.250168725537, 5212.895742085156, 5245.396779370373, 5252.684838909663, 5207.557357624597, 5234.973825130878, 5250.396204436491, 5296.0, 5355.250264962899, 4763.666543341968, 4766.73782941938, 4817.325574419584, 4833.444153922291, 4880.341153944225, 4872.220444728844, 4897.583705385046, 4907.582855457291, 4941.802327906879, 4946.653734238605, 4655.045715628288, 4697.084068606623, 4705.12955103307, 4858.4898585648525, 4924.975375123137, 4732.716037037789, 4752.405949256343, 4755.358026666425, 4757.548032936866, 4757.904841903177, 4710.293455981596, 4720.76396180193, 4725.3384526166365, 4726.243800991825, 4735.526447355272, 5108.208227724708, 5154.53609175176, 5154.819581314673, 5162.0, 5168.689878607295, 5497.367802702701, 5499.560035197174, 5501.422350653163, 5502.58730595207, 5507.834764957058, 5595.300587426572, 5621.7189140542805, 5641.68970706611, 5651.660900345993, 5654.264945557093, 5109.131447653907, 5120.539151476385, 5123.129068058364, 5222.686638801684, 5265.315508983807, 5560.054790685593, 5602.13166959122, 5685.147227915763, 5688.431156884279, 5694.345150307768, 5401.027814993339, 5472.835814925558, 5478.096114141202, 5480.808171713971, 5538.750756215899, 5514.062609356419, 5525.281713377235, 5591.692456914828, 5599.664020158803, 5675.091985282335, 5572.192032155314, 5602.551795856321, 5603.411641777636, 5604.271444712162, 5609.5792815539, 5601.7759289628775, 5614.747336369873, 5616.494515493543, 5617.9438205618235, 5679.630823996427, 4204.705670603028, 4228.830846766156, 4314.9784251078545, 4359.738415695068, 4366.126774645084, 3885.708571857122, 3904.1996390739832, 3930.0960779020415, 3930.6265904739003, 3941.3102707026155, 5326.92009619856, 5350.250964864922, 5362.329708786402, 5363.812266570651, 5365.1147560652835, 5479.013777520085, 5487.780488780404, 5525.198846167364, 5673.319201695823, 5687.857803554862, 5288.629795914249, 5289.523942845085, 5289.656172348862, 5291.603129765283, 5294.576433885357, 4803.951960480351, 4839.491853355417, 4845.733484658307, 4848.684835485682, 4851.296561998491, 5764.538836893039, 5770.6249093808765, 5770.798022069207, 5773.1051686988585, 5813.302403711582, 5606.803761868315, 5612.382637909908, 5612.663240205601, 5612.971935140298, 5615.0, 5816.476517113311, 5837.211976383303, 5843.065109582616, 5843.678597676999, 5845.912311315419, 5469.589780766538, 5477.123660214346, 5506.0089183947275, 5509.889802203853, 5512.779488820403, 5630.324361076697, 5636.351819540805, 5638.464345887134, 5641.9435805641415, 5644.153376993319, 5335.626506144533, 5474.3704473986, 5480.588955828409, 5487.862803429946, 5548.029094908456, 5364.14173732201, 5444.455554444524, 5444.754986025718, 5446.509814116748, 5446.537044351275, 5429.6199266051, 5434.64674796137, 5437.32033495813, 5437.646552974044, 5438.619296649196, 5325.414204437431, 5459.535939445192, 5467.480589344006, 5477.808276710296, 5486.039943010037, 4860.0, 5293.761780719799, 5351.010063138332, 5371.4897084776885, 5372.516473517402], "value": 5158.669512446131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.4135106244817, 602.2592211579757, 608.4888693497464, 610.4201009041411, 613.6716856481781, 32782.50826237605, 42427.0, 43247.567524324746, 43384.78307608461, 48399.0, 46597.30104048442, 46866.29700554494, 46967.651617419164, 47070.705050646466, 47144.76427617857, 8878.600462979166, 9023.45859248444, 9038.86441703375, 9041.593128309241, 9043.547822608876, 8008.7597372078635, 8174.0, 10519.52662130206, 10804.5678172873, 10810.513526891309, 10918.836217456705, 11005.779884402347, 11011.449427528632, 11013.504392302326, 11016.339019658806, 8080.353571714249, 10769.461526923662, 10820.080293175011, 10829.0, 10841.512131954081, 7896.80257993549, 10189.133923616502, 10510.054095131474, 10520.526576304008, 10860.076893464066, 41607.58392416098, 42351.12962009377, 42355.57644423578, 42363.57636423627, 42390.57609423897, 3431.157542166741, 3503.7197024238, 3567.8572857085946, 3626.6373362663785, 3867.45855580219, 32021.519677204862, 32125.51811722826, 32406.6759332406, 33880.0, 33955.0, 4261.850835220753, 4413.779311034467, 4426.977865110686, 4434.4678638563255, 4487.708298960557, 248368.0, 248377.0, 249891.0, 250480.0, 252647.0, 61873.38126618676, 62449.68775156095, 62487.0, 62508.68745656333, 62523.374766252666, 36369.0, 37454.62545374512, 37495.62504374921, 40077.0, 65208.347916521176, 17734.0, 17909.28362865497, 17910.462686119437, 17910.731339029924, 17912.641747164984, 12031.157818952765, 12259.448324825404, 13445.596632101053, 13522.25627590492, 13544.45822167122, 17351.566210844576, 17492.300307987793, 18792.71810922837, 19411.2235510578, 19482.318118865773, 7002.929970700227, 7010.298970102949, 7060.6116663584, 7248.637568121679, 7383.15093764224, 930.4231376546585, 1025.0127005946872, 1046.581367453025, 1079.2337440417234, 1132.2074547816562, 32541.34917301688, 34706.709442332125, 35041.961782038576, 36722.0, 37043.0, 1085.3596378136938, 1113.732704150998, 1124.5445594534226, 1193.254216114928, 1201.5554244929433, 16862.0, 17231.741523877154, 17244.224009919584, 17300.913495432695, 17375.65248695019, 505524.0, 516819.0, 517363.6109111262, 518037.0, 521661.0, 59623.10565341523, 60450.69774651099, 60610.0, 60721.0, 60792.696036519534, 1237.5173682263924, 1275.5854347337151, 1293.5601895355624, 1367.5965590150731, 1382.62669079348, 30161.245968850075, 32749.672503275615, 33666.12005243447, 33980.66019339775, 34529.48205776865, 52149.0, 52859.471405285454, 52955.470445295054, 53005.46994530005, 53007.734961324946, 406623.0, 407026.0, 408652.0, 409932.0, 409936.31082715414, 45785.313220302385, 45883.0, 47635.04729905452, 47979.28031079467, 48196.7590162047, 48169.518304816505, 48501.0, 48868.5113148864, 49226.75386623044, 49616.04607447129, 40729.59270407258, 41127.38308925309, 41582.584174159085, 41601.79199103985, 42790.144197116504, 41291.0, 41978.580214197464, 42004.768507895824, 42148.1570368597, 42410.57589424066, 42591.0, 43086.56913430951, 44404.11191776211, 45714.54285457103, 45790.542094578625, 34754.0, 37415.0, 37603.24793504169, 37738.62261377461, 38539.0, 28212.43575128527, 28374.85812570924, 28631.856840715664, 28694.56958145588, 28737.712622873503], "value": 20638.28806812552, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5632525457332, 381.4202412333253, 393.23908237560323, 396.6033966033967, 414.3929143804326, 13631.522896698618, 15096.396144154234, 17032.65934681307, 19497.805021949775, 19979.50051248716, 18590.256389744427, 18622.81377186228, 19351.709724354147, 19904.10431530581, 19910.900445497788, 5375.0, 5656.377798442168, 5882.4705776480105, 5884.764609415618, 5898.528117750569, 5501.394846566875, 5725.7995970141055, 5742.7415766290615, 5742.827715168531, 5747.281589801275, 5564.387917329091, 5710.371859095496, 5714.342850572196, 5714.742836572344, 5717.599768016241, 5791.855203619901, 5945.702714864239, 5951.940480595182, 5953.166556682025, 5954.255718035246, 5586.636868603528, 5729.1119876419225, 5750.741216645261, 5761.481466667978, 5777.45114214149, 13909.930450347683, 14164.645883852987, 14168.504102356368, 14235.78646320306, 14744.410223591043, 2225.8948766470844, 2293.793558579736, 2347.507023525062, 2661.4810112028163, 2932.8973485928104, 10570.788584228349, 11039.0, 11689.824652630217, 12643.49426022958, 14819.036762610504, 1930.3050901675385, 1974.7334109895123, 2003.2087325506343, 2023.251396983111, 2036.7148599196125, 81185.0, 85135.0, 85950.0, 86172.0, 87674.56162719273, 10978.725531861768, 11179.161562882817, 11188.384638844942, 11200.495977680861, 11232.382218977871, 15682.255605269032, 15786.921065394828, 15810.0, 15819.101707794907, 15832.129232892301, 7931.2068793120225, 8125.212453260391, 8332.083470818205, 8500.10748871372, 8590.0, 7846.254605812439, 7849.0, 7877.56673382958, 7919.604019799102, 8242.793930151674, 4814.975925120352, 4815.542523460265, 4821.251886424704, 4825.855224343275, 4889.584385327216, 1926.730257763914, 2013.3154727392464, 2024.5423295227413, 2026.1085122546033, 2035.196097541463, 704.1837959047197, 927.6196759328643, 947.5001489780103, 996.6612345482724, 1046.4401545173296, 19176.904115479334, 19261.22955081809, 19565.510862228275, 19976.90011549933, 20206.86851056636, 957.4973139101888, 969.7672558585889, 978.7308490165261, 1013.1135256650431, 1051.1223128687632, 10732.678019659423, 11088.611898583511, 11139.496168017215, 11228.663140105646, 11289.887101128883, 465521.0, 467310.0, 467469.0, 485349.0, 485728.0, 96007.51996239975, 97957.0, 100090.49954750325, 101155.0, 104352.0, 1004.753835310339, 1025.4411345816548, 1052.6736711619421, 1059.2214722179192, 1060.7878424315168, 13267.867321326663, 17661.735073973643, 18160.636787264444, 18236.270549177883, 18278.360257390927, 41723.37414938839, 42522.0, 42714.57285427106, 43004.139917202105, 45519.54480455153, 52019.2197117036, 52272.897700856425, 54245.18632220441, 54351.72824135854, 55414.445855542544, 8584.871226931476, 8679.479231246145, 8773.42972706772, 8972.057933916845, 9151.954240228757, 11075.778484430428, 12873.935630321788, 13427.865721343052, 13444.663883402993, 13861.930690346484, 11138.94430527842, 11580.88419115798, 11608.071354291806, 11684.357360344922, 11770.882291176978, 11406.714832129263, 11568.421578921188, 11718.824217636571, 11907.880921191023, 12090.576829810914, 11223.71940701489, 11507.942460287644, 11571.537138514364, 11697.06423486136, 11875.346855922662, 8489.278411334859, 8680.739577812676, 8719.258862996716, 8914.108589141035, 9127.315451341043, 9821.558029888529, 11156.944215278872, 11648.35934023603, 11671.474783634927, 11819.409029548317], "value": 9182.159900590084, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.8626430489107, 1503.736846051941, 1596.6966276407488, 1743.9128043597816, 1792.838644521992, 8098.190180981899, 8359.456635318715, 8714.825703485927, 9430.952845235764, 9442.055794420563, 8723.0, 8955.149260820212, 8960.686375976842, 9227.677031303905, 9230.353875228737, 2305.250793492113, 2358.363241924679, 2360.3509035015422, 2360.44529535559, 2361.067378385537, 1993.4916596268004, 2064.2981386328647, 2263.920762773303, 2318.6985691860036, 2327.359976006595, 2102.2431924507164, 2132.680097985307, 2271.716035495563, 2319.8724070176136, 2338.5206032763326, 2268.432891777056, 2274.215395688493, 2276.9203077892275, 2278.40761402035, 2278.453171238907, 2256.266713318178, 2308.9307320780404, 2309.7921187093243, 2310.122153581645, 2312.595295823241, 9169.083091690778, 9221.031791661846, 9223.400478968846, 9226.30802689801, 9229.077092290785, 5253.52718255355, 5438.857839853636, 5440.455954404528, 5440.646357986758, 5444.0, 3231.159898426426, 3258.2343149360117, 3354.4297469430257, 3398.0315610051016, 3412.351653185887, 1110.3448965110624, 1113.5879724501985, 1114.0530549033338, 1135.4493070860626, 1142.1205671632797, 12923.289219092947, 12940.741185176244, 13040.087193896432, 13059.934700326437, 13068.0, 4559.4072770539615, 4593.26507758757, 4778.546038126373, 4802.0, 4815.855524334275, 10877.728056798644, 10878.40168790724, 10891.891081089088, 10898.782024359469, 10899.237053406345, 5480.287562616914, 5480.424555421703, 5485.588580856452, 5485.917711234335, 5488.451154884559, 4710.128626204163, 4800.279958006327, 5030.496950305013, 5030.89938201234, 5031.496850314939, 3586.5158203642172, 3608.6210947850623, 3636.5454318210222, 3714.23858109087, 3720.8325625346383, 1088.2327958789035, 1095.8520599719095, 1096.923215374932, 1115.0856297835696, 1122.9494672739747, 718.8598223346397, 799.3764863406552, 886.3441053620403, 942.3686130292721, 974.3715303629119, 5700.429957004267, 5998.520118390518, 6044.098832560396, 6133.355997620186, 6142.539309551801, 501.04550830667637, 502.2767215210086, 505.9342285502861, 512.8435827072778, 659.9243233529412, 4120.62914337711, 4179.6238338549065, 4218.177455396169, 4239.533651298355, 4258.467691538558, 10992.615258466076, 11548.538058477734, 11548.653540393801, 11549.249298795552, 11558.653240402802, 10987.725306867393, 11434.313941163557, 11445.599404020819, 11445.713857153638, 11454.312741235553, 8312.8753068704, 8531.701390451304, 8539.274161696325, 8550.273226775793, 8557.657693692307, 5896.55775816824, 6049.395060494091, 6247.5001999840815, 6282.842928926813, 6527.575707579183, 10340.948295258475, 10432.269741118353, 10645.733856653336, 10724.624638137628, 10820.080293174853, 10863.185261105607, 10942.452877355941, 10944.0, 10950.34297942126, 10957.616483423042, 7911.28798408146, 8194.139615340542, 8322.292605128632, 8323.875141872997, 8326.6669333226, 8853.424527405698, 8867.290616750515, 8947.373683842328, 8948.73153805387, 8955.059718729439, 7959.0, 7963.522188668699, 8016.0, 8024.518528888286, 8160.347172226327, 7751.224877512203, 7772.7668169954995, 7852.725154619561, 7856.685732570862, 7952.6421311039985, 7145.821354465972, 7147.785566433015, 7152.0, 7230.493865429369, 7235.746748863765, 5362.463753624606, 5410.3778065522965, 5433.185022246536, 5444.537214336826, 5509.696966666712, 5332.760025798771, 5415.702136382537, 5436.184572314026, 5454.590905682169, 5536.474034966672], "value": 4635.01928170264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.72706988604665, 328.2794266584846, 337.660651045699, 338.6731803809324, 341.67711512620554, 5115.590752739781, 5189.740512974355, 5195.922061169081, 5203.245529398235, 5236.947630523694, 5166.844994650157, 5179.4561571035065, 5180.2229665550185, 5182.37811462625, 5192.247124166994, 4046.4941882264716, 4143.129942712019, 4145.419641250227, 4150.543440221589, 4162.4796900387455, 4096.467459230311, 4132.690048246379, 4138.668906487489, 4141.378793181017, 4154.0, 4052.371882358239, 4078.9184216315803, 4092.7953602319913, 4116.958830411688, 4121.835126594932, 3865.40086286626, 3978.7214894957365, 3987.0, 4090.468239128909, 4106.548279689232, 3632.6185750496084, 3640.2719456108885, 3642.1258897864586, 3644.159699351837, 3649.981750091259, 5013.423456302536, 5014.448410674823, 5014.874628134289, 5020.974895125538, 5023.6985780853265, 4365.3451982202605, 4456.908057525894, 4660.720356778605, 4673.906521869578, 4681.719096854165, 5317.893642127175, 5357.4106848246665, 5382.0, 5396.163594642837, 5406.216098665672, 3978.781167035812, 3983.900402489961, 3987.5613682494904, 3991.201759648082, 3992.441058251847, 5356.91964620531, 5568.916466253009, 5574.331080270353, 5618.410066942953, 5620.690862002588, 4017.979910100431, 4019.718619696593, 4020.8592699255387, 4029.294873397144, 4032.193561287754, 4066.0, 4066.3087275163293, 4071.206114807584, 4079.73481723687, 4081.3877918311896, 4514.706544074625, 4634.119517291704, 4634.37435946143, 4635.420572428447, 4639.582437580567, 5397.919031214535, 5444.40111587725, 5447.4824891635235, 5456.454354564512, 5493.560515158778, 1387.2162228340956, 1398.454602704946, 1398.923059231752, 1417.121384741467, 1424.3803945283835, 851.9787005324793, 900.2392977933636, 909.2271569166288, 910.2990697163148, 924.9260059195249, 4685.461171965199, 4698.355575548599, 4699.906001880012, 4700.647451441156, 4704.717716936994, 4935.654504184745, 4937.407511098691, 4952.306677065214, 4960.379952505937, 4983.177775667047, 4430.851037246933, 4662.461387742037, 4682.227432473604, 4699.694519856198, 4709.434867815816, 2657.933551661224, 2845.729655682707, 2888.407876385336, 2899.9275018124717, 2969.435807196626, 5759.596828222068, 5774.566907481872, 5776.884462310731, 5786.82993877296, 5804.564657650609, 5578.86052848682, 5697.344805347355, 5708.343540492813, 5722.513586345207, 5745.88508229833, 5723.941070901897, 5760.193572899798, 5776.0, 5777.595568310178, 5783.768649253982, 5577.637453565668, 5583.525400341016, 5595.76893083521, 5601.719914004365, 5621.184928185308, 5312.442193569774, 5490.478404551562, 5538.833834984957, 5549.889002220014, 5559.277293951922, 5707.886962042362, 5776.595638305278, 5783.768649254151, 5792.247007888947, 5800.477956983892, 4014.6386825185873, 4023.2154729827403, 4028.6906755304058, 4032.4152997814567, 4040.9595904040584, 5401.378841433128, 5549.0, 5557.916206339886, 5606.878624275243, 5618.438156184349, 5440.646357986719, 5453.336732296688, 5456.181572764117, 5460.460885688174, 5468.535174510212, 5306.628536002443, 5412.918806217831, 5441.918371224514, 5454.236406903116, 5456.0903683710385, 5406.567474602101, 5421.83734487966, 5441.83674489766, 5442.863928401822, 5455.263539422127, 5470.589705772162, 5479.082321187552, 5491.862703432286, 5495.752691128989, 5502.174673798962, 5229.163333866563, 5309.601779866603, 5319.46805319465, 5389.919151212656, 5395.163749618815], "value": 4123.556288092587, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.7667946257199, 747.8392145688675, 770.8689522781128, 804.4730701390583, 806.637013343995, 15776.763348549766, 16484.83515164848, 16927.15364231788, 17031.914840425798, 17056.403025894066, 14389.712205755879, 14484.130952142852, 14514.346854391551, 14536.200508972002, 14571.927140364283, 798.0941631248517, 812.979675508114, 814.8125931035866, 815.5962798414793, 816.4978538198994, 653.1672118049478, 669.8124525132971, 789.960501974899, 805.0902480197369, 810.2019510781876, 864.3992425264412, 865.3769286113987, 865.8398196333699, 866.5667166416791, 867.8264347130568, 863.0075413274722, 863.8876945997043, 864.2524216552669, 864.4424346296666, 864.9264812490945, 501.6755764780981, 512.9358830146232, 590.9320428150731, 607.9817605471843, 624.6751689121631, 13757.17456952586, 14233.217173055478, 14245.501407450793, 14250.287485625677, 14253.0, 13520.526781562598, 14042.719145617031, 14135.929320353434, 14206.928965355108, 14529.183852018497, 12950.186973823673, 13036.41336139876, 13091.86908130916, 13235.669108272274, 13266.933665331708, 4443.577860103285, 4457.3091170868565, 4517.728936263835, 4537.31940208968, 4701.435827700664, 78754.0, 79950.60024699898, 80108.0, 80532.0, 82535.587322063, 11579.305241685526, 11580.594679186357, 11715.707107322214, 11838.704032399086, 12289.324087175291, 21788.34634960922, 21803.563928721655, 21975.670364944537, 22012.779872201394, 22107.0, 8173.79565510867, 8344.8331033379, 8367.748967530984, 8400.201980811813, 8557.27263182624, 4475.753833539122, 4509.143262780061, 4542.954570454253, 4587.4036375271, 4690.9765451172525, 3454.758166928291, 3554.4668299755244, 3565.8217089145437, 3568.1614820517157, 3568.3933731265747, 589.9616524925866, 606.9484093851984, 619.3311223878201, 628.3025841316136, 640.0303540136697, 650.5121159130651, 664.4617859533793, 683.3303362704578, 687.8280429892527, 689.4656641103185, 8392.881118255227, 8813.294936405073, 8848.601812918434, 9000.684976025808, 9067.954660226656, 606.6269244414653, 648.0473703655618, 674.2414783368711, 687.4637782529635, 692.5117791956659, 4160.4591403118, 4502.909941801146, 4858.6356023298395, 5109.821156259513, 5132.794688212504, 86987.56506217555, 116556.0, 117121.41439292749, 119078.0, 119684.0, 101241.0, 105119.0, 106273.0, 109081.45459272653, 109488.0, 92524.0, 93174.53412732892, 95785.52107239558, 96993.0, 97630.0, 9115.316351273548, 9199.448033118035, 9472.810543789223, 9482.28882833804, 9555.61777528891, 51845.22232166596, 51944.143072131395, 52701.7364913173, 53480.73259633677, 53805.0, 70844.29155708376, 73664.89686134628, 79877.60061199658, 80093.19906800857, 81101.59449202953, 13015.934920325337, 13193.340332983504, 13344.266065366499, 13377.66555836112, 13575.932120339336, 14325.57023289303, 14361.497347592784, 14395.496157634432, 14976.400943962119, 15191.164485953379, 12504.249745015328, 12893.563701532801, 13016.088873778745, 13054.347282635641, 13368.90914178368, 13210.339483026002, 13225.0, 13289.601311960656, 13347.199168049949, 13547.187168769906, 12287.508499659914, 12630.810537841757, 13030.609081727564, 13149.474021039052, 13163.341832908507, 10871.565137394417, 10890.945545272223, 11170.776584468103, 11578.826317605412, 11742.412879355827, 10336.328138670962, 10968.890311096788, 11103.111751059734, 11161.55353785872, 11195.552177912792], "value": 7562.641319624339, "unit": "score"}], "name": "dromaeo_css", "value": 7217.168617855861, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 112.0, 111.0, 111.0, 110.0, 111.0, 112.0, 111.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 122.0, 154.0, 126.0, 127.0, 123.0, 121.0, 155.0, 124.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 161.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 119.0, 77.0, 76.0, 75.0, 76.0, 98.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 112.0, 83.0, 83.0, 83.0, 107.0, 82.0, 82.0, 111.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 49.0, 51.0, 51.0, 52.0, 51.0, 51.0, 50.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 60.0, 61.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 82.0, 79.0, 84.0, 80.0, 80.0, 78.0, 85.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 146.0, 129.0, 139.0, 132.0, 129.0, 140.0, 131.0, 164.0, 145.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 171.0, 172.0, 167.0, 171.0, 166.0, 166.0, 167.0, 170.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 67.0, 65.0, 65.0, 67.0, 64.0, 64.0, 68.0], "value": 66.1, "unit": "score"}], "name": "kraken", "value": 1500.9999999999998, "alertThreshold": 2.0}]} 21:50:47 INFO - Return code: 0 21:50:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:50:47 INFO - # TBPL SUCCESS # 21:50:47 INFO - Running post-action listener: _resource_record_post_action 21:50:47 INFO - [mozharness: 2016-10-07 04:50:47.769834Z] Finished run-tests step (success) 21:50:47 INFO - Running post-run listener: _resource_record_post_run 21:50:47 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393490432; Read time: 20; Write time: 294816 21:50:47 INFO - TinderboxPrint: CPU usage
13.1% 21:50:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 21:50:47 INFO - TinderboxPrint: I/O write bytes / time
393,490,432 / 294,816 21:50:47 INFO - TinderboxPrint: CPU idle
8,306.6 (86.9%) 21:50:47 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 21:50:47 INFO - TinderboxPrint: Swap in / out
0 / 0 21:50:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103936000; Read time: 0; Write time: 117240 21:50:47 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289554432; Read time: 0; Write time: 177576 21:50:48 INFO - Running post-run listener: _upload_blobber_files 21:50:48 INFO - Blob upload gear active. 21:50:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:50:48 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 21:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:50:48 INFO - (blobuploader) - INFO - Open directory for files ... 21:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:50:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:52 INFO - (blobuploader) - INFO - Done attempting. 21:50:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:50:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:50:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:53 INFO - (blobuploader) - INFO - Done attempting. 21:50:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:50:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:50:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:50:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:50:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:50:54 INFO - (blobuploader) - INFO - Done attempting. 21:50:54 INFO - (blobuploader) - INFO - Iteration through files over. 21:50:54 INFO - Return code: 0 21:50:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:50:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:50:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dd941edad6cea1b5ff9af553cbbba6ea5ebddebf161a719bc5b8145a858da7278cd40199cf5831a1a2da706596fd33ed4651a2a903d1a70cdc4e6b30043c45b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae86e94c960e47b8759afea3dec14dffe47baf9383c62b16df000ebc9e934f142c828e467c1bba9479e978946d86a586e98449477e01771f1da69a27917fa5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a3d9c1cecec90270bd2798e06b254bd1382b1139faf472764d5357dca6ce069668bc770882704f686a9cc19b4fda494d5ba5b290b0153aa08b9f7ee41c4fcd9"} 21:50:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:50:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:50:54 INFO - Contents: 21:50:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dd941edad6cea1b5ff9af553cbbba6ea5ebddebf161a719bc5b8145a858da7278cd40199cf5831a1a2da706596fd33ed4651a2a903d1a70cdc4e6b30043c45b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae86e94c960e47b8759afea3dec14dffe47baf9383c62b16df000ebc9e934f142c828e467c1bba9479e978946d86a586e98449477e01771f1da69a27917fa5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a3d9c1cecec90270bd2798e06b254bd1382b1139faf472764d5357dca6ce069668bc770882704f686a9cc19b4fda494d5ba5b290b0153aa08b9f7ee41c4fcd9"} 21:50:54 INFO - Running post-run listener: copy_logs_to_upload_dir 21:50:54 INFO - Copying logs to upload dir... 21:50:54 INFO - mkdir: /builds/slave/test/build/upload/logs 21:50:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.822600 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-10-06 21:50:54.187493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:50:54.191107) ========= 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=db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dd941edad6cea1b5ff9af553cbbba6ea5ebddebf161a719bc5b8145a858da7278cd40199cf5831a1a2da706596fd33ed4651a2a903d1a70cdc4e6b30043c45b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae86e94c960e47b8759afea3dec14dffe47baf9383c62b16df000ebc9e934f142c828e467c1bba9479e978946d86a586e98449477e01771f1da69a27917fa5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a3d9c1cecec90270bd2798e06b254bd1382b1139faf472764d5357dca6ce069668bc770882704f686a9cc19b4fda494d5ba5b290b0153aa08b9f7ee41c4fcd9"} build_url:https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011643 build_url: 'https://queue.taskcluster.net/v1/task/BScnetyoQEajr8-q2l-mDA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dd941edad6cea1b5ff9af553cbbba6ea5ebddebf161a719bc5b8145a858da7278cd40199cf5831a1a2da706596fd33ed4651a2a903d1a70cdc4e6b30043c45b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/eae86e94c960e47b8759afea3dec14dffe47baf9383c62b16df000ebc9e934f142c828e467c1bba9479e978946d86a586e98449477e01771f1da69a27917fa5a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a3d9c1cecec90270bd2798e06b254bd1382b1139faf472764d5357dca6ce069668bc770882704f686a9cc19b4fda494d5ba5b290b0153aa08b9f7ee41c4fcd9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:50:54.219360) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:50:54.219689) ========= 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=db0483c52d987ecb441a263b000001ad-1475812050.139379-714444540 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:50:54.304633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:50:54.304957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:50:54.305241) ========= ========= Total master_lag: 0.20 =========