builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-022 starttime: 1475688825.97 results: success (0) buildid: 20161005092400 builduid: 9a60435666a54ff5880f0f342a6b22f5 revision: fd5aadb06d74dec6ee7787bd0f696a318ebcd40e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:45.970332) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:45.970840) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:45.971159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:45.985984) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:45.986280) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 10:33:46-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-10-05 10:33:46 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:46.120346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:46.121127) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017073 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:46.172427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 10:33:46.172798) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fd5aadb06d74dec6ee7787bd0f696a318ebcd40e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev fd5aadb06d74dec6ee7787bd0f696a318ebcd40e --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=9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 10:33:46,787 truncating revision to first 12 chars 2016-10-05 10:33:46,787 Setting DEBUG logging. 2016-10-05 10:33:46,787 attempt 1/10 2016-10-05 10:33:46,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fd5aadb06d74?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 10:33:48,085 unpacking tar archive at: autoland-fd5aadb06d74/testing/mozharness/ program finished with exit code 0 elapsedTime=1.695834 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-05 10:33:47.886804) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:47.887802) ========= script_repo_revision: fd5aadb06d74dec6ee7787bd0f696a318ebcd40e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:47.888921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:47.889609) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 10:33:47.901851) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-05 10:33:47.902155) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:33:48 INFO - MultiFileLogger online at 20161005 10:33:48 in /builds/slave/test 10:33:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 10:33:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:48 INFO - {'append_to_log': False, 10:33:48 INFO - 'base_work_dir': '/builds/slave/test', 10:33:48 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 10:33:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:48 INFO - 'branch': 'Autoland-Non-PGO', 10:33:48 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:48 INFO - 'config_files': ('talos/linux_config.py',), 10:33:48 INFO - 'default_actions': ('clobber', 10:33:48 INFO - 'read-buildbot-config', 10:33:48 INFO - 'download-and-extract', 10:33:48 INFO - 'populate-webroot', 10:33:48 INFO - 'create-virtualenv', 10:33:48 INFO - 'install', 10:33:48 INFO - 'run-tests'), 10:33:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:48 INFO - 'download_minidump_stackwalk': True, 10:33:48 INFO - 'download_symbols': 'ondemand', 10:33:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:48 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:48 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:48 INFO - 'installer_path': 'installer.exe', 10:33:48 INFO - 'log_level': 'info', 10:33:48 INFO - 'log_name': 'talos', 10:33:48 INFO - 'log_to_console': True, 10:33:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:33:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:33:48 INFO - 'opt_config_files': (), 10:33:48 INFO - 'pip_index': False, 10:33:48 INFO - 'sps_profile': False, 10:33:48 INFO - 'sps_profile_interval': 0, 10:33:48 INFO - 'suite': 'dromaeojs', 10:33:48 INFO - 'system_bits': '32', 10:33:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:48 INFO - 'title': 'talos-linux64-ix-022', 10:33:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:48 INFO - 'use_talos_json': True, 10:33:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:48 INFO - 'work_dir': 'build'} 10:33:48 INFO - [mozharness: 2016-10-05 17:33:48.623240Z] Running clobber step. 10:33:48 INFO - Running pre-action listener: _resource_record_pre_action 10:33:48 INFO - Running main action method: clobber 10:33:48 INFO - rmtree: /builds/slave/test/build 10:33:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:49 INFO - Running post-action listener: _resource_record_post_action 10:33:49 INFO - [mozharness: 2016-10-05 17:33:49.083402Z] Finished clobber step (success) 10:33:49 INFO - [mozharness: 2016-10-05 17:33:49.083502Z] Running read-buildbot-config step. 10:33:49 INFO - Running pre-action listener: _resource_record_pre_action 10:33:49 INFO - Running main action method: read_buildbot_config 10:33:49 INFO - Using buildbot properties: 10:33:49 INFO - { 10:33:49 INFO - "project": "", 10:33:49 INFO - "product": "firefox", 10:33:49 INFO - "script_repo_revision": "production", 10:33:49 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 10:33:49 INFO - "repository": "", 10:33:49 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 10:33:49 INFO - "buildid": "20161005092400", 10:33:49 INFO - "pgo_build": "False", 10:33:49 INFO - "basedir": "/builds/slave/test", 10:33:49 INFO - "buildnumber": 791, 10:33:49 INFO - "slavename": "talos-linux64-ix-022", 10:33:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:33:49 INFO - "platform": "ubuntu64_hw", 10:33:49 INFO - "scheduler": "tests-autoland-linux64-talos", 10:33:49 INFO - "branch": "autoland", 10:33:49 INFO - "repo_path": "integration/autoland", 10:33:49 INFO - "revision": "fd5aadb06d74dec6ee7787bd0f696a318ebcd40e", 10:33:49 INFO - "stage_platform": "linux64", 10:33:49 INFO - "builduid": "9a60435666a54ff5880f0f342a6b22f5", 10:33:49 INFO - "slavebuilddir": "test" 10:33:49 INFO - } 10:33:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 10:33:49 INFO - Running post-action listener: _resource_record_post_action 10:33:49 INFO - [mozharness: 2016-10-05 17:33:49.085941Z] Finished read-buildbot-config step (success) 10:33:49 INFO - [mozharness: 2016-10-05 17:33:49.086028Z] Running download-and-extract step. 10:33:49 INFO - Running pre-action listener: _resource_record_pre_action 10:33:49 INFO - Running main action method: download_and_extract 10:33:49 INFO - mkdir: /builds/slave/test/build/tests 10:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:49 INFO - trying https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:33:49 INFO - Downloading https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:33:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:33:49 INFO - Downloaded 1361 bytes. 10:33:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 10:33:49 INFO - Using the following test package requirements: 10:33:49 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:33:49 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:33:49 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:33:49 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'jsshell-linux-x86_64.zip'], 10:33:49 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:33:49 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 10:33:49 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:33:49 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:33:49 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:33:49 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 10:33:49 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:33:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:33:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:33:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:33:49 INFO - Fetch https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:33:50 INFO - Http code: 200 10:33:50 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 10:33:50 INFO - x-amz-cf-id: Aa-_fasPT7Iv39PdRyFNFLdYIXgOAgnB0lr2eLNVj9mbBrcAdJykww== 10:33:50 INFO - x-amz-version-id: Mbg2wdYXjGB7lrsUGr3GNb4..VVxhmvo 10:33:50 INFO - Expected file size: 20421412 10:33:50 INFO - Obtained file size: 20421412 10:33:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:33:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 10:33:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:33:54 INFO - Fetch https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:33:55 INFO - Http code: 200 10:33:55 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 10:33:55 INFO - x-amz-cf-id: 4umrnIU2oPk4nxU5g1OCtknHO3dGTGwD9FOWTPQ1ohfj4oS6S_fsLA== 10:33:55 INFO - x-amz-version-id: Mbg2wdYXjGB7lrsUGr3GNb4..VVxhmvo 10:33:55 INFO - Expected file size: 20421412 10:33:55 INFO - Obtained file size: 20421412 10:33:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 10:33:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:33:59 INFO - Fetch https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:34:00 INFO - Http code: 200 10:34:00 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 10:34:00 INFO - x-amz-cf-id: w4aDBgoKvyucXNEZn9P-94DFAqGx0rlY0rSW36QufLByYW5hw9iEQg== 10:34:00 INFO - x-amz-version-id: 3VYKgNnDCZMr7hKggcQ67v3fMJZ2M_gE 10:34:01 INFO - Expected file size: 14409006 10:34:01 INFO - Obtained file size: 14409006 10:34:01 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')]} 10:34:01 INFO - trying https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:34:01 INFO - Downloading https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:34:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:34:02 INFO - Downloaded 55809072 bytes. 10:34:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:34:02 INFO - mkdir: /builds/slave/test/properties 10:34:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:34:02 INFO - Writing to file /builds/slave/test/properties/build_url 10:34:02 INFO - Contents: 10:34:02 INFO - build_url:https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 10:34:03 INFO - Running post-action listener: _resource_record_post_action 10:34:03 INFO - Running post-action listener: set_extra_try_arguments 10:34:03 INFO - [mozharness: 2016-10-05 17:34:03.566963Z] Finished download-and-extract step (success) 10:34:03 INFO - [mozharness: 2016-10-05 17:34:03.567193Z] Running populate-webroot step. 10:34:03 INFO - Running pre-action listener: _resource_record_pre_action 10:34:03 INFO - Running main action method: populate_webroot 10:34:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:34:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:34:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:34:03 INFO - '--tppagecycles', 10:34:03 INFO - '7'], 10:34:03 INFO - 'tests': ['tsvgm']}}, 10:34:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:34:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:34:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:34:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:34:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:34:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['damp', 'tps']}, 10:34:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'tests': ['damp', 'tps']}, 10:34:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['dromaeo_dom']}, 10:34:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:34:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['basic_compositor_video']}, 10:34:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:34:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['a11yr', 10:34:03 INFO - 'ts_paint', 10:34:03 INFO - 'tpaint', 10:34:03 INFO - 'sessionrestore', 10:34:03 INFO - 'sessionrestore_no_auto_restore', 10:34:03 INFO - 'tabpaint']}, 10:34:03 INFO - 'other-e10s': {'tests': ['a11yr', 10:34:03 INFO - 'ts_paint', 10:34:03 INFO - 'tpaint', 10:34:03 INFO - 'sessionrestore', 10:34:03 INFO - 'sessionrestore_no_auto_restore', 10:34:03 INFO - 'tabpaint']}, 10:34:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:34:03 INFO - 'ts_paint', 10:34:03 INFO - 'tpaint', 10:34:03 INFO - 'sessionrestore', 10:34:03 INFO - 'sessionrestore_no_auto_restore', 10:34:03 INFO - 'tabpaint']}, 10:34:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:34:03 INFO - 'ts_paint', 10:34:03 INFO - 'tpaint', 10:34:03 INFO - 'sessionrestore', 10:34:03 INFO - 'sessionrestore_no_auto_restore', 10:34:03 INFO - 'tabpaint']}, 10:34:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['a11yr', 10:34:03 INFO - 'ts_paint', 10:34:03 INFO - 'tpaint', 10:34:03 INFO - 'sessionrestore', 10:34:03 INFO - 'sessionrestore_no_auto_restore', 10:34:03 INFO - 'tabpaint']}, 10:34:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['a11yr', 10:34:03 INFO - 'ts_paint', 10:34:03 INFO - 'tpaint', 10:34:03 INFO - 'sessionrestore', 10:34:03 INFO - 'sessionrestore_no_auto_restore', 10:34:03 INFO - 'tabpaint']}, 10:34:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['tsvgx', 10:34:03 INFO - 'tsvgr_opacity', 10:34:03 INFO - 'tart', 10:34:03 INFO - 'tscrollx', 10:34:03 INFO - 'cart']}, 10:34:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:34:03 INFO - 'tsvgr_opacity', 10:34:03 INFO - 'tart', 10:34:03 INFO - 'tscrollx', 10:34:03 INFO - 'cart']}, 10:34:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'talos_options': ['--disable-e10s'], 10:34:03 INFO - 'tests': ['tp5o']}, 10:34:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'tests': ['tp5o']}, 10:34:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'talos_options': ['--disable-e10s', 10:34:03 INFO - '--xperf_path', 10:34:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:03 INFO - 'tests': ['tp5n']}, 10:34:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:34:03 INFO - 'talos_options': ['--xperf_path', 10:34:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:34:03 INFO - 'tests': ['tp5n']}}, 10:34:03 INFO - 'talos.zip': {'path': '', 10:34:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:34:03 INFO - Running post-action listener: _resource_record_post_action 10:34:03 INFO - [mozharness: 2016-10-05 17:34:03.584255Z] Finished populate-webroot step (success) 10:34:03 INFO - [mozharness: 2016-10-05 17:34:03.584344Z] Running create-virtualenv step. 10:34:03 INFO - Running pre-action listener: _resource_record_pre_action 10:34:03 INFO - Running main action method: create_virtualenv 10:34:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:34:03 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 10:34:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:34:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:34:03 INFO - Using real prefix '/usr' 10:34:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:34:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:34:06 INFO - Installing pip.................done. 10:34:06 INFO - Return code: 0 10:34:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:34:06 INFO - Reading from file tmpfile_stdout 10:34:06 INFO - Output received: 10:34:06 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) 10:34:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:06 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 10:34:06 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 10:34:06 INFO - Using env: {'DISPLAY': ':0', 10:34:06 INFO - 'HOME': '/home/cltbld', 10:34:06 INFO - 'LANG': 'en_US.UTF-8', 10:34:06 INFO - 'LANGUAGE': 'en_US:en', 10:34:06 INFO - 'LOGNAME': 'cltbld', 10:34:06 INFO - 'MAIL': '/var/mail/cltbld', 10:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:06 INFO - 'MOZ_NO_REMOTE': '1', 10:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:06 INFO - 'NO_EM_RESTART': '1', 10:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:06 INFO - 'PWD': '/builds/slave/test', 10:34:06 INFO - 'SHELL': '/bin/bash', 10:34:06 INFO - 'SHLVL': '1', 10:34:06 INFO - 'TERM': 'linux', 10:34:06 INFO - 'TMOUT': '86400', 10:34:06 INFO - 'USER': 'cltbld', 10:34:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:06 INFO - '_': '/tools/buildbot/bin/python'} 10:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:06 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 10:34:06 INFO - Cleaning up... 10:34:06 INFO - Return code: 0 10:34:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:06 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:06 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 10:34:06 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 10:34:06 INFO - Using env: {'DISPLAY': ':0', 10:34:06 INFO - 'HOME': '/home/cltbld', 10:34:06 INFO - 'LANG': 'en_US.UTF-8', 10:34:06 INFO - 'LANGUAGE': 'en_US:en', 10:34:06 INFO - 'LOGNAME': 'cltbld', 10:34:06 INFO - 'MAIL': '/var/mail/cltbld', 10:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:06 INFO - 'MOZ_NO_REMOTE': '1', 10:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:06 INFO - 'NO_EM_RESTART': '1', 10:34:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:06 INFO - 'PWD': '/builds/slave/test', 10:34:06 INFO - 'SHELL': '/bin/bash', 10:34:06 INFO - 'SHLVL': '1', 10:34:06 INFO - 'TERM': 'linux', 10:34:06 INFO - 'TMOUT': '86400', 10:34:06 INFO - 'USER': 'cltbld', 10:34:06 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:06 INFO - '_': '/tools/buildbot/bin/python'} 10:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:06 INFO - Downloading/unpacking psutil>=3.1.1 10:34:06 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 10:34:06 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 10:34:06 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 10:34:06 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 10:34:06 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 10:34:06 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 10:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:34:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:08 INFO - Installing collected packages: psutil 10:34:08 INFO - Running setup.py install for psutil 10:34:08 INFO - building 'psutil._psutil_linux' extension 10:34:08 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 10:34:09 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 10:34:09 INFO - building 'psutil._psutil_posix' extension 10:34:09 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 10:34:09 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 10:34:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:34:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:34:09 INFO - Successfully installed psutil 10:34:09 INFO - Cleaning up... 10:34:09 INFO - Return code: 0 10:34:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:34:09 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')]} 10:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:09 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')]} 10:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:09 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:09 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 10:34:09 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 10:34:09 INFO - Using env: {'DISPLAY': ':0', 10:34:09 INFO - 'HOME': '/home/cltbld', 10:34:09 INFO - 'LANG': 'en_US.UTF-8', 10:34:09 INFO - 'LANGUAGE': 'en_US:en', 10:34:09 INFO - 'LOGNAME': 'cltbld', 10:34:09 INFO - 'MAIL': '/var/mail/cltbld', 10:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:09 INFO - 'MOZ_NO_REMOTE': '1', 10:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:09 INFO - 'NO_EM_RESTART': '1', 10:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:09 INFO - 'PWD': '/builds/slave/test', 10:34:09 INFO - 'SHELL': '/bin/bash', 10:34:09 INFO - 'SHLVL': '1', 10:34:09 INFO - 'TERM': 'linux', 10:34:09 INFO - 'TMOUT': '86400', 10:34:09 INFO - 'USER': 'cltbld', 10:34:09 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:09 INFO - '_': '/tools/buildbot/bin/python'} 10:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:34:09 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 10:34:09 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 10:34:09 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 10:34:09 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 10:34:09 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 10:34:09 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 10:34:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:34:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:34:11 INFO - Installing collected packages: mozsystemmonitor 10:34:11 INFO - Running setup.py install for mozsystemmonitor 10:34:11 INFO - Successfully installed mozsystemmonitor 10:34:11 INFO - Cleaning up... 10:34:11 INFO - Return code: 0 10:34:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:11 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:11 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 10:34:11 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 10:34:11 INFO - Using env: {'DISPLAY': ':0', 10:34:11 INFO - 'HOME': '/home/cltbld', 10:34:11 INFO - 'LANG': 'en_US.UTF-8', 10:34:11 INFO - 'LANGUAGE': 'en_US:en', 10:34:11 INFO - 'LOGNAME': 'cltbld', 10:34:11 INFO - 'MAIL': '/var/mail/cltbld', 10:34:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:11 INFO - 'MOZ_NO_REMOTE': '1', 10:34:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:11 INFO - 'NO_EM_RESTART': '1', 10:34:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:11 INFO - 'PWD': '/builds/slave/test', 10:34:11 INFO - 'SHELL': '/bin/bash', 10:34:11 INFO - 'SHLVL': '1', 10:34:11 INFO - 'TERM': 'linux', 10:34:11 INFO - 'TMOUT': '86400', 10:34:11 INFO - 'USER': 'cltbld', 10:34:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:11 INFO - '_': '/tools/buildbot/bin/python'} 10:34:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:11 INFO - Downloading/unpacking jsonschema==2.5.1 10:34:11 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 10:34:11 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 10:34:11 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 10:34:11 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 10:34:11 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 10:34:11 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 10:34:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:34:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:13 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 10:34:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:34:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:34:14 INFO - warning: no files found matching '*.txt' 10:34:14 INFO - no previously-included directories found matching 'build' 10:34:14 INFO - no previously-included directories found matching 'dist' 10:34:14 INFO - no previously-included directories found matching '.git*' 10:34:14 INFO - Installing collected packages: jsonschema, functools32 10:34:14 INFO - Running setup.py install for functools32 10:34:14 INFO - warning: no files found matching '*.txt' 10:34:14 INFO - no previously-included directories found matching 'build' 10:34:14 INFO - no previously-included directories found matching 'dist' 10:34:14 INFO - no previously-included directories found matching '.git*' 10:34:14 INFO - Successfully installed jsonschema functools32 10:34:14 INFO - Cleaning up... 10:34:14 INFO - Return code: 0 10:34:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:34:14 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')]} 10:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:14 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')]} 10:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:14 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:14 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 10:34:14 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 10:34:14 INFO - Using env: {'DISPLAY': ':0', 10:34:14 INFO - 'HOME': '/home/cltbld', 10:34:14 INFO - 'LANG': 'en_US.UTF-8', 10:34:14 INFO - 'LANGUAGE': 'en_US:en', 10:34:14 INFO - 'LOGNAME': 'cltbld', 10:34:14 INFO - 'MAIL': '/var/mail/cltbld', 10:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:14 INFO - 'MOZ_NO_REMOTE': '1', 10:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:14 INFO - 'NO_EM_RESTART': '1', 10:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:14 INFO - 'PWD': '/builds/slave/test', 10:34:14 INFO - 'SHELL': '/bin/bash', 10:34:14 INFO - 'SHLVL': '1', 10:34:14 INFO - 'TERM': 'linux', 10:34:14 INFO - 'TMOUT': '86400', 10:34:14 INFO - 'USER': 'cltbld', 10:34:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:14 INFO - '_': '/tools/buildbot/bin/python'} 10:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:34:14 INFO - Cleaning up... 10:34:14 INFO - Return code: 0 10:34:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:34:14 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')]} 10:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:14 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')]} 10:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:14 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:14 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 10:34:14 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 10:34:14 INFO - Using env: {'DISPLAY': ':0', 10:34:14 INFO - 'HOME': '/home/cltbld', 10:34:14 INFO - 'LANG': 'en_US.UTF-8', 10:34:14 INFO - 'LANGUAGE': 'en_US:en', 10:34:14 INFO - 'LOGNAME': 'cltbld', 10:34:14 INFO - 'MAIL': '/var/mail/cltbld', 10:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:14 INFO - 'MOZ_NO_REMOTE': '1', 10:34:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:14 INFO - 'NO_EM_RESTART': '1', 10:34:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:14 INFO - 'PWD': '/builds/slave/test', 10:34:14 INFO - 'SHELL': '/bin/bash', 10:34:14 INFO - 'SHLVL': '1', 10:34:14 INFO - 'TERM': 'linux', 10:34:14 INFO - 'TMOUT': '86400', 10:34:14 INFO - 'USER': 'cltbld', 10:34:14 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:14 INFO - '_': '/tools/buildbot/bin/python'} 10:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:14 INFO - Downloading/unpacking blobuploader==1.2.4 10:34:14 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 10:34:14 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 10:34:14 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 10:34:14 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 10:34:14 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 10:34:14 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 10:34:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:34:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:34:17 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 10:34:17 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 10:34:17 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 10:34:17 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 10:34:17 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 10:34:17 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 10:34:17 INFO - Downloading docopt-0.6.1.tar.gz 10:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:34:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:34:17 INFO - Running setup.py install for blobuploader 10:34:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:34:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:34:17 INFO - Running setup.py install for requests 10:34:17 INFO - Running setup.py install for docopt 10:34:17 INFO - Successfully installed blobuploader requests docopt 10:34:17 INFO - Cleaning up... 10:34:18 INFO - Return code: 0 10:34:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:18 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')]} 10:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:18 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')]} 10:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:18 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:18 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 10:34:18 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 10:34:18 INFO - Using env: {'DISPLAY': ':0', 10:34:18 INFO - 'HOME': '/home/cltbld', 10:34:18 INFO - 'LANG': 'en_US.UTF-8', 10:34:18 INFO - 'LANGUAGE': 'en_US:en', 10:34:18 INFO - 'LOGNAME': 'cltbld', 10:34:18 INFO - 'MAIL': '/var/mail/cltbld', 10:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:18 INFO - 'MOZ_NO_REMOTE': '1', 10:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:18 INFO - 'NO_EM_RESTART': '1', 10:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:18 INFO - 'PWD': '/builds/slave/test', 10:34:18 INFO - 'SHELL': '/bin/bash', 10:34:18 INFO - 'SHLVL': '1', 10:34:18 INFO - 'TERM': 'linux', 10:34:18 INFO - 'TMOUT': '86400', 10:34:18 INFO - 'USER': 'cltbld', 10:34:18 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:18 INFO - '_': '/tools/buildbot/bin/python'} 10:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:18 INFO - Running setup.py (path:/tmp/pip-O6_d9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:18 INFO - Running setup.py (path:/tmp/pip-UNAuJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:18 INFO - Running setup.py (path:/tmp/pip-VdG2I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:18 INFO - Running setup.py (path:/tmp/pip-4kdEEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:18 INFO - Running setup.py (path:/tmp/pip-RllynI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:18 INFO - Running setup.py (path:/tmp/pip-bs5e4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:18 INFO - Running setup.py (path:/tmp/pip-_EDj1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:18 INFO - Running setup.py (path:/tmp/pip-5zB2ms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:18 INFO - Running setup.py (path:/tmp/pip-b4PFlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:18 INFO - Running setup.py (path:/tmp/pip-biqkMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:18 INFO - Running setup.py (path:/tmp/pip-tTyhXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:19 INFO - Running setup.py (path:/tmp/pip-dlB1X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:19 INFO - Running setup.py (path:/tmp/pip-FCClNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:19 INFO - Running setup.py (path:/tmp/pip-O2Brru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:19 INFO - Running setup.py (path:/tmp/pip-1i2sdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:19 INFO - Running setup.py (path:/tmp/pip-eTO7Ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:19 INFO - Running setup.py (path:/tmp/pip-7rouqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:34:19 INFO - Running setup.py install for manifestparser 10:34:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:34:19 INFO - Running setup.py install for mozcrash 10:34:19 INFO - Running setup.py install for mozdebug 10:34:19 INFO - Running setup.py install for mozdevice 10:34:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:34:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:34:19 INFO - Running setup.py install for mozfile 10:34:19 INFO - Running setup.py install for mozhttpd 10:34:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Running setup.py install for mozinfo 10:34:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Running setup.py install for mozInstall 10:34:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Running setup.py install for mozleak 10:34:20 INFO - Running setup.py install for mozlog 10:34:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Running setup.py install for moznetwork 10:34:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Running setup.py install for mozprocess 10:34:20 INFO - Running setup.py install for mozprofile 10:34:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Running setup.py install for mozrunner 10:34:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:34:20 INFO - Running setup.py install for mozscreenshot 10:34:21 INFO - Running setup.py install for moztest 10:34:21 INFO - Running setup.py install for mozversion 10:34:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:34:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:34:21 INFO - Cleaning up... 10:34:21 INFO - Return code: 0 10:34:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:21 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:21 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 10:34:21 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 10:34:21 INFO - Using env: {'DISPLAY': ':0', 10:34:21 INFO - 'HOME': '/home/cltbld', 10:34:21 INFO - 'LANG': 'en_US.UTF-8', 10:34:21 INFO - 'LANGUAGE': 'en_US:en', 10:34:21 INFO - 'LOGNAME': 'cltbld', 10:34:21 INFO - 'MAIL': '/var/mail/cltbld', 10:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:21 INFO - 'MOZ_NO_REMOTE': '1', 10:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:21 INFO - 'NO_EM_RESTART': '1', 10:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:21 INFO - 'PWD': '/builds/slave/test', 10:34:21 INFO - 'SHELL': '/bin/bash', 10:34:21 INFO - 'SHLVL': '1', 10:34:21 INFO - 'TERM': 'linux', 10:34:21 INFO - 'TMOUT': '86400', 10:34:21 INFO - 'USER': 'cltbld', 10:34:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:21 INFO - '_': '/tools/buildbot/bin/python'} 10:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:34:21 INFO - Running setup.py (path:/tmp/pip-Uswn3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:34:21 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)) 10:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:34:21 INFO - Running setup.py (path:/tmp/pip-moTeeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:34:21 INFO - Running setup.py (path:/tmp/pip-Z7gLDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:34:21 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)) 10:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:34:21 INFO - Running setup.py (path:/tmp/pip-3F845q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:34:21 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)) 10:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:34:21 INFO - Running setup.py (path:/tmp/pip-Xdepbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:34:21 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)) 10:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:34:21 INFO - Running setup.py (path:/tmp/pip-sIWCnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:34:21 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)) 10:34:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:34:21 INFO - Running setup.py (path:/tmp/pip-tuIVyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:34:22 INFO - Running setup.py (path:/tmp/pip-nVi2k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:34:22 INFO - Running setup.py (path:/tmp/pip-5QLRML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:34:22 INFO - Running setup.py (path:/tmp/pip-W8d9BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:34:22 INFO - Running setup.py (path:/tmp/pip-aQdspx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:34:22 INFO - Running setup.py (path:/tmp/pip-XqdLi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:34:22 INFO - Running setup.py (path:/tmp/pip-LGJWiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:34:22 INFO - Running setup.py (path:/tmp/pip-NZKyB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:22 INFO - Running setup.py (path:/tmp/pip-clxQt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:34:22 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)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:34:22 INFO - Running setup.py (path:/tmp/pip-aLq3go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:34:22 INFO - Running setup.py (path:/tmp/pip-B6bFv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:34:22 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)) 10:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:34:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:34:22 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)) 10:34:22 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)) 10:34:22 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)) 10:34:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:34:22 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 10:34:22 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 10:34:22 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 10:34:22 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 10:34:22 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 10:34:22 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 10:34:24 INFO - Downloading blessings-1.6.tar.gz 10:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:34:24 INFO - Installing collected packages: blessings 10:34:24 INFO - Running setup.py install for blessings 10:34:24 INFO - Successfully installed blessings 10:34:24 INFO - Cleaning up... 10:34:24 INFO - Return code: 0 10:34:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:34:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:25 INFO - Reading from file tmpfile_stdout 10:34:25 INFO - Current package versions: 10:34:25 INFO - argparse == 1.2.1 10:34:25 INFO - blessings == 1.6 10:34:25 INFO - blobuploader == 1.2.4 10:34:25 INFO - docopt == 0.6.1 10:34:25 INFO - functools32 == 3.2.3-2 10:34:25 INFO - jsonschema == 2.5.1 10:34:25 INFO - manifestparser == 1.1 10:34:25 INFO - mozInstall == 1.12 10:34:25 INFO - mozcrash == 0.17 10:34:25 INFO - mozdebug == 0.1 10:34:25 INFO - mozdevice == 0.48 10:34:25 INFO - mozfile == 1.2 10:34:25 INFO - mozhttpd == 0.7 10:34:25 INFO - mozinfo == 0.9 10:34:25 INFO - mozleak == 0.1 10:34:25 INFO - mozlog == 3.4 10:34:25 INFO - moznetwork == 0.27 10:34:25 INFO - mozprocess == 0.23 10:34:25 INFO - mozprofile == 0.28 10:34:25 INFO - mozrunner == 6.12 10:34:25 INFO - mozscreenshot == 0.1 10:34:25 INFO - mozsystemmonitor == 0.3 10:34:25 INFO - moztest == 0.7 10:34:25 INFO - mozversion == 1.4 10:34:25 INFO - psutil == 3.1.1 10:34:25 INFO - requests == 1.2.3 10:34:25 INFO - wsgiref == 0.1.2 10:34:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:34: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')]} 10:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34: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')]} 10:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34:25 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 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34:25 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 10:34:25 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 10:34:25 INFO - Using env: {'DISPLAY': ':0', 10:34:25 INFO - 'HOME': '/home/cltbld', 10:34:25 INFO - 'LANG': 'en_US.UTF-8', 10:34:25 INFO - 'LANGUAGE': 'en_US:en', 10:34:25 INFO - 'LOGNAME': 'cltbld', 10:34:25 INFO - 'MAIL': '/var/mail/cltbld', 10:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:25 INFO - 'MOZ_NO_REMOTE': '1', 10:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:25 INFO - 'NO_EM_RESTART': '1', 10:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:25 INFO - 'PWD': '/builds/slave/test', 10:34:25 INFO - 'SHELL': '/bin/bash', 10:34:25 INFO - 'SHLVL': '1', 10:34:25 INFO - 'TERM': 'linux', 10:34:25 INFO - 'TMOUT': '86400', 10:34:25 INFO - 'USER': 'cltbld', 10:34:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:25 INFO - '_': '/tools/buildbot/bin/python'} 10:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 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)) 10:34:25 INFO - Cleaning up... 10:34:25 INFO - Return code: 0 10:34:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:34: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')]} 10:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34: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')]} 10:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:34: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1fdd819f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x133bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', '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 10:34: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'] in /builds/slave/test/build 10:34: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 10:34:25 INFO - Using env: {'DISPLAY': ':0', 10:34:25 INFO - 'HOME': '/home/cltbld', 10:34:25 INFO - 'LANG': 'en_US.UTF-8', 10:34:25 INFO - 'LANGUAGE': 'en_US:en', 10:34:25 INFO - 'LOGNAME': 'cltbld', 10:34:25 INFO - 'MAIL': '/var/mail/cltbld', 10:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:25 INFO - 'MOZ_NO_REMOTE': '1', 10:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:25 INFO - 'NO_EM_RESTART': '1', 10:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:25 INFO - 'PWD': '/builds/slave/test', 10:34:25 INFO - 'SHELL': '/bin/bash', 10:34:25 INFO - 'SHLVL': '1', 10:34:25 INFO - 'TERM': 'linux', 10:34:25 INFO - 'TMOUT': '86400', 10:34:25 INFO - 'USER': 'cltbld', 10:34:25 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:25 INFO - '_': '/tools/buildbot/bin/python'} 10:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:34:25 INFO - Cleaning up... 10:34:25 INFO - Return code: 0 10:34:25 INFO - Running post-action listener: _resource_record_post_action 10:34:25 INFO - Running post-action listener: _start_resource_monitoring 10:34:25 INFO - Starting resource monitoring. 10:34:25 INFO - [mozharness: 2016-10-05 17:34:25.646249Z] Finished create-virtualenv step (success) 10:34:25 INFO - [mozharness: 2016-10-05 17:34:25.646710Z] Running install step. 10:34:25 INFO - Running pre-action listener: _resource_record_pre_action 10:34:25 INFO - Running main action method: install 10:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:34:25 INFO - Reading from file tmpfile_stdout 10:34:25 INFO - Detecting whether we're running mozinstall >=1.0... 10:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:34:25 INFO - Reading from file tmpfile_stdout 10:34:25 INFO - Output received: 10:34:25 INFO - Usage: mozinstall [options] installer 10:34:25 INFO - Options: 10:34:25 INFO - -h, --help show this help message and exit 10:34:25 INFO - -d DEST, --destination=DEST 10:34:25 INFO - Directory to install application into. [default: 10:34:25 INFO - "/builds/slave/test"] 10:34:25 INFO - --app=APP Application being installed. [default: firefox] 10:34:25 INFO - mkdir: /builds/slave/test/build/application 10:34:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:34:42 INFO - Reading from file tmpfile_stdout 10:34:42 INFO - Output received: 10:34:42 INFO - /builds/slave/test/build/application/firefox/firefox 10:34:42 INFO - Running post-action listener: _resource_record_post_action 10:34:42 INFO - [mozharness: 2016-10-05 17:34:42.077413Z] Finished install step (success) 10:34:42 INFO - [mozharness: 2016-10-05 17:34:42.077657Z] Running run-tests step. 10:34:42 INFO - Running pre-action listener: _resource_record_pre_action 10:34:42 INFO - Running main action method: run_tests 10:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:42 INFO - Python 2.7.3 10:34:42 INFO - Return code: 0 10:34:42 INFO - grabbing minidump binary from tooltool 10:34:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:42 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 0x1338f60>, '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 0x1339d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x133a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:42 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 10:34:42 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 10:34:42 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 10:34:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:42 INFO - Return code: 0 10:34:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:34:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:34:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 10:34:42 INFO - Using env: {'DISPLAY': ':0', 10:34:42 INFO - 'HOME': '/home/cltbld', 10:34:42 INFO - 'LANG': 'en_US.UTF-8', 10:34:42 INFO - 'LANGUAGE': 'en_US:en', 10:34:42 INFO - 'LOGNAME': 'cltbld', 10:34:42 INFO - 'MAIL': '/var/mail/cltbld', 10:34:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:42 INFO - 'MOZ_NO_REMOTE': '1', 10:34:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:34:42 INFO - 'NO_EM_RESTART': '1', 10:34:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:42 INFO - 'PWD': '/builds/slave/test', 10:34:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:42 INFO - 'SHELL': '/bin/bash', 10:34:42 INFO - 'SHLVL': '1', 10:34:42 INFO - 'TERM': 'linux', 10:34:42 INFO - 'TMOUT': '86400', 10:34:42 INFO - 'USER': 'cltbld', 10:34:42 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245', 10:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:42 INFO - '_': '/tools/buildbot/bin/python'} 10:34:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 10:34:42 INFO - mozversion application_buildid: 20161005092400 10:34:42 INFO - mozversion application_changeset: fd5aadb06d74dec6ee7787bd0f696a318ebcd40e 10:34:42 INFO - mozversion application_display_name: Nightly 10:34:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:42 INFO - mozversion application_name: Firefox 10:34:42 INFO - mozversion application_remotingname: firefox 10:34:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:34:42 INFO - mozversion application_vendor: Mozilla 10:34:42 INFO - mozversion application_version: 52.0a1 10:34:42 INFO - mozversion platform_buildid: 20161005092400 10:34:42 INFO - mozversion platform_changeset: fd5aadb06d74dec6ee7787bd0f696a318ebcd40e 10:34:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:34:42 INFO - mozversion platform_version: 52.0a1 10:34:42 INFO - using testdate: 1475688882 10:34:42 INFO - actual date: 1475688882 10:34:42 INFO - starting webserver on 'localhost:59411' 10:34:42 INFO - SUITE-START | Running 2 tests 10:34:42 INFO - TEST-START | dromaeo_css 10:34:42 INFO - operating with platform_type : linux_ 10:34:42 INFO - Initialising browser for dromaeo_css test... 10:34:42 INFO - TEST-INFO | started process 15234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7zTL7R/profile http://localhost:59411/getInfo.html) 10:34:47 INFO - PROCESS | 15234 | __metrics Screen width/height:1600/1200 10:34:47 INFO - PROCESS | 15234 | colorDepth:24 10:34:47 INFO - PROCESS | 15234 | Browser inner width/height: 1024/697 10:34:47 INFO - PROCESS | 15234 | __metrics 10:34:47 INFO - PROCESS | 15234 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:34:47 INFO - PROCESS | 15234 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:48 INFO - PROCESS | 15234 | console.error: PushService: 10:34:48 INFO - PROCESS | 15234 | stateChangeProcessEnqueue: Error transitioning state 10:34:48 INFO - PROCESS | 15234 | UnknownError 10:34:48 INFO - TEST-INFO | 15234: exit 0 10:34:48 INFO - Browser initialized. 10:34:48 INFO - Running cycle 1/1 for dromaeo_css test... 10:34:48 INFO - TEST-INFO | started process 15316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7zTL7R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:01 INFO - PROCESS | 15316 | RSS: Main: 175857664 10:35:01 INFO - PROCESS | 15316 | 10:35:52 INFO - PROCESS | 15316 | 1475688952520 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:38:06 INFO - PROCESS | 15316 | Cycle 1(1): loaded http://localhost:59411/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59411/tests/dromaeo/cssquery-ext.html) 10:38:07 INFO - PROCESS | 15316 | RSS: Main: 277860352 10:38:07 INFO - PROCESS | 15316 | 10:41:10 INFO - PROCESS | 15316 | Cycle 1(1): loaded http://localhost:59411/tests/dromaeo/cssquery-ext.html (next: http://localhost:59411/tests/dromaeo/cssquery-jquery.html) 10:41:10 INFO - PROCESS | 15316 | RSS: Main: 275193856 10:41:10 INFO - PROCESS | 15316 | 10:44:12 INFO - PROCESS | 15316 | Cycle 1(1): loaded http://localhost:59411/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59411/tests/dromaeo/cssquery-mootools.html) 10:44:13 INFO - PROCESS | 15316 | RSS: Main: 218865664 10:44:13 INFO - PROCESS | 15316 | 10:47:15 INFO - PROCESS | 15316 | Cycle 1(1): loaded http://localhost:59411/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59411/tests/dromaeo/cssquery-prototype.html) 10:47:16 INFO - PROCESS | 15316 | RSS: Main: 220139520 10:47:16 INFO - PROCESS | 15316 | 10:50:19 INFO - PROCESS | 15316 | Cycle 1(1): loaded http://localhost:59411/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59411/tests/dromaeo/cssquery-yui.html) 10:50:20 INFO - PROCESS | 15316 | RSS: Main: 219725824 10:50:20 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | Cycle 1(1): loaded http://localhost:59411/tests/dromaeo/cssquery-yui.html (next: http://localhost:59411/tests/dromaeo/cssquery-dojo.html) 10:53:23 INFO - PROCESS | 15316 | RSS: Main: 318914560 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | __start_tp_report 10:53:23 INFO - PROCESS | 15316 | _x_x_mozilla_page_load 10:53:23 INFO - PROCESS | 15316 | _x_x_mozilla_page_load_details 10:53:23 INFO - PROCESS | 15316 | |i|pagename|runs| 10:53:23 INFO - PROCESS | 15316 | |0;dojo.html;2567.396661784481;2593.0535354595577;2621.515019721351;2632.0656167060692;2642.9867850660758;4344.8913777155585;4427.601515863572;4602.286645569938;4602.700824446413;4656.5110663380365;4466.665000124987;4468.82124715011;4470.798814053367;4473.552644735525;4474.14991151681;4067.0849058961794;4078.775667338295;4086.3870419437026;4106.32245679464;4236.872893813175;4271.124419494012;4277.101808620194;4306.461692288464;4323.762193079395;4343.78281085946;4192.098698779761;4202.495700515927;4256.914861702764;4260.510041345238;4305.741655500664;4267.146570685875;4272.273713468702;4272.700910936236;4352.630026447724;4362.978185109086;4241.851535196253;4299.91400171998;4334.848280310205;4339.60943515082;4376.190404775127;4493.168763778712;4528.230200865828;4533;4593.816247350135;4699.906001879944;4848.466668666444;4886.291487734295;4895.828645997409;4902.3872015998;4905.141600219983;4925.088858561177;4975.726335051607;5004.9749751251375;5028.974855125737;5044.722540260284;4641.512641172696;4642.814287428465;4645.976770116195;4654.511276315938;4708.670393072452;4835.685680430761;5093.18509038552;5096.23556466533;5101.668391554537;5168.560672342893;4691;4759.666823322404;4818.060478206716;4827.372441582572;4903.926441103386;4895.559399653977;4906.1414252505665;4913.524170805404;4915.1644220481885;4977.427595826454;4830.106430310404;4866.4403593586485;4873.415190177201;4883.169861123618;4939.629527785359;4714.528547145326;4779.0680817241;4782.378290822171;4835.927461088087;4836.202026665631;4163.479565054368;4185.0374413884365;4198.916021679611;4224.809883555247;4241.957580424156;3682.4108142697573;3715.256948610289;3739.457778622085;3752.549694036733;3768.8680896168503;4281.507626622916;4282.614564689131;4284.76433796138;4285.442892423965;4344.652427805768;4816.349792778;4854.563089321908;4959.876003099879;4988.201887697951;5031.622628302819;4215.704900656986;4222.662187025092;4226.028013556899;4262.829486820555;4298.4412026436985;4454.443194600675;4459.264221403432;4459.264221403497;4462.085272519126;4517.706349087299;4525.7510836904285;4644.396228490275;4688.038952014829;4689.9296510551685;4743.0988112258565;4801.68789028712;4935.8025678972435;4991.301217829579;4995.775190116381;5053.469385714447;4740.3837501124635;4755.548222918817;4756.262779269219;4760.190767569452;4809.95190048109;4932.950670493393;4934.136526107988;4936.950630493793;4939.382577177853;5002.799888004439;4878.9512104878495;4899.804007839789;4921.237208232729;4946.604271658187;4956.083124621957;4862.367892173995;4863.635227357891;4863.975680121577;4876.853694389174;4919.2129259318335;4739.881502962316;4751.453582838018;4753.382060332135;4757.881052973703;4818.518148185153;4649.697769644962;4697.365855609449;4707.552782485658;4755.358026666356;4770.880727981828;4908.042931628441;4920.335754673073;4921.532454416824;4963.751812409293;4981.726005069756;4577;4619.191641462663;4753.6434767393275;4800.57804898577;4868.683535570318 10:53:23 INFO - PROCESS | 15316 | |1;ext.html;539.9406065332813;564.8446677163779;570.2017175953665;571.1062187676287;582.126809785322;27205;37159.81420092899;38674.61325386749;38738.22523549527;42126.15747685044;39212;39624.4713504434;39637.40543891844;39662.20675586486;39717.40423893644;6903.20613129489;7641.579713115762;7790.727324543642;7791.454598178129;7791.883121753178;7038.26098259683;9631.614735410576;9899.950500247525;9904.801903961916;10264.435456049914;10010.799784004315;10060.144887684555;10078.496075196248;10079.244056695741;10082.495875206247;9919.752006199831;9968.95325990775;9978.900210997943;9986.750331241705;9992.250581206366;9788.265880059023;9836.557354919047;9853.06395892389;9857.11285984265;9858.457784821832;37215.81392093049;37659.811700941595;37715.81142094272;37732.43401348982;37764.81117594422;2762.9447411051665;2780.7219278072234;2888.2923683697627;3113.143885431502;3159.763017773676;26521.867390663116;28632.570511442344;28702.712972870213;28751.56872646912;29111.12666620005;3441.5698037745283;3461.3769521486124;3489.0753950203216;3600.981995090034;3647.9817600912093;249572;249889;250714;250887;251322;30863;52969;53038.73480632572;53129;53332;31706.682933170836;33577.496337554956;33762.66237337644;33768.1557961053;33810.49284260738;12072.215306005082;12102.092343074304;12158.027357811354;12160.695982600506;12190.08574356909;9410.200132988635;9544.570494327632;9798.706038818847;10025.699229023141;10104.797904041878;7672.462927595015;7775.1447340792465;7851.765375001816;7924.960375198087;7935.761927142195;3076.8923087691824;3099.6435409927694;3106.8815226518436;3125.093722820402;3133.107064486656;863.7711006583261;884.4693184089494;889.390767324372;905.4883990545452;933.1135421349745;26799.330016749736;27405.31486712848;27861;27968;28299.43401132007;925.3060204846365;948.7628092976756;949.050949050949;952.4333021851987;976.5410257179115;14604.196769177797;14875.70248595022;14963.70072598542;15095.180776603745;15228.847711522965;369047;378068;378125.4062053172;379169;380892;48348.27477587839;48474.515254847705;48851.51148488541;48975.265371019465;49152.7542362293;1035.6168217759478;1087.6954452753084;1105.1159072741934;1151.5566506894738;1167.217963964129;24620.87689561541;28862.422751544433;28941.276468087624;29393.559096613997;29550.408991820474;39999.20001599893;40414.79792601018;40512.59487405088;40521.79739101286;40548;289385;290094;290102;290418;291058;24288.271351859472;24884.875575622005;25118.623220651338;25171;26592.601110982963;40715;40785.44013866535;40952.79523602363;42137;42166.57833421749;34795.65204347924;35100.297994040484;35299;35426.82286588551;35497.467537986435;34955.650443496255;35118.648813511536;35247.47128793019;35494.822525887204;35513.289734204656;34412.655873441945;35102.64897350994;35188;35214.823925880206;35839.104022399646;29735.55396669095;32050;32108.357832842747;32180.83909580437;32207.51688724718;24620.261392158263;24703.505929880943;24822.751772482043;25106.74893251117;25352.366190845376 10:53:23 INFO - PROCESS | 15316 | |2;jquery.html;339.2899785083181;343.1164750766776;356.09374142806564;360.3531660669099;377.40558620173215;12036;15151.848481515182;15302.311395987179;16483.83516164841;17450.127493625332;16403.753943690856;16444.260008299625;16555.91722041391;16671.41650042249;16884;4146.8133933972895;4976.328195693581;5210.2445145453885;5212.504812042869;5249.081410753122;5134.383873935114;5136.460671629462;5173.586113110942;5178.171492561191;5179.404368497633;4893.266010098479;5131.717755523445;5132.8973420531565;5145.485451454862;5160.277561141444;5074.873128171788;5119.667221630582;5123.795048198068;5128.589712822965;5132.435432102466;4348.7390756554705;4416.183006143841;4452.621527170194;4576.610988066019;4589.5181005994555;20046.599068018702;20047.39857804268;20100.899495502428;20204.797952020584;20232.291869784633;1957.5106223444138;1965.8722183058055;2113.323736404351;2131.392553122368;2282.109977108929;12825.551105711254;12862.485500579965;12933.741325173538;12972;13338.466461341535;1666.5250403634907;1683.882128251023;1686.7132587460162;1735.1931351921291;1806.1962426720115;67462.3253767461;68232.31767682359;68349;69243.30756692469;69733.30266697319;8915.37592368528;9031.729048128567;9195.172434480928;9244.491552964517;9267.860982085274;12781;12792.808107878389;12798.808017879739;12810.743785124245;12825.29460879642;6744.662766861736;6964.965175174193;7004.4046256068805;7117.6085315308155;7188.245234250328;6502.512311576556;6533.673316334164;6578.3750543699225;6702.497312701469;6722.865542689216;5858.619189752652;5875.882482350415;5892.322382925932;5894.734736936848;5940.762369505258;1661.1279078483892;1679.5045461588861;1716.7339062445342;1719.3208682570564;1761.4891681412503;691.8892977123636;801.703369753195;861.9094995025557;874.8337815815102;931.739113048334;15900.284487198103;16472.588185295223;16853.325866965184;17072.48782536526;17728.645427091644;805.0781854776249;816.7345612675904;822.7655118291258;835.7325655790211;887.2414085956543;8945.73162805117;9376.249900007982;9721.708348749407;9731.416115032978;9751.90248097524;384069;386501;391082;392726;394108;77407.61296193484;78455;78860.21139788644;78955.60522197468;79984.20015799884;870.6386849457531;903.7514683461969;907.4328544659588;928.6888892221182;934.990650093504;15352.155631440379;15445.613859653598;15940.202989850693;16269.67460650804;16274.186290685655;36594.26811463809;36698.8165059173;37195;37474.437883432314;37558;50997.49002509927;51226.74386628043;51324.74337628288;51764.74117629388;51983.220251697014;4501.617362524222;5608.663480191201;5771.509421699035;7640.044994375703;8039.557824319719;9920.503974801086;10991.890081099407;11208.27146235492;11231;11588.130890183102;7724.570954373459;9502.667406640734;9669;10016.148627366463;10314.278000540191;9847.212223021997;9991.25065620067;10032.69901902944;10275.177985761271;10312.226583006155;9859.30984831055;9920.553575088994;10234;10354.430506321924;10448.52981615814;7393.149787774475;7430.219826918095;7480.92519074824;7518.887216691644;7543.207963164008;9523.857142142735;9617.182539484222;9798.608055677692;10028.799424011333;10120.797584048425 10:53:23 INFO - PROCESS | 15316 | |3;mootools.html;1337.117502448384;1360.9931950340247;1420.1904914198903;1628.470747007223;1637.459638319354;6770.492213084014;6993.965030174854;7254.38337741292;7771.145174030867;7788.636988527006;7360.926390736091;7634.656440460179;7642.465027448081;7833.82492626105;7838.412119091063;2027.0675489274915;2047.5597746484502;2050.384884534641;2065.1532871522604;2065.483629092727;1726.1800644693797;1777.7155655095187;1986.324649619129;2013.3657897762232;2032.4309193425865;2000.3298894870236;2062.0411508648476;2072.3057775645175;2074.6161960037443;2078.054485209234;2028.9188432462759;2028.9289874854458;2034.1659919433037;2053.5790163016545;2065.10168076887;2045.6317862784692;2049.5695903860205;2053.6303465376227;2056.4858785303672;2066.772655007948;7472.626368681598;7552.66013029415;7554.811129721746;7570.015897933288;7646.694132234704;4418.889527761831;4571;4587.197240482936;4588.151192029485;4591.265397536378;2690.986545067282;2726.495598314298;2840.1763488588285;2860.8426536540483;2872.482953068447;876.548577482597;877.9956100219522;883.584715183869;888.6667499687617;897.5063714956748;10432.321899076536;10439.686809395731;10457.79084418315;10472.26694131411;10509.106725928305;3788.109794198361;3955.169414423003;4084.1219137885496;4106.958930410718;4111.1366613011005;8927.821443571222;8931.821363572692;8934.642614295355;8935.687250946186;8940.821183576292;4624.167649822997;4635.976820115945;4643.233866412072;4653.441587009513;4655.627549796008;4137.420761093449;4197.916041679149;4216.683748718859;4222.071144348239;4223.767692776927;3624.873129440457;3663.798491083016;3708.351038568294;3723.2925744108534;3723.9627603724157;1069.8341757027674;1094.2996482251365;1164.7088227943013;1175.5591653130077;1180.451090243041;643.6717274190103;753.6307209467432;805.4844899264475;824.884516167737;825.529448214524;4911.189653707098;5016.824411145592;5074.82238121664;5153.639245252872;5154.664946778523;799.3525244551815;817.9754607361789;835.4611275727243;858.1075681291512;866.7183165471247;3533.7526373153632;3645.3985092459448;3657.5062366580173;3695.371786796251;3704.759190652599;8883.73348799537;9410.623575056921;9420.24638028956;9420.623175073057;9435.292353073546;9117.08829117083;9121.81756364869;9344.15902568772;9347.90652093484;9368.578413971387;7142.4286057115305;7217.603031833194;7228.060352154292;7230.783076507713;7234.348908598146;4936.136176169228;4972.254161875748;5072;5096.23556466533;5266.762995665128;8616.827663446822;8629.482231066157;8635.740927772176;8667.306615470874;8704.955405351398;8531.8720219198;8722.520261385685;8729.170728780755;8730.869036964577;8797.516136612549;6318.27339855904;6661.800145995628;6742.393184613408;6745.696443660146;6746.224184218878;7025.402840758593;7232.132144142736;7254.056972593529;7289.744858929912;7302.671379788028;6406.967965160145;6424.164858568356;6530.151080359523;6536.346365363425;6577.835554111186;6459.354064593503;6460.806175814733;6485.805425837232;6499.155109835691;6516.022596610546;5911.970440147772;5979.222701048836;5992.670403127696;5996.190514280516;5998.430149135826;4426.048399593974;4474.082813023388;4481.955180448153;4554.772261386851;4571.451425828789;4273.273543497675;4301.784910754513;4316.503602085801;4328.718633288826;4376.474823021258 10:53:23 INFO - PROCESS | 15316 | |4;prototype.html;290.09779585489133;300.1939791659395;302.4706763164462;305.07105862648234;306.2115053736629;4789.928151077732;4804.2793580962825;4808.278758186274;4823.059503396839;4838;4754.310624959378;4755.3104799804005;4761.738104404257;4768.141734487791;4774.474807771151;3571.2500374921233;3678.613745556718;3709.4250391189275;3776.8866933991885;3808;3782.7352085354037;3791.6587507124354;3808.9809550952205;3809.3714537101346;3822.3693090640013;3764;3764.5294338207723;3765.755225910321;3773.4905787718717;3786.2238241160494;3566.5006899034024;3609.530761001079;3681.8159092045425;3730.850765969358;3751.4747935289083;3306.5370848081047;3319.933601327984;3331.2005118771563;3331.4503106987318;3332.516785066152;4610.861674149747;4619.630429565626;4623.514530974233;4632.2588385858435;4645.907081858378;4164;4233.888092252192;4243.172581346638;4269.6370808481315;4275.87172384829;4902.362692849907;4907.975460122712;4916.139675556763;4939.234418665113;4951.133551628451;3614.222942067468;3621.149029977953;3622.5471816022996;3625.9456108158397;3631.6018332941744;4959.6528243023;5152.304438900738;5175.663581867167;5179.741012949337;5198.738548731314;3698.4082546792383;3726.1927964936986;3726.9440958385644;3733.1600389912596;3735.215604722984;3776.339140650375;3777.244551089793;3783.754055986407;3791.9431208531896;3791.962080379216;4242.215190189825;4251.107267473865;4251.617354438054;4260.659147268211;4261.446012018418;4760.642951778561;4939.48135445773;4957.107720610325;4963.181075122637;4971.825986090469;1302.400895588021;1309.6136639691315;1309.705316303824;1315.4540865540885;1315.953941612058;818.3535007344132;833.5496236548483;843.6627944707707;852.5140669818268;854.0946596607616;3954;4193.266178418826;4279.914401711948;4337.89383707159;4430.379746835446;5140.665856719302;5147.6654017488745;5151;5152.252923326097;5155.175171972542;4379.49635791888;4395.7362558246605;4406.757628330409;4427.335899615084;4434.11317736454;2628.132716203648;2692.7307269272915;2706.4316493536576;2724.5559853277796;2725.419256831033;4893.168161412568;4893.975530122398;4900.191468407744;4905.190643543847;4906.239532872411;5233.188855727369;5256.896051829082;5260.13207820713;5266.605004624668;5285.418603953562;4715.308659093374;4825.879353016203;4874.220124779948;4880.829170978998;4890.779914903838;5056.82301119459;5101.525760006468;5109.846704598868;5110.437851836221;5111.488851114858;4955.72921871563;5011.373578302712;5025.195968644999;5040.445550989315;5044.697318160922;4651.348811166372;4886.53577910098;4932.4327702314695;4943.2585112233455;4943.876403089952;3603.549556305462;3606.2787442511076;3611.2416392557857;3612.3858943980113;3616.1682812953695;5181.844544663666;5184.637075404686;5239.685618862881;5249.553787928069;5249.7112658804135;4956.702597844141;5058.924116138187;5061.75986883216;5066.314853127848;5069.3156423883775;5017.397912250407;5041.344625198701;5043.697378157322;5050.3182070420025;5054.620903432331;4964.202385175416;4967.552920237196;4972.577330926912;4972.9254061188385;4981.227909674007;4798.448178459382;4864.537868902448;5025.296458495741;5034.949650503448;5057.898842023213;4793.993261415142;4849.58778503817;4917.803287868445;4922.901541969212;4938.234573641092 10:53:23 INFO - PROCESS | 15316 | |5;yui.html;637.5537124013191;648.9286178520362;669.2938949408378;710.6162672157036;736.7384578474641;12948.805767913476;13579.04946653732;13790.379432925518;13814.861851381484;13824.654383640414;12782.296973666445;12992.870071299285;13069.803952940714;13111.868881311184;13155.605331840035;601.0923505506672;616.2174038970505;724.0768020773503;728.9599072051035;738.7377480994251;740.6704016712538;742.4542960923717;742.832862605912;744.0773440933258;744.4081954845883;786.7364432914981;787.8069872881152;788.1842293226512;788.4283894176733;789.1477204618998;638.1576319258558;652.9020646902956;655.7114869457423;658.0228360884083;784.2862994674847;479.0753845079031;550.1225545255311;563.9266895303625;566.0659911146599;567.4013915319337;12379.75240495185;12505.374731263491;12534.68663283416;12565.497380104785;12647.557335493306;10630.574777008911;10880.836787448194;11030.338179709162;11075.647461352099;11275.49260283281;11722.413879306087;11731.530738770523;11922.582709605209;11939.761204775943;12024.158308918379;3936.3308237599676;4021.195760847813;4056.898577535556;4078.062045729469;4197.559256278108;59963;61410;61639.69180154115;61794;61918;10008.499575021366;10069.79860402788;10197.235207359477;10240;10735.463226838627;18844.246230150642;18884.622307554047;18935.147918343708;18942.337018204296;18959.526011849815;6470.64411457365;6619.735210591619;6682.498812589075;6749.392554670103;6807.591544507345;3519.1554027033326;3644.2711457708565;3647.28877868813;3664.4686520454384;3714.0529165063276;2581.5353236417627;2645.563482025444;2652.403209277897;2655.2830735701255;2670.0654770830056;459.42571785268416;465.6833353319775;466.83660718748166;473.583246742871;485.20426500539145;534.6528738836511;544.4337888595895;544.7140251367985;587.1457030021309;588.1413136820205;7856.175101614363;8023.558704271204;8068.082557588231;8143.877841832377;8331.500109993298;470.9873771391467;555.6443875919415;569.8972488235278;575.2579172867038;609.5245708347496;3765.4728338032696;3998.7400818946676;4031.334829753058;4170.937435938464;4183.330667093312;56435;66680;96118;99035;99468;81886.18113818785;83625;83816;84407;86201.13798862057;71000;72103.63948180225;73526.63236683782;76105.6194719034;76888.84666730004;7183.245759195209;7207.927920720936;7237.963810181126;7489.513181643176;7672.002639656809;43693.34459983166;43936.780316098215;44605.77697111623;45315.546844531134;46110.30834537552;59078;63401.68299158659;64650.35349646631;64768.35231647623;67929;9503.19222866064;9553.570089346134;9623.5669394876;9719;9838.950805245928;10472.790544189225;10479.214058945458;10498.317609355672;10554.894451055392;10610.946945265225;9716.9028309716;9825.557849896915;9861.802763944537;9966.950165249127;10160.745981350525;9916.801663966824;9979.151772099163;10145.79708405813;10216.489175541044;10269.794604108025;9956.352837065568;10025.749356266151;10095.899041009496;10347.327423717434;11029;8430.831383372175;8715.08491608372;8985.595648195716;8994.730158095268;9183.448993060438;8806.339524535557;8895.644174232959;9022.330868789295;10018.148457381205;10831.566737330419 10:53:23 INFO - PROCESS | 15316 | __end_tp_report 10:53:23 INFO - PROCESS | 15316 | __start_cc_report 10:53:23 INFO - PROCESS | 15316 | _x_x_mozilla_cycle_collect,1033 10:53:23 INFO - PROCESS | 15316 | __end_cc_report 10:53:23 INFO - PROCESS | 15316 | __startTimestamp1475690003321__endTimestamp 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | ------- Summary: start ------- 10:53:23 INFO - PROCESS | 15316 | Number of tests: 6 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | [#0] dojo.html Cycles:165 Average:4563.68 Median:4699.91 stddev:469.89 (10.0%) stddev-sans-first:444.47 10:53:23 INFO - PROCESS | 15316 | Values: 2567.4 2593.1 2621.5 2632.1 2643.0 4344.9 4427.6 4602.3 4602.7 4656.5 4466.7 4468.8 4470.8 4473.6 4474.1 4067.1 4078.8 4086.4 4106.3 4236.9 4271.1 4277.1 4306.5 4323.8 4343.8 4192.1 4202.5 4256.9 4260.5 4305.7 4267.1 4272.3 4272.7 4352.6 4363.0 4241.9 4299.9 4334.8 4339.6 4376.2 4493.2 4528.2 4533.0 4593.8 4699.9 4848.5 4886.3 4895.8 4902.4 4905.1 4925.1 4975.7 5005.0 5029.0 5044.7 4641.5 4642.8 4646.0 4654.5 4708.7 4835.7 5093.2 5096.2 5101.7 5168.6 4691.0 4759.7 4818.1 4827.4 4903.9 4895.6 4906.1 4913.5 4915.2 4977.4 4830.1 4866.4 4873.4 4883.2 4939.6 4714.5 4779.1 4782.4 4835.9 4836.2 4163.5 4185.0 4198.9 4224.8 4242.0 3682.4 3715.3 3739.5 3752.5 3768.9 4281.5 4282.6 4284.8 4285.4 4344.7 4816.3 4854.6 4959.9 4988.2 5031.6 4215.7 4222.7 4226.0 4262.8 4298.4 4454.4 4459.3 4459.3 4462.1 4517.7 4525.8 4644.4 4688.0 4689.9 4743.1 4801.7 4935.8 4991.3 4995.8 5053.5 4740.4 4755.5 4756.3 4760.2 4810.0 4933.0 4934.1 4937.0 4939.4 5002.8 4879.0 4899.8 4921.2 4946.6 4956.1 4862.4 4863.6 4864.0 4876.9 4919.2 4739.9 4751.5 4753.4 4757.9 4818.5 4649.7 4697.4 4707.6 4755.4 4770.9 4908.0 4920.3 4921.5 4963.8 4981.7 4577.0 4619.2 4753.6 4800.6 4868.7 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | [#1] ext.html Cycles:180 Average:45014.82 Median:35231.15 stddev:81741.40 (232.0%) stddev-sans-first:81902.50 10:53:23 INFO - PROCESS | 15316 | Values: 539.9 564.8 570.2 571.1 582.1 27205.0 37159.8 38674.6 38738.2 42126.2 39212.0 39624.5 39637.4 39662.2 39717.4 6903.2 7641.6 7790.7 7791.5 7791.9 7038.3 9631.6 9900.0 9904.8 10264.4 10010.8 10060.1 10078.5 10079.2 10082.5 9919.8 9969.0 9978.9 9986.8 9992.3 9788.3 9836.6 9853.1 9857.1 9858.5 37215.8 37659.8 37715.8 37732.4 37764.8 2762.9 2780.7 2888.3 3113.1 3159.8 26521.9 28632.6 28702.7 28751.6 29111.1 3441.6 3461.4 3489.1 3601.0 3648.0 249572.0 249889.0 250714.0 250887.0 251322.0 30863.0 52969.0 53038.7 53129.0 53332.0 31706.7 33577.5 33762.7 33768.2 33810.5 12072.2 12102.1 12158.0 12160.7 12190.1 9410.2 9544.6 9798.7 10025.7 10104.8 7672.5 7775.1 7851.8 7925.0 7935.8 3076.9 3099.6 3106.9 3125.1 3133.1 863.8 884.5 889.4 905.5 933.1 26799.3 27405.3 27861.0 27968.0 28299.4 925.3 948.8 949.1 952.4 976.5 14604.2 14875.7 14963.7 15095.2 15228.8 369047.0 378068.0 378125.4 379169.0 380892.0 48348.3 48474.5 48851.5 48975.3 49152.8 1035.6 1087.7 1105.1 1151.6 1167.2 24620.9 28862.4 28941.3 29393.6 29550.4 39999.2 40414.8 40512.6 40521.8 40548.0 289385.0 290094.0 290102.0 290418.0 291058.0 24288.3 24884.9 25118.6 25171.0 26592.6 40715.0 40785.4 40952.8 42137.0 42166.6 34795.7 35100.3 35299.0 35426.8 35497.5 34955.7 35118.6 35247.5 35494.8 35513.3 34412.7 35102.6 35188.0 35214.8 35839.1 29735.6 32050.0 32108.4 32180.8 32207.5 24620.3 24703.5 24822.8 25106.7 25352.4 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | [#2] jquery.html Cycles:180 Average:24214.76 Median:28173.21 stddev:64412.55 (228.6%) stddev-sans-first:64568.30 10:53:23 INFO - PROCESS | 15316 | Values: 339.3 343.1 356.1 360.4 377.4 12036.0 15151.8 15302.3 16483.8 17450.1 16403.8 16444.3 16555.9 16671.4 16884.0 4146.8 4976.3 5210.2 5212.5 5249.1 5134.4 5136.5 5173.6 5178.2 5179.4 4893.3 5131.7 5132.9 5145.5 5160.3 5074.9 5119.7 5123.8 5128.6 5132.4 4348.7 4416.2 4452.6 4576.6 4589.5 20046.6 20047.4 20100.9 20204.8 20232.3 1957.5 1965.9 2113.3 2131.4 2282.1 12825.6 12862.5 12933.7 12972.0 13338.5 1666.5 1683.9 1686.7 1735.2 1806.2 67462.3 68232.3 68349.0 69243.3 69733.3 8915.4 9031.7 9195.2 9244.5 9267.9 12781.0 12792.8 12798.8 12810.7 12825.3 6744.7 6965.0 7004.4 7117.6 7188.2 6502.5 6533.7 6578.4 6702.5 6722.9 5858.6 5875.9 5892.3 5894.7 5940.8 1661.1 1679.5 1716.7 1719.3 1761.5 691.9 801.7 861.9 874.8 931.7 15900.3 16472.6 16853.3 17072.5 17728.6 805.1 816.7 822.8 835.7 887.2 8945.7 9376.2 9721.7 9731.4 9751.9 384069.0 386501.0 391082.0 392726.0 394108.0 77407.6 78455.0 78860.2 78955.6 79984.2 870.6 903.8 907.4 928.7 935.0 15352.2 15445.6 15940.2 16269.7 16274.2 36594.3 36698.8 37195.0 37474.4 37558.0 50997.5 51226.7 51324.7 51764.7 51983.2 4501.6 5608.7 5771.5 7640.0 8039.6 9920.5 10991.9 11208.3 11231.0 11588.1 7724.6 9502.7 9669.0 10016.1 10314.3 9847.2 9991.3 10032.7 10275.2 10312.2 9859.3 9920.6 10234.0 10354.4 10448.5 7393.1 7430.2 7480.9 7518.9 7543.2 9523.9 9617.2 9798.6 10028.8 10120.8 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | [#3] mootools.html Cycles:180 Average:4988.78 Median:5085.53 stddev:2803.33 (55.1%) stddev-sans-first:2797.77 10:53:23 INFO - PROCESS | 15316 | Values: 1337.1 1361.0 1420.2 1628.5 1637.5 6770.5 6994.0 7254.4 7771.1 7788.6 7360.9 7634.7 7642.5 7833.8 7838.4 2027.1 2047.6 2050.4 2065.2 2065.5 1726.2 1777.7 1986.3 2013.4 2032.4 2000.3 2062.0 2072.3 2074.6 2078.1 2028.9 2028.9 2034.2 2053.6 2065.1 2045.6 2049.6 2053.6 2056.5 2066.8 7472.6 7552.7 7554.8 7570.0 7646.7 4418.9 4571.0 4587.2 4588.2 4591.3 2691.0 2726.5 2840.2 2860.8 2872.5 876.5 878.0 883.6 888.7 897.5 10432.3 10439.7 10457.8 10472.3 10509.1 3788.1 3955.2 4084.1 4107.0 4111.1 8927.8 8931.8 8934.6 8935.7 8940.8 4624.2 4636.0 4643.2 4653.4 4655.6 4137.4 4197.9 4216.7 4222.1 4223.8 3624.9 3663.8 3708.4 3723.3 3724.0 1069.8 1094.3 1164.7 1175.6 1180.5 643.7 753.6 805.5 824.9 825.5 4911.2 5016.8 5074.8 5153.6 5154.7 799.4 818.0 835.5 858.1 866.7 3533.8 3645.4 3657.5 3695.4 3704.8 8883.7 9410.6 9420.2 9420.6 9435.3 9117.1 9121.8 9344.2 9347.9 9368.6 7142.4 7217.6 7228.1 7230.8 7234.3 4936.1 4972.3 5072.0 5096.2 5266.8 8616.8 8629.5 8635.7 8667.3 8705.0 8531.9 8722.5 8729.2 8730.9 8797.5 6318.3 6661.8 6742.4 6745.7 6746.2 7025.4 7232.1 7254.1 7289.7 7302.7 6407.0 6424.2 6530.2 6536.3 6577.8 6459.4 6460.8 6485.8 6499.2 6516.0 5912.0 5979.2 5992.7 5996.2 5998.4 4426.0 4474.1 4482.0 4554.8 4571.5 4273.3 4301.8 4316.5 4328.7 4376.5 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | [#4] prototype.html Cycles:180 Average:4159.13 Median:4764.94 stddev:1200.82 (25.2%) stddev-sans-first:1168.55 10:53:23 INFO - PROCESS | 15316 | Values: 290.1 300.2 302.5 305.1 306.2 4789.9 4804.3 4808.3 4823.1 4838.0 4754.3 4755.3 4761.7 4768.1 4774.5 3571.3 3678.6 3709.4 3776.9 3808.0 3782.7 3791.7 3809.0 3809.4 3822.4 3764.0 3764.5 3765.8 3773.5 3786.2 3566.5 3609.5 3681.8 3730.9 3751.5 3306.5 3319.9 3331.2 3331.5 3332.5 4610.9 4619.6 4623.5 4632.3 4645.9 4164.0 4233.9 4243.2 4269.6 4275.9 4902.4 4908.0 4916.1 4939.2 4951.1 3614.2 3621.1 3622.5 3625.9 3631.6 4959.7 5152.3 5175.7 5179.7 5198.7 3698.4 3726.2 3726.9 3733.2 3735.2 3776.3 3777.2 3783.8 3791.9 3792.0 4242.2 4251.1 4251.6 4260.7 4261.4 4760.6 4939.5 4957.1 4963.2 4971.8 1302.4 1309.6 1309.7 1315.5 1316.0 818.4 833.5 843.7 852.5 854.1 3954.0 4193.3 4279.9 4337.9 4430.4 5140.7 5147.7 5151.0 5152.3 5155.2 4379.5 4395.7 4406.8 4427.3 4434.1 2628.1 2692.7 2706.4 2724.6 2725.4 4893.2 4894.0 4900.2 4905.2 4906.2 5233.2 5256.9 5260.1 5266.6 5285.4 4715.3 4825.9 4874.2 4880.8 4890.8 5056.8 5101.5 5109.8 5110.4 5111.5 4955.7 5011.4 5025.2 5040.4 5044.7 4651.3 4886.5 4932.4 4943.3 4943.9 3603.5 3606.3 3611.2 3612.4 3616.2 5181.8 5184.6 5239.7 5249.6 5249.7 4956.7 5058.9 5061.8 5066.3 5069.3 5017.4 5041.3 5043.7 5050.3 5054.6 4964.2 4967.6 4972.6 4972.9 4981.2 4798.4 4864.5 5025.3 5034.9 5057.9 4794.0 4849.6 4917.8 4922.9 4938.2 10:53:23 INFO - PROCESS | 15316 | 10:53:23 INFO - PROCESS | 15316 | [#5] yui.html Cycles:180 Average:17046.71 Median:568.65 stddev:24438.04 (4297.6%) stddev-sans-first:24475.53 10:53:23 INFO - PROCESS | 15316 | Values: 637.6 648.9 669.3 710.6 736.7 12948.8 13579.0 13790.4 13814.9 13824.7 12782.3 12992.9 13069.8 13111.9 13155.6 601.1 616.2 724.1 729.0 738.7 740.7 742.5 742.8 744.1 744.4 786.7 787.8 788.2 788.4 789.1 638.2 652.9 655.7 658.0 784.3 479.1 550.1 563.9 566.1 567.4 12379.8 12505.4 12534.7 12565.5 12647.6 10630.6 10880.8 11030.3 11075.6 11275.5 11722.4 11731.5 11922.6 11939.8 12024.2 3936.3 4021.2 4056.9 4078.1 4197.6 59963.0 61410.0 61639.7 61794.0 61918.0 10008.5 10069.8 10197.2 10240.0 10735.5 18844.2 18884.6 18935.1 18942.3 18959.5 6470.6 6619.7 6682.5 6749.4 6807.6 3519.2 3644.3 3647.3 3664.5 3714.1 2581.5 2645.6 2652.4 2655.3 2670.1 459.4 465.7 466.8 473.6 485.2 534.7 544.4 544.7 587.1 588.1 7856.2 8023.6 8068.1 8143.9 8331.5 471.0 555.6 569.9 575.3 609.5 3765.5 3998.7 4031.3 4170.9 4183.3 56435.0 66680.0 96118.0 99035.0 99468.0 81886.2 83625.0 83816.0 84407.0 86201.1 71000.0 72103.6 73526.6 76105.6 76888.8 7183.2 7207.9 7238.0 7489.5 7672.0 43693.3 43936.8 44605.8 45315.5 46110.3 59078.0 63401.7 64650.4 64768.4 67929.0 9503.2 9553.6 9623.6 9719.0 9839.0 10472.8 10479.2 10498.3 10554.9 10610.9 9716.9 9825.6 9861.8 9967.0 10160.7 9916.8 9979.2 10145.8 10216.5 10269.8 9956.4 10025.7 10095.9 10347.3 11029.0 8430.8 8715.1 8985.6 8994.7 9183.4 8806.3 8895.6 9022.3 10018.1 10831.6 10:53:23 INFO - PROCESS | 15316 | -------- Summary: end -------- 10:53:23 INFO - PROCESS | 15316 | 10:53:24 INFO - TEST-INFO | 15316: exit 0 10:53:24 INFO - TEST-OK | dromaeo_css | took 1121949ms 10:53:24 INFO - TEST-START | kraken 10:53:24 INFO - operating with platform_type : linux_ 10:53:24 INFO - Initialising browser for kraken test... 10:53:24 INFO - TEST-INFO | started process 15628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqR1gwv/profile http://localhost:59411/getInfo.html) 10:53:29 INFO - PROCESS | 15628 | __metrics Screen width/height:1600/1200 10:53:29 INFO - PROCESS | 15628 | colorDepth:24 10:53:29 INFO - PROCESS | 15628 | Browser inner width/height: 1024/697 10:53:29 INFO - PROCESS | 15628 | __metrics 10:53:29 INFO - PROCESS | 15628 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:53:29 INFO - PROCESS | 15628 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:53:30 INFO - PROCESS | 15628 | console.error: PushService: 10:53:30 INFO - PROCESS | 15628 | stateChangeProcessEnqueue: Error transitioning state 10:53:30 INFO - PROCESS | 15628 | UnknownError 10:53:30 INFO - TEST-INFO | 15628: exit 0 10:53:30 INFO - Browser initialized. 10:53:30 INFO - Running cycle 1/1 for kraken test... 10:53:30 INFO - TEST-INFO | started process 15705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqR1gwv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:43 INFO - PROCESS | 15705 | RSS: Main: 175108096 10:53:43 INFO - PROCESS | 15705 | 10:53:45 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59411/tests/kraken/driver.html?testName=audio-beat-detection) 10:53:46 INFO - PROCESS | 15705 | RSS: Main: 234541056 10:53:46 INFO - PROCESS | 15705 | 10:53:49 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59411/tests/kraken/driver.html?testName=audio-dft) 10:53:50 INFO - PROCESS | 15705 | RSS: Main: 219181056 10:53:50 INFO - PROCESS | 15705 | 10:53:53 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59411/tests/kraken/driver.html?testName=audio-fft) 10:53:54 INFO - PROCESS | 15705 | RSS: Main: 301015040 10:53:54 INFO - PROCESS | 15705 | 10:53:56 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59411/tests/kraken/driver.html?testName=audio-oscillator) 10:53:56 INFO - PROCESS | 15705 | RSS: Main: 209694720 10:53:56 INFO - PROCESS | 15705 | 10:53:59 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59411/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:53:59 INFO - PROCESS | 15705 | RSS: Main: 215478272 10:53:59 INFO - PROCESS | 15705 | 10:54:02 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59411/tests/kraken/driver.html?testName=imaging-darkroom) 10:54:03 INFO - PROCESS | 15705 | RSS: Main: 250953728 10:54:03 INFO - PROCESS | 15705 | 10:54:07 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59411/tests/kraken/driver.html?testName=imaging-desaturate) 10:54:07 INFO - PROCESS | 15705 | RSS: Main: 244891648 10:54:07 INFO - PROCESS | 15705 | 10:54:10 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59411/tests/kraken/driver.html?testName=json-parse-financial) 10:54:11 INFO - PROCESS | 15705 | RSS: Main: 248102912 10:54:11 INFO - PROCESS | 15705 | 10:54:12 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59411/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:54:13 INFO - PROCESS | 15705 | RSS: Main: 211099648 10:54:13 INFO - PROCESS | 15705 | 10:54:15 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:54:16 INFO - PROCESS | 15705 | RSS: Main: 218374144 10:54:16 INFO - PROCESS | 15705 | 10:54:18 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:54:18 INFO - PROCESS | 15705 | RSS: Main: 227868672 10:54:18 INFO - PROCESS | 15705 | 10:54:21 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:54:22 INFO - PROCESS | 15705 | RSS: Main: 231006208 10:54:22 INFO - PROCESS | 15705 | 10:54:25 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:54:26 INFO - PROCESS | 15705 | RSS: Main: 232370176 10:54:26 INFO - PROCESS | 15705 | 10:54:27 INFO - PROCESS | 15705 | Cycle 1(1): loaded http://localhost:59411/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59411/tests/kraken/driver.html?testName=ai-astar) 10:54:28 INFO - PROCESS | 15705 | RSS: Main: 281804800 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | __start_tp_report 10:54:28 INFO - PROCESS | 15705 | _x_x_mozilla_page_load 10:54:28 INFO - PROCESS | 15705 | _x_x_mozilla_page_load_details 10:54:28 INFO - PROCESS | 15705 | |i|pagename|runs| 10:54:28 INFO - PROCESS | 15705 | |0;ai-astar;115;117;117;116;118;118;116;115;115;115 10:54:28 INFO - PROCESS | 15705 | |1;audio-beat-detection;158;127;127;161;130;131;126;125;167;128 10:54:28 INFO - PROCESS | 15705 | |2;audio-dft;162;161;162;162;160;160;162;160;162;160 10:54:28 INFO - PROCESS | 15705 | |3;audio-fft;75;76;77;115;76;75;76;75;99;75 10:54:28 INFO - PROCESS | 15705 | |4;audio-oscillator;85;84;123;84;85;84;107;84;83;118 10:54:28 INFO - PROCESS | 15705 | |5;imaging-gaussian-blur;117;117;116;117;118;118;119;119;117;116 10:54:28 INFO - PROCESS | 15705 | |6;imaging-darkroom;148;147;147;148;148;147;147;147;147;146 10:54:28 INFO - PROCESS | 15705 | |7;imaging-desaturate;95;94;94;95;94;95;95;95;95;95 10:54:28 INFO - PROCESS | 15705 | |8;json-parse-financial;66;64;64;64;63;66;65;65;65;65 10:54:28 INFO - PROCESS | 15705 | |9;json-stringify-tinderbox;67;67;66;66;68;67;68;67;66;67 10:54:28 INFO - PROCESS | 15705 | |10;stanford-crypto-aes;94;87;84;90;90;83;99;87;83;96 10:54:28 INFO - PROCESS | 15705 | |11;stanford-crypto-ccm;150;138;138;138;136;138;137;138;187;148 10:54:28 INFO - PROCESS | 15705 | |12;stanford-crypto-pbkdf2;177;173;179;174;173;176;181;175;174;187 10:54:28 INFO - PROCESS | 15705 | |13;stanford-crypto-sha256-iterative;71;71;70;70;69;70;69;69;70;68 10:54:28 INFO - PROCESS | 15705 | __end_tp_report 10:54:28 INFO - PROCESS | 15705 | __start_cc_report 10:54:28 INFO - PROCESS | 15705 | _x_x_mozilla_cycle_collect,1922 10:54:28 INFO - PROCESS | 15705 | __end_cc_report 10:54:28 INFO - PROCESS | 15705 | __startTimestamp1475690068107__endTimestamp 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | ------- Summary: start ------- 10:54:28 INFO - PROCESS | 15705 | Number of tests: 14 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.50 stddev:1.23 (1.1%) stddev-sans-first:1.22 10:54:28 INFO - PROCESS | 15705 | Values: 115.0 117.0 117.0 116.0 118.0 118.0 116.0 115.0 115.0 115.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:130.50 stddev:16.79 (12.9%) stddev-sans-first:16.18 10:54:28 INFO - PROCESS | 15705 | Values: 158.0 127.0 127.0 161.0 130.0 131.0 126.0 125.0 167.0 128.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 10:54:28 INFO - PROCESS | 15705 | Values: 162.0 161.0 162.0 162.0 160.0 160.0 162.0 160.0 162.0 160.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.77 (18.1%) stddev-sans-first:14.38 10:54:28 INFO - PROCESS | 15705 | Values: 75.0 76.0 77.0 115.0 76.0 75.0 76.0 75.0 99.0 75.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:84.00 stddev:15.87 (18.9%) stddev-sans-first:16.52 10:54:28 INFO - PROCESS | 15705 | Values: 85.0 84.0 123.0 84.0 85.0 84.0 107.0 84.0 83.0 118.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:1.07 (0.9%) stddev-sans-first:1.13 10:54:28 INFO - PROCESS | 15705 | Values: 117.0 117.0 116.0 117.0 118.0 118.0 119.0 119.0 117.0 116.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:54:28 INFO - PROCESS | 15705 | Values: 148.0 147.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 146.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:54:28 INFO - PROCESS | 15705 | Values: 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.88 10:54:28 INFO - PROCESS | 15705 | Values: 66.0 64.0 64.0 64.0 63.0 66.0 65.0 65.0 65.0 65.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 10:54:28 INFO - PROCESS | 15705 | Values: 67.0 67.0 66.0 66.0 68.0 67.0 68.0 67.0 66.0 67.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#10] stanford-crypto-aes Cycles:10 Average:89.30 Median:90.00 stddev:5.58 (6.2%) stddev-sans-first:5.65 10:54:28 INFO - PROCESS | 15705 | Values: 94.0 87.0 84.0 90.0 90.0 83.0 99.0 87.0 83.0 96.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#11] stanford-crypto-ccm Cycles:10 Average:144.80 Median:138.00 stddev:15.59 (11.3%) stddev-sans-first:16.42 10:54:28 INFO - PROCESS | 15705 | Values: 150.0 138.0 138.0 138.0 136.0 138.0 137.0 138.0 187.0 148.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:176.50 stddev:4.41 (2.5%) stddev-sans-first:4.68 10:54:28 INFO - PROCESS | 15705 | Values: 177.0 173.0 179.0 174.0 173.0 176.0 181.0 175.0 174.0 187.0 10:54:28 INFO - PROCESS | 15705 | 10:54:28 INFO - PROCESS | 15705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.95 (1.4%) stddev-sans-first:0.88 10:54:28 INFO - PROCESS | 15705 | Values: 71.0 71.0 70.0 70.0 69.0 70.0 69.0 69.0 70.0 68.0 10:54:28 INFO - PROCESS | 15705 | -------- Summary: end -------- 10:54:28 INFO - PROCESS | 15705 | 10:54:29 INFO - TEST-INFO | 15705: exit 0 10:54:29 INFO - TEST-OK | kraken | took 65061ms 10:54:29 INFO - SUITE-END | took 1187s 10:54:29 INFO - Completed test suite (00:19:47) 10:54:29 INFO - javascript benchmark 10:54:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.396661784481, 2593.0535354595577, 2621.515019721351, 2632.0656167060692, 2642.9867850660758, 4344.8913777155585, 4427.601515863572, 4602.286645569938, 4602.700824446413, 4656.5110663380365, 4466.665000124987, 4468.82124715011, 4470.798814053367, 4473.552644735525, 4474.14991151681, 4067.0849058961794, 4078.775667338295, 4086.3870419437026, 4106.32245679464, 4236.872893813175, 4271.124419494012, 4277.101808620194, 4306.461692288464, 4323.762193079395, 4343.78281085946, 4192.098698779761, 4202.495700515927, 4256.914861702764, 4260.510041345238, 4305.741655500664, 4267.146570685875, 4272.273713468702, 4272.700910936236, 4352.630026447724, 4362.978185109086, 4241.851535196253, 4299.91400171998, 4334.848280310205, 4339.60943515082, 4376.190404775127, 4493.168763778712, 4528.230200865828, 4533.0, 4593.816247350135, 4699.906001879944, 4848.466668666444, 4886.291487734295, 4895.828645997409, 4902.3872015998, 4905.141600219983, 4925.088858561177, 4975.726335051607, 5004.9749751251375, 5028.974855125737, 5044.722540260284, 4641.512641172696, 4642.814287428465, 4645.976770116195, 4654.511276315938, 4708.670393072452, 4835.685680430761, 5093.18509038552, 5096.23556466533, 5101.668391554537, 5168.560672342893, 4691.0, 4759.666823322404, 4818.060478206716, 4827.372441582572, 4903.926441103386, 4895.559399653977, 4906.1414252505665, 4913.524170805404, 4915.1644220481885, 4977.427595826454, 4830.106430310404, 4866.4403593586485, 4873.415190177201, 4883.169861123618, 4939.629527785359, 4714.528547145326, 4779.0680817241, 4782.378290822171, 4835.927461088087, 4836.202026665631, 4163.479565054368, 4185.0374413884365, 4198.916021679611, 4224.809883555247, 4241.957580424156, 3682.4108142697573, 3715.256948610289, 3739.457778622085, 3752.549694036733, 3768.8680896168503, 4281.507626622916, 4282.614564689131, 4284.76433796138, 4285.442892423965, 4344.652427805768, 4816.349792778, 4854.563089321908, 4959.876003099879, 4988.201887697951, 5031.622628302819, 4215.704900656986, 4222.662187025092, 4226.028013556899, 4262.829486820555, 4298.4412026436985, 4454.443194600675, 4459.264221403432, 4459.264221403497, 4462.085272519126, 4517.706349087299, 4525.7510836904285, 4644.396228490275, 4688.038952014829, 4689.9296510551685, 4743.0988112258565, 4801.68789028712, 4935.8025678972435, 4991.301217829579, 4995.775190116381, 5053.469385714447, 4740.3837501124635, 4755.548222918817, 4756.262779269219, 4760.190767569452, 4809.95190048109, 4932.950670493393, 4934.136526107988, 4936.950630493793, 4939.382577177853, 5002.799888004439, 4878.9512104878495, 4899.804007839789, 4921.237208232729, 4946.604271658187, 4956.083124621957, 4862.367892173995, 4863.635227357891, 4863.975680121577, 4876.853694389174, 4919.2129259318335, 4739.881502962316, 4751.453582838018, 4753.382060332135, 4757.881052973703, 4818.518148185153, 4649.697769644962, 4697.365855609449, 4707.552782485658, 4755.358026666356, 4770.880727981828, 4908.042931628441, 4920.335754673073, 4921.532454416824, 4963.751812409293, 4981.726005069756, 4577.0, 4619.191641462663, 4753.6434767393275, 4800.57804898577, 4868.683535570318], "value": 4534.511372089859, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.9406065332813, 564.8446677163779, 570.2017175953665, 571.1062187676287, 582.126809785322, 27205.0, 37159.81420092899, 38674.61325386749, 38738.22523549527, 42126.15747685044, 39212.0, 39624.4713504434, 39637.40543891844, 39662.20675586486, 39717.40423893644, 6903.20613129489, 7641.579713115762, 7790.727324543642, 7791.454598178129, 7791.883121753178, 7038.26098259683, 9631.614735410576, 9899.950500247525, 9904.801903961916, 10264.435456049914, 10010.799784004315, 10060.144887684555, 10078.496075196248, 10079.244056695741, 10082.495875206247, 9919.752006199831, 9968.95325990775, 9978.900210997943, 9986.750331241705, 9992.250581206366, 9788.265880059023, 9836.557354919047, 9853.06395892389, 9857.11285984265, 9858.457784821832, 37215.81392093049, 37659.811700941595, 37715.81142094272, 37732.43401348982, 37764.81117594422, 2762.9447411051665, 2780.7219278072234, 2888.2923683697627, 3113.143885431502, 3159.763017773676, 26521.867390663116, 28632.570511442344, 28702.712972870213, 28751.56872646912, 29111.12666620005, 3441.5698037745283, 3461.3769521486124, 3489.0753950203216, 3600.981995090034, 3647.9817600912093, 249572.0, 249889.0, 250714.0, 250887.0, 251322.0, 30863.0, 52969.0, 53038.73480632572, 53129.0, 53332.0, 31706.682933170836, 33577.496337554956, 33762.66237337644, 33768.1557961053, 33810.49284260738, 12072.215306005082, 12102.092343074304, 12158.027357811354, 12160.695982600506, 12190.08574356909, 9410.200132988635, 9544.570494327632, 9798.706038818847, 10025.699229023141, 10104.797904041878, 7672.462927595015, 7775.1447340792465, 7851.765375001816, 7924.960375198087, 7935.761927142195, 3076.8923087691824, 3099.6435409927694, 3106.8815226518436, 3125.093722820402, 3133.107064486656, 863.7711006583261, 884.4693184089494, 889.390767324372, 905.4883990545452, 933.1135421349745, 26799.330016749736, 27405.31486712848, 27861.0, 27968.0, 28299.43401132007, 925.3060204846365, 948.7628092976756, 949.050949050949, 952.4333021851987, 976.5410257179115, 14604.196769177797, 14875.70248595022, 14963.70072598542, 15095.180776603745, 15228.847711522965, 369047.0, 378068.0, 378125.4062053172, 379169.0, 380892.0, 48348.27477587839, 48474.515254847705, 48851.51148488541, 48975.265371019465, 49152.7542362293, 1035.6168217759478, 1087.6954452753084, 1105.1159072741934, 1151.5566506894738, 1167.217963964129, 24620.87689561541, 28862.422751544433, 28941.276468087624, 29393.559096613997, 29550.408991820474, 39999.20001599893, 40414.79792601018, 40512.59487405088, 40521.79739101286, 40548.0, 289385.0, 290094.0, 290102.0, 290418.0, 291058.0, 24288.271351859472, 24884.875575622005, 25118.623220651338, 25171.0, 26592.601110982963, 40715.0, 40785.44013866535, 40952.79523602363, 42137.0, 42166.57833421749, 34795.65204347924, 35100.297994040484, 35299.0, 35426.82286588551, 35497.467537986435, 34955.650443496255, 35118.648813511536, 35247.47128793019, 35494.822525887204, 35513.289734204656, 34412.655873441945, 35102.64897350994, 35188.0, 35214.823925880206, 35839.104022399646, 29735.55396669095, 32050.0, 32108.357832842747, 32180.83909580437, 32207.51688724718, 24620.261392158263, 24703.505929880943, 24822.751772482043, 25106.74893251117, 25352.366190845376], "value": 16477.229391403598, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.2899785083181, 343.1164750766776, 356.09374142806564, 360.3531660669099, 377.40558620173215, 12036.0, 15151.848481515182, 15302.311395987179, 16483.83516164841, 17450.127493625332, 16403.753943690856, 16444.260008299625, 16555.91722041391, 16671.41650042249, 16884.0, 4146.8133933972895, 4976.328195693581, 5210.2445145453885, 5212.504812042869, 5249.081410753122, 5134.383873935114, 5136.460671629462, 5173.586113110942, 5178.171492561191, 5179.404368497633, 4893.266010098479, 5131.717755523445, 5132.8973420531565, 5145.485451454862, 5160.277561141444, 5074.873128171788, 5119.667221630582, 5123.795048198068, 5128.589712822965, 5132.435432102466, 4348.7390756554705, 4416.183006143841, 4452.621527170194, 4576.610988066019, 4589.5181005994555, 20046.599068018702, 20047.39857804268, 20100.899495502428, 20204.797952020584, 20232.291869784633, 1957.5106223444138, 1965.8722183058055, 2113.323736404351, 2131.392553122368, 2282.109977108929, 12825.551105711254, 12862.485500579965, 12933.741325173538, 12972.0, 13338.466461341535, 1666.5250403634907, 1683.882128251023, 1686.7132587460162, 1735.1931351921291, 1806.1962426720115, 67462.3253767461, 68232.31767682359, 68349.0, 69243.30756692469, 69733.30266697319, 8915.37592368528, 9031.729048128567, 9195.172434480928, 9244.491552964517, 9267.860982085274, 12781.0, 12792.808107878389, 12798.808017879739, 12810.743785124245, 12825.29460879642, 6744.662766861736, 6964.965175174193, 7004.4046256068805, 7117.6085315308155, 7188.245234250328, 6502.512311576556, 6533.673316334164, 6578.3750543699225, 6702.497312701469, 6722.865542689216, 5858.619189752652, 5875.882482350415, 5892.322382925932, 5894.734736936848, 5940.762369505258, 1661.1279078483892, 1679.5045461588861, 1716.7339062445342, 1719.3208682570564, 1761.4891681412503, 691.8892977123636, 801.703369753195, 861.9094995025557, 874.8337815815102, 931.739113048334, 15900.284487198103, 16472.588185295223, 16853.325866965184, 17072.48782536526, 17728.645427091644, 805.0781854776249, 816.7345612675904, 822.7655118291258, 835.7325655790211, 887.2414085956543, 8945.73162805117, 9376.249900007982, 9721.708348749407, 9731.416115032978, 9751.90248097524, 384069.0, 386501.0, 391082.0, 392726.0, 394108.0, 77407.61296193484, 78455.0, 78860.21139788644, 78955.60522197468, 79984.20015799884, 870.6386849457531, 903.7514683461969, 907.4328544659588, 928.6888892221182, 934.990650093504, 15352.155631440379, 15445.613859653598, 15940.202989850693, 16269.67460650804, 16274.186290685655, 36594.26811463809, 36698.8165059173, 37195.0, 37474.437883432314, 37558.0, 50997.49002509927, 51226.74386628043, 51324.74337628288, 51764.74117629388, 51983.220251697014, 4501.617362524222, 5608.663480191201, 5771.509421699035, 7640.044994375703, 8039.557824319719, 9920.503974801086, 10991.890081099407, 11208.27146235492, 11231.0, 11588.130890183102, 7724.570954373459, 9502.667406640734, 9669.0, 10016.148627366463, 10314.278000540191, 9847.212223021997, 9991.25065620067, 10032.69901902944, 10275.177985761271, 10312.226583006155, 9859.30984831055, 9920.553575088994, 10234.0, 10354.430506321924, 10448.52981615814, 7393.149787774475, 7430.219826918095, 7480.92519074824, 7518.887216691644, 7543.207963164008, 9523.857142142735, 9617.182539484222, 9798.608055677692, 10028.799424011333, 10120.797584048425], "value": 8066.477949689963, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.117502448384, 1360.9931950340247, 1420.1904914198903, 1628.470747007223, 1637.459638319354, 6770.492213084014, 6993.965030174854, 7254.38337741292, 7771.145174030867, 7788.636988527006, 7360.926390736091, 7634.656440460179, 7642.465027448081, 7833.82492626105, 7838.412119091063, 2027.0675489274915, 2047.5597746484502, 2050.384884534641, 2065.1532871522604, 2065.483629092727, 1726.1800644693797, 1777.7155655095187, 1986.324649619129, 2013.3657897762232, 2032.4309193425865, 2000.3298894870236, 2062.0411508648476, 2072.3057775645175, 2074.6161960037443, 2078.054485209234, 2028.9188432462759, 2028.9289874854458, 2034.1659919433037, 2053.5790163016545, 2065.10168076887, 2045.6317862784692, 2049.5695903860205, 2053.6303465376227, 2056.4858785303672, 2066.772655007948, 7472.626368681598, 7552.66013029415, 7554.811129721746, 7570.015897933288, 7646.694132234704, 4418.889527761831, 4571.0, 4587.197240482936, 4588.151192029485, 4591.265397536378, 2690.986545067282, 2726.495598314298, 2840.1763488588285, 2860.8426536540483, 2872.482953068447, 876.548577482597, 877.9956100219522, 883.584715183869, 888.6667499687617, 897.5063714956748, 10432.321899076536, 10439.686809395731, 10457.79084418315, 10472.26694131411, 10509.106725928305, 3788.109794198361, 3955.169414423003, 4084.1219137885496, 4106.958930410718, 4111.1366613011005, 8927.821443571222, 8931.821363572692, 8934.642614295355, 8935.687250946186, 8940.821183576292, 4624.167649822997, 4635.976820115945, 4643.233866412072, 4653.441587009513, 4655.627549796008, 4137.420761093449, 4197.916041679149, 4216.683748718859, 4222.071144348239, 4223.767692776927, 3624.873129440457, 3663.798491083016, 3708.351038568294, 3723.2925744108534, 3723.9627603724157, 1069.8341757027674, 1094.2996482251365, 1164.7088227943013, 1175.5591653130077, 1180.451090243041, 643.6717274190103, 753.6307209467432, 805.4844899264475, 824.884516167737, 825.529448214524, 4911.189653707098, 5016.824411145592, 5074.82238121664, 5153.639245252872, 5154.664946778523, 799.3525244551815, 817.9754607361789, 835.4611275727243, 858.1075681291512, 866.7183165471247, 3533.7526373153632, 3645.3985092459448, 3657.5062366580173, 3695.371786796251, 3704.759190652599, 8883.73348799537, 9410.623575056921, 9420.24638028956, 9420.623175073057, 9435.292353073546, 9117.08829117083, 9121.81756364869, 9344.15902568772, 9347.90652093484, 9368.578413971387, 7142.4286057115305, 7217.603031833194, 7228.060352154292, 7230.783076507713, 7234.348908598146, 4936.136176169228, 4972.254161875748, 5072.0, 5096.23556466533, 5266.762995665128, 8616.827663446822, 8629.482231066157, 8635.740927772176, 8667.306615470874, 8704.955405351398, 8531.8720219198, 8722.520261385685, 8729.170728780755, 8730.869036964577, 8797.516136612549, 6318.27339855904, 6661.800145995628, 6742.393184613408, 6745.696443660146, 6746.224184218878, 7025.402840758593, 7232.132144142736, 7254.056972593529, 7289.744858929912, 7302.671379788028, 6406.967965160145, 6424.164858568356, 6530.151080359523, 6536.346365363425, 6577.835554111186, 6459.354064593503, 6460.806175814733, 6485.805425837232, 6499.155109835691, 6516.022596610546, 5911.970440147772, 5979.222701048836, 5992.670403127696, 5996.190514280516, 5998.430149135826, 4426.048399593974, 4474.082813023388, 4481.955180448153, 4554.772261386851, 4571.451425828789, 4273.273543497675, 4301.784910754513, 4316.503602085801, 4328.718633288826, 4376.474823021258], "value": 4002.9202202938445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.09779585489133, 300.1939791659395, 302.4706763164462, 305.07105862648234, 306.2115053736629, 4789.928151077732, 4804.2793580962825, 4808.278758186274, 4823.059503396839, 4838.0, 4754.310624959378, 4755.3104799804005, 4761.738104404257, 4768.141734487791, 4774.474807771151, 3571.2500374921233, 3678.613745556718, 3709.4250391189275, 3776.8866933991885, 3808.0, 3782.7352085354037, 3791.6587507124354, 3808.9809550952205, 3809.3714537101346, 3822.3693090640013, 3764.0, 3764.5294338207723, 3765.755225910321, 3773.4905787718717, 3786.2238241160494, 3566.5006899034024, 3609.530761001079, 3681.8159092045425, 3730.850765969358, 3751.4747935289083, 3306.5370848081047, 3319.933601327984, 3331.2005118771563, 3331.4503106987318, 3332.516785066152, 4610.861674149747, 4619.630429565626, 4623.514530974233, 4632.2588385858435, 4645.907081858378, 4164.0, 4233.888092252192, 4243.172581346638, 4269.6370808481315, 4275.87172384829, 4902.362692849907, 4907.975460122712, 4916.139675556763, 4939.234418665113, 4951.133551628451, 3614.222942067468, 3621.149029977953, 3622.5471816022996, 3625.9456108158397, 3631.6018332941744, 4959.6528243023, 5152.304438900738, 5175.663581867167, 5179.741012949337, 5198.738548731314, 3698.4082546792383, 3726.1927964936986, 3726.9440958385644, 3733.1600389912596, 3735.215604722984, 3776.339140650375, 3777.244551089793, 3783.754055986407, 3791.9431208531896, 3791.962080379216, 4242.215190189825, 4251.107267473865, 4251.617354438054, 4260.659147268211, 4261.446012018418, 4760.642951778561, 4939.48135445773, 4957.107720610325, 4963.181075122637, 4971.825986090469, 1302.400895588021, 1309.6136639691315, 1309.705316303824, 1315.4540865540885, 1315.953941612058, 818.3535007344132, 833.5496236548483, 843.6627944707707, 852.5140669818268, 854.0946596607616, 3954.0, 4193.266178418826, 4279.914401711948, 4337.89383707159, 4430.379746835446, 5140.665856719302, 5147.6654017488745, 5151.0, 5152.252923326097, 5155.175171972542, 4379.49635791888, 4395.7362558246605, 4406.757628330409, 4427.335899615084, 4434.11317736454, 2628.132716203648, 2692.7307269272915, 2706.4316493536576, 2724.5559853277796, 2725.419256831033, 4893.168161412568, 4893.975530122398, 4900.191468407744, 4905.190643543847, 4906.239532872411, 5233.188855727369, 5256.896051829082, 5260.13207820713, 5266.605004624668, 5285.418603953562, 4715.308659093374, 4825.879353016203, 4874.220124779948, 4880.829170978998, 4890.779914903838, 5056.82301119459, 5101.525760006468, 5109.846704598868, 5110.437851836221, 5111.488851114858, 4955.72921871563, 5011.373578302712, 5025.195968644999, 5040.445550989315, 5044.697318160922, 4651.348811166372, 4886.53577910098, 4932.4327702314695, 4943.2585112233455, 4943.876403089952, 3603.549556305462, 3606.2787442511076, 3611.2416392557857, 3612.3858943980113, 3616.1682812953695, 5181.844544663666, 5184.637075404686, 5239.685618862881, 5249.553787928069, 5249.7112658804135, 4956.702597844141, 5058.924116138187, 5061.75986883216, 5066.314853127848, 5069.3156423883775, 5017.397912250407, 5041.344625198701, 5043.697378157322, 5050.3182070420025, 5054.620903432331, 4964.202385175416, 4967.552920237196, 4972.577330926912, 4972.9254061188385, 4981.227909674007, 4798.448178459382, 4864.537868902448, 5025.296458495741, 5034.949650503448, 5057.898842023213, 4793.993261415142, 4849.58778503817, 4917.803287868445, 4922.901541969212, 4938.234573641092], "value": 3778.531978384397, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.5537124013191, 648.9286178520362, 669.2938949408378, 710.6162672157036, 736.7384578474641, 12948.805767913476, 13579.04946653732, 13790.379432925518, 13814.861851381484, 13824.654383640414, 12782.296973666445, 12992.870071299285, 13069.803952940714, 13111.868881311184, 13155.605331840035, 601.0923505506672, 616.2174038970505, 724.0768020773503, 728.9599072051035, 738.7377480994251, 740.6704016712538, 742.4542960923717, 742.832862605912, 744.0773440933258, 744.4081954845883, 786.7364432914981, 787.8069872881152, 788.1842293226512, 788.4283894176733, 789.1477204618998, 638.1576319258558, 652.9020646902956, 655.7114869457423, 658.0228360884083, 784.2862994674847, 479.0753845079031, 550.1225545255311, 563.9266895303625, 566.0659911146599, 567.4013915319337, 12379.75240495185, 12505.374731263491, 12534.68663283416, 12565.497380104785, 12647.557335493306, 10630.574777008911, 10880.836787448194, 11030.338179709162, 11075.647461352099, 11275.49260283281, 11722.413879306087, 11731.530738770523, 11922.582709605209, 11939.761204775943, 12024.158308918379, 3936.3308237599676, 4021.195760847813, 4056.898577535556, 4078.062045729469, 4197.559256278108, 59963.0, 61410.0, 61639.69180154115, 61794.0, 61918.0, 10008.499575021366, 10069.79860402788, 10197.235207359477, 10240.0, 10735.463226838627, 18844.246230150642, 18884.622307554047, 18935.147918343708, 18942.337018204296, 18959.526011849815, 6470.64411457365, 6619.735210591619, 6682.498812589075, 6749.392554670103, 6807.591544507345, 3519.1554027033326, 3644.2711457708565, 3647.28877868813, 3664.4686520454384, 3714.0529165063276, 2581.5353236417627, 2645.563482025444, 2652.403209277897, 2655.2830735701255, 2670.0654770830056, 459.42571785268416, 465.6833353319775, 466.83660718748166, 473.583246742871, 485.20426500539145, 534.6528738836511, 544.4337888595895, 544.7140251367985, 587.1457030021309, 588.1413136820205, 7856.175101614363, 8023.558704271204, 8068.082557588231, 8143.877841832377, 8331.500109993298, 470.9873771391467, 555.6443875919415, 569.8972488235278, 575.2579172867038, 609.5245708347496, 3765.4728338032696, 3998.7400818946676, 4031.334829753058, 4170.937435938464, 4183.330667093312, 56435.0, 66680.0, 96118.0, 99035.0, 99468.0, 81886.18113818785, 83625.0, 83816.0, 84407.0, 86201.13798862057, 71000.0, 72103.63948180225, 73526.63236683782, 76105.6194719034, 76888.84666730004, 7183.245759195209, 7207.927920720936, 7237.963810181126, 7489.513181643176, 7672.002639656809, 43693.34459983166, 43936.780316098215, 44605.77697111623, 45315.546844531134, 46110.30834537552, 59078.0, 63401.68299158659, 64650.35349646631, 64768.35231647623, 67929.0, 9503.19222866064, 9553.570089346134, 9623.5669394876, 9719.0, 9838.950805245928, 10472.790544189225, 10479.214058945458, 10498.317609355672, 10554.894451055392, 10610.946945265225, 9716.9028309716, 9825.557849896915, 9861.802763944537, 9966.950165249127, 10160.745981350525, 9916.801663966824, 9979.151772099163, 10145.79708405813, 10216.489175541044, 10269.794604108025, 9956.352837065568, 10025.749356266151, 10095.899041009496, 10347.327423717434, 11029.0, 8430.831383372175, 8715.08491608372, 8985.595648195716, 8994.730158095268, 9183.448993060438, 8806.339524535557, 8895.644174232959, 9022.330868789295, 10018.148457381205, 10831.566737330419], "value": 6237.31201183288, "unit": "score"}], "name": "dromaeo_css", "value": 6201.177444621912, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 117.0, 116.0, 118.0, 118.0, 116.0, 115.0, 115.0, 115.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 127.0, 127.0, 161.0, 130.0, 131.0, 126.0, 125.0, 167.0, 128.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 160.0, 160.0, 162.0, 160.0, 162.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 115.0, 76.0, 75.0, 76.0, 75.0, 99.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 123.0, 84.0, 85.0, 84.0, 107.0, 84.0, 83.0, 118.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 119.0, 119.0, 117.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 64.0, 63.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 68.0, 67.0, 68.0, 67.0, 66.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 87.0, 84.0, 90.0, 90.0, 83.0, 99.0, 87.0, 83.0, 96.0], "value": 89.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 138.0, 138.0, 138.0, 136.0, 138.0, 137.0, 138.0, 187.0, 148.0], "value": 144.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 173.0, 179.0, 174.0, 173.0, 176.0, 181.0, 175.0, 174.0, 187.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 70.0, 69.0, 70.0, 69.0, 69.0, 70.0, 68.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1562.5000000000002, "alertThreshold": 2.0}]} 10:54:29 INFO - Return code: 0 10:54:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:54:29 INFO - # TBPL SUCCESS # 10:54:29 INFO - Running post-action listener: _resource_record_post_action 10:54:29 INFO - [mozharness: 2016-10-05 17:54:29.928115Z] Finished run-tests step (success) 10:54:29 INFO - Running post-run listener: _resource_record_post_run 10:54:30 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 401629184; Read time: 124; Write time: 263580 10:54:30 INFO - TinderboxPrint: CPU usage
13.0% 10:54:30 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 124 10:54:30 INFO - TinderboxPrint: I/O write bytes / time
401,629,184 / 263,580 10:54:30 INFO - TinderboxPrint: CPU idle
8,354.4 (87.0%) 10:54:30 INFO - TinderboxPrint: CPU user
1,202.0 (12.5%) 10:54:30 INFO - TinderboxPrint: Swap in / out
0 / 0 10:54:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110530560; Read time: 0; Write time: 57180 10:54:30 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290566144; Read time: 104; Write time: 206400 10:54:30 INFO - Running post-run listener: _upload_blobber_files 10:54:30 INFO - Blob upload gear active. 10:54:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:54:30 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 10:54:30 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:54:30 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:54:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:54:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:31 INFO - (blobuploader) - INFO - Done attempting. 10:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:35 INFO - (blobuploader) - INFO - Done attempting. 10:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:54:35 INFO - (blobuploader) - INFO - Done attempting. 10:54:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:54:35 INFO - Return code: 0 10:54:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:54:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:54:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c346ef70c1241316846497a9155fcfbb596372c6897f756d2e8fd637260a3089d109a2f491e397aa718ebcd86c90a5480d803cf614d037aa6277968002cdfb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18af7daae1eb7447068917bff260da1064e22a5b91e7bb6e1100db71ad03a22123642cfe00af66d852d7b76c44368622cda5161ccc5151f433c6e34a45867887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/35332b742cfba5bc85cb81bf12c205fd0b0ead859bbdb51324db55e88eea4244be234a4902bc98fa2e4d2609811964c94f2063fa0a53fb13883b356e89707e32"} 10:54:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:54:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:54:35 INFO - Contents: 10:54:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c346ef70c1241316846497a9155fcfbb596372c6897f756d2e8fd637260a3089d109a2f491e397aa718ebcd86c90a5480d803cf614d037aa6277968002cdfb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18af7daae1eb7447068917bff260da1064e22a5b91e7bb6e1100db71ad03a22123642cfe00af66d852d7b76c44368622cda5161ccc5151f433c6e34a45867887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/35332b742cfba5bc85cb81bf12c205fd0b0ead859bbdb51324db55e88eea4244be234a4902bc98fa2e4d2609811964c94f2063fa0a53fb13883b356e89707e32"} 10:54:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:54:35 INFO - Copying logs to upload dir... 10:54:35 INFO - mkdir: /builds/slave/test/build/upload/logs 10:54:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.533799 ========= master_lag: 0.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-05 10:54:36.104334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 10:54:36.113080) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c346ef70c1241316846497a9155fcfbb596372c6897f756d2e8fd637260a3089d109a2f491e397aa718ebcd86c90a5480d803cf614d037aa6277968002cdfb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18af7daae1eb7447068917bff260da1064e22a5b91e7bb6e1100db71ad03a22123642cfe00af66d852d7b76c44368622cda5161ccc5151f433c6e34a45867887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/35332b742cfba5bc85cb81bf12c205fd0b0ead859bbdb51324db55e88eea4244be234a4902bc98fa2e4d2609811964c94f2063fa0a53fb13883b356e89707e32"} build_url:https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/DkPTDvxFRmCue34kIOS0HQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c346ef70c1241316846497a9155fcfbb596372c6897f756d2e8fd637260a3089d109a2f491e397aa718ebcd86c90a5480d803cf614d037aa6277968002cdfb88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/18af7daae1eb7447068917bff260da1064e22a5b91e7bb6e1100db71ad03a22123642cfe00af66d852d7b76c44368622cda5161ccc5151f433c6e34a45867887", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/35332b742cfba5bc85cb81bf12c205fd0b0ead859bbdb51324db55e88eea4244be234a4902bc98fa2e4d2609811964c94f2063fa0a53fb13883b356e89707e32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 10:54:36.141092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:54:36.141396) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1475688825.745154-398978245 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 10:54:36.190484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 10:54:36.195403) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 10:54:36.480044) ========= ========= Total master_lag: 0.80 =========