builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1479785426.5 results: success (0) buildid: 20161121181650 builduid: a942333ddeaf4bdba91c85befe060906 revision: e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.503841) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.504303) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.504595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.550301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.550646) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 19:30:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-11-21 19:30:27 (218 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.204404 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.786843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.787115) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020182 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.838974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.839334) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c --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=8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 19:30:27,453 truncating revision to first 12 chars 2016-11-21 19:30:27,453 Setting DEBUG logging. 2016-11-21 19:30:27,453 attempt 1/10 2016-11-21 19:30:27,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/e37eaf3f1d2e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 19:30:27,756 unpacking tar archive at: graphics-e37eaf3f1d2e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.655143 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:27.510678) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:27.510986) ========= script_repo_revision: e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:27.511383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:27.511649) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:27.520548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-21 19:30:27.520936) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:30:28 INFO - MultiFileLogger online at 20161121 19:30:28 in /builds/slave/test 19:30:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:30:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:30:28 INFO - {'append_to_log': False, 19:30:28 INFO - 'base_work_dir': '/builds/slave/test', 19:30:28 INFO - 'blob_upload_branch': 'Graphics', 19:30:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:30:28 INFO - 'branch': 'Graphics', 19:30:28 INFO - 'buildbot_json_path': 'buildprops.json', 19:30:28 INFO - 'config_files': ('talos/linux_config.py',), 19:30:28 INFO - 'default_actions': ('clobber', 19:30:28 INFO - 'read-buildbot-config', 19:30:28 INFO - 'download-and-extract', 19:30:28 INFO - 'populate-webroot', 19:30:28 INFO - 'create-virtualenv', 19:30:28 INFO - 'install', 19:30:28 INFO - 'run-tests'), 19:30:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:30:28 INFO - 'download_minidump_stackwalk': True, 19:30:28 INFO - 'download_symbols': 'ondemand', 19:30:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:30:28 INFO - 'tooltool.py': '/tools/tooltool.py', 19:30:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:30:28 INFO - '/tools/misc-python/virtualenv.py')}, 19:30:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:30:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:30:28 INFO - 'installer_path': 'installer.exe', 19:30:28 INFO - 'log_level': 'info', 19:30:28 INFO - 'log_name': 'talos', 19:30:28 INFO - 'log_to_console': True, 19:30:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:30:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:30:28 INFO - 'opt_config_files': (), 19:30:28 INFO - 'pip_index': False, 19:30:28 INFO - 'sps_profile': False, 19:30:28 INFO - 'sps_profile_interval': 0, 19:30:28 INFO - 'suite': 'dromaeojs', 19:30:28 INFO - 'system_bits': '32', 19:30:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:30:28 INFO - 'title': 'talos-linux64-ix-041', 19:30:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:30:28 INFO - 'use_talos_json': True, 19:30:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:30:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:30:28 INFO - 'work_dir': 'build'} 19:30:28 INFO - [mozharness: 2016-11-22 03:30:28.233091Z] Running clobber step. 19:30:28 INFO - Running pre-action listener: _resource_record_pre_action 19:30:28 INFO - Running main action method: clobber 19:30:28 INFO - rmtree: /builds/slave/test/build 19:30:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:30:29 INFO - Running post-action listener: _resource_record_post_action 19:30:29 INFO - [mozharness: 2016-11-22 03:30:29.212892Z] Finished clobber step (success) 19:30:29 INFO - [mozharness: 2016-11-22 03:30:29.212991Z] Running read-buildbot-config step. 19:30:29 INFO - Running pre-action listener: _resource_record_pre_action 19:30:29 INFO - Running main action method: read_buildbot_config 19:30:29 INFO - Using buildbot properties: 19:30:29 INFO - { 19:30:29 INFO - "project": "", 19:30:29 INFO - "product": "firefox", 19:30:29 INFO - "script_repo_revision": "default", 19:30:29 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 19:30:29 INFO - "repository": "", 19:30:29 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 19:30:29 INFO - "buildid": "20161121181650", 19:30:29 INFO - "pgo_build": "False", 19:30:29 INFO - "basedir": "/builds/slave/test", 19:30:29 INFO - "buildnumber": 6, 19:30:29 INFO - "slavename": "talos-linux64-ix-041", 19:30:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:30:29 INFO - "platform": "ubuntu64_hw", 19:30:29 INFO - "scheduler": "tests-graphics-linux64-talos", 19:30:29 INFO - "branch": "graphics", 19:30:29 INFO - "repo_path": "projects/graphics", 19:30:29 INFO - "revision": "e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c", 19:30:29 INFO - "stage_platform": "linux64", 19:30:29 INFO - "builduid": "a942333ddeaf4bdba91c85befe060906", 19:30:29 INFO - "slavebuilddir": "test" 19:30:29 INFO - } 19:30:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 19:30:29 INFO - Running post-action listener: _resource_record_post_action 19:30:29 INFO - [mozharness: 2016-11-22 03:30:29.215642Z] Finished read-buildbot-config step (success) 19:30:29 INFO - [mozharness: 2016-11-22 03:30:29.215731Z] Running download-and-extract step. 19:30:29 INFO - Running pre-action listener: _resource_record_pre_action 19:30:29 INFO - Running main action method: download_and_extract 19:30:29 INFO - mkdir: /builds/slave/test/build/tests 19:30:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:29 INFO - trying https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:30:29 INFO - Downloading https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:30:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:30:29 INFO - Downloaded 1361 bytes. 19:30:29 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:30:29 INFO - Using the following test package requirements: 19:30:29 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:29 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:30:29 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:30:29 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'jsshell-linux-x86_64.zip'], 19:30:29 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:30:29 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:29 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:30:29 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:30:29 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:30:29 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:29 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:30:29 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:30:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:30:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:30:29 INFO - Fetch https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:30:30 INFO - Http code: 200 19:30:30 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 19:30:30 INFO - x-amz-cf-id: 1k1OIUKyC54M-Dy7fSV2taycF0k776gHBxZXK5FlwtfmKdGi3LBZuA== 19:30:30 INFO - x-amz-version-id: My_NV_Votmn2jp3JqHkIGeR08vdJJ.2h 19:30:31 INFO - Expected file size: 20327684 19:30:31 INFO - Obtained file size: 20327684 19:30:35 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:30:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 19:30:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:30:35 INFO - Fetch https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:30:36 INFO - Http code: 200 19:30:36 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 19:30:36 INFO - x-amz-cf-id: ayTb1r15HkXgXEVXGT3-Zebje0mJR0BJPwbymosaN5_TWy35gK1EyQ== 19:30:36 INFO - x-amz-version-id: My_NV_Votmn2jp3JqHkIGeR08vdJJ.2h 19:30:36 INFO - Expected file size: 20327684 19:30:36 INFO - Obtained file size: 20327684 19:30:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 19:30:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:30:40 INFO - Fetch https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:30:41 INFO - Http code: 200 19:30:41 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 19:30:41 INFO - x-amz-cf-id: b2XyeATFVYnZsTanjAHaUpcWqNN5evcqbEZZrg4Y_-aL0XFclzTkmw== 19:30:41 INFO - x-amz-version-id: 3hESrjqw6oEGQ_cnafGAMtYbpTF9NKum 19:30:42 INFO - Expected file size: 14409392 19:30:42 INFO - Obtained file size: 14409392 19:30: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')]} 19:30:42 INFO - trying https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:30:42 INFO - Downloading https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:30:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:30:45 INFO - Downloaded 55400890 bytes. 19:30:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:30:45 INFO - mkdir: /builds/slave/test/properties 19:30:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:30:45 INFO - Writing to file /builds/slave/test/properties/build_url 19:30:45 INFO - Contents: 19:30:45 INFO - build_url:https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 19:30:45 INFO - Running post-action listener: _resource_record_post_action 19:30:45 INFO - Running post-action listener: set_extra_try_arguments 19:30:45 INFO - [mozharness: 2016-11-22 03:30:45.917516Z] Finished download-and-extract step (success) 19:30:45 INFO - [mozharness: 2016-11-22 03:30:45.917744Z] Running populate-webroot step. 19:30:45 INFO - Running pre-action listener: _resource_record_pre_action 19:30:45 INFO - Running main action method: populate_webroot 19:30:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:30:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:30:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:30:45 INFO - '--tppagecycles', 19:30:45 INFO - '7'], 19:30:45 INFO - 'tests': ['tsvgm']}}, 19:30:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:30:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:30:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:30:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:30:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:30:45 INFO - 'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:30:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:30:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:30:45 INFO - 'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['damp', 'tps']}, 19:30:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:30:45 INFO - 'tests': ['damp', 'tps']}, 19:30:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['dromaeo_dom']}, 19:30:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:30:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['basic_compositor_video']}, 19:30:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:30:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['a11yr', 19:30:45 INFO - 'ts_paint', 19:30:45 INFO - 'tpaint', 19:30:45 INFO - 'sessionrestore', 19:30:45 INFO - 'sessionrestore_no_auto_restore', 19:30:45 INFO - 'tabpaint']}, 19:30:45 INFO - 'other-e10s': {'tests': ['a11yr', 19:30:45 INFO - 'ts_paint', 19:30:45 INFO - 'tpaint', 19:30:45 INFO - 'sessionrestore', 19:30:45 INFO - 'sessionrestore_no_auto_restore', 19:30:45 INFO - 'tabpaint']}, 19:30:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:30:45 INFO - 'ts_paint', 19:30:45 INFO - 'tpaint', 19:30:45 INFO - 'sessionrestore', 19:30:45 INFO - 'sessionrestore_no_auto_restore', 19:30:45 INFO - 'tabpaint']}, 19:30:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:30:45 INFO - 'ts_paint', 19:30:45 INFO - 'tpaint', 19:30:45 INFO - 'sessionrestore', 19:30:45 INFO - 'sessionrestore_no_auto_restore', 19:30:45 INFO - 'tabpaint']}, 19:30:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['a11yr', 19:30:45 INFO - 'ts_paint', 19:30:45 INFO - 'tpaint', 19:30:45 INFO - 'sessionrestore', 19:30:45 INFO - 'sessionrestore_no_auto_restore', 19:30:45 INFO - 'tabpaint']}, 19:30:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['a11yr', 19:30:45 INFO - 'ts_paint', 19:30:45 INFO - 'tpaint', 19:30:45 INFO - 'sessionrestore', 19:30:45 INFO - 'sessionrestore_no_auto_restore', 19:30:45 INFO - 'tabpaint']}, 19:30:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['tsvgx', 19:30:45 INFO - 'tsvgr_opacity', 19:30:45 INFO - 'tart', 19:30:45 INFO - 'tscrollx', 19:30:45 INFO - 'cart']}, 19:30:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:30:45 INFO - 'tsvgr_opacity', 19:30:45 INFO - 'tart', 19:30:45 INFO - 'tscrollx', 19:30:45 INFO - 'cart']}, 19:30:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:30:45 INFO - 'talos_options': ['--disable-e10s'], 19:30:45 INFO - 'tests': ['tp5o']}, 19:30:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:30:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:30:45 INFO - 'talos_options': ['--disable-e10s', 19:30:45 INFO - '--xperf_path', 19:30:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:45 INFO - 'tests': ['tp5n']}, 19:30:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:30:45 INFO - 'talos_options': ['--xperf_path', 19:30:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:30:45 INFO - 'tests': ['tp5n']}}, 19:30:45 INFO - 'talos.zip': {'path': '', 19:30:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:30:45 INFO - Running post-action listener: _resource_record_post_action 19:30:45 INFO - [mozharness: 2016-11-22 03:30:45.932789Z] Finished populate-webroot step (success) 19:30:45 INFO - [mozharness: 2016-11-22 03:30:45.932876Z] Running create-virtualenv step. 19:30:45 INFO - Running pre-action listener: _resource_record_pre_action 19:30:45 INFO - Running main action method: create_virtualenv 19:30:45 INFO - Creating virtualenv /builds/slave/test/build/venv 19:30:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:30:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:30:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:30:46 INFO - Using real prefix '/usr' 19:30:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:30:46 INFO - Installing distribute.............................................................................................................................................................................................done. 19:30:48 INFO - Installing pip.................done. 19:30:48 INFO - Return code: 0 19:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:30:48 INFO - Reading from file tmpfile_stdout 19:30:48 INFO - Output received: 19:30:48 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) 19:30:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:30:48 INFO - Using env: {'DISPLAY': ':0', 19:30:48 INFO - 'HOME': '/home/cltbld', 19:30:48 INFO - 'LANG': 'en_US.UTF-8', 19:30:48 INFO - 'LANGUAGE': 'en_US:en', 19:30:48 INFO - 'LOGNAME': 'cltbld', 19:30:48 INFO - 'MAIL': '/var/mail/cltbld', 19:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:48 INFO - 'MOZ_NO_REMOTE': '1', 19:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:48 INFO - 'NO_EM_RESTART': '1', 19:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:48 INFO - 'PWD': '/builds/slave/test', 19:30:48 INFO - 'SHELL': '/bin/bash', 19:30:48 INFO - 'SHLVL': '1', 19:30:48 INFO - 'TERM': 'linux', 19:30:48 INFO - 'TMOUT': '86400', 19:30:48 INFO - 'USER': 'cltbld', 19:30:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:48 INFO - '_': '/tools/buildbot/bin/python'} 19:30:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:48 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 19:30:48 INFO - Cleaning up... 19:30:48 INFO - Return code: 0 19:30:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:30:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:30:48 INFO - Using env: {'DISPLAY': ':0', 19:30:48 INFO - 'HOME': '/home/cltbld', 19:30:48 INFO - 'LANG': 'en_US.UTF-8', 19:30:48 INFO - 'LANGUAGE': 'en_US:en', 19:30:48 INFO - 'LOGNAME': 'cltbld', 19:30:48 INFO - 'MAIL': '/var/mail/cltbld', 19:30:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:48 INFO - 'MOZ_NO_REMOTE': '1', 19:30:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:48 INFO - 'NO_EM_RESTART': '1', 19:30:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:48 INFO - 'PWD': '/builds/slave/test', 19:30:48 INFO - 'SHELL': '/bin/bash', 19:30:48 INFO - 'SHLVL': '1', 19:30:48 INFO - 'TERM': 'linux', 19:30:48 INFO - 'TMOUT': '86400', 19:30:48 INFO - 'USER': 'cltbld', 19:30:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:30:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:48 INFO - '_': '/tools/buildbot/bin/python'} 19:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:49 INFO - Downloading/unpacking psutil>=3.1.1 19:30:49 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 19:30:49 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 19:30:49 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 19:30:49 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 19:30:49 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 19:30:49 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 19:30:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:51 INFO - Installing collected packages: psutil 19:30:51 INFO - Running setup.py install for psutil 19:30:51 INFO - building 'psutil._psutil_linux' extension 19:30:51 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 19:30:51 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 19:30:51 INFO - building 'psutil._psutil_posix' extension 19:30:51 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 19:30:51 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 19:30:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:30:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:30:51 INFO - Successfully installed psutil 19:30:51 INFO - Cleaning up... 19:30:51 INFO - Return code: 0 19:30:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:30:51 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')]} 19:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:51 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')]} 19:30:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:51 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 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:30:51 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 19:30:51 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 19:30:51 INFO - Using env: {'DISPLAY': ':0', 19:30:51 INFO - 'HOME': '/home/cltbld', 19:30:51 INFO - 'LANG': 'en_US.UTF-8', 19:30:51 INFO - 'LANGUAGE': 'en_US:en', 19:30:51 INFO - 'LOGNAME': 'cltbld', 19:30:51 INFO - 'MAIL': '/var/mail/cltbld', 19:30:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:51 INFO - 'MOZ_NO_REMOTE': '1', 19:30:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:51 INFO - 'NO_EM_RESTART': '1', 19:30:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:51 INFO - 'PWD': '/builds/slave/test', 19:30:51 INFO - 'SHELL': '/bin/bash', 19:30:51 INFO - 'SHLVL': '1', 19:30:51 INFO - 'TERM': 'linux', 19:30:51 INFO - 'TMOUT': '86400', 19:30:51 INFO - 'USER': 'cltbld', 19:30:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:30:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:51 INFO - '_': '/tools/buildbot/bin/python'} 19:30:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:30:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:30:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:30:53 INFO - Installing collected packages: mozsystemmonitor 19:30:53 INFO - Running setup.py install for mozsystemmonitor 19:30:54 INFO - Successfully installed mozsystemmonitor 19:30:54 INFO - Cleaning up... 19:30:54 INFO - Return code: 0 19:30:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:54 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 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:30:54 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 19:30:54 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 19:30:54 INFO - Using env: {'DISPLAY': ':0', 19:30:54 INFO - 'HOME': '/home/cltbld', 19:30:54 INFO - 'LANG': 'en_US.UTF-8', 19:30:54 INFO - 'LANGUAGE': 'en_US:en', 19:30:54 INFO - 'LOGNAME': 'cltbld', 19:30:54 INFO - 'MAIL': '/var/mail/cltbld', 19:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:54 INFO - 'MOZ_NO_REMOTE': '1', 19:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:54 INFO - 'NO_EM_RESTART': '1', 19:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:54 INFO - 'PWD': '/builds/slave/test', 19:30:54 INFO - 'SHELL': '/bin/bash', 19:30:54 INFO - 'SHLVL': '1', 19:30:54 INFO - 'TERM': 'linux', 19:30:54 INFO - 'TMOUT': '86400', 19:30:54 INFO - 'USER': 'cltbld', 19:30:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:54 INFO - '_': '/tools/buildbot/bin/python'} 19:30:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:54 INFO - Downloading/unpacking jsonschema==2.5.1 19:30:54 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 19:30:54 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 19:30:54 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 19:30:54 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 19:30:54 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 19:30:54 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 19:30:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:30:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:56 INFO - Downloading functools32-3.2.3-2.tar.gz 19:30:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:30:56 INFO - warning: no files found matching '*.txt' 19:30:56 INFO - no previously-included directories found matching 'build' 19:30:56 INFO - no previously-included directories found matching 'dist' 19:30:56 INFO - no previously-included directories found matching '.git*' 19:30:56 INFO - Installing collected packages: jsonschema, functools32 19:30:56 INFO - Running setup.py install for functools32 19:30:56 INFO - warning: no files found matching '*.txt' 19:30:56 INFO - no previously-included directories found matching 'build' 19:30:56 INFO - no previously-included directories found matching 'dist' 19:30:56 INFO - no previously-included directories found matching '.git*' 19:30:56 INFO - Successfully installed jsonschema functools32 19:30:56 INFO - Cleaning up... 19:30:56 INFO - Return code: 0 19:30:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:30:56 INFO - Using env: {'DISPLAY': ':0', 19:30:56 INFO - 'HOME': '/home/cltbld', 19:30:56 INFO - 'LANG': 'en_US.UTF-8', 19:30:56 INFO - 'LANGUAGE': 'en_US:en', 19:30:56 INFO - 'LOGNAME': 'cltbld', 19:30:56 INFO - 'MAIL': '/var/mail/cltbld', 19:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:56 INFO - 'MOZ_NO_REMOTE': '1', 19:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:56 INFO - 'NO_EM_RESTART': '1', 19:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:56 INFO - 'PWD': '/builds/slave/test', 19:30:56 INFO - 'SHELL': '/bin/bash', 19:30:56 INFO - 'SHLVL': '1', 19:30:56 INFO - 'TERM': 'linux', 19:30:56 INFO - 'TMOUT': '86400', 19:30:56 INFO - 'USER': 'cltbld', 19:30:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:56 INFO - '_': '/tools/buildbot/bin/python'} 19:30:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:30:56 INFO - Cleaning up... 19:30:56 INFO - Return code: 0 19:30:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:30:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:30:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:30:56 INFO - Using env: {'DISPLAY': ':0', 19:30:56 INFO - 'HOME': '/home/cltbld', 19:30:56 INFO - 'LANG': 'en_US.UTF-8', 19:30:56 INFO - 'LANGUAGE': 'en_US:en', 19:30:56 INFO - 'LOGNAME': 'cltbld', 19:30:56 INFO - 'MAIL': '/var/mail/cltbld', 19:30:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:56 INFO - 'MOZ_NO_REMOTE': '1', 19:30:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:56 INFO - 'NO_EM_RESTART': '1', 19:30:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:56 INFO - 'PWD': '/builds/slave/test', 19:30:56 INFO - 'SHELL': '/bin/bash', 19:30:56 INFO - 'SHLVL': '1', 19:30:56 INFO - 'TERM': 'linux', 19:30:56 INFO - 'TMOUT': '86400', 19:30:56 INFO - 'USER': 'cltbld', 19:30:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:30:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:56 INFO - '_': '/tools/buildbot/bin/python'} 19:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:30:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:30:57 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 19:30:57 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 19:30:57 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 19:30:57 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 19:30:57 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 19:30:57 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 19:30:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:30:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:30:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:59 INFO - Downloading docopt-0.6.1.tar.gz 19:30:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:30:59 INFO - Installing collected packages: blobuploader, requests, docopt 19:30:59 INFO - Running setup.py install for blobuploader 19:30:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:30:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:30:59 INFO - Running setup.py install for requests 19:31:00 INFO - Running setup.py install for docopt 19:31:00 INFO - Successfully installed blobuploader requests docopt 19:31:00 INFO - Cleaning up... 19:31:00 INFO - Return code: 0 19:31:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:31:00 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')]} 19:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:00 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')]} 19:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:00 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 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:31:00 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 19:31:00 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 19:31:00 INFO - Using env: {'DISPLAY': ':0', 19:31:00 INFO - 'HOME': '/home/cltbld', 19:31:00 INFO - 'LANG': 'en_US.UTF-8', 19:31:00 INFO - 'LANGUAGE': 'en_US:en', 19:31:00 INFO - 'LOGNAME': 'cltbld', 19:31:00 INFO - 'MAIL': '/var/mail/cltbld', 19:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:00 INFO - 'MOZ_NO_REMOTE': '1', 19:31:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:00 INFO - 'NO_EM_RESTART': '1', 19:31:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:00 INFO - 'PWD': '/builds/slave/test', 19:31:00 INFO - 'SHELL': '/bin/bash', 19:31:00 INFO - 'SHLVL': '1', 19:31:00 INFO - 'TERM': 'linux', 19:31:00 INFO - 'TMOUT': '86400', 19:31:00 INFO - 'USER': 'cltbld', 19:31:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:00 INFO - '_': '/tools/buildbot/bin/python'} 19:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:31:00 INFO - Running setup.py (path:/tmp/pip-9rnWei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:31:00 INFO - Running setup.py (path:/tmp/pip-a7mA_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:31:00 INFO - Running setup.py (path:/tmp/pip-5NzZ1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:31:00 INFO - Running setup.py (path:/tmp/pip-Ue8PXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:31:01 INFO - Running setup.py (path:/tmp/pip-AbSF_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:31:01 INFO - Running setup.py (path:/tmp/pip-GEWniQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:31:01 INFO - Running setup.py (path:/tmp/pip-lJWCH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:31:01 INFO - Running setup.py (path:/tmp/pip-iYrfrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:31:01 INFO - Running setup.py (path:/tmp/pip-Esevai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:31:01 INFO - Running setup.py (path:/tmp/pip-jucInG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:31:01 INFO - Running setup.py (path:/tmp/pip-BURw5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:31:01 INFO - Running setup.py (path:/tmp/pip-Wr67aS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:31:01 INFO - Running setup.py (path:/tmp/pip-OQwGwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:31:01 INFO - Running setup.py (path:/tmp/pip-Rz_An7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:01 INFO - Running setup.py (path:/tmp/pip-iKXsox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:31:01 INFO - Running setup.py (path:/tmp/pip-dtsnJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:31:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:31:01 INFO - Running setup.py (path:/tmp/pip-ncuLf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:31:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:31:01 INFO - Running setup.py install for manifestparser 19:31:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Running setup.py install for mozcrash 19:31:02 INFO - Running setup.py install for mozdebug 19:31:02 INFO - Running setup.py install for mozdevice 19:31:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Running setup.py install for mozfile 19:31:02 INFO - Running setup.py install for mozhttpd 19:31:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Running setup.py install for mozinfo 19:31:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Running setup.py install for mozInstall 19:31:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Running setup.py install for mozleak 19:31:02 INFO - Running setup.py install for mozlog 19:31:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:31:03 INFO - Running setup.py install for moznetwork 19:31:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:31:03 INFO - Running setup.py install for mozprocess 19:31:03 INFO - Running setup.py install for mozprofile 19:31:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:31:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:31:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:31:03 INFO - Running setup.py install for mozrunner 19:31:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:31:03 INFO - Running setup.py install for mozscreenshot 19:31:03 INFO - Running setup.py install for moztest 19:31:03 INFO - Running setup.py install for mozversion 19:31:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:31:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:31:03 INFO - Cleaning up... 19:31:03 INFO - Return code: 0 19:31:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:31:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:31:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:31:03 INFO - Using env: {'DISPLAY': ':0', 19:31:03 INFO - 'HOME': '/home/cltbld', 19:31:03 INFO - 'LANG': 'en_US.UTF-8', 19:31:03 INFO - 'LANGUAGE': 'en_US:en', 19:31:03 INFO - 'LOGNAME': 'cltbld', 19:31:03 INFO - 'MAIL': '/var/mail/cltbld', 19:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:03 INFO - 'MOZ_NO_REMOTE': '1', 19:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:03 INFO - 'NO_EM_RESTART': '1', 19:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:03 INFO - 'PWD': '/builds/slave/test', 19:31:03 INFO - 'SHELL': '/bin/bash', 19:31:03 INFO - 'SHLVL': '1', 19:31:03 INFO - 'TERM': 'linux', 19:31:03 INFO - 'TMOUT': '86400', 19:31:03 INFO - 'USER': 'cltbld', 19:31:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:03 INFO - '_': '/tools/buildbot/bin/python'} 19:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:31:04 INFO - Running setup.py (path:/tmp/pip-MZySCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:31:04 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)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:31:04 INFO - Running setup.py (path:/tmp/pip-FgOaIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:31:04 INFO - Running setup.py (path:/tmp/pip-2jsgwq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:31:04 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)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:31:04 INFO - Running setup.py (path:/tmp/pip-uEd5py-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:31:04 INFO - Running setup.py (path:/tmp/pip-WZKRmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:31:04 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)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:31:04 INFO - Running setup.py (path:/tmp/pip-v1nZKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:31:04 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)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:31:04 INFO - Running setup.py (path:/tmp/pip-jQVQJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:31:04 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)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:31:04 INFO - Running setup.py (path:/tmp/pip-XkGEHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:31:04 INFO - Running setup.py (path:/tmp/pip-1bBsXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:31:04 INFO - Running setup.py (path:/tmp/pip-r_9ZA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:31:04 INFO - Running setup.py (path:/tmp/pip-FmnXHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:31:04 INFO - Running setup.py (path:/tmp/pip-AEq7PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:31:04 INFO - Running setup.py (path:/tmp/pip-vh294I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:31:05 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)) 19:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:31:05 INFO - Running setup.py (path:/tmp/pip-nXQS9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:05 INFO - Running setup.py (path:/tmp/pip-ETkeca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:05 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)) 19:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:31:05 INFO - Running setup.py (path:/tmp/pip-Qcl18p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:31:05 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)) 19:31:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:31:05 INFO - Running setup.py (path:/tmp/pip-xK11BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:31:05 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)) 19:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:31:05 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)) 19:31:05 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:31:05 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:31:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:31:05 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 19:31:05 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 19:31:05 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 19:31:05 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 19:31:05 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 19:31:05 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 19:31:07 INFO - Downloading blessings-1.6.tar.gz 19:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:31:07 INFO - Installing collected packages: blessings 19:31:07 INFO - Running setup.py install for blessings 19:31:07 INFO - Successfully installed blessings 19:31:07 INFO - Cleaning up... 19:31:07 INFO - Return code: 0 19:31:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:31:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:31:07 INFO - Reading from file tmpfile_stdout 19:31:07 INFO - Current package versions: 19:31:07 INFO - argparse == 1.2.1 19:31:07 INFO - blessings == 1.6 19:31:07 INFO - blobuploader == 1.2.4 19:31:07 INFO - docopt == 0.6.1 19:31:07 INFO - functools32 == 3.2.3-2 19:31:07 INFO - jsonschema == 2.5.1 19:31:07 INFO - manifestparser == 1.1 19:31:07 INFO - mozInstall == 1.12 19:31:07 INFO - mozcrash == 1.0 19:31:07 INFO - mozdebug == 0.1 19:31:07 INFO - mozdevice == 0.49 19:31:07 INFO - mozfile == 1.2 19:31:07 INFO - mozhttpd == 0.7 19:31:07 INFO - mozinfo == 0.9 19:31:07 INFO - mozleak == 0.1 19:31:07 INFO - mozlog == 3.4 19:31:07 INFO - moznetwork == 0.27 19:31:07 INFO - mozprocess == 0.23 19:31:07 INFO - mozprofile == 0.28 19:31:07 INFO - mozrunner == 6.13 19:31:07 INFO - mozscreenshot == 0.1 19:31:07 INFO - mozsystemmonitor == 0.3 19:31:07 INFO - moztest == 0.7 19:31:07 INFO - mozversion == 1.4 19:31:07 INFO - psutil == 3.1.1 19:31:07 INFO - requests == 1.2.3 19:31:07 INFO - wsgiref == 0.1.2 19:31:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:31:07 INFO - Using env: {'DISPLAY': ':0', 19:31:07 INFO - 'HOME': '/home/cltbld', 19:31:07 INFO - 'LANG': 'en_US.UTF-8', 19:31:07 INFO - 'LANGUAGE': 'en_US:en', 19:31:07 INFO - 'LOGNAME': 'cltbld', 19:31:07 INFO - 'MAIL': '/var/mail/cltbld', 19:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:07 INFO - 'MOZ_NO_REMOTE': '1', 19:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:07 INFO - 'NO_EM_RESTART': '1', 19:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:07 INFO - 'PWD': '/builds/slave/test', 19:31:07 INFO - 'SHELL': '/bin/bash', 19:31:07 INFO - 'SHLVL': '1', 19:31:07 INFO - 'TERM': 'linux', 19:31:07 INFO - 'TMOUT': '86400', 19:31:07 INFO - 'USER': 'cltbld', 19:31:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:07 INFO - '_': '/tools/buildbot/bin/python'} 19:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:31:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:31:07 INFO - Cleaning up... 19:31:07 INFO - Return code: 0 19:31:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:31:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3f92e5be30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b37130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', '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 19:31:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:31:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:31:07 INFO - Using env: {'DISPLAY': ':0', 19:31:07 INFO - 'HOME': '/home/cltbld', 19:31:07 INFO - 'LANG': 'en_US.UTF-8', 19:31:07 INFO - 'LANGUAGE': 'en_US:en', 19:31:07 INFO - 'LOGNAME': 'cltbld', 19:31:07 INFO - 'MAIL': '/var/mail/cltbld', 19:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:07 INFO - 'MOZ_NO_REMOTE': '1', 19:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:07 INFO - 'NO_EM_RESTART': '1', 19:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:07 INFO - 'PWD': '/builds/slave/test', 19:31:07 INFO - 'SHELL': '/bin/bash', 19:31:07 INFO - 'SHLVL': '1', 19:31:07 INFO - 'TERM': 'linux', 19:31:07 INFO - 'TMOUT': '86400', 19:31:07 INFO - 'USER': 'cltbld', 19:31:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:07 INFO - '_': '/tools/buildbot/bin/python'} 19:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:31:08 INFO - Cleaning up... 19:31:08 INFO - Return code: 0 19:31:08 INFO - Running post-action listener: _resource_record_post_action 19:31:08 INFO - Running post-action listener: _start_resource_monitoring 19:31:08 INFO - Starting resource monitoring. 19:31:08 INFO - [mozharness: 2016-11-22 03:31:08.197996Z] Finished create-virtualenv step (success) 19:31:08 INFO - [mozharness: 2016-11-22 03:31:08.198515Z] Running install step. 19:31:08 INFO - Running pre-action listener: _resource_record_pre_action 19:31:08 INFO - Running main action method: install 19:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:31:08 INFO - Reading from file tmpfile_stdout 19:31:08 INFO - Detecting whether we're running mozinstall >=1.0... 19:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:31:08 INFO - Reading from file tmpfile_stdout 19:31:08 INFO - Output received: 19:31:08 INFO - Usage: mozinstall [options] installer 19:31:08 INFO - Options: 19:31:08 INFO - -h, --help show this help message and exit 19:31:08 INFO - -d DEST, --destination=DEST 19:31:08 INFO - Directory to install application into. [default: 19:31:08 INFO - "/builds/slave/test"] 19:31:08 INFO - --app=APP Application being installed. [default: firefox] 19:31:08 INFO - mkdir: /builds/slave/test/build/application 19:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:31:24 INFO - Reading from file tmpfile_stdout 19:31:24 INFO - Output received: 19:31:24 INFO - /builds/slave/test/build/application/firefox/firefox 19:31:24 INFO - Running post-action listener: _resource_record_post_action 19:31:24 INFO - [mozharness: 2016-11-22 03:31:24.485663Z] Finished install step (success) 19:31:24 INFO - [mozharness: 2016-11-22 03:31:24.485916Z] Running run-tests step. 19:31:24 INFO - Running pre-action listener: _resource_record_pre_action 19:31:24 INFO - Running main action method: run_tests 19:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:31:24 INFO - Python 2.7.3 19:31:24 INFO - Return code: 0 19:31:24 INFO - grabbing minidump binary from tooltool 19:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:24 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 0x2bc5fc0>, '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 0x2bc6ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:31:24 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 19:31:24 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 19:31:24 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 19:31:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:31:24 INFO - Return code: 0 19:31:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:31:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:31:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:31:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:31:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:31:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 19:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 19:31:24 INFO - Using env: {'DISPLAY': ':0', 19:31:24 INFO - 'HOME': '/home/cltbld', 19:31:24 INFO - 'LANG': 'en_US.UTF-8', 19:31:24 INFO - 'LANGUAGE': 'en_US:en', 19:31:24 INFO - 'LOGNAME': 'cltbld', 19:31:24 INFO - 'MAIL': '/var/mail/cltbld', 19:31:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:31:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:31:24 INFO - 'MOZ_NO_REMOTE': '1', 19:31:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:31:24 INFO - 'NO_EM_RESTART': '1', 19:31:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:31:24 INFO - 'PWD': '/builds/slave/test', 19:31:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:31:24 INFO - 'SHELL': '/bin/bash', 19:31:24 INFO - 'SHLVL': '1', 19:31:24 INFO - 'TERM': 'linux', 19:31:24 INFO - 'TMOUT': '86400', 19:31:24 INFO - 'USER': 'cltbld', 19:31:24 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395', 19:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:24 INFO - '_': '/tools/buildbot/bin/python'} 19:31:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 19:31:24 INFO - mozversion application_buildid: 20161121181650 19:31:24 INFO - mozversion application_changeset: e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c 19:31:24 INFO - mozversion application_display_name: Nightly 19:31:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:31:24 INFO - mozversion application_name: Firefox 19:31:24 INFO - mozversion application_remotingname: firefox 19:31:24 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 19:31:24 INFO - mozversion application_vendor: Mozilla 19:31:24 INFO - mozversion application_version: 53.0a1 19:31:24 INFO - mozversion platform_buildid: 20161121181650 19:31:24 INFO - mozversion platform_changeset: e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c 19:31:24 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 19:31:24 INFO - mozversion platform_version: 53.0a1 19:31:24 INFO - using testdate: 1479785484 19:31:24 INFO - actual date: 1479785484 19:31:24 INFO - starting webserver on 'localhost:41882' 19:31:24 INFO - SUITE-START | Running 2 tests 19:31:24 INFO - TEST-START | dromaeo_css 19:31:24 INFO - operating with platform_type : linux_ 19:31:24 INFO - Initialising browser for dromaeo_css test... 19:31:24 INFO - TEST-INFO | started process 1601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1cMG5r/profile http://localhost:41882/getInfo.html) 19:31:29 INFO - PROCESS | 1601 | __metrics Screen width/height:1600/1200 19:31:29 INFO - PROCESS | 1601 | colorDepth:24 19:31:29 INFO - PROCESS | 1601 | Browser inner width/height: 1024/697 19:31:29 INFO - PROCESS | 1601 | __metrics 19:31:29 INFO - PROCESS | 1601 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:31:29 INFO - PROCESS | 1601 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:31:30 INFO - PROCESS | 1601 | console.error: PushService: 19:31:30 INFO - PROCESS | 1601 | stateChangeProcessEnqueue: Error transitioning state 19:31:30 INFO - PROCESS | 1601 | UnknownError 19:31:31 INFO - TEST-INFO | 1601: exit 0 19:31:31 INFO - Browser initialized. 19:31:31 INFO - Running cycle 1/1 for dromaeo_css test... 19:31:31 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1cMG5r/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:31:43 INFO - PROCESS | 1682 | RSS: Main: 175198208 19:31:43 INFO - PROCESS | 1682 | 19:32:34 INFO - PROCESS | 1682 | 1479785554977 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] 19:34:49 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:41882/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41882/tests/dromaeo/cssquery-ext.html) 19:34:50 INFO - PROCESS | 1682 | RSS: Main: 307740672 19:34:50 INFO - PROCESS | 1682 | 19:37:52 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:41882/tests/dromaeo/cssquery-ext.html (next: http://localhost:41882/tests/dromaeo/cssquery-jquery.html) 19:37:53 INFO - PROCESS | 1682 | RSS: Main: 285343744 19:37:53 INFO - PROCESS | 1682 | 19:40:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:41882/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41882/tests/dromaeo/cssquery-mootools.html) 19:40:56 INFO - PROCESS | 1682 | RSS: Main: 259915776 19:40:56 INFO - PROCESS | 1682 | 19:43:59 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:41882/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41882/tests/dromaeo/cssquery-prototype.html) 19:43:59 INFO - PROCESS | 1682 | RSS: Main: 223199232 19:43:59 INFO - PROCESS | 1682 | 19:47:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:41882/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41882/tests/dromaeo/cssquery-yui.html) 19:47:03 INFO - PROCESS | 1682 | RSS: Main: 224747520 19:47:03 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:41882/tests/dromaeo/cssquery-yui.html (next: http://localhost:41882/tests/dromaeo/cssquery-dojo.html) 19:50:06 INFO - PROCESS | 1682 | RSS: Main: 314269696 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | __start_tp_report 19:50:06 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 19:50:06 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 19:50:06 INFO - PROCESS | 1682 | |i|pagename|runs| 19:50:06 INFO - PROCESS | 1682 | |0;dojo.html;2556.1309154887335;2585.095216674163;2605.94788104238;2617.463419998899;2622.6721659792524;4539.160255352762;4635.096156249533;4664.207084795585;4674.859754207375;4686.929696054562;4676.602488788449;4680.5085466026;4693.249080147177;4693.319468677039;4699.013207226487;4278.593533614309;4296.183725092238;4302.462192225972;4339.848105316315;4405.867823965286;4349.521552629224;4362.214801335758;4386.8025938832825;4390.27560452525;4390.934135987946;4262.936055959163;4302.591253830881;4326.84856030039;4332.2851729464755;4389.363542286366;4367.410399596046;4368;4372.147431250907;4377.759223242752;4389.670774691895;4204.831806727758;4256.574342565749;4265.189613973366;4288;4295.226859165349;4641.164590373732;4682.484926658065;4691.249400095969;4699.24812030077;4767.618590512785;4982.551570358685;5008.24876268559;5037.5214354636255;5039.798408063673;5043.773030213612;4835.588974937099;4869.391326084239;4888.682235654671;4972.353594032753;5030.6730062546185;4626.976865115653;4679.906401871944;4691.155591993405;4696.553827386393;4753.572178503882;5174.327337446108;5186.844394668166;5190.11767999441;5192.7403629818355;5238.449962753933;4751.358566593535;4954;4960.429550601655;4964.60283177345;4968.3875143127825;4895.388076490439;4956.776945037482;4963.131451995959;4994.525520075587;5036.823711170165;5024.773885175176;5025.623078269145;5054.064997975386;5076.898462030738;5079.6952182869145;4992.301077849104;5001.674891132065;5003.649744517848;5006.974965125224;5063.468335824686;4207.831686732497;4264.850730224427;4289.63538099265;4291.291936830388;4367.75977321244;3723.3298006359114;3734.3464893643504;3764.322421964018;3769.3403654360377;3780.546334439885;4256.2764330063965;4289.420928174656;4292.463442069741;4294.441722576107;4333.804978775963;4975.577075948512;4986.626003049713;4988;5027.79888804451;5037.748112594356;4328.177646247203;4329.242382583098;4344.044310251739;4344.044310251739;4352.956470435255;4582.358469814229;4609.677322587387;4615.515370886076;4618.792154353062;4621.95378046222;4742.762861856962;4748.810047598057;4758.452777930583;4760.309755085563;4762.78567464458;5098.923516147335;5100.566451851634;5105.540501354747;5107.259447380184;5116.769745361393;4697.553732395417;4716.457607375196;4733.810647574196;4741.075490279501;4755.38180036593;4977.502249774993;4997.200447928314;5004.549590536869;5015;5015.272785446017;5057.797688092435;5122.538971492583;5124.56441202502;5126.846194614168;5176.249443830548;4800.687955282895;4978.30303757467;4983.401991761012;4985.277134815504;4985.651004429655;4828.806847726051;4844.975775121243;4866.1727506323305;4884.78018489176;4930.901381972412;4810.807567697253;4818.807247710192;4821.54195351441;4823.517648235289;4860.878478038077;4903.95096049035;4916.06594746997;4916.139675556835;4916.8770780730765;4978.153713868579;4764.380630518011;4827.058723548875;4833.371661684099;4850.587700045536;4876.512348765095 19:50:06 INFO - PROCESS | 1682 | |1;ext.html;545.2584485100264;556.9640468728167;574.5489790514447;579.6174524813624;587.6562211106502;27296.454070918593;30142.397152056972;38347.23305533891;39716.80141599288;39853.40219896704;38767.612323876754;39165;39219.80390098053;39263;39333.21333573327;7357.26427357264;7495.100587929456;7500.099988001448;7500.54996700197;7503.924960750404;7511.849763004764;7599.468037237396;7601.923980760204;7605.391568674493;7609.277118673717;7583.9241607584045;7641.3122818946285;7646.082470103595;7649.6940122395035;7653.885191722128;7540.962295188544;7579.1662917079075;7581.924180758177;7582.165961744204;7585.279398457165;7474.626268686544;7547.773566793005;7549.924500754977;7554.546727196331;7557.979672744219;36563;37041.81479092614;37072.814635926916;37077.814610927046;37085.258294834224;3046.7410270127066;3073.4928736758407;3090.9536356954663;3259.41330560499;3586.8923932282073;27085.864570677022;27529.724702752916;28409.43181136366;28553;28586.571201431994;3330.900072997814;3395.711364534018;3428.9828550857087;3574.4817001534893;3577;236019;238603;238796;239825;241001.79499102567;48798.756006219744;49364.50635493599;49562.25656615154;49610.255846162334;49681.50318496769;47228.5277147231;47429.5257047432;47570.52429475661;47578.52421475741;47658.285125723145;11328.376939268419;11540.884591154148;11658.600967883738;11660.708482288012;11669.59156429521;8507.70223042203;8600.526971016528;8600.5699715014;8600.956995214983;8604.440711353742;13511.62209447638;14878.545040068484;14886.627834304229;14926.925365373103;15196.240187990556;5505.944940550543;5516.889662206733;5707.34365547959;5753.654780713171;5765.279340082489;673.6227712481026;700.7687463137153;714.2037774995889;842.8482873082904;867.6486023160504;26703.46593068128;26780;26933.461330773665;27235.591466128022;27334.726652733218;921.3642586615214;922.216116301152;926.2775035472342;952.3761935931975;974.4835237324229;14249.715005699827;14321;14431.567052988426;14725.263736813116;14762;347646;351408;351747;351994;352066;47021.76489117533;47165.292520612216;47214.52785472101;47217.29174062392;47238;1114.777044591085;1142.2061667141422;1148.7702459508132;1148.936808475542;1152.4237881059303;24911.377215569755;26160.8691956539;26524.602130968437;26686.59970100489;26858.865705671345;40525.54219035845;44867;46333.76833115813;46394.07211855811;51368;254537;256948;257133;257190;257317;22383.216587419363;22662.66006009878;22892.313230603108;22909.65635515502;22934.19730309431;36721.26557468889;36784.63215367812;37207.25585488221;37558.43662345012;38365.424518631684;31893.36213275768;32128.35743285168;32312.515312269865;32357.514637280932;33308.833455833534;32073.839630801696;32296.83851580727;32364.514532282505;32673.34653306968;32919.67080329166;31201.375972479967;32059.839700801345;32166.83916580402;32470.188245294055;32508;27399.315017124733;29631.85184074066;29641.110766677033;30080.11326530142;30485.847570762005;23129;23330.183443580074;23417.41456463602;23584.52830943406;23751.762482374954 19:50:06 INFO - PROCESS | 1682 | |2;jquery.html;322.0708256679479;330.20091378863134;353.6251573332268;357.1232623908305;374.4308650850707;12231.327276999762;13293.867061329383;15445.613859653515;15648.295826687798;16620.916895415536;14344.569662910104;14468.421263149488;14604.050736702107;14665.340059697313;14832.110073395577;4649.139909116816;5073.086844368012;5073.239014147889;5076.035553244872;5099.949000510003;4718.079974404993;4929.186684197121;4951.900961980758;4953.504649535035;4957.628177886655;4941.629377796662;4941.777620007108;4947.381577302837;4947.653664243504;4950.851474455754;4767.855714628481;4933.777979990909;4949.579285760715;4980.178270585349;4983.800647974077;4422.6240769534625;4425.845095421677;4426.269665505188;4426.800793964279;4426.977865110686;19466.416007519798;19865.80134198654;19876.70184947227;19996;20029;1748.1608827762618;1765.337998250656;1834.2021220769009;1852.1757817771097;2131.339284821695;8671.609777560025;9004.41471304363;9261.536923153815;9591.808163836755;12430.440630171574;1620.6272557311884;1670.9254970853567;1694.3900195929455;1708.487453763866;1752.9211185496683;38124.618753812385;38173.61826381728;58475.70762146205;60577.394226057615;73740.63129684317;15413.46052888166;16333.754993675104;16367.672646547002;16404.343826246815;16874.578135546708;28871.278218044295;28902;28946.710532894824;28962.85518572436;29037.64435334717;7498.987636669089;7545.00057484767;7767.495112817649;7876.527408355517;7974.641141148662;6019;6038.849028774228;6287.088372186007;6392.872142557216;6492.05238428479;8329.5418751968;8342.455551056986;8380.245777879898;8407.285380742705;8592.183742544448;3056.8624411901073;3130.1235654016914;3271.4602090654776;3278.606567211902;3390.6270310266345;788.4874831359662;819.4427789103348;852.7484392104344;877.7717793373769;881.7883707910055;15562.45531406418;16843.494695159166;17087.658246834995;17138.742918856227;17261.91369043147;803.7829785957875;809.0938149272735;811.2050190813036;838.9412741108064;890.6660002499062;8372.41393102477;8919.509426981578;9422.623095076257;9503.192228660502;9519.381240219502;365308;370300;372248.9712860037;372792;373517;74763;75926;76802.61598691971;78442.60778696185;78524.21475785169;824.7690646618956;848.2069265237024;850.9702160424356;853.6116067189414;856.738694698123;14728;14925.701485970438;14930.552083437515;15013.924930375715;15575;36342.454863177605;36541.08647283839;37782.43326350162;37925.24149517049;38175.80912095422;50598;50961;51326.74336628443;51542.22686659778;51708.48291517037;7266.491345605757;7503.737369192052;7791.610419479117;7805.492642978188;7837;10566.947165264124;10587;10729.517171727448;10745.355278682991;11192.1605879561;9864.704058878246;9872;10084.6514585485;10305.690829275134;10434.426106564211;9574.712758617252;9633.662821801203;9691.321607487409;9945.801083978135;10017.198624109908;9386.389884657476;9817.803643927224;9984.550695218877;10307.845382319421;10333.121684656888;7519.398448124028;7593.962030189814;7613.238676132564;7731.458797884094;7953.801154971172;9120.45277283365;9578.856317155387;9665.71002869915;10099.242556808416;10669.8933010672 19:50:06 INFO - PROCESS | 1682 | |3;mootools.html;1193.653840386288;1298.3897568142972;1335.6994676197858;1374.961903762659;1600.6398560323928;5825.65046097234;6230.937690623098;6447.323031081739;6448.806535803922;6616.603003819762;6654.101696271002;6708.798736037927;6724.562903411274;6727.293634168415;6733.932660673392;1982.5935683184985;2007.6285887110857;2010.336588925651;2017.3947815655317;2020.0202901592716;1953.6288105259955;1974.0228586849457;1979.3666026871406;2013.4261735405412;2014.516516036148;1978.179055691886;1995.860289779716;2015.4558269267288;2016.8588198826087;2019.7879222681627;1968.9409317720492;1969.990150049255;1980.0792631426457;1984.1765667248076;1987.2448469581539;1943.689009758446;1954.491832123644;1990.1740777577288;1991.3528103366464;1997.7602687677427;6421.133147025139;6550.148480697527;6559.868802623969;6627.668616569153;6634.535582509178;3826.8469261229516;3968.861089861841;3968.86108986187;3970.8808735737975;3973.940390894139;2573.794096472278;2684.3289177705574;2737.931551711203;2742.8628568571494;2749.3951330707414;837.6440012994453;839.6683310092541;856.0497847389455;859.776458120893;868.5830801215388;8596.097409772008;8685.956570217171;8701.08638592945;8731.956340218321;8736.737897863075;3371.3425881952785;3395.151212196951;3509.9122521937156;3515.367233897923;3522.753407261467;7077.787666370017;7082.681279342442;7108.857822843514;7111.751088711871;7111.928880711127;3866.9226615467533;3913.9021524461546;3914.451976723261;3916.5691773904846;3921.098147426108;3133.9686603133678;3213.244887451447;3491.703205227584;3574.303010912847;3595.856165753393;2774.5283301838735;2789.8326100433633;2860.685324614291;2873;2931.7801164912717;865.2256230673512;877.3156937588691;878.0780180810124;892.1435421994958;897.2149369301861;700.3731660164226;790.8457850719054;810.1655295046112;819.7253919936888;834.995825020871;4496.39298694672;4558.794854231567;4577.5193604671695;4626.352310676508;4730.5032971538185;368.7529355331934;382.19603471613937;386.6269050366354;394.9940750888739;397.56069543154973;3287.3589650018016;3328.900132996014;3329.250918543308;3338.4658454647138;3403.9659603404143;7628.732994345171;8088.555129467818;8089.797755056053;8091.109977902426;8101.6354264058255;8077.676892924217;8086;8086.110527841933;8089.433739638286;8093.635786389626;6289.622622642656;6364.395382438661;6381.776637817747;6384.521160912857;6389.201349831271;4608.446986361658;4681.555252251031;4698.107359601665;4827.637927155548;4830.3237546744185;7078.115235595551;7314.597697126496;7379.704811807467;7398;7399.334059934632;7465.925340746523;7516.962415187889;7530.548167109991;7546.886796698163;7572.924270757442;5318.149096144598;5830.53355731532;5876.529877609695;5923.703814809156;5924.4667979882015;5891.410858914074;6070.3019152798;6077.361877002851;6080.452759251689;6081.726322315595;5648.85877853057;5720.685362305113;5878.353381127987;5881.500072493886;6057.666828324484;5877.5012371844905;5888.057910734262;5897.852553686193;5910.172575839472;5920.703964801829;5374.516293533601;5624.240727501735;5719.685417301922;5723.3418156912485;5723.5707321950185;4046.43349931004;4053.351463765783;4063.512378514597;4184.163167366478;4203.726757760735;3949.9012524687114;4008.559058503504;4105.4662893823615;4135.338345864648;4202.642775364006 19:50:06 INFO - PROCESS | 1682 | |4;prototype.html;281.2406502443403;284.28360531460714;290.1874750698045;291.4375255756391;292.6824395530849;4685.297205419184;4693.671442998992;4713.387259656249;4740.620750339973;4743.359646447729;4634.351190833286;4661.836835710751;4681.578657920786;4682.484926658065;4697.882552936178;3476.4263896457055;3573.1781690211137;3615.331163734704;3695.1131728385194;3700.7795322806237;3692.003159147029;3702.185519185775;3707.8146092695256;3709.329282916296;3718.958691566352;3671.8898433046916;3673.4673472346494;3678.7676128496987;3684.778913265199;3697;3458.913527161816;3554.253606742587;3579.910502237439;3667.559892812866;3675.687566556846;3249.553948492922;3256.6092068951875;3258.234314935988;3259.1526203187104;3281.261716113879;4542.545745425464;4553.248713962193;4562.201614717411;4564.977175114136;4566.748828814414;4135.1729654069;4154.068358213445;4186.372044193365;4190.580941905816;4195.286801243766;4570.542945705402;4795.2087905495555;4814.290926721033;4831.782569784368;4852.805887764485;3427.074689833731;3439.2949445363893;3447.5690538682666;3454.5509083819193;3456.7580269381156;5132.897342053176;5138.2549530318265;5145.562627176694;5157.369741431822;5166.870828229249;3340.5657264555452;3511.631278715749;3517.2262102337445;3520.507129001942;3534.823258837048;3588.336157810761;3593.407087830531;3593.7843729376323;3596.3346780845627;3598.8020658864016;4106.973256685828;4110.301248787653;4112.91774164521;4120.75275483466;4141.337386018223;4910.189818679878;4919.466474765499;4921.9507804922205;4931.58081563064;4935.975320123448;1153.9826902596467;1191.267370567095;1195.1275568834799;1196.4496331687346;1199.7240634654079;790.6086487188763;823.8846561481397;838.4717627894388;841.4278290762218;844.6663567890648;4177.5195852476745;4183.414321994923;4200.684948628865;4281.828726850953;4327.588879056485;5005.599552035828;5027.421846487628;5048.974755126201;5089.440161582223;5091.567216786615;4383.167198232326;4383.430154079949;4386.824527018947;4387.912241755147;4389.692721509464;2481.8634975076543;2523.9242822715346;2537.847729136258;2579.3680548265793;2591.8185726998927;4542.659300552472;4589.5181005994555;4596.4254468191475;4607.861764147081;4622.399088118523;4970.2296144097;4985.202367621236;5002.874928126753;5007.145926821677;5030.647854650212;4445.911081778347;4596.288189967935;4599.632029437637;4721.811127554859;4766.475687674422;5059.949400505948;5064.518870707277;5069.847904562869;5076.695398276115;5087.949120508895;4974.900501990012;4976.975115124546;4980.302757614009;4985.975070124626;4987.077390682735;4648.721076735406;4743.905121897474;4765;4772.809087636456;4787.234042553175;3635.818209089482;3646.161382881899;3653.6894363978295;3656.3601369759654;3661.816909154585;5051.646384753032;5052.5705315048635;5052.797888084582;5074.720890351066;5077.466865979167;4704;4860.3681521403405;4895.290182923385;4899.436564794952;4918.893249018942;4893.339399181065;4894.216925291937;4898;4898.828541001048;4917.164082106122;4839.830605928775;4848;4863.659543832039;4863.8540843774745;4869.904271538875;4760.190767569452;4889.706617602955;4915.18899381598;4930.753462326941;4951.579115775199;4795.232762757942;4805.159097158054;4809.663323567317;4825.95174048255;4833.839878429081 19:50:06 INFO - PROCESS | 1682 | |5;yui.html;607.377438125921;661.4245606322501;664.3423011218895;699.4544255480723;703.922568517463;11397.145214108934;11762.117841161904;12036.51853925844;12072.03423726102;12096.334701591431;12227.755444891096;12339.321337326466;12420.441080151393;12428.502859885617;12435;596.7612954818064;612.7916508387148;728.6939485416111;740.2301606329411;740.2745309596598;741.7922981565171;743.6839343279112;744.6797876912925;744.9143348514909;746.0897704800135;797.1908512859424;798.6046906781152;799.4523751230397;799.4643588795492;799.5642374905661;627.4227710506323;645.6578013652725;647.1425361396169;648.610833499901;787.7400457848925;566.1677334318545;581.1079992211935;582.9679367634778;583.067092651758;584.7018020809376;11648;11662.358570278631;11703.941480292544;11713.238639488405;11728.472218750177;11449.828252576219;11633.70915727105;11828.11289153317;11932.343721095336;12095.153339266255;10777.62278320255;10822;11115.944420277927;11157.944210278896;11604.245724027911;3734.9626503735158;3761.360568703327;3872.457855900148;3880.5731369549326;3913.804309784528;46662;47060.29409558859;47077.29384059242;47177.52822471766;49028.99999999964;9230.723078307527;9233.676821311223;9310.394824336396;9314.20829229523;9346.299027572959;16818.075005874794;16848.74726879098;16855.747163792552;16856.91571542159;16858;6372.681365931685;6476.6114033158165;6501.0573466847045;6677.1319728435965;6775.796726098225;3521.2253304273017;3601.6938560222675;3607.332643460968;3616.746827722087;3617.620149884277;2665.6934452538208;2717.55160398532;2726.332048648094;2742.287005378576;2749.408877091435;470.3767508051845;472.1077164159741;479.7864950097173;479.79608666316676;487.7171240680397;440.0670578373804;485.27451460067425;512.5233532814444;546.131650675428;580.6371018113679;6864.313568643196;6918.342757438036;7168.462365322622;7589.924100759032;7672.5012874163;563.5125616341835;588.4439204951366;589.2781342854969;591.287498564229;607.4320510322774;3432.22774875656;3527.5943266524678;3529.5058691782656;3625.619309972468;3659.1949771050326;56487.71756141193;71830.64084679543;73853.26146738464;75852.24147758562;75934.24065759272;37329.440058399145;43549.78225108918;58229;60848.08727869086;65411.01883471752;43085.56914430815;55512.72243638756;56593.43406565964;57605;58731.412685872594;6706.597604143767;6899;7023.894641580278;7064.131485658999;7100.715971361295;38484.615153848106;39387;39472.802635986634;39720.60279397169;40214.798926006355;50477;51645;52235.47764522458;52254.47745522648;54429.18356224739;8873.778155546162;9018.68434604812;9193.77015574616;9230.169284764403;9391.295652826202;9586.856197156909;9729.756756081155;9984;10208.948955255177;10508.211884108876;9102.408343457653;9270.860937085814;9304.488253146143;9612;9699.321047526606;9927.255455840696;10498;10729.89270107289;10825.381798251015;10972.286801357886;10144.782626084918;10215.540300686338;10467.110295624958;10469.581216751549;10536.824975290228;9280;9567.952160239154;9603.279754018336;9889.307748457539;9938.155256803253;8701.869471958053;9061.909380906107;9326.95336523313;9402.764930876783;9508.809823803624 19:50:06 INFO - PROCESS | 1682 | __end_tp_report 19:50:06 INFO - PROCESS | 1682 | __start_cc_report 19:50:06 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1311 19:50:06 INFO - PROCESS | 1682 | __end_cc_report 19:50:06 INFO - PROCESS | 1682 | __startTimestamp1479786606697__endTimestamp 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | ------- Summary: start ------- 19:50:06 INFO - PROCESS | 1682 | Number of tests: 6 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | [#0] dojo.html Cycles:165 Average:4650.43 Median:4758.45 stddev:490.44 (10.3%) stddev-sans-first:463.61 19:50:06 INFO - PROCESS | 1682 | Values: 2556.1 2585.1 2605.9 2617.5 2622.7 4539.2 4635.1 4664.2 4674.9 4686.9 4676.6 4680.5 4693.2 4693.3 4699.0 4278.6 4296.2 4302.5 4339.8 4405.9 4349.5 4362.2 4386.8 4390.3 4390.9 4262.9 4302.6 4326.8 4332.3 4389.4 4367.4 4368.0 4372.1 4377.8 4389.7 4204.8 4256.6 4265.2 4288.0 4295.2 4641.2 4682.5 4691.2 4699.2 4767.6 4982.6 5008.2 5037.5 5039.8 5043.8 4835.6 4869.4 4888.7 4972.4 5030.7 4627.0 4679.9 4691.2 4696.6 4753.6 5174.3 5186.8 5190.1 5192.7 5238.4 4751.4 4954.0 4960.4 4964.6 4968.4 4895.4 4956.8 4963.1 4994.5 5036.8 5024.8 5025.6 5054.1 5076.9 5079.7 4992.3 5001.7 5003.6 5007.0 5063.5 4207.8 4264.9 4289.6 4291.3 4367.8 3723.3 3734.3 3764.3 3769.3 3780.5 4256.3 4289.4 4292.5 4294.4 4333.8 4975.6 4986.6 4988.0 5027.8 5037.7 4328.2 4329.2 4344.0 4344.0 4353.0 4582.4 4609.7 4615.5 4618.8 4622.0 4742.8 4748.8 4758.5 4760.3 4762.8 5098.9 5100.6 5105.5 5107.3 5116.8 4697.6 4716.5 4733.8 4741.1 4755.4 4977.5 4997.2 5004.5 5015.0 5015.3 5057.8 5122.5 5124.6 5126.8 5176.2 4800.7 4978.3 4983.4 4985.3 4985.7 4828.8 4845.0 4866.2 4884.8 4930.9 4810.8 4818.8 4821.5 4823.5 4860.9 4904.0 4916.1 4916.1 4916.9 4978.2 4764.4 4827.1 4833.4 4850.6 4876.5 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | [#1] ext.html Cycles:180 Average:42823.56 Median:3581.95 stddev:75286.35 (2101.8%) stddev-sans-first:75430.62 19:50:06 INFO - PROCESS | 1682 | Values: 545.3 557.0 574.5 579.6 587.7 27296.5 30142.4 38347.2 39716.8 39853.4 38767.6 39165.0 39219.8 39263.0 39333.2 7357.3 7495.1 7500.1 7500.5 7503.9 7511.8 7599.5 7601.9 7605.4 7609.3 7583.9 7641.3 7646.1 7649.7 7653.9 7541.0 7579.2 7581.9 7582.2 7585.3 7474.6 7547.8 7549.9 7554.5 7558.0 36563.0 37041.8 37072.8 37077.8 37085.3 3046.7 3073.5 3091.0 3259.4 3586.9 27085.9 27529.7 28409.4 28553.0 28586.6 3330.9 3395.7 3429.0 3574.5 3577.0 236019.0 238603.0 238796.0 239825.0 241001.8 48798.8 49364.5 49562.3 49610.3 49681.5 47228.5 47429.5 47570.5 47578.5 47658.3 11328.4 11540.9 11658.6 11660.7 11669.6 8507.7 8600.5 8600.6 8601.0 8604.4 13511.6 14878.5 14886.6 14926.9 15196.2 5505.9 5516.9 5707.3 5753.7 5765.3 673.6 700.8 714.2 842.8 867.6 26703.5 26780.0 26933.5 27235.6 27334.7 921.4 922.2 926.3 952.4 974.5 14249.7 14321.0 14431.6 14725.3 14762.0 347646.0 351408.0 351747.0 351994.0 352066.0 47021.8 47165.3 47214.5 47217.3 47238.0 1114.8 1142.2 1148.8 1148.9 1152.4 24911.4 26160.9 26524.6 26686.6 26858.9 40525.5 44867.0 46333.8 46394.1 51368.0 254537.0 256948.0 257133.0 257190.0 257317.0 22383.2 22662.7 22892.3 22909.7 22934.2 36721.3 36784.6 37207.3 37558.4 38365.4 31893.4 32128.4 32312.5 32357.5 33308.8 32073.8 32296.8 32364.5 32673.3 32919.7 31201.4 32059.8 32166.8 32470.2 32508.0 27399.3 29631.9 29641.1 30080.1 30485.8 23129.0 23330.2 23417.4 23584.5 23751.8 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | [#2] jquery.html Cycles:180 Average:23810.35 Median:4937.70 stddev:61109.05 (1237.6%) stddev-sans-first:61255.03 19:50:06 INFO - PROCESS | 1682 | Values: 322.1 330.2 353.6 357.1 374.4 12231.3 13293.9 15445.6 15648.3 16620.9 14344.6 14468.4 14604.1 14665.3 14832.1 4649.1 5073.1 5073.2 5076.0 5099.9 4718.1 4929.2 4951.9 4953.5 4957.6 4941.6 4941.8 4947.4 4947.7 4950.9 4767.9 4933.8 4949.6 4980.2 4983.8 4422.6 4425.8 4426.3 4426.8 4427.0 19466.4 19865.8 19876.7 19996.0 20029.0 1748.2 1765.3 1834.2 1852.2 2131.3 8671.6 9004.4 9261.5 9591.8 12430.4 1620.6 1670.9 1694.4 1708.5 1752.9 38124.6 38173.6 58475.7 60577.4 73740.6 15413.5 16333.8 16367.7 16404.3 16874.6 28871.3 28902.0 28946.7 28962.9 29037.6 7499.0 7545.0 7767.5 7876.5 7974.6 6019.0 6038.8 6287.1 6392.9 6492.1 8329.5 8342.5 8380.2 8407.3 8592.2 3056.9 3130.1 3271.5 3278.6 3390.6 788.5 819.4 852.7 877.8 881.8 15562.5 16843.5 17087.7 17138.7 17261.9 803.8 809.1 811.2 838.9 890.7 8372.4 8919.5 9422.6 9503.2 9519.4 365308.0 370300.0 372249.0 372792.0 373517.0 74763.0 75926.0 76802.6 78442.6 78524.2 824.8 848.2 851.0 853.6 856.7 14728.0 14925.7 14930.6 15013.9 15575.0 36342.5 36541.1 37782.4 37925.2 38175.8 50598.0 50961.0 51326.7 51542.2 51708.5 7266.5 7503.7 7791.6 7805.5 7837.0 10566.9 10587.0 10729.5 10745.4 11192.2 9864.7 9872.0 10084.7 10305.7 10434.4 9574.7 9633.7 9691.3 9945.8 10017.2 9386.4 9817.8 9984.6 10307.8 10333.1 7519.4 7594.0 7613.2 7731.5 7953.8 9120.5 9578.9 9665.7 10099.2 10669.9 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | [#3] mootools.html Cycles:180 Average:4366.18 Median:5346.33 stddev:2364.69 (44.2%) stddev-sans-first:2359.31 19:50:06 INFO - PROCESS | 1682 | Values: 1193.7 1298.4 1335.7 1375.0 1600.6 5825.7 6230.9 6447.3 6448.8 6616.6 6654.1 6708.8 6724.6 6727.3 6733.9 1982.6 2007.6 2010.3 2017.4 2020.0 1953.6 1974.0 1979.4 2013.4 2014.5 1978.2 1995.9 2015.5 2016.9 2019.8 1968.9 1970.0 1980.1 1984.2 1987.2 1943.7 1954.5 1990.2 1991.4 1997.8 6421.1 6550.1 6559.9 6627.7 6634.5 3826.8 3968.9 3968.9 3970.9 3973.9 2573.8 2684.3 2737.9 2742.9 2749.4 837.6 839.7 856.0 859.8 868.6 8596.1 8686.0 8701.1 8732.0 8736.7 3371.3 3395.2 3509.9 3515.4 3522.8 7077.8 7082.7 7108.9 7111.8 7111.9 3866.9 3913.9 3914.5 3916.6 3921.1 3134.0 3213.2 3491.7 3574.3 3595.9 2774.5 2789.8 2860.7 2873.0 2931.8 865.2 877.3 878.1 892.1 897.2 700.4 790.8 810.2 819.7 835.0 4496.4 4558.8 4577.5 4626.4 4730.5 368.8 382.2 386.6 395.0 397.6 3287.4 3328.9 3329.3 3338.5 3404.0 7628.7 8088.6 8089.8 8091.1 8101.6 8077.7 8086.0 8086.1 8089.4 8093.6 6289.6 6364.4 6381.8 6384.5 6389.2 4608.4 4681.6 4698.1 4827.6 4830.3 7078.1 7314.6 7379.7 7398.0 7399.3 7465.9 7517.0 7530.5 7546.9 7572.9 5318.1 5830.5 5876.5 5923.7 5924.5 5891.4 6070.3 6077.4 6080.5 6081.7 5648.9 5720.7 5878.4 5881.5 6057.7 5877.5 5888.1 5897.9 5910.2 5920.7 5374.5 5624.2 5719.7 5723.3 5723.6 4046.4 4053.4 4063.5 4184.2 4203.7 3949.9 4008.6 4105.5 4135.3 4202.6 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | [#4] prototype.html Cycles:180 Average:4055.94 Median:4598.03 stddev:1186.59 (25.8%) stddev-sans-first:1155.60 19:50:06 INFO - PROCESS | 1682 | Values: 281.2 284.3 290.2 291.4 292.7 4685.3 4693.7 4713.4 4740.6 4743.4 4634.4 4661.8 4681.6 4682.5 4697.9 3476.4 3573.2 3615.3 3695.1 3700.8 3692.0 3702.2 3707.8 3709.3 3719.0 3671.9 3673.5 3678.8 3684.8 3697.0 3458.9 3554.3 3579.9 3667.6 3675.7 3249.6 3256.6 3258.2 3259.2 3281.3 4542.5 4553.2 4562.2 4565.0 4566.7 4135.2 4154.1 4186.4 4190.6 4195.3 4570.5 4795.2 4814.3 4831.8 4852.8 3427.1 3439.3 3447.6 3454.6 3456.8 5132.9 5138.3 5145.6 5157.4 5166.9 3340.6 3511.6 3517.2 3520.5 3534.8 3588.3 3593.4 3593.8 3596.3 3598.8 4107.0 4110.3 4112.9 4120.8 4141.3 4910.2 4919.5 4922.0 4931.6 4936.0 1154.0 1191.3 1195.1 1196.4 1199.7 790.6 823.9 838.5 841.4 844.7 4177.5 4183.4 4200.7 4281.8 4327.6 5005.6 5027.4 5049.0 5089.4 5091.6 4383.2 4383.4 4386.8 4387.9 4389.7 2481.9 2523.9 2537.8 2579.4 2591.8 4542.7 4589.5 4596.4 4607.9 4622.4 4970.2 4985.2 5002.9 5007.1 5030.6 4445.9 4596.3 4599.6 4721.8 4766.5 5059.9 5064.5 5069.8 5076.7 5087.9 4974.9 4977.0 4980.3 4986.0 4987.1 4648.7 4743.9 4765.0 4772.8 4787.2 3635.8 3646.2 3653.7 3656.4 3661.8 5051.6 5052.6 5052.8 5074.7 5077.5 4704.0 4860.4 4895.3 4899.4 4918.9 4893.3 4894.2 4898.0 4898.8 4917.2 4839.8 4848.0 4863.7 4863.9 4869.9 4760.2 4889.7 4915.2 4930.8 4951.6 4795.2 4805.2 4809.7 4826.0 4833.8 19:50:06 INFO - PROCESS | 1682 | 19:50:06 INFO - PROCESS | 1682 | [#5] yui.html Cycles:180 Average:14186.99 Median:56540.58 stddev:18455.50 (32.6%) stddev-sans-first:18479.11 19:50:06 INFO - PROCESS | 1682 | Values: 607.4 661.4 664.3 699.5 703.9 11397.1 11762.1 12036.5 12072.0 12096.3 12227.8 12339.3 12420.4 12428.5 12435.0 596.8 612.8 728.7 740.2 740.3 741.8 743.7 744.7 744.9 746.1 797.2 798.6 799.5 799.5 799.6 627.4 645.7 647.1 648.6 787.7 566.2 581.1 583.0 583.1 584.7 11648.0 11662.4 11703.9 11713.2 11728.5 11449.8 11633.7 11828.1 11932.3 12095.2 10777.6 10822.0 11115.9 11157.9 11604.2 3735.0 3761.4 3872.5 3880.6 3913.8 46662.0 47060.3 47077.3 47177.5 49029.0 9230.7 9233.7 9310.4 9314.2 9346.3 16818.1 16848.7 16855.7 16856.9 16858.0 6372.7 6476.6 6501.1 6677.1 6775.8 3521.2 3601.7 3607.3 3616.7 3617.6 2665.7 2717.6 2726.3 2742.3 2749.4 470.4 472.1 479.8 479.8 487.7 440.1 485.3 512.5 546.1 580.6 6864.3 6918.3 7168.5 7589.9 7672.5 563.5 588.4 589.3 591.3 607.4 3432.2 3527.6 3529.5 3625.6 3659.2 56487.7 71830.6 73853.3 75852.2 75934.2 37329.4 43549.8 58229.0 60848.1 65411.0 43085.6 55512.7 56593.4 57605.0 58731.4 6706.6 6899.0 7023.9 7064.1 7100.7 38484.6 39387.0 39472.8 39720.6 40214.8 50477.0 51645.0 52235.5 52254.5 54429.2 8873.8 9018.7 9193.8 9230.2 9391.3 9586.9 9729.8 9984.0 10208.9 10508.2 9102.4 9270.9 9304.5 9612.0 9699.3 9927.3 10498.0 10729.9 10825.4 10972.3 10144.8 10215.5 10467.1 10469.6 10536.8 9280.0 9568.0 9603.3 9889.3 9938.2 8701.9 9061.9 9327.0 9402.8 9508.8 19:50:06 INFO - PROCESS | 1682 | -------- Summary: end -------- 19:50:06 INFO - PROCESS | 1682 | 19:50:07 INFO - TEST-INFO | 1682: exit 0 19:50:07 INFO - TEST-OK | dromaeo_css | took 1122968ms 19:50:07 INFO - TEST-START | kraken 19:50:07 INFO - operating with platform_type : linux_ 19:50:07 INFO - Initialising browser for kraken test... 19:50:07 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSAUC1t/profile http://localhost:41882/getInfo.html) 19:50:12 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 19:50:12 INFO - PROCESS | 1977 | colorDepth:24 19:50:12 INFO - PROCESS | 1977 | Browser inner width/height: 1024/697 19:50:12 INFO - PROCESS | 1977 | __metrics 19:50:12 INFO - PROCESS | 1977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:50:12 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:50:13 INFO - PROCESS | 1977 | console.error: PushService: 19:50:13 INFO - PROCESS | 1977 | stateChangeProcessEnqueue: Error transitioning state 19:50:13 INFO - PROCESS | 1977 | UnknownError 19:50:14 INFO - TEST-INFO | 1977: exit 0 19:50:14 INFO - Browser initialized. 19:50:14 INFO - Running cycle 1/1 for kraken test... 19:50:14 INFO - TEST-INFO | started process 2058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSAUC1t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:26 INFO - PROCESS | 2058 | RSS: Main: 174567424 19:50:26 INFO - PROCESS | 2058 | 19:50:29 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41882/tests/kraken/driver.html?testName=audio-beat-detection) 19:50:30 INFO - PROCESS | 2058 | RSS: Main: 240517120 19:50:30 INFO - PROCESS | 2058 | 19:50:32 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41882/tests/kraken/driver.html?testName=audio-dft) 19:50:33 INFO - PROCESS | 2058 | RSS: Main: 218406912 19:50:33 INFO - PROCESS | 2058 | 19:50:36 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41882/tests/kraken/driver.html?testName=audio-fft) 19:50:37 INFO - PROCESS | 2058 | RSS: Main: 300204032 19:50:37 INFO - PROCESS | 2058 | 19:50:39 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41882/tests/kraken/driver.html?testName=audio-oscillator) 19:50:40 INFO - PROCESS | 2058 | RSS: Main: 211025920 19:50:40 INFO - PROCESS | 2058 | 19:50:42 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41882/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:50:43 INFO - PROCESS | 2058 | RSS: Main: 214073344 19:50:43 INFO - PROCESS | 2058 | 19:50:46 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41882/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:46 INFO - PROCESS | 2058 | RSS: Main: 253784064 19:50:46 INFO - PROCESS | 2058 | 19:50:50 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41882/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:51 INFO - PROCESS | 2058 | RSS: Main: 248279040 19:50:51 INFO - PROCESS | 2058 | 19:50:53 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41882/tests/kraken/driver.html?testName=json-parse-financial) 19:50:54 INFO - PROCESS | 2058 | RSS: Main: 250593280 19:50:54 INFO - PROCESS | 2058 | 19:50:56 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41882/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:50:56 INFO - PROCESS | 2058 | RSS: Main: 213757952 19:50:56 INFO - PROCESS | 2058 | 19:50:58 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:50:59 INFO - PROCESS | 2058 | RSS: Main: 221442048 19:50:59 INFO - PROCESS | 2058 | 19:51:01 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:51:02 INFO - PROCESS | 2058 | RSS: Main: 230227968 19:51:02 INFO - PROCESS | 2058 | 19:51:05 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:51:05 INFO - PROCESS | 2058 | RSS: Main: 234106880 19:51:05 INFO - PROCESS | 2058 | 19:51:08 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:51:09 INFO - PROCESS | 2058 | RSS: Main: 235524096 19:51:09 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | Cycle 1(1): loaded http://localhost:41882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41882/tests/kraken/driver.html?testName=ai-astar) 19:51:11 INFO - PROCESS | 2058 | RSS: Main: 287387648 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | __start_tp_report 19:51:11 INFO - PROCESS | 2058 | _x_x_mozilla_page_load 19:51:11 INFO - PROCESS | 2058 | _x_x_mozilla_page_load_details 19:51:11 INFO - PROCESS | 2058 | |i|pagename|runs| 19:51:11 INFO - PROCESS | 2058 | |0;ai-astar;106;115;114;116;116;117;115;115;115;115 19:51:11 INFO - PROCESS | 2058 | |1;audio-beat-detection;157;128;127;169;133;132;130;128;159;127 19:51:11 INFO - PROCESS | 2058 | |2;audio-dft;161;162;163;164;161;163;162;161;162;161 19:51:11 INFO - PROCESS | 2058 | |3;audio-fft;76;76;75;112;76;79;78;78;106;76 19:51:11 INFO - PROCESS | 2058 | |4;audio-oscillator;84;83;115;84;83;84;103;85;84;116 19:51:11 INFO - PROCESS | 2058 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 19:51:11 INFO - PROCESS | 2058 | |6;imaging-darkroom;147;147;147;148;147;147;147;148;148;146 19:51:11 INFO - PROCESS | 2058 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;96;96 19:51:11 INFO - PROCESS | 2058 | |8;json-parse-financial;66;64;63;63;64;64;64;64;65;64 19:51:11 INFO - PROCESS | 2058 | |9;json-stringify-tinderbox;66;66;65;66;65;67;67;66;66;66 19:51:11 INFO - PROCESS | 2058 | |10;stanford-crypto-aes;84;87;97;84;84;84;85;85;85;85 19:51:11 INFO - PROCESS | 2058 | |11;stanford-crypto-ccm;145;142;142;153;155;142;139;149;227;147 19:51:11 INFO - PROCESS | 2058 | |12;stanford-crypto-pbkdf2;182;178;183;180;177;179;177;177;176;176 19:51:11 INFO - PROCESS | 2058 | |13;stanford-crypto-sha256-iterative;78;71;70;74;72;70;70;70;71;70 19:51:11 INFO - PROCESS | 2058 | __end_tp_report 19:51:11 INFO - PROCESS | 2058 | __start_cc_report 19:51:11 INFO - PROCESS | 2058 | _x_x_mozilla_cycle_collect,1968 19:51:11 INFO - PROCESS | 2058 | __end_cc_report 19:51:11 INFO - PROCESS | 2058 | __startTimestamp1479786671640__endTimestamp 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | ------- Summary: start ------- 19:51:11 INFO - PROCESS | 2058 | Number of tests: 14 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:3.06 (2.7%) stddev-sans-first:0.87 19:51:11 INFO - PROCESS | 2058 | Values: 106.0 115.0 114.0 116.0 116.0 117.0 115.0 115.0 115.0 115.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:132.50 stddev:16.06 (12.1%) stddev-sans-first:15.65 19:51:11 INFO - PROCESS | 2058 | Values: 157.0 128.0 127.0 169.0 133.0 132.0 130.0 128.0 159.0 127.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 19:51:11 INFO - PROCESS | 2058 | Values: 161.0 162.0 163.0 164.0 161.0 163.0 162.0 161.0 162.0 161.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:13.73 (18.1%) stddev-sans-first:14.31 19:51:11 INFO - PROCESS | 2058 | Values: 76.0 76.0 75.0 112.0 76.0 79.0 78.0 78.0 106.0 76.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:84.00 stddev:13.71 (16.3%) stddev-sans-first:14.23 19:51:11 INFO - PROCESS | 2058 | Values: 84.0 83.0 115.0 84.0 83.0 84.0 103.0 85.0 84.0 116.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 19:51:11 INFO - PROCESS | 2058 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 19:51:11 INFO - PROCESS | 2058 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 148.0 148.0 146.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 19:51:11 INFO - PROCESS | 2058 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.60 19:51:11 INFO - PROCESS | 2058 | Values: 66.0 64.0 63.0 63.0 64.0 64.0 64.0 64.0 65.0 64.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 19:51:11 INFO - PROCESS | 2058 | Values: 66.0 66.0 65.0 66.0 65.0 67.0 67.0 66.0 66.0 66.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:85.00 stddev:3.97 (4.7%) stddev-sans-first:4.15 19:51:11 INFO - PROCESS | 2058 | Values: 84.0 87.0 97.0 84.0 84.0 84.0 85.0 85.0 85.0 85.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:148.00 stddev:26.13 (17.7%) stddev-sans-first:27.50 19:51:11 INFO - PROCESS | 2058 | Values: 145.0 142.0 142.0 153.0 155.0 142.0 139.0 149.0 227.0 147.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:178.50 stddev:2.46 (1.4%) stddev-sans-first:2.26 19:51:11 INFO - PROCESS | 2058 | Values: 182.0 178.0 183.0 180.0 177.0 179.0 177.0 177.0 176.0 176.0 19:51:11 INFO - PROCESS | 2058 | 19:51:11 INFO - PROCESS | 2058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:2.59 (3.6%) stddev-sans-first:1.36 19:51:11 INFO - PROCESS | 2058 | Values: 78.0 71.0 70.0 74.0 72.0 70.0 70.0 70.0 71.0 70.0 19:51:11 INFO - PROCESS | 2058 | -------- Summary: end -------- 19:51:11 INFO - PROCESS | 2058 | 19:51:12 INFO - TEST-INFO | 2058: exit 0 19:51:12 INFO - TEST-OK | kraken | took 65269ms 19:51:12 INFO - SUITE-END | took 1188s 19:51:13 INFO - Completed test suite (00:19:48) 19:51:13 INFO - javascript benchmark 19:51:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2556.1309154887335, 2585.095216674163, 2605.94788104238, 2617.463419998899, 2622.6721659792524, 4539.160255352762, 4635.096156249533, 4664.207084795585, 4674.859754207375, 4686.929696054562, 4676.602488788449, 4680.5085466026, 4693.249080147177, 4693.319468677039, 4699.013207226487, 4278.593533614309, 4296.183725092238, 4302.462192225972, 4339.848105316315, 4405.867823965286, 4349.521552629224, 4362.214801335758, 4386.8025938832825, 4390.27560452525, 4390.934135987946, 4262.936055959163, 4302.591253830881, 4326.84856030039, 4332.2851729464755, 4389.363542286366, 4367.410399596046, 4368.0, 4372.147431250907, 4377.759223242752, 4389.670774691895, 4204.831806727758, 4256.574342565749, 4265.189613973366, 4288.0, 4295.226859165349, 4641.164590373732, 4682.484926658065, 4691.249400095969, 4699.24812030077, 4767.618590512785, 4982.551570358685, 5008.24876268559, 5037.5214354636255, 5039.798408063673, 5043.773030213612, 4835.588974937099, 4869.391326084239, 4888.682235654671, 4972.353594032753, 5030.6730062546185, 4626.976865115653, 4679.906401871944, 4691.155591993405, 4696.553827386393, 4753.572178503882, 5174.327337446108, 5186.844394668166, 5190.11767999441, 5192.7403629818355, 5238.449962753933, 4751.358566593535, 4954.0, 4960.429550601655, 4964.60283177345, 4968.3875143127825, 4895.388076490439, 4956.776945037482, 4963.131451995959, 4994.525520075587, 5036.823711170165, 5024.773885175176, 5025.623078269145, 5054.064997975386, 5076.898462030738, 5079.6952182869145, 4992.301077849104, 5001.674891132065, 5003.649744517848, 5006.974965125224, 5063.468335824686, 4207.831686732497, 4264.850730224427, 4289.63538099265, 4291.291936830388, 4367.75977321244, 3723.3298006359114, 3734.3464893643504, 3764.322421964018, 3769.3403654360377, 3780.546334439885, 4256.2764330063965, 4289.420928174656, 4292.463442069741, 4294.441722576107, 4333.804978775963, 4975.577075948512, 4986.626003049713, 4988.0, 5027.79888804451, 5037.748112594356, 4328.177646247203, 4329.242382583098, 4344.044310251739, 4344.044310251739, 4352.956470435255, 4582.358469814229, 4609.677322587387, 4615.515370886076, 4618.792154353062, 4621.95378046222, 4742.762861856962, 4748.810047598057, 4758.452777930583, 4760.309755085563, 4762.78567464458, 5098.923516147335, 5100.566451851634, 5105.540501354747, 5107.259447380184, 5116.769745361393, 4697.553732395417, 4716.457607375196, 4733.810647574196, 4741.075490279501, 4755.38180036593, 4977.502249774993, 4997.200447928314, 5004.549590536869, 5015.0, 5015.272785446017, 5057.797688092435, 5122.538971492583, 5124.56441202502, 5126.846194614168, 5176.249443830548, 4800.687955282895, 4978.30303757467, 4983.401991761012, 4985.277134815504, 4985.651004429655, 4828.806847726051, 4844.975775121243, 4866.1727506323305, 4884.78018489176, 4930.901381972412, 4810.807567697253, 4818.807247710192, 4821.54195351441, 4823.517648235289, 4860.878478038077, 4903.95096049035, 4916.06594746997, 4916.139675556835, 4916.8770780730765, 4978.153713868579, 4764.380630518011, 4827.058723548875, 4833.371661684099, 4850.587700045536, 4876.512348765095], "value": 4618.647029974329, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2584485100264, 556.9640468728167, 574.5489790514447, 579.6174524813624, 587.6562211106502, 27296.454070918593, 30142.397152056972, 38347.23305533891, 39716.80141599288, 39853.40219896704, 38767.612323876754, 39165.0, 39219.80390098053, 39263.0, 39333.21333573327, 7357.26427357264, 7495.100587929456, 7500.099988001448, 7500.54996700197, 7503.924960750404, 7511.849763004764, 7599.468037237396, 7601.923980760204, 7605.391568674493, 7609.277118673717, 7583.9241607584045, 7641.3122818946285, 7646.082470103595, 7649.6940122395035, 7653.885191722128, 7540.962295188544, 7579.1662917079075, 7581.924180758177, 7582.165961744204, 7585.279398457165, 7474.626268686544, 7547.773566793005, 7549.924500754977, 7554.546727196331, 7557.979672744219, 36563.0, 37041.81479092614, 37072.814635926916, 37077.814610927046, 37085.258294834224, 3046.7410270127066, 3073.4928736758407, 3090.9536356954663, 3259.41330560499, 3586.8923932282073, 27085.864570677022, 27529.724702752916, 28409.43181136366, 28553.0, 28586.571201431994, 3330.900072997814, 3395.711364534018, 3428.9828550857087, 3574.4817001534893, 3577.0, 236019.0, 238603.0, 238796.0, 239825.0, 241001.79499102567, 48798.756006219744, 49364.50635493599, 49562.25656615154, 49610.255846162334, 49681.50318496769, 47228.5277147231, 47429.5257047432, 47570.52429475661, 47578.52421475741, 47658.285125723145, 11328.376939268419, 11540.884591154148, 11658.600967883738, 11660.708482288012, 11669.59156429521, 8507.70223042203, 8600.526971016528, 8600.5699715014, 8600.956995214983, 8604.440711353742, 13511.62209447638, 14878.545040068484, 14886.627834304229, 14926.925365373103, 15196.240187990556, 5505.944940550543, 5516.889662206733, 5707.34365547959, 5753.654780713171, 5765.279340082489, 673.6227712481026, 700.7687463137153, 714.2037774995889, 842.8482873082904, 867.6486023160504, 26703.46593068128, 26780.0, 26933.461330773665, 27235.591466128022, 27334.726652733218, 921.3642586615214, 922.216116301152, 926.2775035472342, 952.3761935931975, 974.4835237324229, 14249.715005699827, 14321.0, 14431.567052988426, 14725.263736813116, 14762.0, 347646.0, 351408.0, 351747.0, 351994.0, 352066.0, 47021.76489117533, 47165.292520612216, 47214.52785472101, 47217.29174062392, 47238.0, 1114.777044591085, 1142.2061667141422, 1148.7702459508132, 1148.936808475542, 1152.4237881059303, 24911.377215569755, 26160.8691956539, 26524.602130968437, 26686.59970100489, 26858.865705671345, 40525.54219035845, 44867.0, 46333.76833115813, 46394.07211855811, 51368.0, 254537.0, 256948.0, 257133.0, 257190.0, 257317.0, 22383.216587419363, 22662.66006009878, 22892.313230603108, 22909.65635515502, 22934.19730309431, 36721.26557468889, 36784.63215367812, 37207.25585488221, 37558.43662345012, 38365.424518631684, 31893.36213275768, 32128.35743285168, 32312.515312269865, 32357.514637280932, 33308.833455833534, 32073.839630801696, 32296.83851580727, 32364.514532282505, 32673.34653306968, 32919.67080329166, 31201.375972479967, 32059.839700801345, 32166.83916580402, 32470.188245294055, 32508.0, 27399.315017124733, 29631.85184074066, 29641.110766677033, 30080.11326530142, 30485.847570762005, 23129.0, 23330.183443580074, 23417.41456463602, 23584.52830943406, 23751.762482374954], "value": 16178.895268151424, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.0708256679479, 330.20091378863134, 353.6251573332268, 357.1232623908305, 374.4308650850707, 12231.327276999762, 13293.867061329383, 15445.613859653515, 15648.295826687798, 16620.916895415536, 14344.569662910104, 14468.421263149488, 14604.050736702107, 14665.340059697313, 14832.110073395577, 4649.139909116816, 5073.086844368012, 5073.239014147889, 5076.035553244872, 5099.949000510003, 4718.079974404993, 4929.186684197121, 4951.900961980758, 4953.504649535035, 4957.628177886655, 4941.629377796662, 4941.777620007108, 4947.381577302837, 4947.653664243504, 4950.851474455754, 4767.855714628481, 4933.777979990909, 4949.579285760715, 4980.178270585349, 4983.800647974077, 4422.6240769534625, 4425.845095421677, 4426.269665505188, 4426.800793964279, 4426.977865110686, 19466.416007519798, 19865.80134198654, 19876.70184947227, 19996.0, 20029.0, 1748.1608827762618, 1765.337998250656, 1834.2021220769009, 1852.1757817771097, 2131.339284821695, 8671.609777560025, 9004.41471304363, 9261.536923153815, 9591.808163836755, 12430.440630171574, 1620.6272557311884, 1670.9254970853567, 1694.3900195929455, 1708.487453763866, 1752.9211185496683, 38124.618753812385, 38173.61826381728, 58475.70762146205, 60577.394226057615, 73740.63129684317, 15413.46052888166, 16333.754993675104, 16367.672646547002, 16404.343826246815, 16874.578135546708, 28871.278218044295, 28902.0, 28946.710532894824, 28962.85518572436, 29037.64435334717, 7498.987636669089, 7545.00057484767, 7767.495112817649, 7876.527408355517, 7974.641141148662, 6019.0, 6038.849028774228, 6287.088372186007, 6392.872142557216, 6492.05238428479, 8329.5418751968, 8342.455551056986, 8380.245777879898, 8407.285380742705, 8592.183742544448, 3056.8624411901073, 3130.1235654016914, 3271.4602090654776, 3278.606567211902, 3390.6270310266345, 788.4874831359662, 819.4427789103348, 852.7484392104344, 877.7717793373769, 881.7883707910055, 15562.45531406418, 16843.494695159166, 17087.658246834995, 17138.742918856227, 17261.91369043147, 803.7829785957875, 809.0938149272735, 811.2050190813036, 838.9412741108064, 890.6660002499062, 8372.41393102477, 8919.509426981578, 9422.623095076257, 9503.192228660502, 9519.381240219502, 365308.0, 370300.0, 372248.9712860037, 372792.0, 373517.0, 74763.0, 75926.0, 76802.61598691971, 78442.60778696185, 78524.21475785169, 824.7690646618956, 848.2069265237024, 850.9702160424356, 853.6116067189414, 856.738694698123, 14728.0, 14925.701485970438, 14930.552083437515, 15013.924930375715, 15575.0, 36342.454863177605, 36541.08647283839, 37782.43326350162, 37925.24149517049, 38175.80912095422, 50598.0, 50961.0, 51326.74336628443, 51542.22686659778, 51708.48291517037, 7266.491345605757, 7503.737369192052, 7791.610419479117, 7805.492642978188, 7837.0, 10566.947165264124, 10587.0, 10729.517171727448, 10745.355278682991, 11192.1605879561, 9864.704058878246, 9872.0, 10084.6514585485, 10305.690829275134, 10434.426106564211, 9574.712758617252, 9633.662821801203, 9691.321607487409, 9945.801083978135, 10017.198624109908, 9386.389884657476, 9817.803643927224, 9984.550695218877, 10307.845382319421, 10333.121684656888, 7519.398448124028, 7593.962030189814, 7613.238676132564, 7731.458797884094, 7953.801154971172, 9120.45277283365, 9578.856317155387, 9665.71002869915, 10099.242556808416, 10669.8933010672], "value": 8394.340216881683, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.653840386288, 1298.3897568142972, 1335.6994676197858, 1374.961903762659, 1600.6398560323928, 5825.65046097234, 6230.937690623098, 6447.323031081739, 6448.806535803922, 6616.603003819762, 6654.101696271002, 6708.798736037927, 6724.562903411274, 6727.293634168415, 6733.932660673392, 1982.5935683184985, 2007.6285887110857, 2010.336588925651, 2017.3947815655317, 2020.0202901592716, 1953.6288105259955, 1974.0228586849457, 1979.3666026871406, 2013.4261735405412, 2014.516516036148, 1978.179055691886, 1995.860289779716, 2015.4558269267288, 2016.8588198826087, 2019.7879222681627, 1968.9409317720492, 1969.990150049255, 1980.0792631426457, 1984.1765667248076, 1987.2448469581539, 1943.689009758446, 1954.491832123644, 1990.1740777577288, 1991.3528103366464, 1997.7602687677427, 6421.133147025139, 6550.148480697527, 6559.868802623969, 6627.668616569153, 6634.535582509178, 3826.8469261229516, 3968.861089861841, 3968.86108986187, 3970.8808735737975, 3973.940390894139, 2573.794096472278, 2684.3289177705574, 2737.931551711203, 2742.8628568571494, 2749.3951330707414, 837.6440012994453, 839.6683310092541, 856.0497847389455, 859.776458120893, 868.5830801215388, 8596.097409772008, 8685.956570217171, 8701.08638592945, 8731.956340218321, 8736.737897863075, 3371.3425881952785, 3395.151212196951, 3509.9122521937156, 3515.367233897923, 3522.753407261467, 7077.787666370017, 7082.681279342442, 7108.857822843514, 7111.751088711871, 7111.928880711127, 3866.9226615467533, 3913.9021524461546, 3914.451976723261, 3916.5691773904846, 3921.098147426108, 3133.9686603133678, 3213.244887451447, 3491.703205227584, 3574.303010912847, 3595.856165753393, 2774.5283301838735, 2789.8326100433633, 2860.685324614291, 2873.0, 2931.7801164912717, 865.2256230673512, 877.3156937588691, 878.0780180810124, 892.1435421994958, 897.2149369301861, 700.3731660164226, 790.8457850719054, 810.1655295046112, 819.7253919936888, 834.995825020871, 4496.39298694672, 4558.794854231567, 4577.5193604671695, 4626.352310676508, 4730.5032971538185, 368.7529355331934, 382.19603471613937, 386.6269050366354, 394.9940750888739, 397.56069543154973, 3287.3589650018016, 3328.900132996014, 3329.250918543308, 3338.4658454647138, 3403.9659603404143, 7628.732994345171, 8088.555129467818, 8089.797755056053, 8091.109977902426, 8101.6354264058255, 8077.676892924217, 8086.0, 8086.110527841933, 8089.433739638286, 8093.635786389626, 6289.622622642656, 6364.395382438661, 6381.776637817747, 6384.521160912857, 6389.201349831271, 4608.446986361658, 4681.555252251031, 4698.107359601665, 4827.637927155548, 4830.3237546744185, 7078.115235595551, 7314.597697126496, 7379.704811807467, 7398.0, 7399.334059934632, 7465.925340746523, 7516.962415187889, 7530.548167109991, 7546.886796698163, 7572.924270757442, 5318.149096144598, 5830.53355731532, 5876.529877609695, 5923.703814809156, 5924.4667979882015, 5891.410858914074, 6070.3019152798, 6077.361877002851, 6080.452759251689, 6081.726322315595, 5648.85877853057, 5720.685362305113, 5878.353381127987, 5881.500072493886, 6057.666828324484, 5877.5012371844905, 5888.057910734262, 5897.852553686193, 5910.172575839472, 5920.703964801829, 5374.516293533601, 5624.240727501735, 5719.685417301922, 5723.3418156912485, 5723.5707321950185, 4046.43349931004, 4053.351463765783, 4063.512378514597, 4184.163167366478, 4203.726757760735, 3949.9012524687114, 4008.559058503504, 4105.4662893823615, 4135.338345864648, 4202.642775364006], "value": 3512.0954028924707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.2406502443403, 284.28360531460714, 290.1874750698045, 291.4375255756391, 292.6824395530849, 4685.297205419184, 4693.671442998992, 4713.387259656249, 4740.620750339973, 4743.359646447729, 4634.351190833286, 4661.836835710751, 4681.578657920786, 4682.484926658065, 4697.882552936178, 3476.4263896457055, 3573.1781690211137, 3615.331163734704, 3695.1131728385194, 3700.7795322806237, 3692.003159147029, 3702.185519185775, 3707.8146092695256, 3709.329282916296, 3718.958691566352, 3671.8898433046916, 3673.4673472346494, 3678.7676128496987, 3684.778913265199, 3697.0, 3458.913527161816, 3554.253606742587, 3579.910502237439, 3667.559892812866, 3675.687566556846, 3249.553948492922, 3256.6092068951875, 3258.234314935988, 3259.1526203187104, 3281.261716113879, 4542.545745425464, 4553.248713962193, 4562.201614717411, 4564.977175114136, 4566.748828814414, 4135.1729654069, 4154.068358213445, 4186.372044193365, 4190.580941905816, 4195.286801243766, 4570.542945705402, 4795.2087905495555, 4814.290926721033, 4831.782569784368, 4852.805887764485, 3427.074689833731, 3439.2949445363893, 3447.5690538682666, 3454.5509083819193, 3456.7580269381156, 5132.897342053176, 5138.2549530318265, 5145.562627176694, 5157.369741431822, 5166.870828229249, 3340.5657264555452, 3511.631278715749, 3517.2262102337445, 3520.507129001942, 3534.823258837048, 3588.336157810761, 3593.407087830531, 3593.7843729376323, 3596.3346780845627, 3598.8020658864016, 4106.973256685828, 4110.301248787653, 4112.91774164521, 4120.75275483466, 4141.337386018223, 4910.189818679878, 4919.466474765499, 4921.9507804922205, 4931.58081563064, 4935.975320123448, 1153.9826902596467, 1191.267370567095, 1195.1275568834799, 1196.4496331687346, 1199.7240634654079, 790.6086487188763, 823.8846561481397, 838.4717627894388, 841.4278290762218, 844.6663567890648, 4177.5195852476745, 4183.414321994923, 4200.684948628865, 4281.828726850953, 4327.588879056485, 5005.599552035828, 5027.421846487628, 5048.974755126201, 5089.440161582223, 5091.567216786615, 4383.167198232326, 4383.430154079949, 4386.824527018947, 4387.912241755147, 4389.692721509464, 2481.8634975076543, 2523.9242822715346, 2537.847729136258, 2579.3680548265793, 2591.8185726998927, 4542.659300552472, 4589.5181005994555, 4596.4254468191475, 4607.861764147081, 4622.399088118523, 4970.2296144097, 4985.202367621236, 5002.874928126753, 5007.145926821677, 5030.647854650212, 4445.911081778347, 4596.288189967935, 4599.632029437637, 4721.811127554859, 4766.475687674422, 5059.949400505948, 5064.518870707277, 5069.847904562869, 5076.695398276115, 5087.949120508895, 4974.900501990012, 4976.975115124546, 4980.302757614009, 4985.975070124626, 4987.077390682735, 4648.721076735406, 4743.905121897474, 4765.0, 4772.809087636456, 4787.234042553175, 3635.818209089482, 3646.161382881899, 3653.6894363978295, 3656.3601369759654, 3661.816909154585, 5051.646384753032, 5052.5705315048635, 5052.797888084582, 5074.720890351066, 5077.466865979167, 4704.0, 4860.3681521403405, 4895.290182923385, 4899.436564794952, 4918.893249018942, 4893.339399181065, 4894.216925291937, 4898.0, 4898.828541001048, 4917.164082106122, 4839.830605928775, 4848.0, 4863.659543832039, 4863.8540843774745, 4869.904271538875, 4760.190767569452, 4889.706617602955, 4915.18899381598, 4930.753462326941, 4951.579115775199, 4795.232762757942, 4805.159097158054, 4809.663323567317, 4825.95174048255, 4833.839878429081], "value": 3675.739653223053, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [607.377438125921, 661.4245606322501, 664.3423011218895, 699.4544255480723, 703.922568517463, 11397.145214108934, 11762.117841161904, 12036.51853925844, 12072.03423726102, 12096.334701591431, 12227.755444891096, 12339.321337326466, 12420.441080151393, 12428.502859885617, 12435.0, 596.7612954818064, 612.7916508387148, 728.6939485416111, 740.2301606329411, 740.2745309596598, 741.7922981565171, 743.6839343279112, 744.6797876912925, 744.9143348514909, 746.0897704800135, 797.1908512859424, 798.6046906781152, 799.4523751230397, 799.4643588795492, 799.5642374905661, 627.4227710506323, 645.6578013652725, 647.1425361396169, 648.610833499901, 787.7400457848925, 566.1677334318545, 581.1079992211935, 582.9679367634778, 583.067092651758, 584.7018020809376, 11648.0, 11662.358570278631, 11703.941480292544, 11713.238639488405, 11728.472218750177, 11449.828252576219, 11633.70915727105, 11828.11289153317, 11932.343721095336, 12095.153339266255, 10777.62278320255, 10822.0, 11115.944420277927, 11157.944210278896, 11604.245724027911, 3734.9626503735158, 3761.360568703327, 3872.457855900148, 3880.5731369549326, 3913.804309784528, 46662.0, 47060.29409558859, 47077.29384059242, 47177.52822471766, 49028.99999999964, 9230.723078307527, 9233.676821311223, 9310.394824336396, 9314.20829229523, 9346.299027572959, 16818.075005874794, 16848.74726879098, 16855.747163792552, 16856.91571542159, 16858.0, 6372.681365931685, 6476.6114033158165, 6501.0573466847045, 6677.1319728435965, 6775.796726098225, 3521.2253304273017, 3601.6938560222675, 3607.332643460968, 3616.746827722087, 3617.620149884277, 2665.6934452538208, 2717.55160398532, 2726.332048648094, 2742.287005378576, 2749.408877091435, 470.3767508051845, 472.1077164159741, 479.7864950097173, 479.79608666316676, 487.7171240680397, 440.0670578373804, 485.27451460067425, 512.5233532814444, 546.131650675428, 580.6371018113679, 6864.313568643196, 6918.342757438036, 7168.462365322622, 7589.924100759032, 7672.5012874163, 563.5125616341835, 588.4439204951366, 589.2781342854969, 591.287498564229, 607.4320510322774, 3432.22774875656, 3527.5943266524678, 3529.5058691782656, 3625.619309972468, 3659.1949771050326, 56487.71756141193, 71830.64084679543, 73853.26146738464, 75852.24147758562, 75934.24065759272, 37329.440058399145, 43549.78225108918, 58229.0, 60848.08727869086, 65411.01883471752, 43085.56914430815, 55512.72243638756, 56593.43406565964, 57605.0, 58731.412685872594, 6706.597604143767, 6899.0, 7023.894641580278, 7064.131485658999, 7100.715971361295, 38484.615153848106, 39387.0, 39472.802635986634, 39720.60279397169, 40214.798926006355, 50477.0, 51645.0, 52235.47764522458, 52254.47745522648, 54429.18356224739, 8873.778155546162, 9018.68434604812, 9193.77015574616, 9230.169284764403, 9391.295652826202, 9586.856197156909, 9729.756756081155, 9984.0, 10208.948955255177, 10508.211884108876, 9102.408343457653, 9270.860937085814, 9304.488253146143, 9612.0, 9699.321047526606, 9927.255455840696, 10498.0, 10729.89270107289, 10825.381798251015, 10972.286801357886, 10144.782626084918, 10215.540300686338, 10467.110295624958, 10469.581216751549, 10536.824975290228, 9280.0, 9567.952160239154, 9603.279754018336, 9889.307748457539, 9938.155256803253, 8701.869471958053, 9061.909380906107, 9326.95336523313, 9402.764930876783, 9508.809823803624], "value": 5843.214861427858, "unit": "score"}], "name": "dromaeo_css", "value": 6014.203154819809, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 116.0, 116.0, 117.0, 115.0, 115.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 127.0, 169.0, 133.0, 132.0, 130.0, 128.0, 159.0, 127.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 164.0, 161.0, 163.0, 162.0, 161.0, 162.0, 161.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 112.0, 76.0, 79.0, 78.0, 78.0, 106.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 115.0, 84.0, 83.0, 84.0, 103.0, 85.0, 84.0, 116.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 63.0, 63.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 65.0, 67.0, 67.0, 66.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 97.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 142.0, 142.0, 153.0, 155.0, 142.0, 139.0, 149.0, 227.0, 147.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 178.0, 183.0, 180.0, 177.0, 179.0, 177.0, 177.0, 176.0, 176.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 70.0, 74.0, 72.0, 70.0, 70.0, 70.0, 71.0, 70.0], "value": 71.6, "unit": "score"}], "name": "kraken", "value": 1570.8999999999996, "alertThreshold": 2.0}]} 19:51:13 INFO - Return code: 0 19:51:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:51:13 INFO - # TBPL SUCCESS # 19:51:13 INFO - Running post-action listener: _resource_record_post_action 19:51:13 INFO - [mozharness: 2016-11-22 03:51:13.429640Z] Finished run-tests step (success) 19:51:13 INFO - Running post-run listener: _resource_record_post_run 19:51:13 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 387891200; Read time: 20; Write time: 271028 19:51:13 INFO - TinderboxPrint: CPU usage
13.0% 19:51:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 19:51:13 INFO - TinderboxPrint: I/O write bytes / time
387,891,200 / 271,028 19:51:13 INFO - TinderboxPrint: CPU idle
8,360.3 (87.0%) 19:51:13 INFO - TinderboxPrint: CPU user
1,203.5 (12.5%) 19:51:13 INFO - TinderboxPrint: Swap in / out
0 / 0 19:51:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99409920; Read time: 0; Write time: 96508 19:51:13 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 288481280; Read time: 0; Write time: 174520 19:51:14 INFO - Running post-run listener: _upload_blobber_files 19:51:14 INFO - Blob upload gear active. 19:51:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:51:14 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 19:51:14 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:51:14 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:51:14 INFO - (blobuploader) - INFO - Open directory for files ... 19:51:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:51:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:51:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:51:17 INFO - (blobuploader) - INFO - Done attempting. 19:51:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:51:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:51:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:51:18 INFO - (blobuploader) - INFO - Done attempting. 19:51:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:51:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:51:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:51:19 INFO - (blobuploader) - INFO - Done attempting. 19:51:19 INFO - (blobuploader) - INFO - Iteration through files over. 19:51:19 INFO - Return code: 0 19:51:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:51:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:51:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d5dfb3ae516264a1db82efab464ac7401a1cc3e7e9dc67407a7e059331a7b42bce8498bed4e1ce4171a1d090f6f248e12c7949f39f52920275a84e80acc3a121", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c52600539840967f0eb48672e24765fb84e2889cb16f06514810104735cb443a79361bd33982ca467bd655b466cbfeb720605591ca3fb9e720efad69c6facd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ff0292de65eed839237323fab5a97d59114219c89ace62d1833b572e7b39639273fd0f00244e116c2e26f70b713f08ac025ab21b70878315a5c80f17c24f0087"} 19:51:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:51:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:51:19 INFO - Contents: 19:51:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d5dfb3ae516264a1db82efab464ac7401a1cc3e7e9dc67407a7e059331a7b42bce8498bed4e1ce4171a1d090f6f248e12c7949f39f52920275a84e80acc3a121", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c52600539840967f0eb48672e24765fb84e2889cb16f06514810104735cb443a79361bd33982ca467bd655b466cbfeb720605591ca3fb9e720efad69c6facd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ff0292de65eed839237323fab5a97d59114219c89ace62d1833b572e7b39639273fd0f00244e116c2e26f70b713f08ac025ab21b70878315a5c80f17c24f0087"} 19:51:19 INFO - Running post-run listener: copy_logs_to_upload_dir 19:51:19 INFO - Copying logs to upload dir... 19:51:19 INFO - mkdir: /builds/slave/test/build/upload/logs 19:51:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.433173 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-21 19:51:19.045176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:19.048664) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d5dfb3ae516264a1db82efab464ac7401a1cc3e7e9dc67407a7e059331a7b42bce8498bed4e1ce4171a1d090f6f248e12c7949f39f52920275a84e80acc3a121", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c52600539840967f0eb48672e24765fb84e2889cb16f06514810104735cb443a79361bd33982ca467bd655b466cbfeb720605591ca3fb9e720efad69c6facd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ff0292de65eed839237323fab5a97d59114219c89ace62d1833b572e7b39639273fd0f00244e116c2e26f70b713f08ac025ab21b70878315a5c80f17c24f0087"} build_url:https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010610 build_url: 'https://queue.taskcluster.net/v1/task/GioESxxoSuyuR7pE4qZ7Jg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d5dfb3ae516264a1db82efab464ac7401a1cc3e7e9dc67407a7e059331a7b42bce8498bed4e1ce4171a1d090f6f248e12c7949f39f52920275a84e80acc3a121", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/4c52600539840967f0eb48672e24765fb84e2889cb16f06514810104735cb443a79361bd33982ca467bd655b466cbfeb720605591ca3fb9e720efad69c6facd5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/ff0292de65eed839237323fab5a97d59114219c89ace62d1833b572e7b39639273fd0f00244e116c2e26f70b713f08ac025ab21b70878315a5c80f17c24f0087"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:19.072718) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:19.073039) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479781195.52803-677225395 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:19.122146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 19:51:19.122468) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 19:51:19.122744) ========= ========= Total master_lag: 0.23 =========