builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1487336521.46 results: success (0) buildid: 20170217031519 builduid: 01cda19a86454dfeafb506c52935c66f revision: 41c9d8ee2649f82bddff7038fd0dfd04f05a6664 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.459475) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.459913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.460191) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.476517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.476880) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-17 05:02:01-- 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% 95.4M=0s 2017-02-17 05:02:01 (95.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.640658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.640973) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019237 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.694201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:01.694568) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 41c9d8ee2649f82bddff7038fd0dfd04f05a6664 --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 41c9d8ee2649f82bddff7038fd0dfd04f05a6664 --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=edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-17 05:02:01,800 truncating revision to first 12 chars 2017-02-17 05:02:01,801 Setting DEBUG logging. 2017-02-17 05:02:01,801 attempt 1/10 2017-02-17 05:02:01,801 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/41c9d8ee2649?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 05:02:02,120 unpacking tar archive at: mozilla-beta-41c9d8ee2649/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615456 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:02.322841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:02.323167) ========= script_repo_revision: 41c9d8ee2649f82bddff7038fd0dfd04f05a6664 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:02.323564) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:02.323834) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 05:02:02.333755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-17 05:02:02.334033) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:02:02 INFO - MultiFileLogger online at 20170217 05:02:02 in /builds/slave/test 05:02:02 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 05:02:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:02:02 INFO - {'append_to_log': False, 05:02:02 INFO - 'base_work_dir': '/builds/slave/test', 05:02:02 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:02:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:02:02 INFO - 'branch': 'Mozilla-Beta', 05:02:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:02:02 INFO - 'config_files': ('talos/linux_config.py',), 05:02:02 INFO - 'default_actions': ('clobber', 05:02:02 INFO - 'read-buildbot-config', 05:02:02 INFO - 'download-and-extract', 05:02:02 INFO - 'populate-webroot', 05:02:02 INFO - 'create-virtualenv', 05:02:02 INFO - 'install', 05:02:02 INFO - 'run-tests'), 05:02:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:02:02 INFO - 'download_minidump_stackwalk': True, 05:02:02 INFO - 'download_symbols': 'ondemand', 05:02:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:02:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:02:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:02:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:02:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:02:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:02:02 INFO - 'installer_path': 'installer.exe', 05:02:02 INFO - 'log_level': 'info', 05:02:02 INFO - 'log_name': 'talos', 05:02:02 INFO - 'log_to_console': True, 05:02:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:02:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:02:02 INFO - 'opt_config_files': (), 05:02:02 INFO - 'pip_index': False, 05:02:02 INFO - 'sps_profile': False, 05:02:02 INFO - 'sps_profile_interval': 0, 05:02:02 INFO - 'suite': 'dromaeojs', 05:02:02 INFO - 'system_bits': '32', 05:02:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:02:02 INFO - 'title': 'talos-linux64-ix-033', 05:02:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:02:02 INFO - 'use_talos_json': True, 05:02:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:02:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:02:02 INFO - 'work_dir': 'build'} 05:02:02 INFO - [mozharness: 2017-02-17 13:02:02.545332Z] Running clobber step. 05:02:02 INFO - Running pre-action listener: _resource_record_pre_action 05:02:02 INFO - Running main action method: clobber 05:02:02 INFO - rmtree: /builds/slave/test/build 05:02:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:02:03 INFO - Running post-action listener: _resource_record_post_action 05:02:03 INFO - [mozharness: 2017-02-17 13:02:03.463776Z] Finished clobber step (success) 05:02:03 INFO - [mozharness: 2017-02-17 13:02:03.463876Z] Running read-buildbot-config step. 05:02:03 INFO - Running pre-action listener: _resource_record_pre_action 05:02:03 INFO - Running main action method: read_buildbot_config 05:02:03 INFO - Using buildbot properties: 05:02:03 INFO - { 05:02:03 INFO - "project": "", 05:02:03 INFO - "product": "firefox", 05:02:03 INFO - "script_repo_revision": "production", 05:02:03 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 05:02:03 INFO - "repository": "", 05:02:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 05:02:03 INFO - "buildid": "20170217031519", 05:02:03 INFO - "pgo_build": "True", 05:02:03 INFO - "basedir": "/builds/slave/test", 05:02:03 INFO - "buildnumber": 559, 05:02:03 INFO - "slavename": "talos-linux64-ix-033", 05:02:03 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:02:03 INFO - "platform": "ubuntu64_hw", 05:02:03 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:02:03 INFO - "branch": "mozilla-beta", 05:02:03 INFO - "repo_path": "releases/mozilla-beta", 05:02:03 INFO - "revision": "41c9d8ee2649f82bddff7038fd0dfd04f05a6664", 05:02:03 INFO - "stage_platform": "linux64-pgo", 05:02:03 INFO - "builduid": "01cda19a86454dfeafb506c52935c66f", 05:02:03 INFO - "slavebuilddir": "test" 05:02:03 INFO - } 05:02:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 05:02:03 INFO - Running post-action listener: _resource_record_post_action 05:02:03 INFO - [mozharness: 2017-02-17 13:02:03.466279Z] Finished read-buildbot-config step (success) 05:02:03 INFO - [mozharness: 2017-02-17 13:02:03.466367Z] Running download-and-extract step. 05:02:03 INFO - Running pre-action listener: _resource_record_pre_action 05:02:03 INFO - Running main action method: download_and_extract 05:02:03 INFO - mkdir: /builds/slave/test/build/tests 05:02: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')]} 05:02:03 INFO - trying https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:02:03 INFO - Downloading https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/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 05:02:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/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 05:02:04 INFO - Downloaded 1327 bytes. 05:02:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 05:02:04 INFO - Using the following test package requirements: 05:02:04 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:02:04 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:02:04 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 05:02:04 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'jsshell-linux-x86_64.zip'], 05:02:04 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:02:04 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 05:02:04 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 05:02:04 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 05:02:04 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:02:04 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 05:02:04 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:02:04 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:02:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:02:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:04 INFO - Fetch https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:02:04 INFO - Http code: 200 05:02:04 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 05:02:04 INFO - x-amz-cf-id: HxvWmtwrKpLP1dgMr28lX6FTsUBMN1KB9Yf1FTsfok4hVQnSsaZGrA== 05:02:04 INFO - x-amz-version-id: QIe.HyWRJKisb2xG7mKtMZ23Htep0c3S 05:02:04 INFO - Expected file size: 21958352 05:02:04 INFO - Obtained file size: 21958352 05:02:08 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 05:02:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 05:02:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:02:08 INFO - Fetch https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 05:02:09 INFO - Http code: 200 05:02:09 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 05:02:09 INFO - x-amz-cf-id: OVIkw3DvjAKvHs8cI06vciPM5UQ-4uy1A2aURd2h1o6S1SfE97xuSQ== 05:02:09 INFO - x-amz-version-id: QIe.HyWRJKisb2xG7mKtMZ23Htep0c3S 05:02:09 INFO - Expected file size: 21958352 05:02:09 INFO - Obtained file size: 21958352 05:02:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 05:02:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:02:14 INFO - Fetch https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 05:02:14 INFO - Http code: 200 05:02:14 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 05:02:14 INFO - x-amz-cf-id: 9yeUKqm8CdcdX7pxXRpxRrBSFg63GQz_Q4Aa5xZzryJX7dAMb43iYQ== 05:02:14 INFO - x-amz-version-id: 4eAYilr1iaZY7SbaIEIgwzoKcDQwB5BF 05:02:14 INFO - Expected file size: 14403005 05:02:14 INFO - Obtained file size: 14403005 05:02:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:15 INFO - trying https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:02:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/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 05:02:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/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 05:02:16 INFO - Downloaded 57773586 bytes. 05:02:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:02:16 INFO - mkdir: /builds/slave/test/properties 05:02:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:02:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:02:16 INFO - Contents: 05:02:16 INFO - build_url:https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 05:02:16 INFO - Running post-action listener: _resource_record_post_action 05:02:16 INFO - Running post-action listener: set_extra_try_arguments 05:02:16 INFO - [mozharness: 2017-02-17 13:02:16.960892Z] Finished download-and-extract step (success) 05:02:16 INFO - [mozharness: 2017-02-17 13:02:16.961117Z] Running populate-webroot step. 05:02:16 INFO - Running pre-action listener: _resource_record_pre_action 05:02:16 INFO - Running main action method: populate_webroot 05:02:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:02:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:02:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:02:16 INFO - '--tppagecycles', 05:02:16 INFO - '7'], 05:02:16 INFO - 'tests': ['tsvgm']}}, 05:02:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:02:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:02:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:02:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:02:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:02:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['damp', 'tps']}, 05:02:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'tests': ['damp', 'tps']}, 05:02:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['dromaeo_dom']}, 05:02:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:02:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['basic_compositor_video']}, 05:02:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:02:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['a11yr', 05:02:16 INFO - 'ts_paint', 05:02:16 INFO - 'tpaint', 05:02:16 INFO - 'sessionrestore', 05:02:16 INFO - 'sessionrestore_no_auto_restore', 05:02:16 INFO - 'tabpaint']}, 05:02:16 INFO - 'other-e10s': {'tests': ['a11yr', 05:02:16 INFO - 'ts_paint', 05:02:16 INFO - 'tpaint', 05:02:16 INFO - 'sessionrestore', 05:02:16 INFO - 'sessionrestore_no_auto_restore', 05:02:16 INFO - 'tabpaint']}, 05:02:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:02:16 INFO - 'ts_paint', 05:02:16 INFO - 'tpaint', 05:02:16 INFO - 'sessionrestore', 05:02:16 INFO - 'sessionrestore_no_auto_restore', 05:02:16 INFO - 'tabpaint']}, 05:02:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:02:16 INFO - 'ts_paint', 05:02:16 INFO - 'tpaint', 05:02:16 INFO - 'sessionrestore', 05:02:16 INFO - 'sessionrestore_no_auto_restore', 05:02:16 INFO - 'tabpaint']}, 05:02:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['a11yr', 05:02:16 INFO - 'ts_paint', 05:02:16 INFO - 'tpaint', 05:02:16 INFO - 'sessionrestore', 05:02:16 INFO - 'sessionrestore_no_auto_restore', 05:02:16 INFO - 'tabpaint']}, 05:02:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['a11yr', 05:02:16 INFO - 'ts_paint', 05:02:16 INFO - 'tpaint', 05:02:16 INFO - 'sessionrestore', 05:02:16 INFO - 'sessionrestore_no_auto_restore', 05:02:16 INFO - 'tabpaint']}, 05:02:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['tsvgx', 05:02:16 INFO - 'tsvgr_opacity', 05:02:16 INFO - 'tart', 05:02:16 INFO - 'tscrollx', 05:02:16 INFO - 'cart']}, 05:02:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:02:16 INFO - 'tsvgr_opacity', 05:02:16 INFO - 'tart', 05:02:16 INFO - 'tscrollx', 05:02:16 INFO - 'cart']}, 05:02:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'talos_options': ['--disable-e10s'], 05:02:16 INFO - 'tests': ['tp5o']}, 05:02:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'tests': ['tp5o']}, 05:02:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'talos_options': ['--disable-e10s', 05:02:16 INFO - '--xperf_path', 05:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:16 INFO - 'tests': ['tp5n']}, 05:02:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:02:16 INFO - 'talos_options': ['--xperf_path', 05:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:02:16 INFO - 'tests': ['tp5n']}}, 05:02:16 INFO - 'talos.zip': {'path': '', 05:02:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:02:16 INFO - Running post-action listener: _resource_record_post_action 05:02:16 INFO - [mozharness: 2017-02-17 13:02:16.979571Z] Finished populate-webroot step (success) 05:02:16 INFO - [mozharness: 2017-02-17 13:02:16.979658Z] Running create-virtualenv step. 05:02:16 INFO - Running pre-action listener: _resource_record_pre_action 05:02:16 INFO - Running main action method: create_virtualenv 05:02:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:02:16 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 05:02:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:02:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:02:17 INFO - Using real prefix '/usr' 05:02:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:02:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:02:19 INFO - Installing pip.................done. 05:02:19 INFO - Return code: 0 05:02:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:02:19 INFO - Reading from file tmpfile_stdout 05:02:19 INFO - Output received: 05:02:19 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) 05:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:02:19 INFO - Using env: {'DISPLAY': ':0', 05:02:19 INFO - 'HOME': '/home/cltbld', 05:02:19 INFO - 'LANG': 'en_US.UTF-8', 05:02:19 INFO - 'LANGUAGE': 'en_US:en', 05:02:19 INFO - 'LOGNAME': 'cltbld', 05:02:19 INFO - 'MAIL': '/var/mail/cltbld', 05:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:19 INFO - 'MOZ_NO_REMOTE': '1', 05:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:19 INFO - 'NO_EM_RESTART': '1', 05:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:19 INFO - 'PWD': '/builds/slave/test', 05:02:19 INFO - 'SHELL': '/bin/bash', 05:02:19 INFO - 'SHLVL': '1', 05:02:19 INFO - 'TERM': 'linux', 05:02:19 INFO - 'TMOUT': '86400', 05:02:19 INFO - 'USER': 'cltbld', 05:02:19 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:19 INFO - '_': '/tools/buildbot/bin/python'} 05:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:19 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 05:02:19 INFO - Cleaning up... 05:02:19 INFO - Return code: 0 05:02:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:20 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:20 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 05:02:20 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 05:02:20 INFO - Using env: {'DISPLAY': ':0', 05:02:20 INFO - 'HOME': '/home/cltbld', 05:02:20 INFO - 'LANG': 'en_US.UTF-8', 05:02:20 INFO - 'LANGUAGE': 'en_US:en', 05:02:20 INFO - 'LOGNAME': 'cltbld', 05:02:20 INFO - 'MAIL': '/var/mail/cltbld', 05:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:20 INFO - 'MOZ_NO_REMOTE': '1', 05:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:20 INFO - 'NO_EM_RESTART': '1', 05:02:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:20 INFO - 'PWD': '/builds/slave/test', 05:02:20 INFO - 'SHELL': '/bin/bash', 05:02:20 INFO - 'SHLVL': '1', 05:02:20 INFO - 'TERM': 'linux', 05:02:20 INFO - 'TMOUT': '86400', 05:02:20 INFO - 'USER': 'cltbld', 05:02:20 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:20 INFO - '_': '/tools/buildbot/bin/python'} 05:02:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:20 INFO - Downloading/unpacking psutil>=3.1.1 05:02:20 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 05:02:20 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 05:02:20 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 05:02:20 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 05:02:20 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 05:02:20 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 05:02:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:22 INFO - Installing collected packages: psutil 05:02:22 INFO - Running setup.py install for psutil 05:02:22 INFO - building 'psutil._psutil_linux' extension 05:02:22 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 05:02:22 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 05:02:22 INFO - building 'psutil._psutil_posix' extension 05:02:22 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 05:02:22 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 05:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:02:22 INFO - Successfully installed psutil 05:02:22 INFO - Cleaning up... 05:02:22 INFO - Return code: 0 05:02:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:02:22 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')]} 05:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:22 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')]} 05:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:22 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:22 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 05:02:22 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 05:02:22 INFO - Using env: {'DISPLAY': ':0', 05:02:22 INFO - 'HOME': '/home/cltbld', 05:02:22 INFO - 'LANG': 'en_US.UTF-8', 05:02:22 INFO - 'LANGUAGE': 'en_US:en', 05:02:22 INFO - 'LOGNAME': 'cltbld', 05:02:22 INFO - 'MAIL': '/var/mail/cltbld', 05:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:22 INFO - 'MOZ_NO_REMOTE': '1', 05:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:22 INFO - 'NO_EM_RESTART': '1', 05:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:22 INFO - 'PWD': '/builds/slave/test', 05:02:22 INFO - 'SHELL': '/bin/bash', 05:02:22 INFO - 'SHLVL': '1', 05:02:22 INFO - 'TERM': 'linux', 05:02:22 INFO - 'TMOUT': '86400', 05:02:22 INFO - 'USER': 'cltbld', 05:02:22 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:22 INFO - '_': '/tools/buildbot/bin/python'} 05:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:02:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:02:25 INFO - Installing collected packages: mozsystemmonitor 05:02:25 INFO - Running setup.py install for mozsystemmonitor 05:02:25 INFO - Successfully installed mozsystemmonitor 05:02:25 INFO - Cleaning up... 05:02:25 INFO - Return code: 0 05:02:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:02:25 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')]} 05:02:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:25 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')]} 05:02:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:25 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:25 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 05:02:25 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 05:02:25 INFO - Using env: {'DISPLAY': ':0', 05:02:25 INFO - 'HOME': '/home/cltbld', 05:02:25 INFO - 'LANG': 'en_US.UTF-8', 05:02:25 INFO - 'LANGUAGE': 'en_US:en', 05:02:25 INFO - 'LOGNAME': 'cltbld', 05:02:25 INFO - 'MAIL': '/var/mail/cltbld', 05:02:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:25 INFO - 'MOZ_NO_REMOTE': '1', 05:02:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:25 INFO - 'NO_EM_RESTART': '1', 05:02:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:25 INFO - 'PWD': '/builds/slave/test', 05:02:25 INFO - 'SHELL': '/bin/bash', 05:02:25 INFO - 'SHLVL': '1', 05:02:25 INFO - 'TERM': 'linux', 05:02:25 INFO - 'TMOUT': '86400', 05:02:25 INFO - 'USER': 'cltbld', 05:02:25 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:25 INFO - '_': '/tools/buildbot/bin/python'} 05:02:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:25 INFO - Downloading/unpacking jsonschema==2.5.1 05:02:25 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 05:02:25 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 05:02:25 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 05:02:25 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 05:02:25 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 05:02:25 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 05:02:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:02:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:02:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:02:27 INFO - warning: no files found matching '*.txt' 05:02:27 INFO - no previously-included directories found matching 'build' 05:02:27 INFO - no previously-included directories found matching 'dist' 05:02:27 INFO - no previously-included directories found matching '.git*' 05:02:27 INFO - Installing collected packages: jsonschema, functools32 05:02:27 INFO - Running setup.py install for functools32 05:02:27 INFO - warning: no files found matching '*.txt' 05:02:27 INFO - no previously-included directories found matching 'build' 05:02:27 INFO - no previously-included directories found matching 'dist' 05:02:27 INFO - no previously-included directories found matching '.git*' 05:02:27 INFO - Successfully installed jsonschema functools32 05:02:27 INFO - Cleaning up... 05:02:28 INFO - Return code: 0 05:02:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:28 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:28 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 05:02:28 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 05:02:28 INFO - Using env: {'DISPLAY': ':0', 05:02:28 INFO - 'HOME': '/home/cltbld', 05:02:28 INFO - 'LANG': 'en_US.UTF-8', 05:02:28 INFO - 'LANGUAGE': 'en_US:en', 05:02:28 INFO - 'LOGNAME': 'cltbld', 05:02:28 INFO - 'MAIL': '/var/mail/cltbld', 05:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:28 INFO - 'MOZ_NO_REMOTE': '1', 05:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:28 INFO - 'NO_EM_RESTART': '1', 05:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:28 INFO - 'PWD': '/builds/slave/test', 05:02:28 INFO - 'SHELL': '/bin/bash', 05:02:28 INFO - 'SHLVL': '1', 05:02:28 INFO - 'TERM': 'linux', 05:02:28 INFO - 'TMOUT': '86400', 05:02:28 INFO - 'USER': 'cltbld', 05:02:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:28 INFO - '_': '/tools/buildbot/bin/python'} 05:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:02:28 INFO - Cleaning up... 05:02:28 INFO - Return code: 0 05:02:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:02: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')]} 05:02:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02: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')]} 05:02:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:28 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:28 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 05:02:28 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 05:02:28 INFO - Using env: {'DISPLAY': ':0', 05:02:28 INFO - 'HOME': '/home/cltbld', 05:02:28 INFO - 'LANG': 'en_US.UTF-8', 05:02:28 INFO - 'LANGUAGE': 'en_US:en', 05:02:28 INFO - 'LOGNAME': 'cltbld', 05:02:28 INFO - 'MAIL': '/var/mail/cltbld', 05:02:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:28 INFO - 'MOZ_NO_REMOTE': '1', 05:02:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:28 INFO - 'NO_EM_RESTART': '1', 05:02:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:28 INFO - 'PWD': '/builds/slave/test', 05:02:28 INFO - 'SHELL': '/bin/bash', 05:02:28 INFO - 'SHLVL': '1', 05:02:28 INFO - 'TERM': 'linux', 05:02:28 INFO - 'TMOUT': '86400', 05:02:28 INFO - 'USER': 'cltbld', 05:02:28 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:28 INFO - '_': '/tools/buildbot/bin/python'} 05:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:02:28 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 05:02:28 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 05:02:28 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 05:02:28 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 05:02:28 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 05:02:28 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 05:02:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:02:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:02:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:02:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:02:31 INFO - Downloading docopt-0.6.1.tar.gz 05:02:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:02:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:02:31 INFO - Running setup.py install for blobuploader 05:02:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:02:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:02:31 INFO - Running setup.py install for requests 05:02:31 INFO - Running setup.py install for docopt 05:02:31 INFO - Successfully installed blobuploader requests docopt 05:02:31 INFO - Cleaning up... 05:02:31 INFO - Return code: 0 05:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:31 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:31 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 05:02:31 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 05:02:31 INFO - Using env: {'DISPLAY': ':0', 05:02:31 INFO - 'HOME': '/home/cltbld', 05:02:31 INFO - 'LANG': 'en_US.UTF-8', 05:02:31 INFO - 'LANGUAGE': 'en_US:en', 05:02:31 INFO - 'LOGNAME': 'cltbld', 05:02:31 INFO - 'MAIL': '/var/mail/cltbld', 05:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:31 INFO - 'MOZ_NO_REMOTE': '1', 05:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:31 INFO - 'NO_EM_RESTART': '1', 05:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:31 INFO - 'PWD': '/builds/slave/test', 05:02:31 INFO - 'SHELL': '/bin/bash', 05:02:31 INFO - 'SHLVL': '1', 05:02:31 INFO - 'TERM': 'linux', 05:02:31 INFO - 'TMOUT': '86400', 05:02:31 INFO - 'USER': 'cltbld', 05:02:31 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:31 INFO - '_': '/tools/buildbot/bin/python'} 05:02:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:32 INFO - Running setup.py (path:/tmp/pip-fIOf1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:32 INFO - Running setup.py (path:/tmp/pip-53wdbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:32 INFO - Running setup.py (path:/tmp/pip-lX2iC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:32 INFO - Running setup.py (path:/tmp/pip-xRF2iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:32 INFO - Running setup.py (path:/tmp/pip-xbySgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:32 INFO - Running setup.py (path:/tmp/pip-_UvWNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:32 INFO - Running setup.py (path:/tmp/pip-0MEo7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:32 INFO - Running setup.py (path:/tmp/pip-vWpVJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:32 INFO - Running setup.py (path:/tmp/pip-KMDvf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:32 INFO - Running setup.py (path:/tmp/pip-vzVUP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:32 INFO - Running setup.py (path:/tmp/pip-5ue2Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:32 INFO - Running setup.py (path:/tmp/pip-h_B31Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:32 INFO - Running setup.py (path:/tmp/pip-8TgU6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:33 INFO - Running setup.py (path:/tmp/pip-2h6U5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:33 INFO - Running setup.py (path:/tmp/pip-FsdqyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:33 INFO - Running setup.py (path:/tmp/pip-dQKry8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:33 INFO - Running setup.py (path:/tmp/pip-VCsqp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:02:33 INFO - Running setup.py install for manifestparser 05:02:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:02:33 INFO - Running setup.py install for mozcrash 05:02:33 INFO - Running setup.py install for mozdebug 05:02:33 INFO - Running setup.py install for mozdevice 05:02:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:02:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:02:33 INFO - Running setup.py install for mozfile 05:02:33 INFO - Running setup.py install for mozhttpd 05:02:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:02:33 INFO - Running setup.py install for mozinfo 05:02:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Running setup.py install for mozInstall 05:02:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Running setup.py install for mozleak 05:02:34 INFO - Running setup.py install for mozlog 05:02:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Running setup.py install for moznetwork 05:02:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Running setup.py install for mozprocess 05:02:34 INFO - Running setup.py install for mozprofile 05:02:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Running setup.py install for mozrunner 05:02:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:02:34 INFO - Running setup.py install for mozscreenshot 05:02:34 INFO - Running setup.py install for moztest 05:02:35 INFO - Running setup.py install for mozversion 05:02:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:02:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:02:35 INFO - Cleaning up... 05:02:35 INFO - Return code: 0 05:02:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:35 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:35 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 05:02:35 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 05:02:35 INFO - Using env: {'DISPLAY': ':0', 05:02:35 INFO - 'HOME': '/home/cltbld', 05:02:35 INFO - 'LANG': 'en_US.UTF-8', 05:02:35 INFO - 'LANGUAGE': 'en_US:en', 05:02:35 INFO - 'LOGNAME': 'cltbld', 05:02:35 INFO - 'MAIL': '/var/mail/cltbld', 05:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:35 INFO - 'MOZ_NO_REMOTE': '1', 05:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:35 INFO - 'NO_EM_RESTART': '1', 05:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:35 INFO - 'PWD': '/builds/slave/test', 05:02:35 INFO - 'SHELL': '/bin/bash', 05:02:35 INFO - 'SHLVL': '1', 05:02:35 INFO - 'TERM': 'linux', 05:02:35 INFO - 'TMOUT': '86400', 05:02:35 INFO - 'USER': 'cltbld', 05:02:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:35 INFO - '_': '/tools/buildbot/bin/python'} 05:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:02:35 INFO - Running setup.py (path:/tmp/pip-yWw2b1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:02:35 INFO - Running setup.py (path:/tmp/pip-fxmiAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:02:35 INFO - Running setup.py (path:/tmp/pip-mFFdcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:02:35 INFO - Running setup.py (path:/tmp/pip-MVjFVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:02:35 INFO - Running setup.py (path:/tmp/pip-Jwledo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:02:35 INFO - Running setup.py (path:/tmp/pip-ax4P29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:02:35 INFO - Running setup.py (path:/tmp/pip-UVPHAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:02:35 INFO - Running setup.py (path:/tmp/pip-eq0vry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:02:35 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)) 05:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:02:35 INFO - Running setup.py (path:/tmp/pip-19TbDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:02:36 INFO - Running setup.py (path:/tmp/pip-rVkmGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:02:36 INFO - Running setup.py (path:/tmp/pip-iNVPWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:02:36 INFO - Running setup.py (path:/tmp/pip-6kEsgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:02:36 INFO - Running setup.py (path:/tmp/pip-LTQB5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:02:36 INFO - Running setup.py (path:/tmp/pip-NFwmaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:36 INFO - Running setup.py (path:/tmp/pip-f06MBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:02:36 INFO - Running setup.py (path:/tmp/pip-EWzWSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:02:36 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)) 05:02:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:02:36 INFO - Running setup.py (path:/tmp/pip-DM3w88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 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)) 05:02:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:02:36 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 05:02:36 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 05:02:36 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 05:02:36 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 05:02:36 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 05:02:36 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 05:02:38 INFO - Downloading blessings-1.6.tar.gz 05:02:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:02:38 INFO - Installing collected packages: blessings 05:02:38 INFO - Running setup.py install for blessings 05:02:38 INFO - Successfully installed blessings 05:02:38 INFO - Cleaning up... 05:02:38 INFO - Return code: 0 05:02:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:39 INFO - Reading from file tmpfile_stdout 05:02:39 INFO - Current package versions: 05:02:39 INFO - argparse == 1.2.1 05:02:39 INFO - blessings == 1.6 05:02:39 INFO - blobuploader == 1.2.4 05:02:39 INFO - docopt == 0.6.1 05:02:39 INFO - functools32 == 3.2.3-2 05:02:39 INFO - jsonschema == 2.5.1 05:02:39 INFO - manifestparser == 1.1 05:02:39 INFO - mozInstall == 1.12 05:02:39 INFO - mozcrash == 1.0 05:02:39 INFO - mozdebug == 0.1 05:02:39 INFO - mozdevice == 0.48 05:02:39 INFO - mozfile == 1.2 05:02:39 INFO - mozhttpd == 0.7 05:02:39 INFO - mozinfo == 0.9 05:02:39 INFO - mozleak == 0.1 05:02:39 INFO - mozlog == 3.4 05:02:39 INFO - moznetwork == 0.27 05:02:39 INFO - mozprocess == 0.23 05:02:39 INFO - mozprofile == 0.28 05:02:39 INFO - mozrunner == 6.13 05:02:39 INFO - mozscreenshot == 0.1 05:02:39 INFO - mozsystemmonitor == 0.3 05:02:39 INFO - moztest == 0.8 05:02:39 INFO - mozversion == 1.4 05:02:39 INFO - psutil == 3.1.1 05:02:39 INFO - requests == 1.2.3 05:02:39 INFO - wsgiref == 0.1.2 05:02:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:39 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 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:39 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 05:02:39 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 05:02:39 INFO - Using env: {'DISPLAY': ':0', 05:02:39 INFO - 'HOME': '/home/cltbld', 05:02:39 INFO - 'LANG': 'en_US.UTF-8', 05:02:39 INFO - 'LANGUAGE': 'en_US:en', 05:02:39 INFO - 'LOGNAME': 'cltbld', 05:02:39 INFO - 'MAIL': '/var/mail/cltbld', 05:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:39 INFO - 'MOZ_NO_REMOTE': '1', 05:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:39 INFO - 'NO_EM_RESTART': '1', 05:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:39 INFO - 'PWD': '/builds/slave/test', 05:02:39 INFO - 'SHELL': '/bin/bash', 05:02:39 INFO - 'SHLVL': '1', 05:02:39 INFO - 'TERM': 'linux', 05:02:39 INFO - 'TMOUT': '86400', 05:02:39 INFO - 'USER': 'cltbld', 05:02:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:39 INFO - '_': '/tools/buildbot/bin/python'} 05:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 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)) 05:02:39 INFO - Cleaning up... 05:02:39 INFO - Return code: 0 05:02:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:02:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:02:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:02:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:02:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f32dc51cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15deca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', '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 05:02:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:02:39 INFO - Using env: {'DISPLAY': ':0', 05:02:39 INFO - 'HOME': '/home/cltbld', 05:02:39 INFO - 'LANG': 'en_US.UTF-8', 05:02:39 INFO - 'LANGUAGE': 'en_US:en', 05:02:39 INFO - 'LOGNAME': 'cltbld', 05:02:39 INFO - 'MAIL': '/var/mail/cltbld', 05:02:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:39 INFO - 'MOZ_NO_REMOTE': '1', 05:02:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:39 INFO - 'NO_EM_RESTART': '1', 05:02:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:39 INFO - 'PWD': '/builds/slave/test', 05:02:39 INFO - 'SHELL': '/bin/bash', 05:02:39 INFO - 'SHLVL': '1', 05:02:39 INFO - 'TERM': 'linux', 05:02:39 INFO - 'TMOUT': '86400', 05:02:39 INFO - 'USER': 'cltbld', 05:02:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:39 INFO - '_': '/tools/buildbot/bin/python'} 05:02:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:02:39 INFO - Cleaning up... 05:02:39 INFO - Return code: 0 05:02:39 INFO - Running post-action listener: _resource_record_post_action 05:02:39 INFO - Running post-action listener: _start_resource_monitoring 05:02:39 INFO - Starting resource monitoring. 05:02:39 INFO - [mozharness: 2017-02-17 13:02:39.568904Z] Finished create-virtualenv step (success) 05:02:39 INFO - [mozharness: 2017-02-17 13:02:39.569358Z] Running install step. 05:02:39 INFO - Running pre-action listener: _resource_record_pre_action 05:02:39 INFO - Running main action method: install 05:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:02:39 INFO - Reading from file tmpfile_stdout 05:02:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:02:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:02:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:02:39 INFO - Reading from file tmpfile_stdout 05:02:39 INFO - Output received: 05:02:39 INFO - Usage: mozinstall [options] installer 05:02:39 INFO - Options: 05:02:39 INFO - -h, --help show this help message and exit 05:02:39 INFO - -d DEST, --destination=DEST 05:02:39 INFO - Directory to install application into. [default: 05:02:39 INFO - "/builds/slave/test"] 05:02:39 INFO - --app=APP Application being installed. [default: firefox] 05:02:39 INFO - mkdir: /builds/slave/test/build/application 05:02:39 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'] 05:02:39 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 05:02:54 INFO - Reading from file tmpfile_stdout 05:02:54 INFO - Output received: 05:02:54 INFO - /builds/slave/test/build/application/firefox/firefox 05:02:54 INFO - Running post-action listener: _resource_record_post_action 05:02:54 INFO - [mozharness: 2017-02-17 13:02:54.446225Z] Finished install step (success) 05:02:54 INFO - [mozharness: 2017-02-17 13:02:54.446467Z] Running run-tests step. 05:02:54 INFO - Running pre-action listener: _resource_record_pre_action 05:02:54 INFO - Running main action method: run_tests 05:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:02:54 INFO - Python 2.7.3 05:02:54 INFO - Return code: 0 05:02:54 INFO - grabbing minidump binary from tooltool 05:02:54 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')]} 05:02:54 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 0x15dbf60>, '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 0x15dcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15dd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:02:54 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 05:02:54 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 05:02:54 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 05:02:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:02:54 INFO - Return code: 0 05:02:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:02:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:02:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:02:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:02:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:02:54 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/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 05:02:54 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/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 05:02:54 INFO - Using env: {'DISPLAY': ':0', 05:02:54 INFO - 'HOME': '/home/cltbld', 05:02:54 INFO - 'LANG': 'en_US.UTF-8', 05:02:54 INFO - 'LANGUAGE': 'en_US:en', 05:02:54 INFO - 'LOGNAME': 'cltbld', 05:02:54 INFO - 'MAIL': '/var/mail/cltbld', 05:02:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:02:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:02:54 INFO - 'MOZ_NO_REMOTE': '1', 05:02:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:02:54 INFO - 'NO_EM_RESTART': '1', 05:02:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:02:54 INFO - 'PWD': '/builds/slave/test', 05:02:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:02:54 INFO - 'SHELL': '/bin/bash', 05:02:54 INFO - 'SHLVL': '1', 05:02:54 INFO - 'TERM': 'linux', 05:02:54 INFO - 'TMOUT': '86400', 05:02:54 INFO - 'USER': 'cltbld', 05:02:54 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093', 05:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:02:54 INFO - '_': '/tools/buildbot/bin/python'} 05:02:54 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/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 05:02:54 INFO - mozversion application_buildid: 20170217031519 05:02:54 INFO - mozversion application_changeset: 41c9d8ee2649f82bddff7038fd0dfd04f05a6664 05:02:54 INFO - mozversion application_display_name: Firefox 05:02:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:02:54 INFO - mozversion application_name: Firefox 05:02:54 INFO - mozversion application_remotingname: firefox 05:02:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:02:54 INFO - mozversion application_vendor: Mozilla 05:02:54 INFO - mozversion application_version: 52.0 05:02:54 INFO - mozversion platform_buildid: 20170217031519 05:02:54 INFO - mozversion platform_changeset: 41c9d8ee2649f82bddff7038fd0dfd04f05a6664 05:02:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:02:54 INFO - mozversion platform_version: 52.0 05:02:54 INFO - using testdate: 1487336574 05:02:54 INFO - actual date: 1487336574 05:02:54 INFO - starting webserver on 'localhost:43826' 05:02:54 INFO - SUITE-START | Running 2 tests 05:02:54 INFO - TEST-START | dromaeo_css 05:02:54 INFO - operating with platform_type : linux_ 05:02:54 INFO - Initialising browser for dromaeo_css test... 05:02:54 INFO - TEST-INFO | started process 16629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW5f9oo/profile http://localhost:43826/getInfo.html) 05:02:59 INFO - PROCESS | 16629 | __metrics Screen width/height:1600/1200 05:02:59 INFO - PROCESS | 16629 | colorDepth:24 05:02:59 INFO - PROCESS | 16629 | Browser inner width/height: 1024/697 05:02:59 INFO - PROCESS | 16629 | __metrics 05:03:00 INFO - PROCESS | 16629 | 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" 05:03:00 INFO - PROCESS | 16629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:03:01 INFO - TEST-INFO | 16629: exit 0 05:03:01 INFO - Browser initialized. 05:03:01 INFO - Running cycle 1/1 for dromaeo_css test... 05:03:01 INFO - TEST-INFO | started process 16724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW5f9oo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:03:12 INFO - PROCESS | 16724 | RSS: Main: 141828096 05:03:12 INFO - PROCESS | 16724 | 05:06:14 INFO - PROCESS | 16724 | Cycle 1(1): loaded http://localhost:43826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43826/tests/dromaeo/cssquery-ext.html) 05:06:15 INFO - PROCESS | 16724 | RSS: Main: 234901504 05:06:15 INFO - PROCESS | 16724 | 05:09:18 INFO - PROCESS | 16724 | Cycle 1(1): loaded http://localhost:43826/tests/dromaeo/cssquery-ext.html (next: http://localhost:43826/tests/dromaeo/cssquery-jquery.html) 05:09:18 INFO - PROCESS | 16724 | RSS: Main: 229273600 05:09:18 INFO - PROCESS | 16724 | 05:12:20 INFO - PROCESS | 16724 | Cycle 1(1): loaded http://localhost:43826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43826/tests/dromaeo/cssquery-mootools.html) 05:12:21 INFO - PROCESS | 16724 | RSS: Main: 219324416 05:12:21 INFO - PROCESS | 16724 | 05:15:23 INFO - PROCESS | 16724 | Cycle 1(1): loaded http://localhost:43826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43826/tests/dromaeo/cssquery-prototype.html) 05:15:23 INFO - PROCESS | 16724 | RSS: Main: 209068032 05:15:23 INFO - PROCESS | 16724 | 05:18:26 INFO - PROCESS | 16724 | Cycle 1(1): loaded http://localhost:43826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43826/tests/dromaeo/cssquery-yui.html) 05:18:26 INFO - PROCESS | 16724 | RSS: Main: 177659904 05:18:26 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | Cycle 1(1): loaded http://localhost:43826/tests/dromaeo/cssquery-yui.html (next: http://localhost:43826/tests/dromaeo/cssquery-dojo.html) 05:21:29 INFO - PROCESS | 16724 | RSS: Main: 274452480 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | __start_tp_report 05:21:29 INFO - PROCESS | 16724 | _x_x_mozilla_page_load 05:21:29 INFO - PROCESS | 16724 | _x_x_mozilla_page_load_details 05:21:29 INFO - PROCESS | 16724 | |i|pagename|runs| 05:21:29 INFO - PROCESS | 16724 | |0;dojo.html;3195.9360812783743;3217.9356412871743;3238.724708399786;3246.935061298773;3250.691184337487;5505.807296744615;5572.136318870582;5602.1596760485945;5606.663600183992;5630.436956304367;5570.916436253459;5579.163125531172;5589.161625756138;5590.748416321265;5596.328440587125;5004.149294619923;5026.396832380119;5065.594752419797;5069.9493005070035;5135.255387968742;4974.626902982272;5068.974655126719;5110.386753589574;5126.154184559543;5126.359205099363;4983.950160498403;4984.850454486371;5001.324821149153;5018.046571151488;5049.242613607951;5028.6982781033075;5047.242913562958;5058.822941197041;5114.309568208281;5137.48625137487;4948.975255123702;5030.421501527335;5064.620153488466;5078.568321692661;5082.720450375228;5349.5720342372515;5404.405515393303;5407.107827208506;5417;5537.556995440355;5839.474447299764;5849.064149736022;5859;5949.226600541945;5961.642301461926;5942.316633587149;5969.04495280753;5969.910451343233;5977.252843394575;5984.251968503937;5394.298741163623;5466.863328416822;5474.09677403228;5550.72246387679;5626.831195064155;6061.272647282354;6074.605150665193;6074.726637301332;6085.817425477154;6094.238220222473;5853.122031695195;5863.472287494061;5863.765449381977;5864.501517371071;5864.912026319608;5783;5814.418558144236;5855.707214639337;5905.645661260338;5947.1079338099635;5851.882962340729;5866.50134738552;5886.3230728465915;5892.145638882338;5894.705264736832;5802.4197580241635;5848.415158484203;5861.238039054895;5862.941370586324;5870.64776113426;4535.841245556389;4577.61090307321;4596.333531637893;4609.446866376056;4614.446266448048;4118.485189351331;4120.670346372283;4130.339145736728;4161.687873409506;4177.3316269397355;5684.403137670568;5725.942740572541;5726.599138060379;5729.0260655688635;5755.827325180251;5807.622504537191;5903.881922361615;6019.307779605314;6024.036154215392;6034.09488576717;5574.832755017356;5622.775088996476;5639.8590035249445;5663.207150998864;5693;5136.717480538607;5163;5166.560842328369;5169.534741873174;5177.974110129425;5950.613210141327;6134.5092392608485;6134.9693251534345;6136.7852125175405;6137.907931380943;5846.473817356458;5947.3457919627945;5973.193618861398;6005.489533389536;6082.9695851520455;6203.540884022032;6254.093156492192;6255.46828519581;6257.217847769029;6266.028765541349;5919.763209471573;5920.052791553331;5924.289085309618;5933.258342707161;5971.044632858895;5747.885042299215;5765.596408251382;5849.1226316052935;5892.204552385373;5898.439648233411;5792.7103644818435;5794.942050579609;5798.652080875161;5809.2738407699035;5823.35943046273;5695.743691533974;5792.623479473821;5794.449527294901;5800.361960184292;5803.245578074823;5600.85997850057;5608.8878222434505;5673.943260567342;5687.317521897398;5732.684702341411;5868.765249389977;5876.265466816648;5876.941230587639;5896.7936122235515;5898.380670029585;5511.917321240105;5690.487856092972;5694.487496125369;5695.686737229492;5699.34457537372 05:21:29 INFO - PROCESS | 16724 | |1;ext.html;586.437020460358;596.8090211132437;637.5314144104084;655.5247445601937;661.9205695316563;34389.65610343896;44469.99885005174;45181.32228016583;45221.54778452215;45243.09513809722;48319;48545.51454485454;48767.75616121914;48826.51173488264;48850;8407.70573029944;8961.775955601113;9103.135202155818;9109.45343279402;9111.043340449256;8463.534505602189;10637.414942178177;10877.02106810387;10897.237193396466;11133.610323638673;11145;11205.551777928873;11211.719707007349;11215.046721028722;11218.439078046065;10920.563177472892;10965.780684386267;10995.790463049058;10996.450177491093;11004.229703920728;10829.891701082966;10900.07349375304;10900.07349375304;10902.945485272603;10907.454627268684;44152.3377149343;44406;44459.55540444619;44525.10949780986;44527.33209001867;3616.7287453440836;3952.249072676211;4254.532001479834;4289.335153051282;4344.370066340363;31642.525362119355;33207.66792332094;33520.16199595005;33731.83134084338;34748.826255868815;4550.567696068868;4570.748608826513;4574.817007319703;4584.770761461947;4665.09030739006;355038;355523;356285.9999999974;356506;357471.21264393773;64795.67602161959;65171;65198;65228.347716523174;65240;40046.799766000986;40900.386494202015;41165.382519261635;43002.35496467556;43002.78498607487;19467.51331216731;19637.60724785496;19642.803571964098;19643.508912277022;19647.705284420746;12871.292078935749;12875.35623218854;13793.24137172445;14087.929560352133;14763.77854332186;19900.303489377802;20935.581288374146;20973.895130524248;21042.158313667587;21052.78947210539;6987.755428560077;7040.683169257396;7082.893756593655;7096.53872498286;7313.341799238094;931.7763736703278;980.7838280532089;992.9255305851946;997.4264797741328;1012.1245122968579;33209.66790332114;33606.66393336084;33630.327393452484;33742.156446089044;33875;1093.7101668057971;1101.7025403141106;1121.9495122719497;1169.5964892112208;1171.6485054483621;17346.91326543359;17476.475705728848;17756.37852675176;17760.55598610045;17781;544980;549923;552152;554320;554724;41792.791036044626;42003.7899810499;42069.57930420718;42201.57798422038;42263.15473690509;1296.5915736542959;1338.7456383287144;1363.7272545490941;1387.5559820857432;1409.598264494614;31817;33321.666783332825;34195.316093678484;34257.14357140992;34990.30019399649;58094.709526453786;60020.699896500235;60095.699521502116;65016.67491662512;65114;453481;460218;460390;461105;461343;39579.80210098931;40579;41854.6763588764;44066;44160;48847.75576122239;49375.25937110875;49411;49718.50281497139;49838.25242621291;39502.40746388864;42420.78789606032;43338.78330608453;44635.10729785451;44831.551684482736;42966.78516607397;42999.57000430081;43605;43751.56248437602;44946.3258051136;41629;42317.36523952205;42407;43768.562314376446;43795.34306985334;35819.462708059924;38523.42214866835;38583.614163858;38703.61296387113;39396.2120757589;28882.422351553272;28985.275368115967;29071.273218169714;29203.561946570393;29317 05:21:29 INFO - PROCESS | 16724 | |2;jquery.html;400.3134624119636;412.2394182732857;413.25820152825673;422.3074158380256;427.4379191363357;18528.536786580324;19199.616007679837;19783.208671653116;20117.698234526477;20122;12804.423800928957;13048.28234447105;18189.7271540927;19747;19860.80139198611;5351.411344752074;5467.6719396836115;5810.912836307459;5947.910781338283;5956.076808094731;3993.3011722948368;4157.5010998680045;5854.88290234195;5907.084401917709;5911.733971971272;5634.887302253953;5860.326062502802;5898.557608179382;6006.939930600682;6018.699065046752;5973.551983601247;5990.161377407167;6226.782062627832;6566.967165164191;6616.338366163393;5965.373635768268;5968.820935371902;5975.611585246945;5976.073708575178;5977.252843394575;14216.644583885382;16198.271077801528;23750.524989500285;23860.761392386026;23964;2238.3396897915154;2260.400993736661;2288.5880541502524;2413.1553956115395;2518.937026574332;10138.645147419878;10532.684019479428;10538.789224215549;10555.208359373079;11014.669559913216;1967.527793329605;1972.556174860645;2017.4956260934766;2019.2730616977876;2034.338839877031;83541;85311.57344213239;86483;86997;87306.56346718289;11273.492692828842;11807.763844723057;11828.881711182778;11863.940680296544;12165.695857603454;17078.658426831644;17092.0599367036;17107.657846842994;17114.743278850827;17138.914305428392;8632.093630168867;8678.78303042429;8721.694740684046;8901.75375447438;8954.2836573074;8475.194856488624;8486.872696909551;8554.657813687383;8722.738317850475;8739.388242823068;5045.974770126126;5081.8475445736685;5090.2364645303505;5116.56509196715;5190.792368305301;1843.8617103717274;2015.748031496063;2060.733193487152;2081.91672333108;2098.674705420662;914.8078903430221;963.8120566489467;986.9506524673737;1000.0049950299499;1003.4832061488194;19146.52133696669;19224.903875480533;19354.129064192144;19364.612707746048;19655.213791448467;951.1439704266215;958.5830163878595;975.6195083917278;1019.8113349030453;1030.891756365571;10445.321054131457;10850.511726972147;10904.182186336056;10970.780584388267;11002.119830413547;463197;465899;466778;468771;470599;87126;87254.56372718095;88645;89034;89106;1008.702432782331;1015.3248090020054;1083.0360978728938;1084.804735147681;1085.2349093888947;16452;16637.750433743262;17018.319267229173;17427.128643568023;17935.73096403581;43066.56933430626;43705.12589748251;43757;43841.34237986369;43909.78045109754;59303.70348148232;59451;59853.700731496065;60990.69504652448;61110;7934.2859142677435;8101.392395570474;8306.916930830614;8361.665533378597;8526.403151779565;11545.307281563133;12476.750464990831;12892.48430062787;13172.670683232996;13316.33418329099;10486.528106235086;10833.133349332193;11282.605108821152;11469.082473402275;11599.130065244972;5287.709175995357;10235.437050962268;10934.890651093705;11001.487357461576;11210.383428911487;11226.719332016764;11238.55045798159;11458.369789661649;11592.0146787524;11707.180497365103;8214.63034163476;8346.62440190205;8357.038940521918;8741.650333986569;8984;8776.605052772768;11092.389918554558;11302.208845380745;11381;11818.054555635701 05:21:29 INFO - PROCESS | 16724 | |3;mootools.html;1496.274306961124;1500.0924440713368;1632.7224371856782;1739.9391021314257;1744.3109971561234;7739.303462688364;8198.590070496473;8238.588070596461;8261.50430974142;8267.462614930026;7091.929080709191;7291.416686665068;7293.307135822089;7480.812979675511;8117.39119566032;2336.2991102669216;2396.59257926153;2420.394901274681;2437.609982402816;2443.621238707994;2426.1993542131054;2438.890249938757;2454.472288457981;2460.052879641342;2460.3111128883943;2405.783479486846;2411.204302580153;2424.9030038798514;2430.6597076409316;2431.234161239204;2352.2355234548754;2391.1989483522866;2397.029203172709;2400.039984006403;2400.531896280226;2369.372116389141;2369.5024044950583;2383.4637206628545;2383.5232953409386;2390.964135537968;8093.838123237561;8141.1451797561585;8151.755447336589;8154.959225203836;8166.142555031695;5104.3619547556555;5235.110031294651;5242.9213561796605;5248.317718696583;5248.632595718302;3161.7154456098833;3276.7050965413227;3375.835336808797;3381.5942086949476;3388.796672199676;1033.2302434686133;1068.114777417858;1074.2265568790458;1077.8113830079706;1095.11842966412;11061.889381106246;11141.944290278578;11158.609448669338;11196.384198869058;11201.71995700114;4458.130664520388;4542.613877820422;4642.86071417858;4644.094401591725;4660.790264438108;9368.110029547182;9368.203702685349;9384.061593840697;9385.62457501706;9405.529723513797;5184.196449550326;5192.039472697563;5193.039287731782;5198.2202669599865;5199.012187684328;4276.294411422143;4695.3426520287185;4795.568398844121;4830.082284365959;4839.201531747222;3614.042278796121;3797.2595343907674;3885.1452680410266;3976.661983731415;3978.4629075074495;1281.1288323939625;1283.6983308922395;1284.6980959474515;1302.8110923915979;1319.6239071864472;965.8551217317319;970.3207754571828;979.2508730820928;984.601236499219;992.8014397120605;5754.251947246831;5799.33307669615;5808.680522571215;5880.441358070976;5882.882342353129;931.6925414613162;964.5002021856081;995.3977843404781;1008.4302369161547;1024.4979959819634;4078.898027549276;4079.102597428561;4092.3043082676018;4129.442525259052;4149.854755083557;9743.853842192373;9964.900350996397;10040.548175332127;10071.798564028679;10074.546645400975;8861.556922153866;9152.95423522878;9280.257579393767;9488.240940724725;9506.809863802824;7546.698132074765;7561.848763024709;7645.00614920068;7734.57459839703;7739.883901741478;5727.455891690282;5763.94236057634;5864.384239654775;5883.470487656132;5962.807438512402;8914;8964.238039766693;9030.999999999738;9094.681686141217;9117;9214.815703686023;9219.631214751334;9237.07629237071;9286.489243091695;9309.953450232977;6648.966755166387;7280.162781280221;7405.333519983227;7419.591922444318;7436.479446438698;7102.360787529147;7555.09338879338;7887.802804929923;7899.447038707465;8063.516189028677;7051.823704407431;7148.892766608401;7154.248803875518;7178.24628414009;7316.634168291671;7110.040144580622;7119.6084215368655;7129.4652901031595;7149.7140114396925;7161.534500257467;6669.866602667822;6714.630695311805;6774.254831968578;6798.422134118655;6799.762008329685;4797.808087676453;4891.706497610013;4925.679830810986;4938.358013458371;5021.573166280907;4973.850784476472;5047.697138171721;5114.974425127851;5139.4603566626465;5150.48495150482 05:21:29 INFO - PROCESS | 16724 | |4;prototype.html;332.42822345565617;346.68798081726453;350.6388419927476;350.8177442020392;353.5651149086623;5492.890142197154;5495.6702597844105;5500.147477141039;5527.50252477277;5543.473370029851;5105.974470127653;5230.6600070995455;5249.737513124348;5352.330958630171;5377.0321342158395;4204.2432362174795;4214.157168566284;4223.197592457439;4236.661067114639;4254.27677294859;4225.661947044229;4234.280172370689;4235.8093885775215;4248.192843359767;4251.957480425187;3998.8000599969887;4207.305794543912;4257.212415703105;4258.425112609804;4262.893427664318;4211;4225.197212529641;4230.8519201827785;4246.917036155776;4248.957510424887;3736.1220113273357;3748.3253014457387;3750.7749535027715;3756.605556416564;3780.7542509736777;5037.5718063964605;5266.34170728659;5282.973585132088;5300.072487314743;5307.389650190239;4791.401074865642;4805.807767689324;4826.372571565709;4827.203511420611;4842.12841688496;5616.213730077792;5631.352394474647;5636.351819540764;5641.605087643867;5659.971700141514;4000.239954408653;4060.6345428911245;4065.8170382332864;4087.652549533293;4122.40225167352;5843.655959129382;5855.473007429309;5858.472737453607;5868.325142608612;5880.705964701748;4239.1521695660995;4254.510731265882;4267.295896177158;4281.2293787118;4287.828486860553;4102.646126778156;4269.188854117708;4290.635295999875;4318.78406079701;4340.327249276367;4800.879978000578;4800.975995120002;4819.349387832598;4840.177169881129;4847.175980083394;5624.353199382123;5647.181158731961;5649.700568869183;5661.377248502661;5691.573132015115;1419.9432022718975;1424.287856071964;1437.4690954133814;1438.6691061056015;1448.4278709909527;984.9953047891254;993.1409330928694;1005.1305620638242;1006.4917216805612;1014.9644762433279;5291.814786482531;5295.841124766263;5304.204369344629;5308.681479111266;5313.601479889024;5594.384617692132;5601.974933535845;5613.943860561424;5617.876424715073;5621.4659607337235;5107.719075450812;5294.49702278283;5300.893982120413;5328.946710532845;5329.653572517774;2973.8513074346197;2981.5390458675092;2983.9104826855228;2984.253936515871;2990.327176385296;5678.716064196774;5726.885462290731;5774.48029677331;5785.4214578541805;5791.276090488689;5433.565314774809;5621.775128994795;5629.802956896489;5645.745941432645;5649.519790817744;5784.2769653793275;5789.768409263583;5792.304923409218;5798.94201057984;5800.332961709458;5573.27547418833;5584.916226256528;5606.523445507178;5608.747606357642;5860.531157507304;5791.218185545066;5798.855028624318;5810.883782324246;5829.562782791223;5833.329167145663;6093.725782339717;6116;6119.4798442132915;6122.755089796358;6141.232345956755;4019.8995025124605;4064.674826013971;4211.852585159627;4245.469316335458;4248.468941382327;5779.479846813639;5791.189233507396;5900.170947006442;5901.852453688693;5910.734016969161;5737.397573254748;5754.187430959234;5756.251687280626;5759.992001399822;5761.366249712612;5585.301837270341;5621.718914054362;5682.602217844711;5691.8292451226525;5734.168545560787;5636.379998200113;5665.376808551138;5671.234383358359;5671.858203544944;5684.8294551163535;5557.638753481173;5716;5719.456651618089;5734.655920644775;5767.904098221325;5515.31782806248;5574.888502230014;5585.547757583139;5593.8321850344555;5607.355154157324 05:21:29 INFO - PROCESS | 16724 | |5;yui.html;777.3314949143739;780.4341852157185;792.5535896987998;801.9438639295252;866.5060915278292;14223.43106275749;14383.496577619771;14534.854651453483;14707.705845883103;15066;13111.934440327808;14838.629034274149;14927.7014459711;15018.324175412105;15019.098854068763;834.7454026521908;863.1756672377895;863.5984267315697;863.6027427383411;864.0193380513132;836.2891542189151;837.5351679817729;839.093778718982;840.1094839470181;840.3319361107904;878.6221924572432;880.0978996528545;880.6477409036372;880.8766772651834;881.4006475596624;874.6676263020075;876.0319846569513;877.675260153744;877.9078196789341;878.3895192840978;648.5460177875506;652.2271108736115;652.422605993699;652.6964961293022;653.3858173317067;14101.294935253196;14125.223112728796;14134.787978180335;15700;15830.604234894105;14569.927150364287;14792.852071479256;15157;15401.537953861402;15524.767128493082;11652.00957918578;11711.7072073198;12086.274823510617;12160.148789584733;12222.877771222351;3799.715021373408;3805.904852378685;3928.5874983126646;3932.7640341579313;3981.3231750602467;38864.80567597172;46397.30404043942;58183.70908145432;65767.67116164436;68657.31342686558;11472.4837382318;11867.406629668481;12014.939925300318;12038.87961120395;12060.457279422448;21106.78893211079;21256.574868502852;21435.356939291847;21444.785552144593;21516.677249841265;8283.50298982063;8293;8520.14798520143;8642.265407440438;8655.826883462421;4386.385905973167;4472.195004899084;4527.750973696412;4534.183846907522;4576.633869290449;3180.236743181666;3228.838558072087;3233.7873297513433;3563.1448452371765;3714.108613932691;619.5074915442234;647.8833809914261;653.5033374635311;657.6613044282199;658.2232965101131;554.282204545107;576.3199424678835;622.8536293970914;643.9678016099176;671.7078071039114;9152.496612686366;9215.354925155309;9239.076092390707;9337.486438245962;9399;635.9554831161867;725.9401274139709;740.7999840043158;751.0686748431905;766.5285849202812;4387.210302145644;4548.7725613719185;4601.930971035437;4628.305754136906;4703.0593881223895;74361.62819185869;75100.62449687716;78500.60749696215;86215.56892215624;88590.55704721434;72180.2781972184;72411.63794180995;73924.26075739281;74643.62678186683;75602;66624;68224;68450.3154968444;69456.30543694498;72201.6389918047;9661.758456038655;10013.299069065388;10058.02132407637;10171;10350.896491034993;43241.783791080845;43948;44625.33062004137;44832.775836120614;45100.548994509634;57495.425045749005;60333;62965.59240853096;64271.35728642841;64329.678351609815;12469.625911222678;12554.686132846751;12694.87305126937;12947.805782913452;13081.280529570964;14499;14608.488702895773;14712.337944792724;14726.779098313747;14928.178950157411;13010.869891300967;13271.469141234242;13378.464861405435;13503.527376542166;13946.930265348608;13403.262820544574;13482.19106853592;13537.59387218385;13647.365203691741;14013.43946242139;12887.93556032214;13016.284104373972;13149.276789776653;14338.49815256461;14362.532523850823;10620.84068738954;11445.25605835618;11591.884081159418;11811.350375729417;12184.57353992606;10940.288881222696;11458.000638773408;11552.364619945984;11756.412179390825;11801.29192248468 05:21:29 INFO - PROCESS | 16724 | __end_tp_report 05:21:29 INFO - PROCESS | 16724 | __start_cc_report 05:21:29 INFO - PROCESS | 16724 | _x_x_mozilla_cycle_collect,940 05:21:29 INFO - PROCESS | 16724 | __end_cc_report 05:21:29 INFO - PROCESS | 16724 | __startTimestamp1487337689644__endTimestamp 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | ------- Summary: start ------- 05:21:29 INFO - PROCESS | 16724 | Number of tests: 6 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | [#0] dojo.html Cycles:165 Average:5516.91 Median:5726.60 stddev:613.39 (10.7%) stddev-sans-first:587.62 05:21:29 INFO - PROCESS | 16724 | Values: 3195.9 3217.9 3238.7 3246.9 3250.7 5505.8 5572.1 5602.2 5606.7 5630.4 5570.9 5579.2 5589.2 5590.7 5596.3 5004.1 5026.4 5065.6 5069.9 5135.3 4974.6 5069.0 5110.4 5126.2 5126.4 4984.0 4984.9 5001.3 5018.0 5049.2 5028.7 5047.2 5058.8 5114.3 5137.5 4949.0 5030.4 5064.6 5078.6 5082.7 5349.6 5404.4 5407.1 5417.0 5537.6 5839.5 5849.1 5859.0 5949.2 5961.6 5942.3 5969.0 5969.9 5977.3 5984.3 5394.3 5466.9 5474.1 5550.7 5626.8 6061.3 6074.6 6074.7 6085.8 6094.2 5853.1 5863.5 5863.8 5864.5 5864.9 5783.0 5814.4 5855.7 5905.6 5947.1 5851.9 5866.5 5886.3 5892.1 5894.7 5802.4 5848.4 5861.2 5862.9 5870.6 4535.8 4577.6 4596.3 4609.4 4614.4 4118.5 4120.7 4130.3 4161.7 4177.3 5684.4 5725.9 5726.6 5729.0 5755.8 5807.6 5903.9 6019.3 6024.0 6034.1 5574.8 5622.8 5639.9 5663.2 5693.0 5136.7 5163.0 5166.6 5169.5 5178.0 5950.6 6134.5 6135.0 6136.8 6137.9 5846.5 5947.3 5973.2 6005.5 6083.0 6203.5 6254.1 6255.5 6257.2 6266.0 5919.8 5920.1 5924.3 5933.3 5971.0 5747.9 5765.6 5849.1 5892.2 5898.4 5792.7 5794.9 5798.7 5809.3 5823.4 5695.7 5792.6 5794.4 5800.4 5803.2 5600.9 5608.9 5673.9 5687.3 5732.7 5868.8 5876.3 5876.9 5896.8 5898.4 5511.9 5690.5 5694.5 5695.7 5699.3 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | [#1] ext.html Cycles:180 Average:62388.92 Median:41823.73 stddev:122447.59 (292.8%) stddev-sans-first:122703.17 05:21:29 INFO - PROCESS | 16724 | Values: 586.4 596.8 637.5 655.5 661.9 34389.7 44470.0 45181.3 45221.5 45243.1 48319.0 48545.5 48767.8 48826.5 48850.0 8407.7 8961.8 9103.1 9109.5 9111.0 8463.5 10637.4 10877.0 10897.2 11133.6 11145.0 11205.6 11211.7 11215.0 11218.4 10920.6 10965.8 10995.8 10996.5 11004.2 10829.9 10900.1 10900.1 10902.9 10907.5 44152.3 44406.0 44459.6 44525.1 44527.3 3616.7 3952.2 4254.5 4289.3 4344.4 31642.5 33207.7 33520.2 33731.8 34748.8 4550.6 4570.7 4574.8 4584.8 4665.1 355038.0 355523.0 356286.0 356506.0 357471.2 64795.7 65171.0 65198.0 65228.3 65240.0 40046.8 40900.4 41165.4 43002.4 43002.8 19467.5 19637.6 19642.8 19643.5 19647.7 12871.3 12875.4 13793.2 14087.9 14763.8 19900.3 20935.6 20973.9 21042.2 21052.8 6987.8 7040.7 7082.9 7096.5 7313.3 931.8 980.8 992.9 997.4 1012.1 33209.7 33606.7 33630.3 33742.2 33875.0 1093.7 1101.7 1121.9 1169.6 1171.6 17346.9 17476.5 17756.4 17760.6 17781.0 544980.0 549923.0 552152.0 554320.0 554724.0 41792.8 42003.8 42069.6 42201.6 42263.2 1296.6 1338.7 1363.7 1387.6 1409.6 31817.0 33321.7 34195.3 34257.1 34990.3 58094.7 60020.7 60095.7 65016.7 65114.0 453481.0 460218.0 460390.0 461105.0 461343.0 39579.8 40579.0 41854.7 44066.0 44160.0 48847.8 49375.3 49411.0 49718.5 49838.3 39502.4 42420.8 43338.8 44635.1 44831.6 42966.8 42999.6 43605.0 43751.6 44946.3 41629.0 42317.4 42407.0 43768.6 43795.3 35819.5 38523.4 38583.6 38703.6 39396.2 28882.4 28985.3 29071.3 29203.6 29317.0 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | [#2] jquery.html Cycles:180 Average:28398.22 Median:2466.05 stddev:77202.82 (3130.6%) stddev-sans-first:77390.77 05:21:29 INFO - PROCESS | 16724 | Values: 400.3 412.2 413.3 422.3 427.4 18528.5 19199.6 19783.2 20117.7 20122.0 12804.4 13048.3 18189.7 19747.0 19860.8 5351.4 5467.7 5810.9 5947.9 5956.1 3993.3 4157.5 5854.9 5907.1 5911.7 5634.9 5860.3 5898.6 6006.9 6018.7 5973.6 5990.2 6226.8 6567.0 6616.3 5965.4 5968.8 5975.6 5976.1 5977.3 14216.6 16198.3 23750.5 23860.8 23964.0 2238.3 2260.4 2288.6 2413.2 2518.9 10138.6 10532.7 10538.8 10555.2 11014.7 1967.5 1972.6 2017.5 2019.3 2034.3 83541.0 85311.6 86483.0 86997.0 87306.6 11273.5 11807.8 11828.9 11863.9 12165.7 17078.7 17092.1 17107.7 17114.7 17138.9 8632.1 8678.8 8721.7 8901.8 8954.3 8475.2 8486.9 8554.7 8722.7 8739.4 5046.0 5081.8 5090.2 5116.6 5190.8 1843.9 2015.7 2060.7 2081.9 2098.7 914.8 963.8 987.0 1000.0 1003.5 19146.5 19224.9 19354.1 19364.6 19655.2 951.1 958.6 975.6 1019.8 1030.9 10445.3 10850.5 10904.2 10970.8 11002.1 463197.0 465899.0 466778.0 468771.0 470599.0 87126.0 87254.6 88645.0 89034.0 89106.0 1008.7 1015.3 1083.0 1084.8 1085.2 16452.0 16637.8 17018.3 17427.1 17935.7 43066.6 43705.1 43757.0 43841.3 43909.8 59303.7 59451.0 59853.7 60990.7 61110.0 7934.3 8101.4 8306.9 8361.7 8526.4 11545.3 12476.8 12892.5 13172.7 13316.3 10486.5 10833.1 11282.6 11469.1 11599.1 5287.7 10235.4 10934.9 11001.5 11210.4 11226.7 11238.6 11458.4 11592.0 11707.2 8214.6 8346.6 8357.0 8741.7 8984.0 8776.6 11092.4 11302.2 11381.0 11818.1 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | [#3] mootools.html Cycles:180 Average:5445.73 Median:5217.06 stddev:2886.40 (55.3%) stddev-sans-first:2879.24 05:21:29 INFO - PROCESS | 16724 | Values: 1496.3 1500.1 1632.7 1739.9 1744.3 7739.3 8198.6 8238.6 8261.5 8267.5 7091.9 7291.4 7293.3 7480.8 8117.4 2336.3 2396.6 2420.4 2437.6 2443.6 2426.2 2438.9 2454.5 2460.1 2460.3 2405.8 2411.2 2424.9 2430.7 2431.2 2352.2 2391.2 2397.0 2400.0 2400.5 2369.4 2369.5 2383.5 2383.5 2391.0 8093.8 8141.1 8151.8 8155.0 8166.1 5104.4 5235.1 5242.9 5248.3 5248.6 3161.7 3276.7 3375.8 3381.6 3388.8 1033.2 1068.1 1074.2 1077.8 1095.1 11061.9 11141.9 11158.6 11196.4 11201.7 4458.1 4542.6 4642.9 4644.1 4660.8 9368.1 9368.2 9384.1 9385.6 9405.5 5184.2 5192.0 5193.0 5198.2 5199.0 4276.3 4695.3 4795.6 4830.1 4839.2 3614.0 3797.3 3885.1 3976.7 3978.5 1281.1 1283.7 1284.7 1302.8 1319.6 965.9 970.3 979.3 984.6 992.8 5754.3 5799.3 5808.7 5880.4 5882.9 931.7 964.5 995.4 1008.4 1024.5 4078.9 4079.1 4092.3 4129.4 4149.9 9743.9 9964.9 10040.5 10071.8 10074.5 8861.6 9153.0 9280.3 9488.2 9506.8 7546.7 7561.8 7645.0 7734.6 7739.9 5727.5 5763.9 5864.4 5883.5 5962.8 8914.0 8964.2 9031.0 9094.7 9117.0 9214.8 9219.6 9237.1 9286.5 9310.0 6649.0 7280.2 7405.3 7419.6 7436.5 7102.4 7555.1 7887.8 7899.4 8063.5 7051.8 7148.9 7154.2 7178.2 7316.6 7110.0 7119.6 7129.5 7149.7 7161.5 6669.9 6714.6 6774.3 6798.4 6799.8 4797.8 4891.7 4925.7 4938.4 5021.6 4973.9 5047.7 5115.0 5139.5 5150.5 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | [#4] prototype.html Cycles:180 Average:4752.65 Median:5340.99 stddev:1382.19 (25.9%) stddev-sans-first:1345.66 05:21:29 INFO - PROCESS | 16724 | Values: 332.4 346.7 350.6 350.8 353.6 5492.9 5495.7 5500.1 5527.5 5543.5 5106.0 5230.7 5249.7 5352.3 5377.0 4204.2 4214.2 4223.2 4236.7 4254.3 4225.7 4234.3 4235.8 4248.2 4252.0 3998.8 4207.3 4257.2 4258.4 4262.9 4211.0 4225.2 4230.9 4246.9 4249.0 3736.1 3748.3 3750.8 3756.6 3780.8 5037.6 5266.3 5283.0 5300.1 5307.4 4791.4 4805.8 4826.4 4827.2 4842.1 5616.2 5631.4 5636.4 5641.6 5660.0 4000.2 4060.6 4065.8 4087.7 4122.4 5843.7 5855.5 5858.5 5868.3 5880.7 4239.2 4254.5 4267.3 4281.2 4287.8 4102.6 4269.2 4290.6 4318.8 4340.3 4800.9 4801.0 4819.3 4840.2 4847.2 5624.4 5647.2 5649.7 5661.4 5691.6 1419.9 1424.3 1437.5 1438.7 1448.4 985.0 993.1 1005.1 1006.5 1015.0 5291.8 5295.8 5304.2 5308.7 5313.6 5594.4 5602.0 5613.9 5617.9 5621.5 5107.7 5294.5 5300.9 5328.9 5329.7 2973.9 2981.5 2983.9 2984.3 2990.3 5678.7 5726.9 5774.5 5785.4 5791.3 5433.6 5621.8 5629.8 5645.7 5649.5 5784.3 5789.8 5792.3 5798.9 5800.3 5573.3 5584.9 5606.5 5608.7 5860.5 5791.2 5798.9 5810.9 5829.6 5833.3 6093.7 6116.0 6119.5 6122.8 6141.2 4019.9 4064.7 4211.9 4245.5 4248.5 5779.5 5791.2 5900.2 5901.9 5910.7 5737.4 5754.2 5756.3 5760.0 5761.4 5585.3 5621.7 5682.6 5691.8 5734.2 5636.4 5665.4 5671.2 5671.9 5684.8 5557.6 5716.0 5719.5 5734.7 5767.9 5515.3 5574.9 5585.5 5593.8 5607.4 05:21:29 INFO - PROCESS | 16724 | 05:21:29 INFO - PROCESS | 16724 | [#5] yui.html Cycles:180 Average:17540.30 Median:24652.49 stddev:22305.33 (90.5%) stddev-sans-first:22332.39 05:21:29 INFO - PROCESS | 16724 | Values: 777.3 780.4 792.6 801.9 866.5 14223.4 14383.5 14534.9 14707.7 15066.0 13111.9 14838.6 14927.7 15018.3 15019.1 834.7 863.2 863.6 863.6 864.0 836.3 837.5 839.1 840.1 840.3 878.6 880.1 880.6 880.9 881.4 874.7 876.0 877.7 877.9 878.4 648.5 652.2 652.4 652.7 653.4 14101.3 14125.2 14134.8 15700.0 15830.6 14569.9 14792.9 15157.0 15401.5 15524.8 11652.0 11711.7 12086.3 12160.1 12222.9 3799.7 3805.9 3928.6 3932.8 3981.3 38864.8 46397.3 58183.7 65767.7 68657.3 11472.5 11867.4 12014.9 12038.9 12060.5 21106.8 21256.6 21435.4 21444.8 21516.7 8283.5 8293.0 8520.1 8642.3 8655.8 4386.4 4472.2 4527.8 4534.2 4576.6 3180.2 3228.8 3233.8 3563.1 3714.1 619.5 647.9 653.5 657.7 658.2 554.3 576.3 622.9 644.0 671.7 9152.5 9215.4 9239.1 9337.5 9399.0 636.0 725.9 740.8 751.1 766.5 4387.2 4548.8 4601.9 4628.3 4703.1 74361.6 75100.6 78500.6 86215.6 88590.6 72180.3 72411.6 73924.3 74643.6 75602.0 66624.0 68224.0 68450.3 69456.3 72201.6 9661.8 10013.3 10058.0 10171.0 10350.9 43241.8 43948.0 44625.3 44832.8 45100.5 57495.4 60333.0 62965.6 64271.4 64329.7 12469.6 12554.7 12694.9 12947.8 13081.3 14499.0 14608.5 14712.3 14726.8 14928.2 13010.9 13271.5 13378.5 13503.5 13946.9 13403.3 13482.2 13537.6 13647.4 14013.4 12887.9 13016.3 13149.3 14338.5 14362.5 10620.8 11445.3 11591.9 11811.4 12184.6 10940.3 11458.0 11552.4 11756.4 11801.3 05:21:29 INFO - PROCESS | 16724 | -------- Summary: end -------- 05:21:29 INFO - PROCESS | 16724 | 05:21:30 INFO - TEST-INFO | 16724: exit 0 05:21:30 INFO - TEST-OK | dromaeo_css | took 1115706ms 05:21:30 INFO - TEST-START | kraken 05:21:30 INFO - operating with platform_type : linux_ 05:21:30 INFO - Initialising browser for kraken test... 05:21:30 INFO - TEST-INFO | started process 17031 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHHaZLG/profile http://localhost:43826/getInfo.html) 05:21:34 INFO - PROCESS | 17031 | __metrics Screen width/height:1600/1200 05:21:34 INFO - PROCESS | 17031 | colorDepth:24 05:21:34 INFO - PROCESS | 17031 | Browser inner width/height: 1024/697 05:21:34 INFO - PROCESS | 17031 | __metrics 05:21:35 INFO - PROCESS | 17031 | 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" 05:21:35 INFO - PROCESS | 17031 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:21:36 INFO - TEST-INFO | 17031: exit 0 05:21:36 INFO - Browser initialized. 05:21:36 INFO - Running cycle 1/1 for kraken test... 05:21:36 INFO - TEST-INFO | started process 17122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHHaZLG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:48 INFO - PROCESS | 17122 | RSS: Main: 142127104 05:21:48 INFO - PROCESS | 17122 | 05:21:51 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43826/tests/kraken/driver.html?testName=audio-beat-detection) 05:21:52 INFO - PROCESS | 17122 | RSS: Main: 183947264 05:21:52 INFO - PROCESS | 17122 | 05:21:54 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43826/tests/kraken/driver.html?testName=audio-dft) 05:21:55 INFO - PROCESS | 17122 | RSS: Main: 173711360 05:21:55 INFO - PROCESS | 17122 | 05:21:57 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43826/tests/kraken/driver.html?testName=audio-fft) 05:21:58 INFO - PROCESS | 17122 | RSS: Main: 264699904 05:21:58 INFO - PROCESS | 17122 | 05:22:00 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43826/tests/kraken/driver.html?testName=audio-oscillator) 05:22:01 INFO - PROCESS | 17122 | RSS: Main: 171298816 05:22:01 INFO - PROCESS | 17122 | 05:22:03 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:22:03 INFO - PROCESS | 17122 | RSS: Main: 174514176 05:22:03 INFO - PROCESS | 17122 | 05:22:06 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43826/tests/kraken/driver.html?testName=imaging-darkroom) 05:22:07 INFO - PROCESS | 17122 | RSS: Main: 211177472 05:22:07 INFO - PROCESS | 17122 | 05:22:10 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43826/tests/kraken/driver.html?testName=imaging-desaturate) 05:22:11 INFO - PROCESS | 17122 | RSS: Main: 211779584 05:22:11 INFO - PROCESS | 17122 | 05:22:13 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43826/tests/kraken/driver.html?testName=json-parse-financial) 05:22:14 INFO - PROCESS | 17122 | RSS: Main: 210104320 05:22:14 INFO - PROCESS | 17122 | 05:22:16 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:22:16 INFO - PROCESS | 17122 | RSS: Main: 172265472 05:22:16 INFO - PROCESS | 17122 | 05:22:18 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:22:18 INFO - PROCESS | 17122 | RSS: Main: 179580928 05:22:18 INFO - PROCESS | 17122 | 05:22:20 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:22:21 INFO - PROCESS | 17122 | RSS: Main: 188538880 05:22:21 INFO - PROCESS | 17122 | 05:22:24 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:22:24 INFO - PROCESS | 17122 | RSS: Main: 196116480 05:22:24 INFO - PROCESS | 17122 | 05:22:27 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:22:28 INFO - PROCESS | 17122 | RSS: Main: 193085440 05:22:28 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | Cycle 1(1): loaded http://localhost:43826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43826/tests/kraken/driver.html?testName=ai-astar) 05:22:29 INFO - PROCESS | 17122 | RSS: Main: 245170176 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | __start_tp_report 05:22:29 INFO - PROCESS | 17122 | _x_x_mozilla_page_load 05:22:29 INFO - PROCESS | 17122 | _x_x_mozilla_page_load_details 05:22:29 INFO - PROCESS | 17122 | |i|pagename|runs| 05:22:29 INFO - PROCESS | 17122 | |0;ai-astar;103;112;113;112;113;114;111;111;113;113 05:22:29 INFO - PROCESS | 17122 | |1;audio-beat-detection;141;117;121;146;118;121;116;116;148;120 05:22:29 INFO - PROCESS | 17122 | |2;audio-dft;160;161;160;162;160;160;160;159;161;159 05:22:29 INFO - PROCESS | 17122 | |3;audio-fft;75;75;77;115;75;75;78;75;97;75 05:22:29 INFO - PROCESS | 17122 | |4;audio-oscillator;82;82;113;83;85;83;98;83;81;103 05:22:29 INFO - PROCESS | 17122 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;117;117;117 05:22:29 INFO - PROCESS | 17122 | |6;imaging-darkroom;147;146;146;145;146;146;145;146;146;145 05:22:29 INFO - PROCESS | 17122 | |7;imaging-desaturate;87;85;85;85;84;84;84;84;86;84 05:22:29 INFO - PROCESS | 17122 | |8;json-parse-financial;52;50;52;51;51;53;51;50;50;50 05:22:29 INFO - PROCESS | 17122 | |9;json-stringify-tinderbox;59;64;60;60;59;61;59;60;60;60 05:22:29 INFO - PROCESS | 17122 | |10;stanford-crypto-aes;75;74;81;75;76;75;74;75;74;74 05:22:29 INFO - PROCESS | 17122 | |11;stanford-crypto-ccm;127;135;124;129;123;121;122;119;164;132 05:22:29 INFO - PROCESS | 17122 | |12;stanford-crypto-pbkdf2;160;161;160;157;158;160;156;159;156;158 05:22:29 INFO - PROCESS | 17122 | |13;stanford-crypto-sha256-iterative;63;63;65;62;62;64;70;64;62;61 05:22:29 INFO - PROCESS | 17122 | __end_tp_report 05:22:29 INFO - PROCESS | 17122 | __start_cc_report 05:22:29 INFO - PROCESS | 17122 | _x_x_mozilla_cycle_collect,1590 05:22:29 INFO - PROCESS | 17122 | __end_cc_report 05:22:29 INFO - PROCESS | 17122 | __startTimestamp1487337749939__endTimestamp 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | ------- Summary: start ------- 05:22:29 INFO - PROCESS | 17122 | Number of tests: 14 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.14 (2.8%) stddev-sans-first:1.01 05:22:29 INFO - PROCESS | 17122 | Values: 103.0 112.0 113.0 112.0 113.0 114.0 111.0 111.0 113.0 113.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:121.00 stddev:13.07 (10.8%) stddev-sans-first:12.76 05:22:29 INFO - PROCESS | 17122 | Values: 141.0 117.0 121.0 146.0 118.0 121.0 116.0 116.0 148.0 120.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 05:22:29 INFO - PROCESS | 17122 | Values: 160.0 161.0 160.0 162.0 160.0 160.0 160.0 159.0 161.0 159.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.53 (18.0%) stddev-sans-first:14.13 05:22:29 INFO - PROCESS | 17122 | Values: 75.0 75.0 77.0 115.0 75.0 75.0 78.0 75.0 97.0 75.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.00 stddev:11.25 (13.5%) stddev-sans-first:11.61 05:22:29 INFO - PROCESS | 17122 | Values: 82.0 82.0 113.0 83.0 85.0 83.0 98.0 83.0 81.0 103.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:22:29 INFO - PROCESS | 17122 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 05:22:29 INFO - PROCESS | 17122 | Values: 147.0 146.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 145.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:1.03 (1.2%) stddev-sans-first:0.73 05:22:29 INFO - PROCESS | 17122 | Values: 87.0 85.0 85.0 85.0 84.0 84.0 84.0 84.0 86.0 84.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:1.05 (2.1%) stddev-sans-first:1.05 05:22:29 INFO - PROCESS | 17122 | Values: 52.0 50.0 52.0 51.0 51.0 53.0 51.0 50.0 50.0 50.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:1.48 (2.5%) stddev-sans-first:1.50 05:22:29 INFO - PROCESS | 17122 | Values: 59.0 64.0 60.0 60.0 59.0 61.0 59.0 60.0 60.0 60.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#10] stanford-crypto-aes Cycles:10 Average:75.30 Median:75.00 stddev:2.11 (2.8%) stddev-sans-first:2.24 05:22:29 INFO - PROCESS | 17122 | Values: 75.0 74.0 81.0 75.0 76.0 75.0 74.0 75.0 74.0 74.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:128.00 stddev:13.10 (10.2%) stddev-sans-first:13.86 05:22:29 INFO - PROCESS | 17122 | Values: 127.0 135.0 124.0 129.0 123.0 121.0 122.0 119.0 164.0 132.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.50 Median:159.50 stddev:1.78 (1.1%) stddev-sans-first:1.80 05:22:29 INFO - PROCESS | 17122 | Values: 160.0 161.0 160.0 157.0 158.0 160.0 156.0 159.0 156.0 158.0 05:22:29 INFO - PROCESS | 17122 | 05:22:29 INFO - PROCESS | 17122 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:63.50 stddev:2.55 (4.0%) stddev-sans-first:2.69 05:22:29 INFO - PROCESS | 17122 | Values: 63.0 63.0 65.0 62.0 62.0 64.0 70.0 64.0 62.0 61.0 05:22:29 INFO - PROCESS | 17122 | -------- Summary: end -------- 05:22:29 INFO - PROCESS | 17122 | 05:22:30 INFO - TEST-INFO | 17122: exit 0 05:22:30 INFO - TEST-OK | kraken | took 60527ms 05:22:30 INFO - SUITE-END | took 1176s 05:22:31 INFO - Completed test suite (00:19:36) 05:22:31 INFO - javascript benchmark 05:22:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3195.9360812783743, 3217.9356412871743, 3238.724708399786, 3246.935061298773, 3250.691184337487, 5505.807296744615, 5572.136318870582, 5602.1596760485945, 5606.663600183992, 5630.436956304367, 5570.916436253459, 5579.163125531172, 5589.161625756138, 5590.748416321265, 5596.328440587125, 5004.149294619923, 5026.396832380119, 5065.594752419797, 5069.9493005070035, 5135.255387968742, 4974.626902982272, 5068.974655126719, 5110.386753589574, 5126.154184559543, 5126.359205099363, 4983.950160498403, 4984.850454486371, 5001.324821149153, 5018.046571151488, 5049.242613607951, 5028.6982781033075, 5047.242913562958, 5058.822941197041, 5114.309568208281, 5137.48625137487, 4948.975255123702, 5030.421501527335, 5064.620153488466, 5078.568321692661, 5082.720450375228, 5349.5720342372515, 5404.405515393303, 5407.107827208506, 5417.0, 5537.556995440355, 5839.474447299764, 5849.064149736022, 5859.0, 5949.226600541945, 5961.642301461926, 5942.316633587149, 5969.04495280753, 5969.910451343233, 5977.252843394575, 5984.251968503937, 5394.298741163623, 5466.863328416822, 5474.09677403228, 5550.72246387679, 5626.831195064155, 6061.272647282354, 6074.605150665193, 6074.726637301332, 6085.817425477154, 6094.238220222473, 5853.122031695195, 5863.472287494061, 5863.765449381977, 5864.501517371071, 5864.912026319608, 5783.0, 5814.418558144236, 5855.707214639337, 5905.645661260338, 5947.1079338099635, 5851.882962340729, 5866.50134738552, 5886.3230728465915, 5892.145638882338, 5894.705264736832, 5802.4197580241635, 5848.415158484203, 5861.238039054895, 5862.941370586324, 5870.64776113426, 4535.841245556389, 4577.61090307321, 4596.333531637893, 4609.446866376056, 4614.446266448048, 4118.485189351331, 4120.670346372283, 4130.339145736728, 4161.687873409506, 4177.3316269397355, 5684.403137670568, 5725.942740572541, 5726.599138060379, 5729.0260655688635, 5755.827325180251, 5807.622504537191, 5903.881922361615, 6019.307779605314, 6024.036154215392, 6034.09488576717, 5574.832755017356, 5622.775088996476, 5639.8590035249445, 5663.207150998864, 5693.0, 5136.717480538607, 5163.0, 5166.560842328369, 5169.534741873174, 5177.974110129425, 5950.613210141327, 6134.5092392608485, 6134.9693251534345, 6136.7852125175405, 6137.907931380943, 5846.473817356458, 5947.3457919627945, 5973.193618861398, 6005.489533389536, 6082.9695851520455, 6203.540884022032, 6254.093156492192, 6255.46828519581, 6257.217847769029, 6266.028765541349, 5919.763209471573, 5920.052791553331, 5924.289085309618, 5933.258342707161, 5971.044632858895, 5747.885042299215, 5765.596408251382, 5849.1226316052935, 5892.204552385373, 5898.439648233411, 5792.7103644818435, 5794.942050579609, 5798.652080875161, 5809.2738407699035, 5823.35943046273, 5695.743691533974, 5792.623479473821, 5794.449527294901, 5800.361960184292, 5803.245578074823, 5600.85997850057, 5608.8878222434505, 5673.943260567342, 5687.317521897398, 5732.684702341411, 5868.765249389977, 5876.265466816648, 5876.941230587639, 5896.7936122235515, 5898.380670029585, 5511.917321240105, 5690.487856092972, 5694.487496125369, 5695.686737229492, 5699.34457537372], "value": 5476.42160833709, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.437020460358, 596.8090211132437, 637.5314144104084, 655.5247445601937, 661.9205695316563, 34389.65610343896, 44469.99885005174, 45181.32228016583, 45221.54778452215, 45243.09513809722, 48319.0, 48545.51454485454, 48767.75616121914, 48826.51173488264, 48850.0, 8407.70573029944, 8961.775955601113, 9103.135202155818, 9109.45343279402, 9111.043340449256, 8463.534505602189, 10637.414942178177, 10877.02106810387, 10897.237193396466, 11133.610323638673, 11145.0, 11205.551777928873, 11211.719707007349, 11215.046721028722, 11218.439078046065, 10920.563177472892, 10965.780684386267, 10995.790463049058, 10996.450177491093, 11004.229703920728, 10829.891701082966, 10900.07349375304, 10900.07349375304, 10902.945485272603, 10907.454627268684, 44152.3377149343, 44406.0, 44459.55540444619, 44525.10949780986, 44527.33209001867, 3616.7287453440836, 3952.249072676211, 4254.532001479834, 4289.335153051282, 4344.370066340363, 31642.525362119355, 33207.66792332094, 33520.16199595005, 33731.83134084338, 34748.826255868815, 4550.567696068868, 4570.748608826513, 4574.817007319703, 4584.770761461947, 4665.09030739006, 355038.0, 355523.0, 356285.9999999974, 356506.0, 357471.21264393773, 64795.67602161959, 65171.0, 65198.0, 65228.347716523174, 65240.0, 40046.799766000986, 40900.386494202015, 41165.382519261635, 43002.35496467556, 43002.78498607487, 19467.51331216731, 19637.60724785496, 19642.803571964098, 19643.508912277022, 19647.705284420746, 12871.292078935749, 12875.35623218854, 13793.24137172445, 14087.929560352133, 14763.77854332186, 19900.303489377802, 20935.581288374146, 20973.895130524248, 21042.158313667587, 21052.78947210539, 6987.755428560077, 7040.683169257396, 7082.893756593655, 7096.53872498286, 7313.341799238094, 931.7763736703278, 980.7838280532089, 992.9255305851946, 997.4264797741328, 1012.1245122968579, 33209.66790332114, 33606.66393336084, 33630.327393452484, 33742.156446089044, 33875.0, 1093.7101668057971, 1101.7025403141106, 1121.9495122719497, 1169.5964892112208, 1171.6485054483621, 17346.91326543359, 17476.475705728848, 17756.37852675176, 17760.55598610045, 17781.0, 544980.0, 549923.0, 552152.0, 554320.0, 554724.0, 41792.791036044626, 42003.7899810499, 42069.57930420718, 42201.57798422038, 42263.15473690509, 1296.5915736542959, 1338.7456383287144, 1363.7272545490941, 1387.5559820857432, 1409.598264494614, 31817.0, 33321.666783332825, 34195.316093678484, 34257.14357140992, 34990.30019399649, 58094.709526453786, 60020.699896500235, 60095.699521502116, 65016.67491662512, 65114.0, 453481.0, 460218.0, 460390.0, 461105.0, 461343.0, 39579.80210098931, 40579.0, 41854.6763588764, 44066.0, 44160.0, 48847.75576122239, 49375.25937110875, 49411.0, 49718.50281497139, 49838.25242621291, 39502.40746388864, 42420.78789606032, 43338.78330608453, 44635.10729785451, 44831.551684482736, 42966.78516607397, 42999.57000430081, 43605.0, 43751.56248437602, 44946.3258051136, 41629.0, 42317.36523952205, 42407.0, 43768.562314376446, 43795.34306985334, 35819.462708059924, 38523.42214866835, 38583.614163858, 38703.61296387113, 39396.2120757589, 28882.422351553272, 28985.275368115967, 29071.273218169714, 29203.561946570393, 29317.0], "value": 21279.32407716664, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.3134624119636, 412.2394182732857, 413.25820152825673, 422.3074158380256, 427.4379191363357, 18528.536786580324, 19199.616007679837, 19783.208671653116, 20117.698234526477, 20122.0, 12804.423800928957, 13048.28234447105, 18189.7271540927, 19747.0, 19860.80139198611, 5351.411344752074, 5467.6719396836115, 5810.912836307459, 5947.910781338283, 5956.076808094731, 3993.3011722948368, 4157.5010998680045, 5854.88290234195, 5907.084401917709, 5911.733971971272, 5634.887302253953, 5860.326062502802, 5898.557608179382, 6006.939930600682, 6018.699065046752, 5973.551983601247, 5990.161377407167, 6226.782062627832, 6566.967165164191, 6616.338366163393, 5965.373635768268, 5968.820935371902, 5975.611585246945, 5976.073708575178, 5977.252843394575, 14216.644583885382, 16198.271077801528, 23750.524989500285, 23860.761392386026, 23964.0, 2238.3396897915154, 2260.400993736661, 2288.5880541502524, 2413.1553956115395, 2518.937026574332, 10138.645147419878, 10532.684019479428, 10538.789224215549, 10555.208359373079, 11014.669559913216, 1967.527793329605, 1972.556174860645, 2017.4956260934766, 2019.2730616977876, 2034.338839877031, 83541.0, 85311.57344213239, 86483.0, 86997.0, 87306.56346718289, 11273.492692828842, 11807.763844723057, 11828.881711182778, 11863.940680296544, 12165.695857603454, 17078.658426831644, 17092.0599367036, 17107.657846842994, 17114.743278850827, 17138.914305428392, 8632.093630168867, 8678.78303042429, 8721.694740684046, 8901.75375447438, 8954.2836573074, 8475.194856488624, 8486.872696909551, 8554.657813687383, 8722.738317850475, 8739.388242823068, 5045.974770126126, 5081.8475445736685, 5090.2364645303505, 5116.56509196715, 5190.792368305301, 1843.8617103717274, 2015.748031496063, 2060.733193487152, 2081.91672333108, 2098.674705420662, 914.8078903430221, 963.8120566489467, 986.9506524673737, 1000.0049950299499, 1003.4832061488194, 19146.52133696669, 19224.903875480533, 19354.129064192144, 19364.612707746048, 19655.213791448467, 951.1439704266215, 958.5830163878595, 975.6195083917278, 1019.8113349030453, 1030.891756365571, 10445.321054131457, 10850.511726972147, 10904.182186336056, 10970.780584388267, 11002.119830413547, 463197.0, 465899.0, 466778.0, 468771.0, 470599.0, 87126.0, 87254.56372718095, 88645.0, 89034.0, 89106.0, 1008.702432782331, 1015.3248090020054, 1083.0360978728938, 1084.804735147681, 1085.2349093888947, 16452.0, 16637.750433743262, 17018.319267229173, 17427.128643568023, 17935.73096403581, 43066.56933430626, 43705.12589748251, 43757.0, 43841.34237986369, 43909.78045109754, 59303.70348148232, 59451.0, 59853.700731496065, 60990.69504652448, 61110.0, 7934.2859142677435, 8101.392395570474, 8306.916930830614, 8361.665533378597, 8526.403151779565, 11545.307281563133, 12476.750464990831, 12892.48430062787, 13172.670683232996, 13316.33418329099, 10486.528106235086, 10833.133349332193, 11282.605108821152, 11469.082473402275, 11599.130065244972, 5287.709175995357, 10235.437050962268, 10934.890651093705, 11001.487357461576, 11210.383428911487, 11226.719332016764, 11238.55045798159, 11458.369789661649, 11592.0146787524, 11707.180497365103, 8214.63034163476, 8346.62440190205, 8357.038940521918, 8741.650333986569, 8984.0, 8776.605052772768, 11092.389918554558, 11302.208845380745, 11381.0, 11818.054555635701], "value": 9236.04849291128, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.274306961124, 1500.0924440713368, 1632.7224371856782, 1739.9391021314257, 1744.3109971561234, 7739.303462688364, 8198.590070496473, 8238.588070596461, 8261.50430974142, 8267.462614930026, 7091.929080709191, 7291.416686665068, 7293.307135822089, 7480.812979675511, 8117.39119566032, 2336.2991102669216, 2396.59257926153, 2420.394901274681, 2437.609982402816, 2443.621238707994, 2426.1993542131054, 2438.890249938757, 2454.472288457981, 2460.052879641342, 2460.3111128883943, 2405.783479486846, 2411.204302580153, 2424.9030038798514, 2430.6597076409316, 2431.234161239204, 2352.2355234548754, 2391.1989483522866, 2397.029203172709, 2400.039984006403, 2400.531896280226, 2369.372116389141, 2369.5024044950583, 2383.4637206628545, 2383.5232953409386, 2390.964135537968, 8093.838123237561, 8141.1451797561585, 8151.755447336589, 8154.959225203836, 8166.142555031695, 5104.3619547556555, 5235.110031294651, 5242.9213561796605, 5248.317718696583, 5248.632595718302, 3161.7154456098833, 3276.7050965413227, 3375.835336808797, 3381.5942086949476, 3388.796672199676, 1033.2302434686133, 1068.114777417858, 1074.2265568790458, 1077.8113830079706, 1095.11842966412, 11061.889381106246, 11141.944290278578, 11158.609448669338, 11196.384198869058, 11201.71995700114, 4458.130664520388, 4542.613877820422, 4642.86071417858, 4644.094401591725, 4660.790264438108, 9368.110029547182, 9368.203702685349, 9384.061593840697, 9385.62457501706, 9405.529723513797, 5184.196449550326, 5192.039472697563, 5193.039287731782, 5198.2202669599865, 5199.012187684328, 4276.294411422143, 4695.3426520287185, 4795.568398844121, 4830.082284365959, 4839.201531747222, 3614.042278796121, 3797.2595343907674, 3885.1452680410266, 3976.661983731415, 3978.4629075074495, 1281.1288323939625, 1283.6983308922395, 1284.6980959474515, 1302.8110923915979, 1319.6239071864472, 965.8551217317319, 970.3207754571828, 979.2508730820928, 984.601236499219, 992.8014397120605, 5754.251947246831, 5799.33307669615, 5808.680522571215, 5880.441358070976, 5882.882342353129, 931.6925414613162, 964.5002021856081, 995.3977843404781, 1008.4302369161547, 1024.4979959819634, 4078.898027549276, 4079.102597428561, 4092.3043082676018, 4129.442525259052, 4149.854755083557, 9743.853842192373, 9964.900350996397, 10040.548175332127, 10071.798564028679, 10074.546645400975, 8861.556922153866, 9152.95423522878, 9280.257579393767, 9488.240940724725, 9506.809863802824, 7546.698132074765, 7561.848763024709, 7645.00614920068, 7734.57459839703, 7739.883901741478, 5727.455891690282, 5763.94236057634, 5864.384239654775, 5883.470487656132, 5962.807438512402, 8914.0, 8964.238039766693, 9030.999999999738, 9094.681686141217, 9117.0, 9214.815703686023, 9219.631214751334, 9237.07629237071, 9286.489243091695, 9309.953450232977, 6648.966755166387, 7280.162781280221, 7405.333519983227, 7419.591922444318, 7436.479446438698, 7102.360787529147, 7555.09338879338, 7887.802804929923, 7899.447038707465, 8063.516189028677, 7051.823704407431, 7148.892766608401, 7154.248803875518, 7178.24628414009, 7316.634168291671, 7110.040144580622, 7119.6084215368655, 7129.4652901031595, 7149.7140114396925, 7161.534500257467, 6669.866602667822, 6714.630695311805, 6774.254831968578, 6798.422134118655, 6799.762008329685, 4797.808087676453, 4891.706497610013, 4925.679830810986, 4938.358013458371, 5021.573166280907, 4973.850784476472, 5047.697138171721, 5114.974425127851, 5139.4603566626465, 5150.48495150482], "value": 4475.078189647478, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.42822345565617, 346.68798081726453, 350.6388419927476, 350.8177442020392, 353.5651149086623, 5492.890142197154, 5495.6702597844105, 5500.147477141039, 5527.50252477277, 5543.473370029851, 5105.974470127653, 5230.6600070995455, 5249.737513124348, 5352.330958630171, 5377.0321342158395, 4204.2432362174795, 4214.157168566284, 4223.197592457439, 4236.661067114639, 4254.27677294859, 4225.661947044229, 4234.280172370689, 4235.8093885775215, 4248.192843359767, 4251.957480425187, 3998.8000599969887, 4207.305794543912, 4257.212415703105, 4258.425112609804, 4262.893427664318, 4211.0, 4225.197212529641, 4230.8519201827785, 4246.917036155776, 4248.957510424887, 3736.1220113273357, 3748.3253014457387, 3750.7749535027715, 3756.605556416564, 3780.7542509736777, 5037.5718063964605, 5266.34170728659, 5282.973585132088, 5300.072487314743, 5307.389650190239, 4791.401074865642, 4805.807767689324, 4826.372571565709, 4827.203511420611, 4842.12841688496, 5616.213730077792, 5631.352394474647, 5636.351819540764, 5641.605087643867, 5659.971700141514, 4000.239954408653, 4060.6345428911245, 4065.8170382332864, 4087.652549533293, 4122.40225167352, 5843.655959129382, 5855.473007429309, 5858.472737453607, 5868.325142608612, 5880.705964701748, 4239.1521695660995, 4254.510731265882, 4267.295896177158, 4281.2293787118, 4287.828486860553, 4102.646126778156, 4269.188854117708, 4290.635295999875, 4318.78406079701, 4340.327249276367, 4800.879978000578, 4800.975995120002, 4819.349387832598, 4840.177169881129, 4847.175980083394, 5624.353199382123, 5647.181158731961, 5649.700568869183, 5661.377248502661, 5691.573132015115, 1419.9432022718975, 1424.287856071964, 1437.4690954133814, 1438.6691061056015, 1448.4278709909527, 984.9953047891254, 993.1409330928694, 1005.1305620638242, 1006.4917216805612, 1014.9644762433279, 5291.814786482531, 5295.841124766263, 5304.204369344629, 5308.681479111266, 5313.601479889024, 5594.384617692132, 5601.974933535845, 5613.943860561424, 5617.876424715073, 5621.4659607337235, 5107.719075450812, 5294.49702278283, 5300.893982120413, 5328.946710532845, 5329.653572517774, 2973.8513074346197, 2981.5390458675092, 2983.9104826855228, 2984.253936515871, 2990.327176385296, 5678.716064196774, 5726.885462290731, 5774.48029677331, 5785.4214578541805, 5791.276090488689, 5433.565314774809, 5621.775128994795, 5629.802956896489, 5645.745941432645, 5649.519790817744, 5784.2769653793275, 5789.768409263583, 5792.304923409218, 5798.94201057984, 5800.332961709458, 5573.27547418833, 5584.916226256528, 5606.523445507178, 5608.747606357642, 5860.531157507304, 5791.218185545066, 5798.855028624318, 5810.883782324246, 5829.562782791223, 5833.329167145663, 6093.725782339717, 6116.0, 6119.4798442132915, 6122.755089796358, 6141.232345956755, 4019.8995025124605, 4064.674826013971, 4211.852585159627, 4245.469316335458, 4248.468941382327, 5779.479846813639, 5791.189233507396, 5900.170947006442, 5901.852453688693, 5910.734016969161, 5737.397573254748, 5754.187430959234, 5756.251687280626, 5759.992001399822, 5761.366249712612, 5585.301837270341, 5621.718914054362, 5682.602217844711, 5691.8292451226525, 5734.168545560787, 5636.379998200113, 5665.376808551138, 5671.234383358359, 5671.858203544944, 5684.8294551163535, 5557.638753481173, 5716.0, 5719.456651618089, 5734.655920644775, 5767.904098221325, 5515.31782806248, 5574.888502230014, 5585.547757583139, 5593.8321850344555, 5607.355154157324], "value": 4315.902842051988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.3314949143739, 780.4341852157185, 792.5535896987998, 801.9438639295252, 866.5060915278292, 14223.43106275749, 14383.496577619771, 14534.854651453483, 14707.705845883103, 15066.0, 13111.934440327808, 14838.629034274149, 14927.7014459711, 15018.324175412105, 15019.098854068763, 834.7454026521908, 863.1756672377895, 863.5984267315697, 863.6027427383411, 864.0193380513132, 836.2891542189151, 837.5351679817729, 839.093778718982, 840.1094839470181, 840.3319361107904, 878.6221924572432, 880.0978996528545, 880.6477409036372, 880.8766772651834, 881.4006475596624, 874.6676263020075, 876.0319846569513, 877.675260153744, 877.9078196789341, 878.3895192840978, 648.5460177875506, 652.2271108736115, 652.422605993699, 652.6964961293022, 653.3858173317067, 14101.294935253196, 14125.223112728796, 14134.787978180335, 15700.0, 15830.604234894105, 14569.927150364287, 14792.852071479256, 15157.0, 15401.537953861402, 15524.767128493082, 11652.00957918578, 11711.7072073198, 12086.274823510617, 12160.148789584733, 12222.877771222351, 3799.715021373408, 3805.904852378685, 3928.5874983126646, 3932.7640341579313, 3981.3231750602467, 38864.80567597172, 46397.30404043942, 58183.70908145432, 65767.67116164436, 68657.31342686558, 11472.4837382318, 11867.406629668481, 12014.939925300318, 12038.87961120395, 12060.457279422448, 21106.78893211079, 21256.574868502852, 21435.356939291847, 21444.785552144593, 21516.677249841265, 8283.50298982063, 8293.0, 8520.14798520143, 8642.265407440438, 8655.826883462421, 4386.385905973167, 4472.195004899084, 4527.750973696412, 4534.183846907522, 4576.633869290449, 3180.236743181666, 3228.838558072087, 3233.7873297513433, 3563.1448452371765, 3714.108613932691, 619.5074915442234, 647.8833809914261, 653.5033374635311, 657.6613044282199, 658.2232965101131, 554.282204545107, 576.3199424678835, 622.8536293970914, 643.9678016099176, 671.7078071039114, 9152.496612686366, 9215.354925155309, 9239.076092390707, 9337.486438245962, 9399.0, 635.9554831161867, 725.9401274139709, 740.7999840043158, 751.0686748431905, 766.5285849202812, 4387.210302145644, 4548.7725613719185, 4601.930971035437, 4628.305754136906, 4703.0593881223895, 74361.62819185869, 75100.62449687716, 78500.60749696215, 86215.56892215624, 88590.55704721434, 72180.2781972184, 72411.63794180995, 73924.26075739281, 74643.62678186683, 75602.0, 66624.0, 68224.0, 68450.3154968444, 69456.30543694498, 72201.6389918047, 9661.758456038655, 10013.299069065388, 10058.02132407637, 10171.0, 10350.896491034993, 43241.783791080845, 43948.0, 44625.33062004137, 44832.775836120614, 45100.548994509634, 57495.425045749005, 60333.0, 62965.59240853096, 64271.35728642841, 64329.678351609815, 12469.625911222678, 12554.686132846751, 12694.87305126937, 12947.805782913452, 13081.280529570964, 14499.0, 14608.488702895773, 14712.337944792724, 14726.779098313747, 14928.178950157411, 13010.869891300967, 13271.469141234242, 13378.464861405435, 13503.527376542166, 13946.930265348608, 13403.262820544574, 13482.19106853592, 13537.59387218385, 13647.365203691741, 14013.43946242139, 12887.93556032214, 13016.284104373972, 13149.276789776653, 14338.49815256461, 14362.532523850823, 10620.84068738954, 11445.25605835618, 11591.884081159418, 11811.350375729417, 12184.57353992606, 10940.288881222696, 11458.000638773408, 11552.364619945984, 11756.412179390825, 11801.29192248468], "value": 7263.396813121592, "unit": "score"}], "name": "dromaeo_css", "value": 7297.375236622402, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 112.0, 113.0, 114.0, 111.0, 111.0, 113.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 121.0, 146.0, 118.0, 121.0, 116.0, 116.0, 148.0, 120.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 162.0, 160.0, 160.0, 160.0, 159.0, 161.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 115.0, 75.0, 75.0, 78.0, 75.0, 97.0, 75.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 83.0, 85.0, 83.0, 98.0, 83.0, 81.0, 103.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 52.0, 51.0, 51.0, 53.0, 51.0, 50.0, 50.0, 50.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 60.0, 60.0, 59.0, 61.0, 59.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 81.0, 75.0, 76.0, 75.0, 74.0, 75.0, 74.0, 74.0], "value": 75.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 135.0, 124.0, 129.0, 123.0, 121.0, 122.0, 119.0, 164.0, 132.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 157.0, 158.0, 160.0, 156.0, 159.0, 156.0, 158.0], "value": 158.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 65.0, 62.0, 62.0, 64.0, 70.0, 64.0, 62.0, 61.0], "value": 63.6, "unit": "score"}], "name": "kraken", "value": 1454.6999999999998, "alertThreshold": 2.0}]} 05:22:31 INFO - Return code: 0 05:22:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:22:31 INFO - # TBPL SUCCESS # 05:22:31 INFO - Running post-action listener: _resource_record_post_action 05:22:31 INFO - [mozharness: 2017-02-17 13:22:31.245732Z] Finished run-tests step (success) 05:22:31 INFO - Running post-run listener: _resource_record_post_run 05:22:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 442368; Write bytes: 324718592; Read time: 768; Write time: 276968 05:22:31 INFO - TinderboxPrint: CPU usage
13.0% 05:22:31 INFO - TinderboxPrint: I/O read bytes / time
442,368 / 768 05:22:31 INFO - TinderboxPrint: I/O write bytes / time
324,718,592 / 276,968 05:22:31 INFO - TinderboxPrint: CPU idle
8,274.6 (87.0%) 05:22:31 INFO - TinderboxPrint: CPU user
1,188.2 (12.5%) 05:22:31 INFO - TinderboxPrint: Swap in / out
0 / 0 05:22:31 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107696128; Read time: 76; Write time: 114848 05:22:31 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 438272; Write bytes: 217022464; Read time: 692; Write time: 162120 05:22:31 INFO - Running post-run listener: _upload_blobber_files 05:22:31 INFO - Blob upload gear active. 05:22:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:22:31 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 05:22:31 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'] 05:22:31 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 05:22:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:35 INFO - (blobuploader) - INFO - Done attempting. 05:22:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:22:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:35 INFO - (blobuploader) - INFO - Done attempting. 05:22:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:22:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:22:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:22:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:22:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:22:36 INFO - (blobuploader) - INFO - Done attempting. 05:22:36 INFO - (blobuploader) - INFO - Iteration through files over. 05:22:36 INFO - Return code: 0 05:22:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:22:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:22:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e04a97bcbf281c184c0ca3dae5a00bd3198f348f055358777122afeb421247462c03fc6e6d265dd1d1a1ec1f09e6dbc4c62c90b4675a336de6991432566f6335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/832286153422bbc35729b59223a80fdca68f84b2eae87a2dfc4027d346c7081d32e8567433c9f432baaa5c83896d4451ec839c2ad3146b4f01af3c3914ce3154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da47bfc4c4f03380dff37fa009313df1fc46f76e23345a01b40ad48c1e797dee0c585c39cabaf9f6d4150e5bc21773d90eb70fe8312860fd01bd6a67af639913"} 05:22:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:22:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:22:36 INFO - Contents: 05:22:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e04a97bcbf281c184c0ca3dae5a00bd3198f348f055358777122afeb421247462c03fc6e6d265dd1d1a1ec1f09e6dbc4c62c90b4675a336de6991432566f6335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/832286153422bbc35729b59223a80fdca68f84b2eae87a2dfc4027d346c7081d32e8567433c9f432baaa5c83896d4451ec839c2ad3146b4f01af3c3914ce3154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da47bfc4c4f03380dff37fa009313df1fc46f76e23345a01b40ad48c1e797dee0c585c39cabaf9f6d4150e5bc21773d90eb70fe8312860fd01bd6a67af639913"} 05:22:36 INFO - Running post-run listener: copy_logs_to_upload_dir 05:22:36 INFO - Copying logs to upload dir... 05:22:36 INFO - mkdir: /builds/slave/test/build/upload/logs 05:22:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.302222 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-02-17 05:22:36.658437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 05:22:36.661791) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093 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/e04a97bcbf281c184c0ca3dae5a00bd3198f348f055358777122afeb421247462c03fc6e6d265dd1d1a1ec1f09e6dbc4c62c90b4675a336de6991432566f6335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/832286153422bbc35729b59223a80fdca68f84b2eae87a2dfc4027d346c7081d32e8567433c9f432baaa5c83896d4451ec839c2ad3146b4f01af3c3914ce3154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da47bfc4c4f03380dff37fa009313df1fc46f76e23345a01b40ad48c1e797dee0c585c39cabaf9f6d4150e5bc21773d90eb70fe8312860fd01bd6a67af639913"} build_url:https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/SWVkmhq7TsWmivUtRxknMA/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/e04a97bcbf281c184c0ca3dae5a00bd3198f348f055358777122afeb421247462c03fc6e6d265dd1d1a1ec1f09e6dbc4c62c90b4675a336de6991432566f6335", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/832286153422bbc35729b59223a80fdca68f84b2eae87a2dfc4027d346c7081d32e8567433c9f432baaa5c83896d4451ec839c2ad3146b4f01af3c3914ce3154", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/da47bfc4c4f03380dff37fa009313df1fc46f76e23345a01b40ad48c1e797dee0c585c39cabaf9f6d4150e5bc21773d90eb70fe8312860fd01bd6a67af639913"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 05:22:36.686151) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:22:36.686470) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1487336520.898941-484811093 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 05:22:36.769169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 05:22:36.769490) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 05:22:36.769780) ========= ========= Total master_lag: 0.17 =========