builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-032 starttime: 1485378566.43 results: success (0) buildid: 20170125112431 builduid: 548a8a5539b1412ca708c30ba7c11d8c revision: 2cfff4488cc160aafb9d8f1b3baa8543d7a170b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.427456) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.428513) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.429208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.447541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.448199) ========= 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=745a4373a2a16df560f216e000000264-1485378566.66156-2082913319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-25 13:09:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2017-01-25 13:09:26 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078627 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.545321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.546110) ========= 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=745a4373a2a16df560f216e000000264-1485378566.66156-2082913319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017712 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.598853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:26.599677) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2cfff4488cc160aafb9d8f1b3baa8543d7a170b2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2cfff4488cc160aafb9d8f1b3baa8543d7a170b2 --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=745a4373a2a16df560f216e000000264-1485378566.66156-2082913319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-25 13:09:26,909 truncating revision to first 12 chars 2017-01-25 13:09:26,909 Setting DEBUG logging. 2017-01-25 13:09:26,909 attempt 1/10 2017-01-25 13:09:26,909 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2cfff4488cc1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 13:09:27,216 unpacking tar archive at: mozilla-beta-2cfff4488cc1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.623737 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:27.238928) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:27.239293) ========= script_repo_revision: 2cfff4488cc160aafb9d8f1b3baa8543d7a170b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:27.239840) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:27.240196) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 13:09:27.249278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-25 13:09:27.249677) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=745a4373a2a16df560f216e000000264-1485378566.66156-2082913319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:09:27 INFO - MultiFileLogger online at 20170125 13:09:27 in /builds/slave/test 13:09:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:09:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:09:27 INFO - {'append_to_log': False, 13:09:27 INFO - 'base_work_dir': '/builds/slave/test', 13:09:27 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:09:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:09:27 INFO - 'branch': 'Mozilla-Beta', 13:09:27 INFO - 'buildbot_json_path': 'buildprops.json', 13:09:27 INFO - 'config_files': ('talos/linux_config.py',), 13:09:27 INFO - 'default_actions': ('clobber', 13:09:27 INFO - 'read-buildbot-config', 13:09:27 INFO - 'download-and-extract', 13:09:27 INFO - 'populate-webroot', 13:09:27 INFO - 'create-virtualenv', 13:09:27 INFO - 'install', 13:09:27 INFO - 'run-tests'), 13:09:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:09:27 INFO - 'download_minidump_stackwalk': True, 13:09:27 INFO - 'download_symbols': 'ondemand', 13:09:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:09:27 INFO - 'tooltool.py': '/tools/tooltool.py', 13:09:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:09:27 INFO - '/tools/misc-python/virtualenv.py')}, 13:09:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:09:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:09:27 INFO - 'installer_path': 'installer.exe', 13:09:27 INFO - 'log_level': 'info', 13:09:27 INFO - 'log_name': 'talos', 13:09:27 INFO - 'log_to_console': True, 13:09:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:09:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:09:27 INFO - 'opt_config_files': (), 13:09:27 INFO - 'pip_index': False, 13:09:27 INFO - 'sps_profile': False, 13:09:27 INFO - 'sps_profile_interval': 0, 13:09:27 INFO - 'suite': 'dromaeojs', 13:09:27 INFO - 'system_bits': '32', 13:09:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:09:27 INFO - 'title': 'talos-linux64-ix-032', 13:09:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:09:27 INFO - 'use_talos_json': True, 13:09:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:09:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:09:27 INFO - 'work_dir': 'build'} 13:09:27 INFO - [mozharness: 2017-01-25 21:09:27.650025Z] Running clobber step. 13:09:27 INFO - Running pre-action listener: _resource_record_pre_action 13:09:27 INFO - Running main action method: clobber 13:09:27 INFO - rmtree: /builds/slave/test/build 13:09:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - [mozharness: 2017-01-25 21:09:28.128498Z] Finished clobber step (success) 13:09:28 INFO - [mozharness: 2017-01-25 21:09:28.128599Z] Running read-buildbot-config step. 13:09:28 INFO - Running pre-action listener: _resource_record_pre_action 13:09:28 INFO - Running main action method: read_buildbot_config 13:09:28 INFO - Using buildbot properties: 13:09:28 INFO - { 13:09:28 INFO - "project": "", 13:09:28 INFO - "product": "firefox", 13:09:28 INFO - "script_repo_revision": "production", 13:09:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 13:09:28 INFO - "repository": "", 13:09:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 13:09:28 INFO - "buildid": "20170125112431", 13:09:28 INFO - "pgo_build": "True", 13:09:28 INFO - "basedir": "/builds/slave/test", 13:09:28 INFO - "buildnumber": 523, 13:09:28 INFO - "slavename": "talos-linux64-ix-032", 13:09:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:09:28 INFO - "platform": "ubuntu64_hw", 13:09:28 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 13:09:28 INFO - "branch": "mozilla-beta", 13:09:28 INFO - "repo_path": "releases/mozilla-beta", 13:09:28 INFO - "revision": "2cfff4488cc160aafb9d8f1b3baa8543d7a170b2", 13:09:28 INFO - "stage_platform": "linux64-pgo", 13:09:28 INFO - "builduid": "548a8a5539b1412ca708c30ba7c11d8c", 13:09:28 INFO - "slavebuilddir": "test" 13:09:28 INFO - } 13:09:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 13:09:28 INFO - Running post-action listener: _resource_record_post_action 13:09:28 INFO - [mozharness: 2017-01-25 21:09:28.131037Z] Finished read-buildbot-config step (success) 13:09:28 INFO - [mozharness: 2017-01-25 21:09:28.131124Z] Running download-and-extract step. 13:09:28 INFO - Running pre-action listener: _resource_record_pre_action 13:09:28 INFO - Running main action method: download_and_extract 13:09:28 INFO - mkdir: /builds/slave/test/build/tests 13:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:28 INFO - trying https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:09:28 INFO - Downloading https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:09:28 INFO - Downloaded 1327 bytes. 13:09:28 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 13:09:28 INFO - Using the following test package requirements: 13:09:28 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 13:09:28 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 13:09:28 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 13:09:28 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'jsshell-linux-x86_64.zip'], 13:09:28 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 13:09:28 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 13:09:28 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 13:09:28 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 13:09:28 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 13:09:28 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 13:09:28 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 13:09:28 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:09:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 13:09:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:09:28 INFO - Fetch https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 13:09:29 INFO - Http code: 200 13:09:29 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 13:09:29 INFO - x-amz-cf-id: qiGW-KVpq6-oCjQXPhL3X4mlcTycUB8Hcs9RXpGV3x9c7c1z2W0BQA== 13:09:29 INFO - x-amz-version-id: 81_lhHp4PORHRx0iyZxOWAp9Abpj2Tek 13:09:30 INFO - Expected file size: 21950272 13:09:30 INFO - Obtained file size: 21950272 13:09:34 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:09:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 13:09:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:09:34 INFO - Fetch https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 13:09:35 INFO - Http code: 200 13:09:35 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:09:35 INFO - x-amz-cf-id: IGkOnzfjm46UjwtRwf4GLb-or65igzd4ueIGZrhxXoQnvZSieno8RA== 13:09:35 INFO - x-amz-version-id: 81_lhHp4PORHRx0iyZxOWAp9Abpj2Tek 13:09:35 INFO - Expected file size: 21950272 13:09:35 INFO - Obtained file size: 21950272 13:09:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 13:09:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:09:39 INFO - Fetch https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 13:09:41 INFO - Http code: 200 13:09:41 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 13:09:41 INFO - x-amz-cf-id: JcnbViYwC2KC7--rBRWljVhisX4PB-eUn2jY1EDdZ0KIG5jN3j9jxw== 13:09:41 INFO - x-amz-version-id: xruWfevWgLP6FyHO358dYZsg_mA6WG_W 13:09:41 INFO - Expected file size: 14402992 13:09:41 INFO - Obtained file size: 14402992 13:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:42 INFO - trying https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:09:42 INFO - Downloading https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:09:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:09:44 INFO - Downloaded 57679007 bytes. 13:09:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:09:44 INFO - mkdir: /builds/slave/test/properties 13:09:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:09:44 INFO - Writing to file /builds/slave/test/properties/build_url 13:09:44 INFO - Contents: 13:09:44 INFO - build_url:https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 13:09:44 INFO - Running post-action listener: _resource_record_post_action 13:09:44 INFO - Running post-action listener: set_extra_try_arguments 13:09:44 INFO - [mozharness: 2017-01-25 21:09:44.986144Z] Finished download-and-extract step (success) 13:09:44 INFO - [mozharness: 2017-01-25 21:09:44.986371Z] Running populate-webroot step. 13:09:44 INFO - Running pre-action listener: _resource_record_pre_action 13:09:44 INFO - Running main action method: populate_webroot 13:09:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:09:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:09:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:09:45 INFO - '--tppagecycles', 13:09:45 INFO - '7'], 13:09:45 INFO - 'tests': ['tsvgm']}}, 13:09:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:09:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:09:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:09:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:09:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:09:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['damp', 'tps']}, 13:09:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'tests': ['damp', 'tps']}, 13:09:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['dromaeo_dom']}, 13:09:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:09:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['basic_compositor_video']}, 13:09:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:09:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['a11yr', 13:09:45 INFO - 'ts_paint', 13:09:45 INFO - 'tpaint', 13:09:45 INFO - 'sessionrestore', 13:09:45 INFO - 'sessionrestore_no_auto_restore', 13:09:45 INFO - 'tabpaint']}, 13:09:45 INFO - 'other-e10s': {'tests': ['a11yr', 13:09:45 INFO - 'ts_paint', 13:09:45 INFO - 'tpaint', 13:09:45 INFO - 'sessionrestore', 13:09:45 INFO - 'sessionrestore_no_auto_restore', 13:09:45 INFO - 'tabpaint']}, 13:09:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:09:45 INFO - 'ts_paint', 13:09:45 INFO - 'tpaint', 13:09:45 INFO - 'sessionrestore', 13:09:45 INFO - 'sessionrestore_no_auto_restore', 13:09:45 INFO - 'tabpaint']}, 13:09:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:09:45 INFO - 'ts_paint', 13:09:45 INFO - 'tpaint', 13:09:45 INFO - 'sessionrestore', 13:09:45 INFO - 'sessionrestore_no_auto_restore', 13:09:45 INFO - 'tabpaint']}, 13:09:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['a11yr', 13:09:45 INFO - 'ts_paint', 13:09:45 INFO - 'tpaint', 13:09:45 INFO - 'sessionrestore', 13:09:45 INFO - 'sessionrestore_no_auto_restore', 13:09:45 INFO - 'tabpaint']}, 13:09:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['a11yr', 13:09:45 INFO - 'ts_paint', 13:09:45 INFO - 'tpaint', 13:09:45 INFO - 'sessionrestore', 13:09:45 INFO - 'sessionrestore_no_auto_restore', 13:09:45 INFO - 'tabpaint']}, 13:09:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['tsvgx', 13:09:45 INFO - 'tsvgr_opacity', 13:09:45 INFO - 'tart', 13:09:45 INFO - 'tscrollx', 13:09:45 INFO - 'cart']}, 13:09:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:09:45 INFO - 'tsvgr_opacity', 13:09:45 INFO - 'tart', 13:09:45 INFO - 'tscrollx', 13:09:45 INFO - 'cart']}, 13:09:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'talos_options': ['--disable-e10s'], 13:09:45 INFO - 'tests': ['tp5o']}, 13:09:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'tests': ['tp5o']}, 13:09:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'talos_options': ['--disable-e10s', 13:09:45 INFO - '--xperf_path', 13:09:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:45 INFO - 'tests': ['tp5n']}, 13:09:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:09:45 INFO - 'talos_options': ['--xperf_path', 13:09:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:09:45 INFO - 'tests': ['tp5n']}}, 13:09:45 INFO - 'talos.zip': {'path': '', 13:09:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:09:45 INFO - Running post-action listener: _resource_record_post_action 13:09:45 INFO - [mozharness: 2017-01-25 21:09:45.010608Z] Finished populate-webroot step (success) 13:09:45 INFO - [mozharness: 2017-01-25 21:09:45.010696Z] Running create-virtualenv step. 13:09:45 INFO - Running pre-action listener: _resource_record_pre_action 13:09:45 INFO - Running main action method: create_virtualenv 13:09:45 INFO - Creating virtualenv /builds/slave/test/build/venv 13:09:45 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 13:09:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:09:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:09:45 INFO - Using real prefix '/usr' 13:09:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:09:45 INFO - Installing distribute.............................................................................................................................................................................................done. 13:09:47 INFO - Installing pip.................done. 13:09:47 INFO - Return code: 0 13:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:09:47 INFO - Reading from file tmpfile_stdout 13:09:47 INFO - Output received: 13:09:47 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) 13:09:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:09:47 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')]} 13:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:47 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')]} 13:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:47 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:09:47 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 13:09:47 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 13:09:47 INFO - Using env: {'DISPLAY': ':0', 13:09:47 INFO - 'HOME': '/home/cltbld', 13:09:47 INFO - 'LANG': 'en_US.UTF-8', 13:09:47 INFO - 'LANGUAGE': 'en_US:en', 13:09:47 INFO - 'LOGNAME': 'cltbld', 13:09:47 INFO - 'MAIL': '/var/mail/cltbld', 13:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:47 INFO - 'MOZ_NO_REMOTE': '1', 13:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:47 INFO - 'NO_EM_RESTART': '1', 13:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:47 INFO - 'PWD': '/builds/slave/test', 13:09:47 INFO - 'SHELL': '/bin/bash', 13:09:47 INFO - 'SHLVL': '1', 13:09:47 INFO - 'TERM': 'linux', 13:09:47 INFO - 'TMOUT': '86400', 13:09:47 INFO - 'USER': 'cltbld', 13:09:47 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:47 INFO - '_': '/tools/buildbot/bin/python'} 13:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:47 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 13:09:47 INFO - Cleaning up... 13:09:48 INFO - Return code: 0 13:09:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:09: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')]} 13:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09: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')]} 13:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:48 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:09:48 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 13:09:48 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 13:09:48 INFO - Using env: {'DISPLAY': ':0', 13:09:48 INFO - 'HOME': '/home/cltbld', 13:09:48 INFO - 'LANG': 'en_US.UTF-8', 13:09:48 INFO - 'LANGUAGE': 'en_US:en', 13:09:48 INFO - 'LOGNAME': 'cltbld', 13:09:48 INFO - 'MAIL': '/var/mail/cltbld', 13:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:48 INFO - 'MOZ_NO_REMOTE': '1', 13:09:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:48 INFO - 'NO_EM_RESTART': '1', 13:09:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:48 INFO - 'PWD': '/builds/slave/test', 13:09:48 INFO - 'SHELL': '/bin/bash', 13:09:48 INFO - 'SHLVL': '1', 13:09:48 INFO - 'TERM': 'linux', 13:09:48 INFO - 'TMOUT': '86400', 13:09:48 INFO - 'USER': 'cltbld', 13:09:48 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:48 INFO - '_': '/tools/buildbot/bin/python'} 13:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:48 INFO - Downloading/unpacking psutil>=3.1.1 13:09:48 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 13:09:48 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 13:09:48 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 13:09:48 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 13:09:48 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 13:09:48 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 13:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:50 INFO - Installing collected packages: psutil 13:09:50 INFO - Running setup.py install for psutil 13:09:50 INFO - building 'psutil._psutil_linux' extension 13:09:50 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 13:09:50 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 13:09:50 INFO - building 'psutil._psutil_posix' extension 13:09:50 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 13:09:50 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 13:09:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:09:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:09:50 INFO - Successfully installed psutil 13:09:50 INFO - Cleaning up... 13:09:50 INFO - Return code: 0 13:09:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:50 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:09:50 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 13:09:50 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 13:09:50 INFO - Using env: {'DISPLAY': ':0', 13:09:50 INFO - 'HOME': '/home/cltbld', 13:09:50 INFO - 'LANG': 'en_US.UTF-8', 13:09:50 INFO - 'LANGUAGE': 'en_US:en', 13:09:50 INFO - 'LOGNAME': 'cltbld', 13:09:50 INFO - 'MAIL': '/var/mail/cltbld', 13:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:50 INFO - 'MOZ_NO_REMOTE': '1', 13:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:50 INFO - 'NO_EM_RESTART': '1', 13:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:50 INFO - 'PWD': '/builds/slave/test', 13:09:50 INFO - 'SHELL': '/bin/bash', 13:09:50 INFO - 'SHLVL': '1', 13:09:50 INFO - 'TERM': 'linux', 13:09:50 INFO - 'TMOUT': '86400', 13:09:50 INFO - 'USER': 'cltbld', 13:09:50 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:50 INFO - '_': '/tools/buildbot/bin/python'} 13:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:51 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 13:09:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:09:53 INFO - Installing collected packages: mozsystemmonitor 13:09:53 INFO - Running setup.py install for mozsystemmonitor 13:09:53 INFO - Successfully installed mozsystemmonitor 13:09:53 INFO - Cleaning up... 13:09:53 INFO - Return code: 0 13:09:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:09:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:09:53 INFO - Using env: {'DISPLAY': ':0', 13:09:53 INFO - 'HOME': '/home/cltbld', 13:09:53 INFO - 'LANG': 'en_US.UTF-8', 13:09:53 INFO - 'LANGUAGE': 'en_US:en', 13:09:53 INFO - 'LOGNAME': 'cltbld', 13:09:53 INFO - 'MAIL': '/var/mail/cltbld', 13:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:53 INFO - 'MOZ_NO_REMOTE': '1', 13:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:53 INFO - 'NO_EM_RESTART': '1', 13:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:53 INFO - 'PWD': '/builds/slave/test', 13:09:53 INFO - 'SHELL': '/bin/bash', 13:09:53 INFO - 'SHLVL': '1', 13:09:53 INFO - 'TERM': 'linux', 13:09:53 INFO - 'TMOUT': '86400', 13:09:53 INFO - 'USER': 'cltbld', 13:09:53 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:53 INFO - '_': '/tools/buildbot/bin/python'} 13:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:53 INFO - Downloading/unpacking jsonschema==2.5.1 13:09:53 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 13:09:53 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 13:09:53 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 13:09:53 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 13:09:53 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 13:09:53 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 13:09:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:09:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:55 INFO - Downloading functools32-3.2.3-2.tar.gz 13:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:09:55 INFO - warning: no files found matching '*.txt' 13:09:55 INFO - no previously-included directories found matching 'build' 13:09:55 INFO - no previously-included directories found matching 'dist' 13:09:55 INFO - no previously-included directories found matching '.git*' 13:09:55 INFO - Installing collected packages: jsonschema, functools32 13:09:55 INFO - Running setup.py install for functools32 13:09:55 INFO - warning: no files found matching '*.txt' 13:09:55 INFO - no previously-included directories found matching 'build' 13:09:55 INFO - no previously-included directories found matching 'dist' 13:09:55 INFO - no previously-included directories found matching '.git*' 13:09:55 INFO - Successfully installed jsonschema functools32 13:09:55 INFO - Cleaning up... 13:09:56 INFO - Return code: 0 13:09:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:09:56 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')]} 13:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:56 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')]} 13:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:56 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:09:56 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 13:09:56 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 13:09:56 INFO - Using env: {'DISPLAY': ':0', 13:09:56 INFO - 'HOME': '/home/cltbld', 13:09:56 INFO - 'LANG': 'en_US.UTF-8', 13:09:56 INFO - 'LANGUAGE': 'en_US:en', 13:09:56 INFO - 'LOGNAME': 'cltbld', 13:09:56 INFO - 'MAIL': '/var/mail/cltbld', 13:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:56 INFO - 'MOZ_NO_REMOTE': '1', 13:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:56 INFO - 'NO_EM_RESTART': '1', 13:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:56 INFO - 'PWD': '/builds/slave/test', 13:09:56 INFO - 'SHELL': '/bin/bash', 13:09:56 INFO - 'SHLVL': '1', 13:09:56 INFO - 'TERM': 'linux', 13:09:56 INFO - 'TMOUT': '86400', 13:09:56 INFO - 'USER': 'cltbld', 13:09:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:56 INFO - '_': '/tools/buildbot/bin/python'} 13:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:09:56 INFO - Cleaning up... 13:09:56 INFO - Return code: 0 13:09:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:09:56 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')]} 13:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:56 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')]} 13:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:56 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:09:56 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 13:09:56 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 13:09:56 INFO - Using env: {'DISPLAY': ':0', 13:09:56 INFO - 'HOME': '/home/cltbld', 13:09:56 INFO - 'LANG': 'en_US.UTF-8', 13:09:56 INFO - 'LANGUAGE': 'en_US:en', 13:09:56 INFO - 'LOGNAME': 'cltbld', 13:09:56 INFO - 'MAIL': '/var/mail/cltbld', 13:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:56 INFO - 'MOZ_NO_REMOTE': '1', 13:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:56 INFO - 'NO_EM_RESTART': '1', 13:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:56 INFO - 'PWD': '/builds/slave/test', 13:09:56 INFO - 'SHELL': '/bin/bash', 13:09:56 INFO - 'SHLVL': '1', 13:09:56 INFO - 'TERM': 'linux', 13:09:56 INFO - 'TMOUT': '86400', 13:09:56 INFO - 'USER': 'cltbld', 13:09:56 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:56 INFO - '_': '/tools/buildbot/bin/python'} 13:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:09:56 INFO - Downloading/unpacking blobuploader==1.2.4 13:09:56 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 13:09:56 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 13:09:56 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 13:09:56 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 13:09:56 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 13:09:56 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 13:09:58 INFO - Downloading blobuploader-1.2.4.tar.gz 13:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:09:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:09:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:09:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:09:59 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 13:09:59 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 13:09:59 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 13:09:59 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 13:09:59 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 13:09:59 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 13:09:59 INFO - Downloading docopt-0.6.1.tar.gz 13:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:09:59 INFO - Installing collected packages: blobuploader, requests, docopt 13:09:59 INFO - Running setup.py install for blobuploader 13:09:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:09:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:09:59 INFO - Running setup.py install for requests 13:09:59 INFO - Running setup.py install for docopt 13:09:59 INFO - Successfully installed blobuploader requests docopt 13:09:59 INFO - Cleaning up... 13:09:59 INFO - Return code: 0 13:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:09:59 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:09:59 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 13:09:59 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 13:09:59 INFO - Using env: {'DISPLAY': ':0', 13:09:59 INFO - 'HOME': '/home/cltbld', 13:09:59 INFO - 'LANG': 'en_US.UTF-8', 13:09:59 INFO - 'LANGUAGE': 'en_US:en', 13:09:59 INFO - 'LOGNAME': 'cltbld', 13:09:59 INFO - 'MAIL': '/var/mail/cltbld', 13:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:59 INFO - 'MOZ_NO_REMOTE': '1', 13:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:59 INFO - 'NO_EM_RESTART': '1', 13:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:59 INFO - 'PWD': '/builds/slave/test', 13:09:59 INFO - 'SHELL': '/bin/bash', 13:09:59 INFO - 'SHLVL': '1', 13:09:59 INFO - 'TERM': 'linux', 13:09:59 INFO - 'TMOUT': '86400', 13:09:59 INFO - 'USER': 'cltbld', 13:09:59 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:59 INFO - '_': '/tools/buildbot/bin/python'} 13:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:00 INFO - Running setup.py (path:/tmp/pip-8Os6Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:00 INFO - Running setup.py (path:/tmp/pip-ZLbcpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:00 INFO - Running setup.py (path:/tmp/pip-Jfxeqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:00 INFO - Running setup.py (path:/tmp/pip-29GTPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:00 INFO - Running setup.py (path:/tmp/pip-4HBphJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:00 INFO - Running setup.py (path:/tmp/pip-RbAhBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:00 INFO - Running setup.py (path:/tmp/pip-XWTCSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:00 INFO - Running setup.py (path:/tmp/pip-OBzpHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:00 INFO - Running setup.py (path:/tmp/pip-J21Wei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:00 INFO - Running setup.py (path:/tmp/pip-6KOify-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:00 INFO - Running setup.py (path:/tmp/pip-W8jaWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:00 INFO - Running setup.py (path:/tmp/pip-__FneV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:01 INFO - Running setup.py (path:/tmp/pip-AzdGsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:01 INFO - Running setup.py (path:/tmp/pip-jZ7HAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:01 INFO - Running setup.py (path:/tmp/pip-RwKyk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:01 INFO - Running setup.py (path:/tmp/pip-pjQGs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:01 INFO - Running setup.py (path:/tmp/pip-aP5qkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:10:01 INFO - Running setup.py install for manifestparser 13:10:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:10:01 INFO - Running setup.py install for mozcrash 13:10:01 INFO - Running setup.py install for mozdebug 13:10:01 INFO - Running setup.py install for mozdevice 13:10:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:10:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:10:01 INFO - Running setup.py install for mozfile 13:10:01 INFO - Running setup.py install for mozhttpd 13:10:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:10:01 INFO - Running setup.py install for mozinfo 13:10:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Running setup.py install for mozInstall 13:10:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Running setup.py install for mozleak 13:10:02 INFO - Running setup.py install for mozlog 13:10:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Running setup.py install for moznetwork 13:10:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Running setup.py install for mozprocess 13:10:02 INFO - Running setup.py install for mozprofile 13:10:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Running setup.py install for mozrunner 13:10:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:10:02 INFO - Running setup.py install for mozscreenshot 13:10:02 INFO - Running setup.py install for moztest 13:10:03 INFO - Running setup.py install for mozversion 13:10:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:10:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:10:03 INFO - Cleaning up... 13:10:03 INFO - Return code: 0 13:10:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:03 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:10:03 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 13:10:03 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 13:10:03 INFO - Using env: {'DISPLAY': ':0', 13:10:03 INFO - 'HOME': '/home/cltbld', 13:10:03 INFO - 'LANG': 'en_US.UTF-8', 13:10:03 INFO - 'LANGUAGE': 'en_US:en', 13:10:03 INFO - 'LOGNAME': 'cltbld', 13:10:03 INFO - 'MAIL': '/var/mail/cltbld', 13:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:03 INFO - 'MOZ_NO_REMOTE': '1', 13:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:03 INFO - 'NO_EM_RESTART': '1', 13:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:03 INFO - 'PWD': '/builds/slave/test', 13:10:03 INFO - 'SHELL': '/bin/bash', 13:10:03 INFO - 'SHLVL': '1', 13:10:03 INFO - 'TERM': 'linux', 13:10:03 INFO - 'TMOUT': '86400', 13:10:03 INFO - 'USER': 'cltbld', 13:10:03 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:03 INFO - '_': '/tools/buildbot/bin/python'} 13:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:10:03 INFO - Running setup.py (path:/tmp/pip-CGSOtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:10:03 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)) 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:10:03 INFO - Running setup.py (path:/tmp/pip-RPghSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:10:03 INFO - Running setup.py (path:/tmp/pip-YID3M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:10:03 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)) 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:10:03 INFO - Running setup.py (path:/tmp/pip-QIxJSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:10:03 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)) 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:10:03 INFO - Running setup.py (path:/tmp/pip-6BLsQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:10:03 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)) 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:10:03 INFO - Running setup.py (path:/tmp/pip-AQolEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:10:03 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)) 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:10:03 INFO - Running setup.py (path:/tmp/pip-cceEpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:10:03 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)) 13:10:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:10:03 INFO - Running setup.py (path:/tmp/pip-PmnmQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:10:04 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)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:10:04 INFO - Running setup.py (path:/tmp/pip-1KRhuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:10:04 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)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:10:04 INFO - Running setup.py (path:/tmp/pip-qlCKi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:10:04 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)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:10:04 INFO - Running setup.py (path:/tmp/pip-JusDKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:10:04 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)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:10:04 INFO - Running setup.py (path:/tmp/pip-BnSdPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:10:04 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)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:10:04 INFO - Running setup.py (path:/tmp/pip-Iqui6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:10:04 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)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:10:04 INFO - Running setup.py (path:/tmp/pip-usJySJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:04 INFO - Running setup.py (path:/tmp/pip-DJttk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:10:04 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)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:10:04 INFO - Running setup.py (path:/tmp/pip-22WwrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:10:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:10:04 INFO - Running setup.py (path:/tmp/pip-wICJ2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:10:04 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)) 13:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:10:04 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)) 13:10:04 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)) 13:10:04 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)) 13:10:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:10:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:10:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:10:06 INFO - Downloading blessings-1.6.tar.gz 13:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:10:06 INFO - Installing collected packages: blessings 13:10:06 INFO - Running setup.py install for blessings 13:10:06 INFO - Successfully installed blessings 13:10:06 INFO - Cleaning up... 13:10:06 INFO - Return code: 0 13:10:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:10:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:07 INFO - Reading from file tmpfile_stdout 13:10:07 INFO - Current package versions: 13:10:07 INFO - argparse == 1.2.1 13:10:07 INFO - blessings == 1.6 13:10:07 INFO - blobuploader == 1.2.4 13:10:07 INFO - docopt == 0.6.1 13:10:07 INFO - functools32 == 3.2.3-2 13:10:07 INFO - jsonschema == 2.5.1 13:10:07 INFO - manifestparser == 1.1 13:10:07 INFO - mozInstall == 1.12 13:10:07 INFO - mozcrash == 1.0 13:10:07 INFO - mozdebug == 0.1 13:10:07 INFO - mozdevice == 0.48 13:10:07 INFO - mozfile == 1.2 13:10:07 INFO - mozhttpd == 0.7 13:10:07 INFO - mozinfo == 0.9 13:10:07 INFO - mozleak == 0.1 13:10:07 INFO - mozlog == 3.4 13:10:07 INFO - moznetwork == 0.27 13:10:07 INFO - mozprocess == 0.23 13:10:07 INFO - mozprofile == 0.28 13:10:07 INFO - mozrunner == 6.13 13:10:07 INFO - mozscreenshot == 0.1 13:10:07 INFO - mozsystemmonitor == 0.3 13:10:07 INFO - moztest == 0.8 13:10:07 INFO - mozversion == 1.4 13:10:07 INFO - psutil == 3.1.1 13:10:07 INFO - requests == 1.2.3 13:10:07 INFO - wsgiref == 0.1.2 13:10:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:07 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:10:07 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 13:10:07 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 13:10:07 INFO - Using env: {'DISPLAY': ':0', 13:10:07 INFO - 'HOME': '/home/cltbld', 13:10:07 INFO - 'LANG': 'en_US.UTF-8', 13:10:07 INFO - 'LANGUAGE': 'en_US:en', 13:10:07 INFO - 'LOGNAME': 'cltbld', 13:10:07 INFO - 'MAIL': '/var/mail/cltbld', 13:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:07 INFO - 'MOZ_NO_REMOTE': '1', 13:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:07 INFO - 'NO_EM_RESTART': '1', 13:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:07 INFO - 'PWD': '/builds/slave/test', 13:10:07 INFO - 'SHELL': '/bin/bash', 13:10:07 INFO - 'SHLVL': '1', 13:10:07 INFO - 'TERM': 'linux', 13:10:07 INFO - 'TMOUT': '86400', 13:10:07 INFO - 'USER': 'cltbld', 13:10:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:07 INFO - '_': '/tools/buildbot/bin/python'} 13:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 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)) 13:10:07 INFO - Cleaning up... 13:10:07 INFO - Return code: 0 13:10:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:10:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:10:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:10:07 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 0x7f2397dbdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dfca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, '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': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', '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 13:10:07 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 13:10:07 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 13:10:07 INFO - Using env: {'DISPLAY': ':0', 13:10:07 INFO - 'HOME': '/home/cltbld', 13:10:07 INFO - 'LANG': 'en_US.UTF-8', 13:10:07 INFO - 'LANGUAGE': 'en_US:en', 13:10:07 INFO - 'LOGNAME': 'cltbld', 13:10:07 INFO - 'MAIL': '/var/mail/cltbld', 13:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:07 INFO - 'MOZ_NO_REMOTE': '1', 13:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:07 INFO - 'NO_EM_RESTART': '1', 13:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:07 INFO - 'PWD': '/builds/slave/test', 13:10:07 INFO - 'SHELL': '/bin/bash', 13:10:07 INFO - 'SHLVL': '1', 13:10:07 INFO - 'TERM': 'linux', 13:10:07 INFO - 'TMOUT': '86400', 13:10:07 INFO - 'USER': 'cltbld', 13:10:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:07 INFO - '_': '/tools/buildbot/bin/python'} 13:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:10:07 INFO - Cleaning up... 13:10:07 INFO - Return code: 0 13:10:07 INFO - Running post-action listener: _resource_record_post_action 13:10:07 INFO - Running post-action listener: _start_resource_monitoring 13:10:07 INFO - Starting resource monitoring. 13:10:07 INFO - [mozharness: 2017-01-25 21:10:07.663400Z] Finished create-virtualenv step (success) 13:10:07 INFO - [mozharness: 2017-01-25 21:10:07.663858Z] Running install step. 13:10:07 INFO - Running pre-action listener: _resource_record_pre_action 13:10:07 INFO - Running main action method: install 13:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:10:07 INFO - Reading from file tmpfile_stdout 13:10:07 INFO - Detecting whether we're running mozinstall >=1.0... 13:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:10:07 INFO - Reading from file tmpfile_stdout 13:10:07 INFO - Output received: 13:10:07 INFO - Usage: mozinstall [options] installer 13:10:07 INFO - Options: 13:10:07 INFO - -h, --help show this help message and exit 13:10:07 INFO - -d DEST, --destination=DEST 13:10:07 INFO - Directory to install application into. [default: 13:10:07 INFO - "/builds/slave/test"] 13:10:07 INFO - --app=APP Application being installed. [default: firefox] 13:10:07 INFO - mkdir: /builds/slave/test/build/application 13:10:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:10:21 INFO - Reading from file tmpfile_stdout 13:10:21 INFO - Output received: 13:10:21 INFO - /builds/slave/test/build/application/firefox/firefox 13:10:21 INFO - Running post-action listener: _resource_record_post_action 13:10:21 INFO - [mozharness: 2017-01-25 21:10:21.578021Z] Finished install step (success) 13:10:21 INFO - [mozharness: 2017-01-25 21:10:21.578263Z] Running run-tests step. 13:10:21 INFO - Running pre-action listener: _resource_record_pre_action 13:10:21 INFO - Running main action method: run_tests 13:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:10:21 INFO - Python 2.7.3 13:10:21 INFO - Return code: 0 13:10:21 INFO - grabbing minidump binary from tooltool 13:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:21 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 0x23dcf60>, '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 0x23ddd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23de1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:10:21 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 13:10:21 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 13:10:21 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 13:10:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:10:21 INFO - Return code: 0 13:10:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:10:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:10:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:10:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:10:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:10:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 13:10:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 13:10:21 INFO - Using env: {'DISPLAY': ':0', 13:10:21 INFO - 'HOME': '/home/cltbld', 13:10:21 INFO - 'LANG': 'en_US.UTF-8', 13:10:21 INFO - 'LANGUAGE': 'en_US:en', 13:10:21 INFO - 'LOGNAME': 'cltbld', 13:10:21 INFO - 'MAIL': '/var/mail/cltbld', 13:10:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:10:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:10:21 INFO - 'MOZ_NO_REMOTE': '1', 13:10:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:10:21 INFO - 'NO_EM_RESTART': '1', 13:10:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:10:21 INFO - 'PWD': '/builds/slave/test', 13:10:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:10:21 INFO - 'SHELL': '/bin/bash', 13:10:21 INFO - 'SHLVL': '1', 13:10:21 INFO - 'TERM': 'linux', 13:10:21 INFO - 'TMOUT': '86400', 13:10:21 INFO - 'USER': 'cltbld', 13:10:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1485378566.66156-2082913319', 13:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:10:21 INFO - '_': '/tools/buildbot/bin/python'} 13:10:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 13:10:21 INFO - mozversion application_buildid: 20170125112431 13:10:21 INFO - mozversion application_changeset: 2cfff4488cc160aafb9d8f1b3baa8543d7a170b2 13:10:21 INFO - mozversion application_display_name: Firefox 13:10:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:10:21 INFO - mozversion application_name: Firefox 13:10:21 INFO - mozversion application_remotingname: firefox 13:10:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:10:21 INFO - mozversion application_vendor: Mozilla 13:10:21 INFO - mozversion application_version: 52.0 13:10:21 INFO - mozversion platform_buildid: 20170125112431 13:10:21 INFO - mozversion platform_changeset: 2cfff4488cc160aafb9d8f1b3baa8543d7a170b2 13:10:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:10:21 INFO - mozversion platform_version: 52.0 13:10:21 INFO - using testdate: 1485378621 13:10:21 INFO - actual date: 1485378621 13:10:21 INFO - starting webserver on 'localhost:43494' 13:10:21 INFO - SUITE-START | Running 2 tests 13:10:21 INFO - TEST-START | dromaeo_css 13:10:21 INFO - operating with platform_type : linux_ 13:10:21 INFO - Initialising browser for dromaeo_css test... 13:10:21 INFO - TEST-INFO | started process 12949 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRrN04/profile http://localhost:43494/getInfo.html) 13:10:26 INFO - PROCESS | 12949 | __metrics Screen width/height:1600/1200 13:10:26 INFO - PROCESS | 12949 | colorDepth:24 13:10:26 INFO - PROCESS | 12949 | Browser inner width/height: 1024/697 13:10:26 INFO - PROCESS | 12949 | __metrics 13:10:26 INFO - PROCESS | 12949 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:10:26 INFO - PROCESS | 12949 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:10:27 INFO - PROCESS | 12949 | console.error: PushService: 13:10:27 INFO - PROCESS | 12949 | stateChangeProcessEnqueue: Error transitioning state 13:10:27 INFO - PROCESS | 12949 | UnknownError 13:10:27 INFO - TEST-INFO | 12949: exit 0 13:10:27 INFO - Browser initialized. 13:10:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:10:27 INFO - TEST-INFO | started process 13039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbRrN04/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:10:39 INFO - PROCESS | 13039 | RSS: Main: 141406208 13:10:39 INFO - PROCESS | 13039 | 13:13:41 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:43494/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43494/tests/dromaeo/cssquery-ext.html) 13:13:42 INFO - PROCESS | 13039 | RSS: Main: 240484352 13:13:42 INFO - PROCESS | 13039 | 13:16:44 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:43494/tests/dromaeo/cssquery-ext.html (next: http://localhost:43494/tests/dromaeo/cssquery-jquery.html) 13:16:45 INFO - PROCESS | 13039 | RSS: Main: 229163008 13:16:45 INFO - PROCESS | 13039 | 13:19:47 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:43494/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43494/tests/dromaeo/cssquery-mootools.html) 13:19:47 INFO - PROCESS | 13039 | RSS: Main: 230187008 13:19:47 INFO - PROCESS | 13039 | 13:22:49 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:43494/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43494/tests/dromaeo/cssquery-prototype.html) 13:22:50 INFO - PROCESS | 13039 | RSS: Main: 195182592 13:22:50 INFO - PROCESS | 13039 | 13:25:52 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:43494/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43494/tests/dromaeo/cssquery-yui.html) 13:25:53 INFO - PROCESS | 13039 | RSS: Main: 176386048 13:25:53 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | Cycle 1(1): loaded http://localhost:43494/tests/dromaeo/cssquery-yui.html (next: http://localhost:43494/tests/dromaeo/cssquery-dojo.html) 13:28:55 INFO - PROCESS | 13039 | RSS: Main: 260702208 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | __start_tp_report 13:28:55 INFO - PROCESS | 13039 | _x_x_mozilla_page_load 13:28:55 INFO - PROCESS | 13039 | _x_x_mozilla_page_load_details 13:28:55 INFO - PROCESS | 13039 | |i|pagename|runs| 13:28:55 INFO - PROCESS | 13039 | |0;dojo.html;3206.8396580170993;3241.465158248888;3242.481203007519;3259.1852036990754;3283.6059672839265;5523.25436066131;5585.52523035542;5593.440655934414;5610.803621873235;5642.435756424361;5564.610477266583;5608.551315894719;5608.6073974821775;5624.21261023457;5636.2954630671165;5066.974665126679;5098.643094983353;5128.05131050755;5147.996140752554;5154.664946778466;5050.444451110375;5149.613778966574;5184.637075404723;5185.351831021122;5199.714015729133;5021.598272138239;5045.64680472367;5045.672031317971;5086.872828179288;5127.641065125443;5171.120909445384;5193.324867767166;5200.427952925194;5267.9736601316745;5270.683758974474;5092.9745351273;5168.966206758663;5206.76569554371;5235.712035838027;5259.815906443256;5403.918941215885;5442.836714898559;5463.754131064072;5506.063969125258;5539.833804985857;5950.553708471839;5960.523158147338;5981.700914954278;6048.03231482965;6061.181740465069;6070.0591408331775;6078.726457309432;6093.573449858512;6094.238220222473;6097.847553811191;5444.346678398578;5475;5531.446855314477;5574.860628484239;5581.302337207849;6121.938780612137;6149.661768602769;6154;6159.168512250879;6168.722407491584;5894.351621321651;5908.05471124618;5908.231929849178;5911.556633252523;5916.290045194518;5839.211706419664;5890.322612899486;5892.145638882424;5896.351401345849;5939.346671866091;5917.023691090922;5917.437843404956;5926.940730592725;5927.970360148258;5950.869334826369;5937.406259374028;5971.641701497924;5983.252093488314;5998.610090344114;6002.249718785152;4567.4062371892105;4571.017231295287;4586.633069354443;4596.4254468191475;4597.655175861823;4127.318992366286;4128.091819799639;4131.814068366871;4136.689748268892;4165.146145040259;5709.942900571024;5718.656880587095;5719.656820590778;5722.399148089391;5735.225744524436;5883.14694369314;5914.9704251479325;5938.584299099021;5966.463018328284;6020.578559500793;5729.799457018984;5734.713264336767;5750.338711048199;5759.107338362561;5765.509931655856;5142.61430392722;5151.613628977767;5155.407128180233;5159.277701121846;5166.974165129225;5849.2103566018895;5973.163757073926;6128.480168759602;6150.815475535741;6156.322804491502;5868.501177399969;5878.088896221093;5906.616069955439;5957.225560677084;5993;6030.3668114847305;6031.517478601613;6034.728437220423;6035.064564992434;6040.214772079602;5574.888502230014;5807.274090738658;5810.389909059657;5814.476697097281;5818.563607729353;5755.424457554211;5865.5600829937075;5923.85190370227;5925.585209035326;6019;5785.218995435731;5824.5340372770925;5833.67914764692;5835.4748072673665;5841.065429531254;5830.271216097988;5838.649681019152;5840.328362238397;5840.357560668238;5842;5596.832095037155;5624.690642014729;5771.249737534262;5803.593748437569;5808.796692115756;5945.3757355477055;5947.524198064231;5949.405059494016;5959.22530071088;5983.072623743326;5570.693611851387;5626.38109807929;5785.566082543742;5795.971020144872;5796.594238403271 13:28:55 INFO - PROCESS | 13039 | |1;ext.html;594.8839976204639;603.5805115444766;623.5759683415279;673.8012286375518;685.8731134740077;34171;36928.446073308885;45126.32310515341;45949;46086;45708;46331.536684633225;46340.76829615847;46349.53650463495;46351;8888.911110888905;9033.774155646128;9050.1854833065;9053.637854485813;9054.683086091987;8199.508029518218;8426.115257897924;10645.680629581126;10889.727756806064;10896.019358257756;11022.228444008922;11046.668599942015;11058.391788451632;11060.502277397496;11073.612423565177;10922.508487118099;10984.450777461096;10986.395748233845;10986.450677466095;11000.504977276041;10773.245872788908;10840.403777792219;10852.511636976355;10864.6197383092;10866.61966831157;43595.56404435947;43909;43963.34054989178;43980.34029489528;44020;3590.120420496995;3719.6094410087094;3749.493818334517;3792.1081804472196;4028.8589899353674;33433;33587.496187557204;33880.83059584711;33914.812981545525;35142.82428587866;4472.127935052666;4524.977375113136;4549.772511374418;4556.749378784166;4611.054733779567;353496;354911;355859;357163;360070;37704;66391.66804165948;67052.99999999903;67098.66450667813;67120.6643966777;38454;40352.79823600863;40429.79785101055;40433.59566404357;40474.59525404767;16926.74609880853;17066.658666826595;17129;17129.22918468647;17141;13118.081734278509;13346.532871349651;14133.363998620087;14298.928505357406;14312.06971546867;9162.083791620918;9497.050294970448;9504.144626983605;9597.23222142227;9724.75688107803;3607.9458808117897;3664.706823454117;3670.926581468409;3672.8163591820835;3735.234276973268;1035.7048241251207;1156.439127023393;1164.650604818551;1209.57060243614;1212.1454374665839;33947.32105357879;34201.144971375914;34293.65706342954;34438.827805861314;34534.13664658403;1113.6993011886746;1156.4795841871023;1206.276234259455;1221.694576355911;1232.2668012532529;17783.288668453377;17930.91034544819;18095.45713628593;18206.817931820777;18256.087195640164;511891;513835;515776;517719;520251;63739.36260637427;64003.679981599795;64200.357996420375;64244.35755642477;64250.35749642537;1267.8288431061874;1351.4999450203488;1364.781634938425;1400.0899415379881;1424.5227848670604;29965.55051674183;33258.66741332556;34855;35157.12107197341;35642.86142831438;53852;53912.460875390745;54724.726376367864;54783.17825232545;54946.450535494136;446024;446214;451678;451704;452642;38689;39077.41383879301;41088.38367424551;43641;46851.06297874091;49289.26066108939;50254.497455026445;50565.74717126391;50620.746896265286;51406.74296628493;41253;41423;41531;43106;43291.56708432875;41801.79099104485;41830.58169418267;42818;43425.3486197701;43844.56155438533;42891.57108428876;43573.782131089145;43646;43688;43708.34437483377;35452;38200.2359952805;38360.80819595884;38546.229075418894;39572.604273956895;28394.71605283921;28742.42515149727;28875.7112428873;28956.710432896245;28997.42005159927 13:28:55 INFO - PROCESS | 13039 | |2;jquery.html;397.61431411530805;408.3405300439791;410.46844336584127;411.0813226094728;417.3989455184534;14511.709765804677;18579.535511612215;19809.40571782849;20457.079431425584;20458.18167273309;15823.604409889758;18244.270229190817;18284.451466456027;18987.52531186721;19592.60814783707;5667.518260947824;5880.7353669085;5912.615679980788;5918.40815918409;5919.319278282988;5642.887142257153;5769.7115144242825;5822.301323841145;5884;5889.352171261158;5756.3092428908585;5760.567957403212;5760.9711951440395;5769.1923130761725;5776.537876969833;5585.944140558603;5755.021646320115;5774.364819869811;5781.624194427349;5818.0981947798155;5249;5261.815836445744;5268.868278293074;5269.6311258211945;5277.445868183862;22911.312660620042;23073.19243826458;23608.40978975522;23693.17073902405;24017.27948161558;2427.5198441297566;2438;2472.307753828931;2604.1666666666674;3094.8297843618593;12865.4210560525;14576.979611427205;14845.925770371186;15094.094354338775;15419.383224670999;1831.6611426885936;1940.4935192683163;1968.7539057617798;1991.5917236966386;2053.3121404329568;82904.58547707222;84518;85103;86731.99999999937;88026.5598672009;10598.152147828156;10852.39542509792;10926.781464370828;11159.107271418266;11192.496337664825;15534.378624855106;15571.844281557265;15603.921980390025;15605.063696178266;15614.45349412765;7428.480006399608;7886.44794864354;8400.201980811935;8635.784105397415;8741.91258087411;8560.700375486827;8597;8599.183077607617;8756.992945811186;8798.208161265517;6688.933110668929;6850.897236541456;6866.6566671667215;6913.688884000232;6916.446684265246;1856.6379555986452;1967.6163148186254;2006.7591888973416;2048.8258498027535;2059.9485012874497;960.2845879819579;1026.2816028779735;1048.2505008918508;1057.434272664121;1107.5182295701395;19464.805351946583;20014.49963750918;20027.499312517302;20034.89982550107;20040.298589549297;1016.1565900302732;1026.7279171019686;1070.9036186743074;1093.7265683579105;1093.9835902461468;10685.465726713788;11396.088312934946;11425.942870285595;11439.485223164978;11440.885591144148;436975;449078;450907;456930;458766;56883;58321.41678583244;81549.59225203836;85613;86466.56766716126;1019.913307368882;1055.3245922609535;1083.6803143072812;1088.5591335509132;1095.769888323445;16738.246778894736;17099.487015389557;17472.563185920455;17541.649167016843;17832.286708531512;40651.1869762609;40796.79601601973;41409.58590414057;42239.155216896106;42252;54261.45738542564;54860.17709734277;54867;55927.72036139793;56706;8271.462354946909;8555.914440855511;8702.390832641655;8780.03419623828;8807;12009.279443233085;12498.43757030954;12544.587991966464;13203.933980330037;13224.140430871963;11539;11812;12147;12276.754464910831;12361.505539778309;11338.09295256394;11342.20604557673;11417;11628.476718547854;11908.583199587973;11010.174236932422;11159.72100697489;11611.013063889326;11795.882041179479;12145;8438.831223375375;8453.154684531497;8456.450330728483;8520.786980325542;8775.210231079234;11467.942660286646;11699.649010529698;11749.412529373669;11784.351860647404;11848.58529951482 13:28:55 INFO - PROCESS | 13039 | |3;mootools.html;1415.702702432489;1494.1110039526482;1510.2826157575153;1636.6808472347889;1798.9370372036974;7326;7826.060872695278;8405.91594084059;8780.604872780725;8793;8516.361272904525;8583.313334933206;8592.39853210274;8597.441166324184;8606.397552171351;2340.262817212577;2356.163561935514;2368.2421625079896;2370.111208296889;2370.2652177824843;2345.6481527770884;2399.796017338528;2407.313915534073;2418.3470462974988;2418.4921166555046;2362.976370236293;2378.6907701998716;2392.3899405651537;2392.425817803732;2399.916002939897;2278.931632051041;2290.3358026172473;2312.398776318161;2313.1788215183537;2318.8840557972035;2316.4903721181313;2332.7433982261937;2348.377679914824;2352.4354155002675;2353.329301149164;8534.70128545498;8600.5699715014;8606.182412670787;8627.913720862836;8634.352423568194;5111.8466446006305;5296.496832800878;5296.735163241861;5388.676679399209;5401.027814993299;3328.3842489139342;3391.796492210475;3431.1250631088915;3491.7555771096036;3502.0369398415387;992.5186284651938;1007.5566750629699;1029.922755793311;1033.6485594897772;1072.367303291062;11764.41177941108;11819.88180118205;11882.940585297105;11887.702807429798;11917.284962902253;4309.181255561433;4444.511103778582;4511.796969136397;4588.88527786808;4604.411478040138;9536.332456728102;9549.522523873778;9565.330426870052;9568.808623827485;9569.712908612753;5251.973740131275;5252.054630166606;5256.342957130359;5257.868553286198;5261.184516399964;4190.099128687347;4414.602685758297;4488.4613846338;4498.032922921588;4931.5315045070665;3862.478565393636;3878;3943.921121577552;4014.959850401517;4023.959760402417;1204.7349583091707;1205.1624121235657;1209.6371088673363;1210.5036934856842;1234.8209509621233;806.9112397636255;814.5316443045155;876.6186708781701;901.5627420700955;912.7900582865979;5293.100172970604;5334.866628334245;5373.516383525502;5400.594955378362;5464.590155738336;467.0938379543674;468.34197951877667;468.45191126381536;989.4854675568664;996.038822536256;3502.6847583717586;3521.4893840393;3651.8539258429896;3652.908677283036;3694.224212915264;9966.501674916226;10416.583336666448;10428.27002109845;10441.68674939753;10451.529681164366;10243.692689219335;10271.9486402569;10275.075243228146;10277.537510812032;10299;7644.426667999922;7902.0912595052305;7907.011623547171;8007.919920800718;8168.509889406655;5054.747262636927;5190.8961820764125;5196.9740151299;5477.835664930059;5505.642133261325;9225.169734723908;9355;9450.43297402158;9949.751256218653;10126.746831329276;8405.075441701285;8771.38600297973;9848.162906152771;9927.801443971224;9960.55177517028;7849.921500784919;8033.718819841278;8055;8133.552654604054;8253.504789712637;8263.504189748634;8264.21489958453;8309.086000540057;8325.458845175044;8346.332293416634;7210.531315464478;7298.2701729826595;7302.6713797878165;7369.8157546061775;7474.215207403145;7147.3210045045635;7162.104736907887;7236.167840698387;7245.347918687344;7299.890501642586;6487.416132548094;6589.505787065893;6630.30381809903;6751.662416879039;6754.628495432798;4705.270683044134;4844.660873738945;4850.80596776125;4861.513848615252;4924.236743304794;4843.709377437365;4932.926006109983;4966.602671786176;4981.551660350586;5030.698158110525 13:28:55 INFO - PROCESS | 13039 | |4;prototype.html;337.7500649519355;341.39402560455187;345.78591987476403;349.9247661752723;353.7046566117294;5379.973100134499;5411.107167317388;5428.972855135718;5469.72651367432;5498.3127109111365;5150.613703972198;5222.164453687411;5261.473852614737;5333.546648534879;5421.882417609871;4271.978640106795;4276.208901353244;4280.871573852789;4291.785410729467;4300.311950087971;4261.552536983603;4268.914621707564;4290.6352959998285;4292.763897985609;4294.892627684301;4109.260333140033;4229.471316085489;4247.617714405703;4259.914801703964;4283.121959998209;4246.4691913510815;4257.3613957906255;4257.382679511454;4260.488741351027;4265.083007153461;3784.2970663201395;3786.413105968579;3798.1454172811173;3799;3811.904702382435;5029.471905449912;5179.974100129475;5237.423883372826;5252.894942101175;5265.420803711589;4786.234202527578;4796.25658023007;4801.759912004386;4811.13399588074;4821.63837712173;5601.271834661508;5606.943930560724;5619.943800561983;5634.859128521779;5644.858878528029;3998.4801975743258;4013.4381186633896;4054.878353649395;4106.753594784323;4112.958870411318;5822.534197264251;5854.356020837705;5856.472917437451;5864.472197502245;5868;4180.853670121592;4190.476190476191;4193.622573968297;4198.244316023145;4205.600467955539;4132.5454200037975;4221.775685051301;4234;4235.559909630741;4240.363945408213;4751.216049351888;4800.007996681408;4802;4808.3989501312335;4812.25410061441;5649.661020338793;5666.433356664301;5669;5670.291213598301;5681.545476361881;1355.8372995240634;1406.8522805105522;1413.9787903181461;1420.6377373769621;1430.306301443799;964.6623681711345;979.5934687104914;981.1562056631292;990.4997976022207;991.6182269826024;5230.895382092413;5258;5296.735163241822;5308.893822123536;5315.920261196085;5513.669179849222;5521.868017056494;5537.833864984057;5614.466625670637;5639.3232812062;5207.921881171786;5239.711815850089;5340.332458442695;5343.5457986071615;5524.861878453071;2963.822170669767;2967.7477414419586;2967.985160074186;2980.985095074511;2986.65547545176;5648.943510564842;5663.9716801415725;5682.6361673198135;5683.573731970118;5709.714514274269;5577.458313970657;5660.745266463019;5706.771729130871;5715.28541437567;5737.713114344266;5604.775808967677;5644.943550564524;5656.575756818255;5662.2639056922335;5683.232763576947;5364.973175134255;5557.861053473695;5558.388577256418;5566.610337276352;5615.578831587565;5544.279243698294;5554.888902222014;5567.638103523258;5569.443055694398;5571.192177134212;5665.943340566541;5670.546356291569;5682.232898558807;5690.687012214203;5700.68646224445;3970.5433875103577;3987.92024159521;4000.7199496035;4169.708120431541;4220.599043090901;5570.832875013756;5641.871625674964;5716.342620598518;5761.567882408753;5802.707930367397;5642.078755265052;5661.943380566142;5682.147677848356;5695.4688093382365;5700;5534.529564987021;5561.693002144574;5625.943740562542;5646.548276137817;5690.174924635988;5626.718664066862;5628.60599758013;5633.8309850704545;5641.37944826077;5642;5667.8866422672145;5672.5461963042035;5698.344690360662;5700.743466544099;5703.372629010889;5448.536874365724;5522.447755224445;5550.55595552363;5564.33228012641;5572.108462645957 13:28:55 INFO - PROCESS | 13039 | |5;yui.html;784.6743601405417;787.8463699578581;831.634081004358;845.8392905347986;867.0116067682839;13216.669583260424;13897.305134743261;14484.782728259084;14699.41202351906;14710.19093949835;13186.208827470358;13350.933245333785;13467.797983030263;13472.66318342042;13701;730.7880714592761;845.6659619450329;867.4188293843109;871.6818361298144;871.9825603487926;754.2156157596094;836.1304243586662;852.6802449081595;854.1842540373927;859.7034023261996;899.9145081217274;900.4417261297972;903.0698380667923;903.3856977255464;904.3217586809892;880.6609455359669;886.1935638568904;886.756142060932;890.0165317324328;893.6604090445621;654.653033892038;656.6749459017817;657.4904449051975;659.2056571830932;660.9438197753196;13250.536231231861;13271.933640331834;13283.136596121221;13285.601431957057;13305.201687898758;13628.659283517893;14393.928030359886;14432.494862679861;14445.277736113152;14581.781273280909;12119.454624541917;12247.69380765488;12320.137590368679;12406;12571.434285457177;3802.258559580883;3821.2739579479808;3881.777240169338;3884.8834534964;3895.435161901537;67692.661536692;67850;68238;69241.3075869245;69349.30650693529;11212.159088068265;11222.607208747655;11268.154888383404;11317.264377815416;11349.375784331776;20566.69149962752;20669.689954650694;20707.27524536634;20713.68929466059;20725.067371968296;7644.961775191088;7759.340456061298;7767.1067827200595;7824.491408058458;8064.798380040546;4341.60925516705;4348.978255108705;4546.590806827401;4554.4990051094355;4654.836290927268;3349.815760133216;3444.0873168610337;3467.6532346765625;3478.913027174341;3508.8596456141977;562.3532937122342;577.0622738050668;597.5279529171905;604.9516038716893;613.7882430561449;672.7342699633617;678.521642242218;681.7000519771285;712.1169749510673;753.2580408297822;9055.275577953747;9181.219596334386;9270.165685088374;9508.191803696625;9564.70934848716;633.3508154142041;639.5746828359089;663.6847497438774;688.0539258519535;713.3223437734069;3803.82882770276;3901.4147877818555;4094.28350038742;4096.365063415175;4154.750714957112;52962.73518632382;53418.465815342126;78172;85688;89303;74747;76432;77117;80392.59803701061;81954;67932.660336698;69418.3058169422;69599.30400695928;71622.28377716156;73617.26382736104;8270.297024752963;8289.461185022954;8424.62089205975;8582.227599516074;8673.869891951499;47127.52288532584;47391.630418479624;47924.28113578369;48530;49992.50007499878;64478.677606611665;64987.35012649813;65048;65103.67448162729;67310;10466.529006194893;10471.3193642413;10599.523021463898;10628.309159904891;10884.183686223723;12701.87298127007;13112;13217.669558261121;13339.799903001269;13800.171989680652;13356.933215333862;13623.455061797416;13783.035187536776;13834.308284585932;14280.857191427953;13195.340232988121;13286.601401957956;13431.395587198795;14005.929970350084;14459.927700361432;12887;13266.403011864297;13526.93236533811;14010.229437381042;14783.630409239855;11120.332780033224;11234.719132021764;11551.364674942959;11707.648770536898;12177.573784917486;10795.730106747395;11012.834807478055;11778.352190629597;12263.099219620974;12355.196912200678 13:28:55 INFO - PROCESS | 13039 | __end_tp_report 13:28:55 INFO - PROCESS | 13039 | __start_cc_report 13:28:55 INFO - PROCESS | 13039 | _x_x_mozilla_cycle_collect,998 13:28:55 INFO - PROCESS | 13039 | __end_cc_report 13:28:55 INFO - PROCESS | 13039 | __startTimestamp1485379735924__endTimestamp 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | ------- Summary: start ------- 13:28:55 INFO - PROCESS | 13039 | Number of tests: 6 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | [#0] dojo.html Cycles:165 Average:5550.02 Median:5785.22 stddev:607.63 (10.5%) stddev-sans-first:581.02 13:28:55 INFO - PROCESS | 13039 | Values: 3206.8 3241.5 3242.5 3259.2 3283.6 5523.3 5585.5 5593.4 5610.8 5642.4 5564.6 5608.6 5608.6 5624.2 5636.3 5067.0 5098.6 5128.1 5148.0 5154.7 5050.4 5149.6 5184.6 5185.4 5199.7 5021.6 5045.6 5045.7 5086.9 5127.6 5171.1 5193.3 5200.4 5268.0 5270.7 5093.0 5169.0 5206.8 5235.7 5259.8 5403.9 5442.8 5463.8 5506.1 5539.8 5950.6 5960.5 5981.7 6048.0 6061.2 6070.1 6078.7 6093.6 6094.2 6097.8 5444.3 5475.0 5531.4 5574.9 5581.3 6121.9 6149.7 6154.0 6159.2 6168.7 5894.4 5908.1 5908.2 5911.6 5916.3 5839.2 5890.3 5892.1 5896.4 5939.3 5917.0 5917.4 5926.9 5928.0 5950.9 5937.4 5971.6 5983.3 5998.6 6002.2 4567.4 4571.0 4586.6 4596.4 4597.7 4127.3 4128.1 4131.8 4136.7 4165.1 5709.9 5718.7 5719.7 5722.4 5735.2 5883.1 5915.0 5938.6 5966.5 6020.6 5729.8 5734.7 5750.3 5759.1 5765.5 5142.6 5151.6 5155.4 5159.3 5167.0 5849.2 5973.2 6128.5 6150.8 6156.3 5868.5 5878.1 5906.6 5957.2 5993.0 6030.4 6031.5 6034.7 6035.1 6040.2 5574.9 5807.3 5810.4 5814.5 5818.6 5755.4 5865.6 5923.9 5925.6 6019.0 5785.2 5824.5 5833.7 5835.5 5841.1 5830.3 5838.6 5840.3 5840.4 5842.0 5596.8 5624.7 5771.2 5803.6 5808.8 5945.4 5947.5 5949.4 5959.2 5983.1 5570.7 5626.4 5785.6 5796.0 5796.6 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | [#1] ext.html Cycles:180 Average:60813.13 Median:38883.21 stddev:117893.55 (303.2%) stddev-sans-first:118137.57 13:28:55 INFO - PROCESS | 13039 | Values: 594.9 603.6 623.6 673.8 685.9 34171.0 36928.4 45126.3 45949.0 46086.0 45708.0 46331.5 46340.8 46349.5 46351.0 8888.9 9033.8 9050.2 9053.6 9054.7 8199.5 8426.1 10645.7 10889.7 10896.0 11022.2 11046.7 11058.4 11060.5 11073.6 10922.5 10984.5 10986.4 10986.5 11000.5 10773.2 10840.4 10852.5 10864.6 10866.6 43595.6 43909.0 43963.3 43980.3 44020.0 3590.1 3719.6 3749.5 3792.1 4028.9 33433.0 33587.5 33880.8 33914.8 35142.8 4472.1 4525.0 4549.8 4556.7 4611.1 353496.0 354911.0 355859.0 357163.0 360070.0 37704.0 66391.7 67053.0 67098.7 67120.7 38454.0 40352.8 40429.8 40433.6 40474.6 16926.7 17066.7 17129.0 17129.2 17141.0 13118.1 13346.5 14133.4 14298.9 14312.1 9162.1 9497.1 9504.1 9597.2 9724.8 3607.9 3664.7 3670.9 3672.8 3735.2 1035.7 1156.4 1164.7 1209.6 1212.1 33947.3 34201.1 34293.7 34438.8 34534.1 1113.7 1156.5 1206.3 1221.7 1232.3 17783.3 17930.9 18095.5 18206.8 18256.1 511891.0 513835.0 515776.0 517719.0 520251.0 63739.4 64003.7 64200.4 64244.4 64250.4 1267.8 1351.5 1364.8 1400.1 1424.5 29965.6 33258.7 34855.0 35157.1 35642.9 53852.0 53912.5 54724.7 54783.2 54946.5 446024.0 446214.0 451678.0 451704.0 452642.0 38689.0 39077.4 41088.4 43641.0 46851.1 49289.3 50254.5 50565.7 50620.7 51406.7 41253.0 41423.0 41531.0 43106.0 43291.6 41801.8 41830.6 42818.0 43425.3 43844.6 42891.6 43573.8 43646.0 43688.0 43708.3 35452.0 38200.2 38360.8 38546.2 39572.6 28394.7 28742.4 28875.7 28956.7 28997.4 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | [#2] jquery.html Cycles:180 Average:27653.67 Median:23340.80 stddev:74196.00 (317.9%) stddev-sans-first:74375.91 13:28:55 INFO - PROCESS | 13039 | Values: 397.6 408.3 410.5 411.1 417.4 14511.7 18579.5 19809.4 20457.1 20458.2 15823.6 18244.3 18284.5 18987.5 19592.6 5667.5 5880.7 5912.6 5918.4 5919.3 5642.9 5769.7 5822.3 5884.0 5889.4 5756.3 5760.6 5761.0 5769.2 5776.5 5585.9 5755.0 5774.4 5781.6 5818.1 5249.0 5261.8 5268.9 5269.6 5277.4 22911.3 23073.2 23608.4 23693.2 24017.3 2427.5 2438.0 2472.3 2604.2 3094.8 12865.4 14577.0 14845.9 15094.1 15419.4 1831.7 1940.5 1968.8 1991.6 2053.3 82904.6 84518.0 85103.0 86732.0 88026.6 10598.2 10852.4 10926.8 11159.1 11192.5 15534.4 15571.8 15603.9 15605.1 15614.5 7428.5 7886.4 8400.2 8635.8 8741.9 8560.7 8597.0 8599.2 8757.0 8798.2 6688.9 6850.9 6866.7 6913.7 6916.4 1856.6 1967.6 2006.8 2048.8 2059.9 960.3 1026.3 1048.3 1057.4 1107.5 19464.8 20014.5 20027.5 20034.9 20040.3 1016.2 1026.7 1070.9 1093.7 1094.0 10685.5 11396.1 11425.9 11439.5 11440.9 436975.0 449078.0 450907.0 456930.0 458766.0 56883.0 58321.4 81549.6 85613.0 86466.6 1019.9 1055.3 1083.7 1088.6 1095.8 16738.2 17099.5 17472.6 17541.6 17832.3 40651.2 40796.8 41409.6 42239.2 42252.0 54261.5 54860.2 54867.0 55927.7 56706.0 8271.5 8555.9 8702.4 8780.0 8807.0 12009.3 12498.4 12544.6 13203.9 13224.1 11539.0 11812.0 12147.0 12276.8 12361.5 11338.1 11342.2 11417.0 11628.5 11908.6 11010.2 11159.7 11611.0 11795.9 12145.0 8438.8 8453.2 8456.5 8520.8 8775.2 11467.9 11699.6 11749.4 11784.4 11848.6 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | [#3] mootools.html Cycles:180 Average:5556.60 Median:5006.12 stddev:3135.04 (62.6%) stddev-sans-first:3128.39 13:28:55 INFO - PROCESS | 13039 | Values: 1415.7 1494.1 1510.3 1636.7 1798.9 7326.0 7826.1 8405.9 8780.6 8793.0 8516.4 8583.3 8592.4 8597.4 8606.4 2340.3 2356.2 2368.2 2370.1 2370.3 2345.6 2399.8 2407.3 2418.3 2418.5 2363.0 2378.7 2392.4 2392.4 2399.9 2278.9 2290.3 2312.4 2313.2 2318.9 2316.5 2332.7 2348.4 2352.4 2353.3 8534.7 8600.6 8606.2 8627.9 8634.4 5111.8 5296.5 5296.7 5388.7 5401.0 3328.4 3391.8 3431.1 3491.8 3502.0 992.5 1007.6 1029.9 1033.6 1072.4 11764.4 11819.9 11882.9 11887.7 11917.3 4309.2 4444.5 4511.8 4588.9 4604.4 9536.3 9549.5 9565.3 9568.8 9569.7 5252.0 5252.1 5256.3 5257.9 5261.2 4190.1 4414.6 4488.5 4498.0 4931.5 3862.5 3878.0 3943.9 4015.0 4024.0 1204.7 1205.2 1209.6 1210.5 1234.8 806.9 814.5 876.6 901.6 912.8 5293.1 5334.9 5373.5 5400.6 5464.6 467.1 468.3 468.5 989.5 996.0 3502.7 3521.5 3651.9 3652.9 3694.2 9966.5 10416.6 10428.3 10441.7 10451.5 10243.7 10271.9 10275.1 10277.5 10299.0 7644.4 7902.1 7907.0 8007.9 8168.5 5054.7 5190.9 5197.0 5477.8 5505.6 9225.2 9355.0 9450.4 9949.8 10126.7 8405.1 8771.4 9848.2 9927.8 9960.6 7849.9 8033.7 8055.0 8133.6 8253.5 8263.5 8264.2 8309.1 8325.5 8346.3 7210.5 7298.3 7302.7 7369.8 7474.2 7147.3 7162.1 7236.2 7245.3 7299.9 6487.4 6589.5 6630.3 6751.7 6754.6 4705.3 4844.7 4850.8 4861.5 4924.2 4843.7 4932.9 4966.6 4981.6 5030.7 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | [#4] prototype.html Cycles:180 Average:4709.39 Median:5416.49 stddev:1356.47 (25.0%) stddev-sans-first:1320.00 13:28:55 INFO - PROCESS | 13039 | Values: 337.8 341.4 345.8 349.9 353.7 5380.0 5411.1 5429.0 5469.7 5498.3 5150.6 5222.2 5261.5 5333.5 5421.9 4272.0 4276.2 4280.9 4291.8 4300.3 4261.6 4268.9 4290.6 4292.8 4294.9 4109.3 4229.5 4247.6 4259.9 4283.1 4246.5 4257.4 4257.4 4260.5 4265.1 3784.3 3786.4 3798.1 3799.0 3811.9 5029.5 5180.0 5237.4 5252.9 5265.4 4786.2 4796.3 4801.8 4811.1 4821.6 5601.3 5606.9 5619.9 5634.9 5644.9 3998.5 4013.4 4054.9 4106.8 4113.0 5822.5 5854.4 5856.5 5864.5 5868.0 4180.9 4190.5 4193.6 4198.2 4205.6 4132.5 4221.8 4234.0 4235.6 4240.4 4751.2 4800.0 4802.0 4808.4 4812.3 5649.7 5666.4 5669.0 5670.3 5681.5 1355.8 1406.9 1414.0 1420.6 1430.3 964.7 979.6 981.2 990.5 991.6 5230.9 5258.0 5296.7 5308.9 5315.9 5513.7 5521.9 5537.8 5614.5 5639.3 5207.9 5239.7 5340.3 5343.5 5524.9 2963.8 2967.7 2968.0 2981.0 2986.7 5648.9 5664.0 5682.6 5683.6 5709.7 5577.5 5660.7 5706.8 5715.3 5737.7 5604.8 5644.9 5656.6 5662.3 5683.2 5365.0 5557.9 5558.4 5566.6 5615.6 5544.3 5554.9 5567.6 5569.4 5571.2 5665.9 5670.5 5682.2 5690.7 5700.7 3970.5 3987.9 4000.7 4169.7 4220.6 5570.8 5641.9 5716.3 5761.6 5802.7 5642.1 5661.9 5682.1 5695.5 5700.0 5534.5 5561.7 5625.9 5646.5 5690.2 5626.7 5628.6 5633.8 5641.4 5642.0 5667.9 5672.5 5698.3 5700.7 5703.4 5448.5 5522.4 5550.6 5564.3 5572.1 13:28:55 INFO - PROCESS | 13039 | 13:28:55 INFO - PROCESS | 13039 | [#5] yui.html Cycles:180 Average:17735.99 Median:47259.58 stddev:23242.17 (49.2%) stddev-sans-first:23272.51 13:28:55 INFO - PROCESS | 13039 | Values: 784.7 787.8 831.6 845.8 867.0 13216.7 13897.3 14484.8 14699.4 14710.2 13186.2 13350.9 13467.8 13472.7 13701.0 730.8 845.7 867.4 871.7 872.0 754.2 836.1 852.7 854.2 859.7 899.9 900.4 903.1 903.4 904.3 880.7 886.2 886.8 890.0 893.7 654.7 656.7 657.5 659.2 660.9 13250.5 13271.9 13283.1 13285.6 13305.2 13628.7 14393.9 14432.5 14445.3 14581.8 12119.5 12247.7 12320.1 12406.0 12571.4 3802.3 3821.3 3881.8 3884.9 3895.4 67692.7 67850.0 68238.0 69241.3 69349.3 11212.2 11222.6 11268.2 11317.3 11349.4 20566.7 20669.7 20707.3 20713.7 20725.1 7645.0 7759.3 7767.1 7824.5 8064.8 4341.6 4349.0 4546.6 4554.5 4654.8 3349.8 3444.1 3467.7 3478.9 3508.9 562.4 577.1 597.5 605.0 613.8 672.7 678.5 681.7 712.1 753.3 9055.3 9181.2 9270.2 9508.2 9564.7 633.4 639.6 663.7 688.1 713.3 3803.8 3901.4 4094.3 4096.4 4154.8 52962.7 53418.5 78172.0 85688.0 89303.0 74747.0 76432.0 77117.0 80392.6 81954.0 67932.7 69418.3 69599.3 71622.3 73617.3 8270.3 8289.5 8424.6 8582.2 8673.9 47127.5 47391.6 47924.3 48530.0 49992.5 64478.7 64987.4 65048.0 65103.7 67310.0 10466.5 10471.3 10599.5 10628.3 10884.2 12701.9 13112.0 13217.7 13339.8 13800.2 13356.9 13623.5 13783.0 13834.3 14280.9 13195.3 13286.6 13431.4 14005.9 14459.9 12887.0 13266.4 13526.9 14010.2 14783.6 11120.3 11234.7 11551.4 11707.6 12177.6 10795.7 11012.8 11778.4 12263.1 12355.2 13:28:55 INFO - PROCESS | 13039 | -------- Summary: end -------- 13:28:55 INFO - PROCESS | 13039 | 13:28:56 INFO - TEST-INFO | 13039: exit 0 13:28:56 INFO - TEST-OK | dromaeo_css | took 1114848ms 13:28:56 INFO - TEST-START | kraken 13:28:56 INFO - operating with platform_type : linux_ 13:28:56 INFO - Initialising browser for kraken test... 13:28:56 INFO - TEST-INFO | started process 13347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcXNbt/profile http://localhost:43494/getInfo.html) 13:29:00 INFO - PROCESS | 13347 | __metrics Screen width/height:1600/1200 13:29:00 INFO - PROCESS | 13347 | colorDepth:24 13:29:00 INFO - PROCESS | 13347 | Browser inner width/height: 1024/697 13:29:00 INFO - PROCESS | 13347 | __metrics 13:29:01 INFO - PROCESS | 13347 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:29:01 INFO - PROCESS | 13347 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:29:02 INFO - PROCESS | 13347 | console.error: PushService: 13:29:02 INFO - PROCESS | 13347 | stateChangeProcessEnqueue: Error transitioning state 13:29:02 INFO - PROCESS | 13347 | UnknownError 13:29:02 INFO - TEST-INFO | 13347: exit 0 13:29:02 INFO - Browser initialized. 13:29:02 INFO - Running cycle 1/1 for kraken test... 13:29:02 INFO - TEST-INFO | started process 13438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcXNbt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:29:14 INFO - PROCESS | 13438 | RSS: Main: 141250560 13:29:14 INFO - PROCESS | 13438 | 13:29:16 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43494/tests/kraken/driver.html?testName=audio-beat-detection) 13:29:17 INFO - PROCESS | 13438 | RSS: Main: 182988800 13:29:17 INFO - PROCESS | 13438 | 13:29:20 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43494/tests/kraken/driver.html?testName=audio-dft) 13:29:20 INFO - PROCESS | 13438 | RSS: Main: 173113344 13:29:20 INFO - PROCESS | 13438 | 13:29:23 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43494/tests/kraken/driver.html?testName=audio-fft) 13:29:24 INFO - PROCESS | 13438 | RSS: Main: 263864320 13:29:24 INFO - PROCESS | 13438 | 13:29:26 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43494/tests/kraken/driver.html?testName=audio-oscillator) 13:29:26 INFO - PROCESS | 13438 | RSS: Main: 170762240 13:29:26 INFO - PROCESS | 13438 | 13:29:29 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43494/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:29:29 INFO - PROCESS | 13438 | RSS: Main: 173121536 13:29:29 INFO - PROCESS | 13438 | 13:29:32 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43494/tests/kraken/driver.html?testName=imaging-darkroom) 13:29:33 INFO - PROCESS | 13438 | RSS: Main: 211214336 13:29:33 INFO - PROCESS | 13438 | 13:29:36 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43494/tests/kraken/driver.html?testName=imaging-desaturate) 13:29:37 INFO - PROCESS | 13438 | RSS: Main: 210554880 13:29:37 INFO - PROCESS | 13438 | 13:29:39 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43494/tests/kraken/driver.html?testName=json-parse-financial) 13:29:40 INFO - PROCESS | 13438 | RSS: Main: 209203200 13:29:40 INFO - PROCESS | 13438 | 13:29:41 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43494/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:29:42 INFO - PROCESS | 13438 | RSS: Main: 171593728 13:29:42 INFO - PROCESS | 13438 | 13:29:44 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:29:44 INFO - PROCESS | 13438 | RSS: Main: 178524160 13:29:44 INFO - PROCESS | 13438 | 13:29:46 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:29:47 INFO - PROCESS | 13438 | RSS: Main: 187650048 13:29:47 INFO - PROCESS | 13438 | 13:29:49 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:29:50 INFO - PROCESS | 13438 | RSS: Main: 196739072 13:29:50 INFO - PROCESS | 13438 | 13:29:53 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:29:53 INFO - PROCESS | 13438 | RSS: Main: 192335872 13:29:53 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | Cycle 1(1): loaded http://localhost:43494/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43494/tests/kraken/driver.html?testName=ai-astar) 13:29:55 INFO - PROCESS | 13438 | RSS: Main: 245202944 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | __start_tp_report 13:29:55 INFO - PROCESS | 13438 | _x_x_mozilla_page_load 13:29:55 INFO - PROCESS | 13438 | _x_x_mozilla_page_load_details 13:29:55 INFO - PROCESS | 13438 | |i|pagename|runs| 13:29:55 INFO - PROCESS | 13438 | |0;ai-astar;104;114;115;112;112;113;113;112;116;112 13:29:55 INFO - PROCESS | 13438 | |1;audio-beat-detection;148;120;124;156;118;123;117;118;149;120 13:29:55 INFO - PROCESS | 13438 | |2;audio-dft;161;160;161;159;161;160;162;160;160;161 13:29:55 INFO - PROCESS | 13438 | |3;audio-fft;76;76;76;106;76;75;76;75;98;75 13:29:55 INFO - PROCESS | 13438 | |4;audio-oscillator;81;84;112;82;82;82;102;82;82;112 13:29:55 INFO - PROCESS | 13438 | |5;imaging-gaussian-blur;118;117;116;117;117;117;117;117;117;117 13:29:55 INFO - PROCESS | 13438 | |6;imaging-darkroom;146;146;145;146;145;146;146;146;145;145 13:29:55 INFO - PROCESS | 13438 | |7;imaging-desaturate;84;85;84;85;85;84;84;84;85;84 13:29:55 INFO - PROCESS | 13438 | |8;json-parse-financial;53;51;52;51;62;51;53;51;51;52 13:29:55 INFO - PROCESS | 13438 | |9;json-stringify-tinderbox;60;59;60;59;60;59;60;60;62;61 13:29:55 INFO - PROCESS | 13438 | |10;stanford-crypto-aes;75;76;75;75;76;75;75;75;75;74 13:29:55 INFO - PROCESS | 13438 | |11;stanford-crypto-ccm;122;122;129;132;123;129;119;118;159;138 13:29:55 INFO - PROCESS | 13438 | |12;stanford-crypto-pbkdf2;154;154;151;152;152;154;161;159;154;162 13:29:55 INFO - PROCESS | 13438 | |13;stanford-crypto-sha256-iterative;62;62;63;64;63;63;61;62;61;60 13:29:55 INFO - PROCESS | 13438 | __end_tp_report 13:29:55 INFO - PROCESS | 13438 | __start_cc_report 13:29:55 INFO - PROCESS | 13438 | _x_x_mozilla_cycle_collect,1584 13:29:55 INFO - PROCESS | 13438 | __end_cc_report 13:29:55 INFO - PROCESS | 13438 | __startTimestamp1485379795686__endTimestamp 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | ------- Summary: start ------- 13:29:55 INFO - PROCESS | 13438 | Number of tests: 14 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.23 (2.9%) stddev-sans-first:1.48 13:29:55 INFO - PROCESS | 13438 | Values: 104.0 114.0 115.0 112.0 112.0 113.0 113.0 112.0 116.0 112.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#1] audio-beat-detection Cycles:10 Average:129.30 Median:123.50 stddev:15.27 (12.4%) stddev-sans-first:14.62 13:29:55 INFO - PROCESS | 13438 | Values: 148.0 120.0 124.0 156.0 118.0 123.0 117.0 118.0 149.0 120.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 13:29:55 INFO - PROCESS | 13438 | Values: 161.0 160.0 161.0 159.0 161.0 160.0 162.0 160.0 160.0 161.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:11.29 (14.9%) stddev-sans-first:11.83 13:29:55 INFO - PROCESS | 13438 | Values: 76.0 76.0 76.0 106.0 76.0 75.0 76.0 75.0 98.0 75.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:82.00 stddev:13.12 (16.0%) stddev-sans-first:13.49 13:29:55 INFO - PROCESS | 13438 | Values: 81.0 84.0 112.0 82.0 82.0 82.0 102.0 82.0 82.0 112.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 13:29:55 INFO - PROCESS | 13438 | Values: 118.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:29:55 INFO - PROCESS | 13438 | Values: 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 145.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 13:29:55 INFO - PROCESS | 13438 | Values: 84.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:3.37 (6.5%) stddev-sans-first:3.57 13:29:55 INFO - PROCESS | 13438 | Values: 53.0 51.0 52.0 51.0 62.0 51.0 53.0 51.0 51.0 52.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.94 (1.6%) stddev-sans-first:1.00 13:29:55 INFO - PROCESS | 13438 | Values: 60.0 59.0 60.0 59.0 60.0 59.0 60.0 60.0 62.0 61.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 13:29:55 INFO - PROCESS | 13438 | Values: 75.0 76.0 75.0 75.0 76.0 75.0 75.0 75.0 75.0 74.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:129.00 stddev:12.22 (9.5%) stddev-sans-first:12.69 13:29:55 INFO - PROCESS | 13438 | Values: 122.0 122.0 129.0 132.0 123.0 129.0 119.0 118.0 159.0 138.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:154.00 stddev:3.92 (2.5%) stddev-sans-first:4.13 13:29:55 INFO - PROCESS | 13438 | Values: 154.0 154.0 151.0 152.0 152.0 154.0 161.0 159.0 154.0 162.0 13:29:55 INFO - PROCESS | 13438 | 13:29:55 INFO - PROCESS | 13438 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.20 (1.9%) stddev-sans-first:1.27 13:29:55 INFO - PROCESS | 13438 | Values: 62.0 62.0 63.0 64.0 63.0 63.0 61.0 62.0 61.0 60.0 13:29:55 INFO - PROCESS | 13438 | -------- Summary: end -------- 13:29:55 INFO - PROCESS | 13438 | 13:29:56 INFO - TEST-INFO | 13438: exit 0 13:29:56 INFO - TEST-OK | kraken | took 60035ms 13:29:56 INFO - SUITE-END | took 1174s 13:29:56 INFO - Completed test suite (00:19:35) 13:29:56 INFO - javascript benchmark 13:29:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3206.8396580170993, 3241.465158248888, 3242.481203007519, 3259.1852036990754, 3283.6059672839265, 5523.25436066131, 5585.52523035542, 5593.440655934414, 5610.803621873235, 5642.435756424361, 5564.610477266583, 5608.551315894719, 5608.6073974821775, 5624.21261023457, 5636.2954630671165, 5066.974665126679, 5098.643094983353, 5128.05131050755, 5147.996140752554, 5154.664946778466, 5050.444451110375, 5149.613778966574, 5184.637075404723, 5185.351831021122, 5199.714015729133, 5021.598272138239, 5045.64680472367, 5045.672031317971, 5086.872828179288, 5127.641065125443, 5171.120909445384, 5193.324867767166, 5200.427952925194, 5267.9736601316745, 5270.683758974474, 5092.9745351273, 5168.966206758663, 5206.76569554371, 5235.712035838027, 5259.815906443256, 5403.918941215885, 5442.836714898559, 5463.754131064072, 5506.063969125258, 5539.833804985857, 5950.553708471839, 5960.523158147338, 5981.700914954278, 6048.03231482965, 6061.181740465069, 6070.0591408331775, 6078.726457309432, 6093.573449858512, 6094.238220222473, 6097.847553811191, 5444.346678398578, 5475.0, 5531.446855314477, 5574.860628484239, 5581.302337207849, 6121.938780612137, 6149.661768602769, 6154.0, 6159.168512250879, 6168.722407491584, 5894.351621321651, 5908.05471124618, 5908.231929849178, 5911.556633252523, 5916.290045194518, 5839.211706419664, 5890.322612899486, 5892.145638882424, 5896.351401345849, 5939.346671866091, 5917.023691090922, 5917.437843404956, 5926.940730592725, 5927.970360148258, 5950.869334826369, 5937.406259374028, 5971.641701497924, 5983.252093488314, 5998.610090344114, 6002.249718785152, 4567.4062371892105, 4571.017231295287, 4586.633069354443, 4596.4254468191475, 4597.655175861823, 4127.318992366286, 4128.091819799639, 4131.814068366871, 4136.689748268892, 4165.146145040259, 5709.942900571024, 5718.656880587095, 5719.656820590778, 5722.399148089391, 5735.225744524436, 5883.14694369314, 5914.9704251479325, 5938.584299099021, 5966.463018328284, 6020.578559500793, 5729.799457018984, 5734.713264336767, 5750.338711048199, 5759.107338362561, 5765.509931655856, 5142.61430392722, 5151.613628977767, 5155.407128180233, 5159.277701121846, 5166.974165129225, 5849.2103566018895, 5973.163757073926, 6128.480168759602, 6150.815475535741, 6156.322804491502, 5868.501177399969, 5878.088896221093, 5906.616069955439, 5957.225560677084, 5993.0, 6030.3668114847305, 6031.517478601613, 6034.728437220423, 6035.064564992434, 6040.214772079602, 5574.888502230014, 5807.274090738658, 5810.389909059657, 5814.476697097281, 5818.563607729353, 5755.424457554211, 5865.5600829937075, 5923.85190370227, 5925.585209035326, 6019.0, 5785.218995435731, 5824.5340372770925, 5833.67914764692, 5835.4748072673665, 5841.065429531254, 5830.271216097988, 5838.649681019152, 5840.328362238397, 5840.357560668238, 5842.0, 5596.832095037155, 5624.690642014729, 5771.249737534262, 5803.593748437569, 5808.796692115756, 5945.3757355477055, 5947.524198064231, 5949.405059494016, 5959.22530071088, 5983.072623743326, 5570.693611851387, 5626.38109807929, 5785.566082543742, 5795.971020144872, 5796.594238403271], "value": 5510.183010719692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8839976204639, 603.5805115444766, 623.5759683415279, 673.8012286375518, 685.8731134740077, 34171.0, 36928.446073308885, 45126.32310515341, 45949.0, 46086.0, 45708.0, 46331.536684633225, 46340.76829615847, 46349.53650463495, 46351.0, 8888.911110888905, 9033.774155646128, 9050.1854833065, 9053.637854485813, 9054.683086091987, 8199.508029518218, 8426.115257897924, 10645.680629581126, 10889.727756806064, 10896.019358257756, 11022.228444008922, 11046.668599942015, 11058.391788451632, 11060.502277397496, 11073.612423565177, 10922.508487118099, 10984.450777461096, 10986.395748233845, 10986.450677466095, 11000.504977276041, 10773.245872788908, 10840.403777792219, 10852.511636976355, 10864.6197383092, 10866.61966831157, 43595.56404435947, 43909.0, 43963.34054989178, 43980.34029489528, 44020.0, 3590.120420496995, 3719.6094410087094, 3749.493818334517, 3792.1081804472196, 4028.8589899353674, 33433.0, 33587.496187557204, 33880.83059584711, 33914.812981545525, 35142.82428587866, 4472.127935052666, 4524.977375113136, 4549.772511374418, 4556.749378784166, 4611.054733779567, 353496.0, 354911.0, 355859.0, 357163.0, 360070.0, 37704.0, 66391.66804165948, 67052.99999999903, 67098.66450667813, 67120.6643966777, 38454.0, 40352.79823600863, 40429.79785101055, 40433.59566404357, 40474.59525404767, 16926.74609880853, 17066.658666826595, 17129.0, 17129.22918468647, 17141.0, 13118.081734278509, 13346.532871349651, 14133.363998620087, 14298.928505357406, 14312.06971546867, 9162.083791620918, 9497.050294970448, 9504.144626983605, 9597.23222142227, 9724.75688107803, 3607.9458808117897, 3664.706823454117, 3670.926581468409, 3672.8163591820835, 3735.234276973268, 1035.7048241251207, 1156.439127023393, 1164.650604818551, 1209.57060243614, 1212.1454374665839, 33947.32105357879, 34201.144971375914, 34293.65706342954, 34438.827805861314, 34534.13664658403, 1113.6993011886746, 1156.4795841871023, 1206.276234259455, 1221.694576355911, 1232.2668012532529, 17783.288668453377, 17930.91034544819, 18095.45713628593, 18206.817931820777, 18256.087195640164, 511891.0, 513835.0, 515776.0, 517719.0, 520251.0, 63739.36260637427, 64003.679981599795, 64200.357996420375, 64244.35755642477, 64250.35749642537, 1267.8288431061874, 1351.4999450203488, 1364.781634938425, 1400.0899415379881, 1424.5227848670604, 29965.55051674183, 33258.66741332556, 34855.0, 35157.12107197341, 35642.86142831438, 53852.0, 53912.460875390745, 54724.726376367864, 54783.17825232545, 54946.450535494136, 446024.0, 446214.0, 451678.0, 451704.0, 452642.0, 38689.0, 39077.41383879301, 41088.38367424551, 43641.0, 46851.06297874091, 49289.26066108939, 50254.497455026445, 50565.74717126391, 50620.746896265286, 51406.74296628493, 41253.0, 41423.0, 41531.0, 43106.0, 43291.56708432875, 41801.79099104485, 41830.58169418267, 42818.0, 43425.3486197701, 43844.56155438533, 42891.57108428876, 43573.782131089145, 43646.0, 43688.0, 43708.34437483377, 35452.0, 38200.2359952805, 38360.80819595884, 38546.229075418894, 39572.604273956895, 28394.71605283921, 28742.42515149727, 28875.7112428873, 28956.710432896245, 28997.42005159927], "value": 20439.651693404016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.61431411530805, 408.3405300439791, 410.46844336584127, 411.0813226094728, 417.3989455184534, 14511.709765804677, 18579.535511612215, 19809.40571782849, 20457.079431425584, 20458.18167273309, 15823.604409889758, 18244.270229190817, 18284.451466456027, 18987.52531186721, 19592.60814783707, 5667.518260947824, 5880.7353669085, 5912.615679980788, 5918.40815918409, 5919.319278282988, 5642.887142257153, 5769.7115144242825, 5822.301323841145, 5884.0, 5889.352171261158, 5756.3092428908585, 5760.567957403212, 5760.9711951440395, 5769.1923130761725, 5776.537876969833, 5585.944140558603, 5755.021646320115, 5774.364819869811, 5781.624194427349, 5818.0981947798155, 5249.0, 5261.815836445744, 5268.868278293074, 5269.6311258211945, 5277.445868183862, 22911.312660620042, 23073.19243826458, 23608.40978975522, 23693.17073902405, 24017.27948161558, 2427.5198441297566, 2438.0, 2472.307753828931, 2604.1666666666674, 3094.8297843618593, 12865.4210560525, 14576.979611427205, 14845.925770371186, 15094.094354338775, 15419.383224670999, 1831.6611426885936, 1940.4935192683163, 1968.7539057617798, 1991.5917236966386, 2053.3121404329568, 82904.58547707222, 84518.0, 85103.0, 86731.99999999937, 88026.5598672009, 10598.152147828156, 10852.39542509792, 10926.781464370828, 11159.107271418266, 11192.496337664825, 15534.378624855106, 15571.844281557265, 15603.921980390025, 15605.063696178266, 15614.45349412765, 7428.480006399608, 7886.44794864354, 8400.201980811935, 8635.784105397415, 8741.91258087411, 8560.700375486827, 8597.0, 8599.183077607617, 8756.992945811186, 8798.208161265517, 6688.933110668929, 6850.897236541456, 6866.6566671667215, 6913.688884000232, 6916.446684265246, 1856.6379555986452, 1967.6163148186254, 2006.7591888973416, 2048.8258498027535, 2059.9485012874497, 960.2845879819579, 1026.2816028779735, 1048.2505008918508, 1057.434272664121, 1107.5182295701395, 19464.805351946583, 20014.49963750918, 20027.499312517302, 20034.89982550107, 20040.298589549297, 1016.1565900302732, 1026.7279171019686, 1070.9036186743074, 1093.7265683579105, 1093.9835902461468, 10685.465726713788, 11396.088312934946, 11425.942870285595, 11439.485223164978, 11440.885591144148, 436975.0, 449078.0, 450907.0, 456930.0, 458766.0, 56883.0, 58321.41678583244, 81549.59225203836, 85613.0, 86466.56766716126, 1019.913307368882, 1055.3245922609535, 1083.6803143072812, 1088.5591335509132, 1095.769888323445, 16738.246778894736, 17099.487015389557, 17472.563185920455, 17541.649167016843, 17832.286708531512, 40651.1869762609, 40796.79601601973, 41409.58590414057, 42239.155216896106, 42252.0, 54261.45738542564, 54860.17709734277, 54867.0, 55927.72036139793, 56706.0, 8271.462354946909, 8555.914440855511, 8702.390832641655, 8780.03419623828, 8807.0, 12009.279443233085, 12498.43757030954, 12544.587991966464, 13203.933980330037, 13224.140430871963, 11539.0, 11812.0, 12147.0, 12276.754464910831, 12361.505539778309, 11338.09295256394, 11342.20604557673, 11417.0, 11628.476718547854, 11908.583199587973, 11010.174236932422, 11159.72100697489, 11611.013063889326, 11795.882041179479, 12145.0, 8438.831223375375, 8453.154684531497, 8456.450330728483, 8520.786980325542, 8775.210231079234, 11467.942660286646, 11699.649010529698, 11749.412529373669, 11784.351860647404, 11848.58529951482], "value": 9439.563601359687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.702702432489, 1494.1110039526482, 1510.2826157575153, 1636.6808472347889, 1798.9370372036974, 7326.0, 7826.060872695278, 8405.91594084059, 8780.604872780725, 8793.0, 8516.361272904525, 8583.313334933206, 8592.39853210274, 8597.441166324184, 8606.397552171351, 2340.262817212577, 2356.163561935514, 2368.2421625079896, 2370.111208296889, 2370.2652177824843, 2345.6481527770884, 2399.796017338528, 2407.313915534073, 2418.3470462974988, 2418.4921166555046, 2362.976370236293, 2378.6907701998716, 2392.3899405651537, 2392.425817803732, 2399.916002939897, 2278.931632051041, 2290.3358026172473, 2312.398776318161, 2313.1788215183537, 2318.8840557972035, 2316.4903721181313, 2332.7433982261937, 2348.377679914824, 2352.4354155002675, 2353.329301149164, 8534.70128545498, 8600.5699715014, 8606.182412670787, 8627.913720862836, 8634.352423568194, 5111.8466446006305, 5296.496832800878, 5296.735163241861, 5388.676679399209, 5401.027814993299, 3328.3842489139342, 3391.796492210475, 3431.1250631088915, 3491.7555771096036, 3502.0369398415387, 992.5186284651938, 1007.5566750629699, 1029.922755793311, 1033.6485594897772, 1072.367303291062, 11764.41177941108, 11819.88180118205, 11882.940585297105, 11887.702807429798, 11917.284962902253, 4309.181255561433, 4444.511103778582, 4511.796969136397, 4588.88527786808, 4604.411478040138, 9536.332456728102, 9549.522523873778, 9565.330426870052, 9568.808623827485, 9569.712908612753, 5251.973740131275, 5252.054630166606, 5256.342957130359, 5257.868553286198, 5261.184516399964, 4190.099128687347, 4414.602685758297, 4488.4613846338, 4498.032922921588, 4931.5315045070665, 3862.478565393636, 3878.0, 3943.921121577552, 4014.959850401517, 4023.959760402417, 1204.7349583091707, 1205.1624121235657, 1209.6371088673363, 1210.5036934856842, 1234.8209509621233, 806.9112397636255, 814.5316443045155, 876.6186708781701, 901.5627420700955, 912.7900582865979, 5293.100172970604, 5334.866628334245, 5373.516383525502, 5400.594955378362, 5464.590155738336, 467.0938379543674, 468.34197951877667, 468.45191126381536, 989.4854675568664, 996.038822536256, 3502.6847583717586, 3521.4893840393, 3651.8539258429896, 3652.908677283036, 3694.224212915264, 9966.501674916226, 10416.583336666448, 10428.27002109845, 10441.68674939753, 10451.529681164366, 10243.692689219335, 10271.9486402569, 10275.075243228146, 10277.537510812032, 10299.0, 7644.426667999922, 7902.0912595052305, 7907.011623547171, 8007.919920800718, 8168.509889406655, 5054.747262636927, 5190.8961820764125, 5196.9740151299, 5477.835664930059, 5505.642133261325, 9225.169734723908, 9355.0, 9450.43297402158, 9949.751256218653, 10126.746831329276, 8405.075441701285, 8771.38600297973, 9848.162906152771, 9927.801443971224, 9960.55177517028, 7849.921500784919, 8033.718819841278, 8055.0, 8133.552654604054, 8253.504789712637, 8263.504189748634, 8264.21489958453, 8309.086000540057, 8325.458845175044, 8346.332293416634, 7210.531315464478, 7298.2701729826595, 7302.6713797878165, 7369.8157546061775, 7474.215207403145, 7147.3210045045635, 7162.104736907887, 7236.167840698387, 7245.347918687344, 7299.890501642586, 6487.416132548094, 6589.505787065893, 6630.30381809903, 6751.662416879039, 6754.628495432798, 4705.270683044134, 4844.660873738945, 4850.80596776125, 4861.513848615252, 4924.236743304794, 4843.709377437365, 4932.926006109983, 4966.602671786176, 4981.551660350586, 5030.698158110525], "value": 4433.730523309198, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.7500649519355, 341.39402560455187, 345.78591987476403, 349.9247661752723, 353.7046566117294, 5379.973100134499, 5411.107167317388, 5428.972855135718, 5469.72651367432, 5498.3127109111365, 5150.613703972198, 5222.164453687411, 5261.473852614737, 5333.546648534879, 5421.882417609871, 4271.978640106795, 4276.208901353244, 4280.871573852789, 4291.785410729467, 4300.311950087971, 4261.552536983603, 4268.914621707564, 4290.6352959998285, 4292.763897985609, 4294.892627684301, 4109.260333140033, 4229.471316085489, 4247.617714405703, 4259.914801703964, 4283.121959998209, 4246.4691913510815, 4257.3613957906255, 4257.382679511454, 4260.488741351027, 4265.083007153461, 3784.2970663201395, 3786.413105968579, 3798.1454172811173, 3799.0, 3811.904702382435, 5029.471905449912, 5179.974100129475, 5237.423883372826, 5252.894942101175, 5265.420803711589, 4786.234202527578, 4796.25658023007, 4801.759912004386, 4811.13399588074, 4821.63837712173, 5601.271834661508, 5606.943930560724, 5619.943800561983, 5634.859128521779, 5644.858878528029, 3998.4801975743258, 4013.4381186633896, 4054.878353649395, 4106.753594784323, 4112.958870411318, 5822.534197264251, 5854.356020837705, 5856.472917437451, 5864.472197502245, 5868.0, 4180.853670121592, 4190.476190476191, 4193.622573968297, 4198.244316023145, 4205.600467955539, 4132.5454200037975, 4221.775685051301, 4234.0, 4235.559909630741, 4240.363945408213, 4751.216049351888, 4800.007996681408, 4802.0, 4808.3989501312335, 4812.25410061441, 5649.661020338793, 5666.433356664301, 5669.0, 5670.291213598301, 5681.545476361881, 1355.8372995240634, 1406.8522805105522, 1413.9787903181461, 1420.6377373769621, 1430.306301443799, 964.6623681711345, 979.5934687104914, 981.1562056631292, 990.4997976022207, 991.6182269826024, 5230.895382092413, 5258.0, 5296.735163241822, 5308.893822123536, 5315.920261196085, 5513.669179849222, 5521.868017056494, 5537.833864984057, 5614.466625670637, 5639.3232812062, 5207.921881171786, 5239.711815850089, 5340.332458442695, 5343.5457986071615, 5524.861878453071, 2963.822170669767, 2967.7477414419586, 2967.985160074186, 2980.985095074511, 2986.65547545176, 5648.943510564842, 5663.9716801415725, 5682.6361673198135, 5683.573731970118, 5709.714514274269, 5577.458313970657, 5660.745266463019, 5706.771729130871, 5715.28541437567, 5737.713114344266, 5604.775808967677, 5644.943550564524, 5656.575756818255, 5662.2639056922335, 5683.232763576947, 5364.973175134255, 5557.861053473695, 5558.388577256418, 5566.610337276352, 5615.578831587565, 5544.279243698294, 5554.888902222014, 5567.638103523258, 5569.443055694398, 5571.192177134212, 5665.943340566541, 5670.546356291569, 5682.232898558807, 5690.687012214203, 5700.68646224445, 3970.5433875103577, 3987.92024159521, 4000.7199496035, 4169.708120431541, 4220.599043090901, 5570.832875013756, 5641.871625674964, 5716.342620598518, 5761.567882408753, 5802.707930367397, 5642.078755265052, 5661.943380566142, 5682.147677848356, 5695.4688093382365, 5700.0, 5534.529564987021, 5561.693002144574, 5625.943740562542, 5646.548276137817, 5690.174924635988, 5626.718664066862, 5628.60599758013, 5633.8309850704545, 5641.37944826077, 5642.0, 5667.8866422672145, 5672.5461963042035, 5698.344690360662, 5700.743466544099, 5703.372629010889, 5448.536874365724, 5522.447755224445, 5550.55595552363, 5564.33228012641, 5572.108462645957], "value": 4278.930672733831, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.6743601405417, 787.8463699578581, 831.634081004358, 845.8392905347986, 867.0116067682839, 13216.669583260424, 13897.305134743261, 14484.782728259084, 14699.41202351906, 14710.19093949835, 13186.208827470358, 13350.933245333785, 13467.797983030263, 13472.66318342042, 13701.0, 730.7880714592761, 845.6659619450329, 867.4188293843109, 871.6818361298144, 871.9825603487926, 754.2156157596094, 836.1304243586662, 852.6802449081595, 854.1842540373927, 859.7034023261996, 899.9145081217274, 900.4417261297972, 903.0698380667923, 903.3856977255464, 904.3217586809892, 880.6609455359669, 886.1935638568904, 886.756142060932, 890.0165317324328, 893.6604090445621, 654.653033892038, 656.6749459017817, 657.4904449051975, 659.2056571830932, 660.9438197753196, 13250.536231231861, 13271.933640331834, 13283.136596121221, 13285.601431957057, 13305.201687898758, 13628.659283517893, 14393.928030359886, 14432.494862679861, 14445.277736113152, 14581.781273280909, 12119.454624541917, 12247.69380765488, 12320.137590368679, 12406.0, 12571.434285457177, 3802.258559580883, 3821.2739579479808, 3881.777240169338, 3884.8834534964, 3895.435161901537, 67692.661536692, 67850.0, 68238.0, 69241.3075869245, 69349.30650693529, 11212.159088068265, 11222.607208747655, 11268.154888383404, 11317.264377815416, 11349.375784331776, 20566.69149962752, 20669.689954650694, 20707.27524536634, 20713.68929466059, 20725.067371968296, 7644.961775191088, 7759.340456061298, 7767.1067827200595, 7824.491408058458, 8064.798380040546, 4341.60925516705, 4348.978255108705, 4546.590806827401, 4554.4990051094355, 4654.836290927268, 3349.815760133216, 3444.0873168610337, 3467.6532346765625, 3478.913027174341, 3508.8596456141977, 562.3532937122342, 577.0622738050668, 597.5279529171905, 604.9516038716893, 613.7882430561449, 672.7342699633617, 678.521642242218, 681.7000519771285, 712.1169749510673, 753.2580408297822, 9055.275577953747, 9181.219596334386, 9270.165685088374, 9508.191803696625, 9564.70934848716, 633.3508154142041, 639.5746828359089, 663.6847497438774, 688.0539258519535, 713.3223437734069, 3803.82882770276, 3901.4147877818555, 4094.28350038742, 4096.365063415175, 4154.750714957112, 52962.73518632382, 53418.465815342126, 78172.0, 85688.0, 89303.0, 74747.0, 76432.0, 77117.0, 80392.59803701061, 81954.0, 67932.660336698, 69418.3058169422, 69599.30400695928, 71622.28377716156, 73617.26382736104, 8270.297024752963, 8289.461185022954, 8424.62089205975, 8582.227599516074, 8673.869891951499, 47127.52288532584, 47391.630418479624, 47924.28113578369, 48530.0, 49992.50007499878, 64478.677606611665, 64987.35012649813, 65048.0, 65103.67448162729, 67310.0, 10466.529006194893, 10471.3193642413, 10599.523021463898, 10628.309159904891, 10884.183686223723, 12701.87298127007, 13112.0, 13217.669558261121, 13339.799903001269, 13800.171989680652, 13356.933215333862, 13623.455061797416, 13783.035187536776, 13834.308284585932, 14280.857191427953, 13195.340232988121, 13286.601401957956, 13431.395587198795, 14005.929970350084, 14459.927700361432, 12887.0, 13266.403011864297, 13526.93236533811, 14010.229437381042, 14783.630409239855, 11120.332780033224, 11234.719132021764, 11551.364674942959, 11707.648770536898, 12177.573784917486, 10795.730106747395, 11012.834807478055, 11778.352190629597, 12263.099219620974, 12355.196912200678], "value": 7138.68647971152, "unit": "score"}], "name": "dromaeo_css", "value": 7239.80359195417, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 112.0, 112.0, 113.0, 113.0, 112.0, 116.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 124.0, 156.0, 118.0, 123.0, 117.0, 118.0, 149.0, 120.0], "value": 129.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 161.0, 160.0, 162.0, 160.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 76.0, 75.0, 76.0, 75.0, 98.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 112.0, 82.0, 82.0, 82.0, 102.0, 82.0, 82.0, 112.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 52.0, 51.0, 62.0, 51.0, 53.0, 51.0, 51.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 60.0, 60.0, 62.0, 61.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 76.0, 75.0, 75.0, 75.0, 75.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 129.0, 132.0, 123.0, 129.0, 119.0, 118.0, 159.0, 138.0], "value": 129.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 151.0, 152.0, 152.0, 154.0, 161.0, 159.0, 154.0, 162.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 64.0, 63.0, 63.0, 61.0, 62.0, 61.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1454.3999999999999, "alertThreshold": 2.0}]} 13:29:56 INFO - Return code: 0 13:29:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:29:56 INFO - # TBPL SUCCESS # 13:29:56 INFO - Running post-action listener: _resource_record_post_action 13:29:56 INFO - [mozharness: 2017-01-25 21:29:56.973691Z] Finished run-tests step (success) 13:29:56 INFO - Running post-run listener: _resource_record_post_run 13:29:57 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 320192512; Read time: 0; Write time: 293820 13:29:57 INFO - TinderboxPrint: CPU usage
13.0% 13:29:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:29:57 INFO - TinderboxPrint: I/O write bytes / time
320,192,512 / 293,820 13:29:57 INFO - TinderboxPrint: CPU idle
8,259.5 (87.0%) 13:29:57 INFO - TinderboxPrint: CPU user
1,187.6 (12.5%) 13:29:57 INFO - TinderboxPrint: Swap in / out
0 / 0 13:29:57 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101015552; Read time: 0; Write time: 107636 13:29:57 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 219176960; Read time: 0; Write time: 186184 13:29:57 INFO - Running post-run listener: _upload_blobber_files 13:29:57 INFO - Blob upload gear active. 13:29:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:29:57 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 13:29:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:29:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:29:58 INFO - (blobuploader) - INFO - Open directory for files ... 13:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:01 INFO - (blobuploader) - INFO - Done attempting. 13:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:30:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:02 INFO - (blobuploader) - INFO - Done attempting. 13:30:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:30:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:30:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:30:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:30:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:30:03 INFO - (blobuploader) - INFO - Done attempting. 13:30:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:30:03 INFO - Return code: 0 13:30:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:30:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:30:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00f1c4553952f4678bb9110ce61e123498d7af1608970ce39349d3edcce59e94e82e249d53b0e01906ecf46c7c98a85c966c69f983fc67b880a49a9370518d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/524d70e9f74207461cd12ecf5a31918b9447eece57916d9d6141da8700c09c9d670610d32575fd10d2332446c35628e15988298cc937c1029bd145a6cc7e0ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/373f9419f2d183f7a470b3a944a0ac9ee98b5087b838c6eeb9f3b2a587ece29422e05d113eb524a0cff10f1166bc07edd7b536048cd31ea9e5741c0a52c41444"} 13:30:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:30:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:30:03 INFO - Contents: 13:30:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00f1c4553952f4678bb9110ce61e123498d7af1608970ce39349d3edcce59e94e82e249d53b0e01906ecf46c7c98a85c966c69f983fc67b880a49a9370518d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/524d70e9f74207461cd12ecf5a31918b9447eece57916d9d6141da8700c09c9d670610d32575fd10d2332446c35628e15988298cc937c1029bd145a6cc7e0ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/373f9419f2d183f7a470b3a944a0ac9ee98b5087b838c6eeb9f3b2a587ece29422e05d113eb524a0cff10f1166bc07edd7b536048cd31ea9e5741c0a52c41444"} 13:30:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:30:03 INFO - Copying logs to upload dir... 13:30:03 INFO - mkdir: /builds/slave/test/build/upload/logs 13:30:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.252530 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-01-25 13:30:03.524716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 13:30:03.528073) ========= 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=745a4373a2a16df560f216e000000264-1485378566.66156-2082913319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00f1c4553952f4678bb9110ce61e123498d7af1608970ce39349d3edcce59e94e82e249d53b0e01906ecf46c7c98a85c966c69f983fc67b880a49a9370518d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/524d70e9f74207461cd12ecf5a31918b9447eece57916d9d6141da8700c09c9d670610d32575fd10d2332446c35628e15988298cc937c1029bd145a6cc7e0ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/373f9419f2d183f7a470b3a944a0ac9ee98b5087b838c6eeb9f3b2a587ece29422e05d113eb524a0cff10f1166bc07edd7b536048cd31ea9e5741c0a52c41444"} build_url:https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/LM56_4PvQvGyfsi_2xYv8A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a00f1c4553952f4678bb9110ce61e123498d7af1608970ce39349d3edcce59e94e82e249d53b0e01906ecf46c7c98a85c966c69f983fc67b880a49a9370518d1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/524d70e9f74207461cd12ecf5a31918b9447eece57916d9d6141da8700c09c9d670610d32575fd10d2332446c35628e15988298cc937c1029bd145a6cc7e0ed5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/373f9419f2d183f7a470b3a944a0ac9ee98b5087b838c6eeb9f3b2a587ece29422e05d113eb524a0cff10f1166bc07edd7b536048cd31ea9e5741c0a52c41444"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 13:30:03.554676) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:30:03.555135) ========= 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=745a4373a2a16df560f216e000000264-1485378566.66156-2082913319 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 13:30:03.640436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 13:30:03.640756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 13:30:03.641047) ========= ========= Total master_lag: 0.19 =========