builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-057 starttime: 1479785426.61 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.607942) ========= 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.608409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.608690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.656632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.656886) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219 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% 223M=0s 2016-11-21 19:30:27 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100044 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.784152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.784481) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021820 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:26.850025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 19:30:26.850336) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 19:30:27,247 truncating revision to first 12 chars 2016-11-21 19:30:27,247 Setting DEBUG logging. 2016-11-21 19:30:27,247 attempt 1/10 2016-11-21 19:30:27,247 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:28,637 unpacking tar archive at: graphics-e37eaf3f1d2e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.745976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 19:30:28.613793) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:28.614214) ========= script_repo_revision: e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:28.615001) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:28.615314) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 19:30:28.626392) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-21 19:30:28.626836) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:30:29 INFO - MultiFileLogger online at 20161121 19:30:29 in /builds/slave/test 19:30:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 19:30:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:30:29 INFO - {'append_to_log': False, 19:30:29 INFO - 'base_work_dir': '/builds/slave/test', 19:30:29 INFO - 'blob_upload_branch': 'Graphics', 19:30:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:30:29 INFO - 'branch': 'Graphics', 19:30:29 INFO - 'buildbot_json_path': 'buildprops.json', 19:30:29 INFO - 'config_files': ('talos/linux_config.py',), 19:30:29 INFO - 'default_actions': ('clobber', 19:30:29 INFO - 'read-buildbot-config', 19:30:29 INFO - 'download-and-extract', 19:30:29 INFO - 'populate-webroot', 19:30:29 INFO - 'create-virtualenv', 19:30:29 INFO - 'install', 19:30:29 INFO - 'run-tests'), 19:30:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:30:29 INFO - 'download_minidump_stackwalk': True, 19:30:29 INFO - 'download_symbols': 'ondemand', 19:30:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:30:29 INFO - 'tooltool.py': '/tools/tooltool.py', 19:30:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:30:29 INFO - '/tools/misc-python/virtualenv.py')}, 19:30:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:30:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:30:29 INFO - 'installer_path': 'installer.exe', 19:30:29 INFO - 'log_level': 'info', 19:30:29 INFO - 'log_name': 'talos', 19:30:29 INFO - 'log_to_console': True, 19:30:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:30:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:30:29 INFO - 'opt_config_files': (), 19:30:29 INFO - 'pip_index': False, 19:30:29 INFO - 'sps_profile': False, 19:30:29 INFO - 'sps_profile_interval': 0, 19:30:29 INFO - 'suite': 'dromaeojs-e10s', 19:30:29 INFO - 'system_bits': '32', 19:30:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:30:29 INFO - 'title': 'talos-linux64-ix-057', 19:30:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:30:29 INFO - 'use_talos_json': True, 19:30:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:30:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:30:29 INFO - 'work_dir': 'build'} 19:30:29 INFO - [mozharness: 2016-11-22 03:30:29.118831Z] Running clobber step. 19:30:29 INFO - Running pre-action listener: _resource_record_pre_action 19:30:29 INFO - Running main action method: clobber 19:30:29 INFO - rmtree: /builds/slave/test/build 19:30:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:30:30 INFO - Running post-action listener: _resource_record_post_action 19:30:30 INFO - [mozharness: 2016-11-22 03:30:30.094753Z] Finished clobber step (success) 19:30:30 INFO - [mozharness: 2016-11-22 03:30:30.094848Z] Running read-buildbot-config step. 19:30:30 INFO - Running pre-action listener: _resource_record_pre_action 19:30:30 INFO - Running main action method: read_buildbot_config 19:30:30 INFO - Using buildbot properties: 19:30:30 INFO - { 19:30:30 INFO - "project": "", 19:30:30 INFO - "product": "firefox", 19:30:30 INFO - "script_repo_revision": "default", 19:30:30 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 19:30:30 INFO - "repository": "", 19:30:30 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 19:30:30 INFO - "buildid": "20161121181650", 19:30:30 INFO - "pgo_build": "False", 19:30:30 INFO - "basedir": "/builds/slave/test", 19:30:30 INFO - "buildnumber": 3, 19:30:30 INFO - "slavename": "talos-linux64-ix-057", 19:30:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:30:30 INFO - "platform": "ubuntu64_hw", 19:30:30 INFO - "scheduler": "tests-graphics-linux64-talos", 19:30:30 INFO - "branch": "graphics", 19:30:30 INFO - "repo_path": "projects/graphics", 19:30:30 INFO - "revision": "e37eaf3f1d2e99c5f7362d580b8358fcb86bb24c", 19:30:30 INFO - "stage_platform": "linux64", 19:30:30 INFO - "builduid": "a942333ddeaf4bdba91c85befe060906", 19:30:30 INFO - "slavebuilddir": "test" 19:30:30 INFO - } 19:30:30 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:30 INFO - Running post-action listener: _resource_record_post_action 19:30:30 INFO - [mozharness: 2016-11-22 03:30:30.097619Z] Finished read-buildbot-config step (success) 19:30:30 INFO - [mozharness: 2016-11-22 03:30:30.097736Z] Running download-and-extract step. 19:30:30 INFO - Running pre-action listener: _resource_record_pre_action 19:30:30 INFO - Running main action method: download_and_extract 19:30:30 INFO - mkdir: /builds/slave/test/build/tests 19:30:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:30 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:30 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:30 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:30 INFO - Downloaded 1361 bytes. 19:30:30 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 19:30:30 INFO - Using the following test package requirements: 19:30:30 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:30 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:30:30 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:30:30 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'jsshell-linux-x86_64.zip'], 19:30:30 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:30:30 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 19:30:30 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:30:30 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:30:30 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:30:30 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 19:30:30 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:30:30 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:30:30 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:30 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:30 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:31 INFO - Http code: 200 19:30:31 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 19:30:31 INFO - x-amz-cf-id: oufP7X7i_2GWCq9rrPkDZzhyx68vVicwAfEFpxIOhILvo5uLC9HU8Q== 19:30:31 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 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 19:30:36 INFO - x-amz-cf-id: HVt0WZAX_luKTKA8LfscZc23In8gge0P5Zgy7bZWGXGgf_04Dl1Qag== 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 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 19:30:41 INFO - x-amz-cf-id: bk2XsmSd1AfnnxWbpQEcwPjDD3ddYZv8L4BH8zS5dC6kFtscAVPaGg== 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:44 INFO - Downloaded 55400890 bytes. 19:30:44 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:44 INFO - mkdir: /builds/slave/test/properties 19:30:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:30:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:30:44 INFO - Contents: 19:30:44 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.698537Z] Finished download-and-extract step (success) 19:30:45 INFO - [mozharness: 2016-11-22 03:30:45.698760Z] 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.717654Z] Finished populate-webroot step (success) 19:30:45 INFO - [mozharness: 2016-11-22 03:30:45.717741Z] 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:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:30:45 INFO - Using real prefix '/usr' 19:30:45 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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 - Downloading/unpacking psutil>=3.1.1 19:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:30:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:30:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:30:50 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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:53 INFO - Successfully installed mozsystemmonitor 19:30:53 INFO - Cleaning up... 19:30:53 INFO - Return code: 0 19:30:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:30:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:30:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:30:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:30:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:30:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:30:53 INFO - Using env: {'DISPLAY': ':0', 19:30:53 INFO - 'HOME': '/home/cltbld', 19:30:53 INFO - 'LANG': 'en_US.UTF-8', 19:30:53 INFO - 'LANGUAGE': 'en_US:en', 19:30:53 INFO - 'LOGNAME': 'cltbld', 19:30:53 INFO - 'MAIL': '/var/mail/cltbld', 19:30:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:30:53 INFO - 'MOZ_NO_REMOTE': '1', 19:30:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:30:53 INFO - 'NO_EM_RESTART': '1', 19:30:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:30:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:30:53 INFO - 'PWD': '/builds/slave/test', 19:30:53 INFO - 'SHELL': '/bin/bash', 19:30:53 INFO - 'SHLVL': '1', 19:30:53 INFO - 'TERM': 'linux', 19:30:53 INFO - 'TMOUT': '86400', 19:30:53 INFO - 'USER': 'cltbld', 19:30:53 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 19:30:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:30:53 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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:58 INFO - Downloading blobuploader-1.2.4.tar.gz 19:30:58 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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-tgVOhj-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-RKyIqh-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-SLqqtG-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-pmodJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:31:00 INFO - Running setup.py (path:/tmp/pip-qa23G2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:31:00 INFO - Running setup.py (path:/tmp/pip-AkEo7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:31:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:31:00 INFO - Running setup.py (path:/tmp/pip-v3dMa9-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-EJ8xmp-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-9BuOCU-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-UbFTvX-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-vZrW2H-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-g9w5_z-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-yAlxj6-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-vR8jAJ-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-H40noW-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-5CSRI5-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-GE4sXY-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:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:31:01 INFO - Running setup.py install for mozcrash 19:31:01 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:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:31:02 INFO - Running setup.py install for moznetwork 19:31:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:31:02 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 19:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:31:03 INFO - '_': '/tools/buildbot/bin/python'} 19:31:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:31:03 INFO - Running setup.py (path:/tmp/pip-EnFtM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:31:03 INFO - Running setup.py (path:/tmp/pip-YLnDgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:31:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:31:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:31:03 INFO - Running setup.py (path:/tmp/pip-2t6wSm-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-RyzFc3-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-02RoXs-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-TMbAbY-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-9NT0Zn-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-iAaGW9-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-5Qkugn-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-mDvOpl-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-xs_NKe-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-WfE0rc-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-jTNzfZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:31:04 INFO - Running setup.py (path:/tmp/pip-rBKugo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:04 INFO - Running setup.py (path:/tmp/pip-DxW_Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:31:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:31:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:31:04 INFO - Running setup.py (path:/tmp/pip-Y46Idz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:31:04 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:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:31:04 INFO - Running setup.py (path:/tmp/pip-F8Vehu-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:06 INFO - Downloading blessings-1.6.tar.gz 19:31:06 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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 0x7f40103ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19ee130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', '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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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): jsonschema in ./venv/lib/python2.7/site-packages 19:31:07 INFO - Cleaning up... 19:31:07 INFO - Return code: 0 19:31:07 INFO - Running post-action listener: _resource_record_post_action 19:31:07 INFO - Running post-action listener: _start_resource_monitoring 19:31:07 INFO - Starting resource monitoring. 19:31:07 INFO - [mozharness: 2016-11-22 03:31:07.970930Z] Finished create-virtualenv step (success) 19:31:07 INFO - [mozharness: 2016-11-22 03:31:07.971432Z] Running install step. 19:31:07 INFO - Running pre-action listener: _resource_record_pre_action 19:31:07 INFO - Running main action method: install 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: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.432097Z] Finished install step (success) 19:31:24 INFO - [mozharness: 2016-11-22 03:31:24.432349Z] 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 0x1a7cfc0>, '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 0x1a7dec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a7e350>, '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-e10s', '--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-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_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-e10s --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-057 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_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': '934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219', 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-e10s', '--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-057', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_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:47864' 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 16823 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ0qNXA/profile http://localhost:47864/getInfo.html) 19:31:29 INFO - PROCESS | 16823 | __metrics Screen width/height:1600/1200 19:31:29 INFO - PROCESS | 16823 | colorDepth:24 19:31:29 INFO - PROCESS | 16823 | Browser inner width/height: 1024/697 19:31:29 INFO - PROCESS | 16823 | __metrics 19:31:30 ERROR - PROCESS | 16823 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 19:31:31 INFO - TEST-INFO | 16823: 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 16945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJ0qNXA/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 | 16945 | RSS: Main: 187502592 19:31:43 INFO - PROCESS | 16945 | 19:32:33 INFO - PROCESS | 16945 | 1479785553490 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:47 INFO - PROCESS | 16945 | Cycle 1(1): loaded http://localhost:47864/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47864/tests/dromaeo/cssquery-ext.html) 19:34:49 INFO - PROCESS | 16945 | RSS: Main: 197300224 19:34:49 INFO - PROCESS | 16945 | 19:37:51 INFO - PROCESS | 16945 | Cycle 1(1): loaded http://localhost:47864/tests/dromaeo/cssquery-ext.html (next: http://localhost:47864/tests/dromaeo/cssquery-jquery.html) 19:37:52 INFO - PROCESS | 16945 | RSS: Main: 197959680 19:37:52 INFO - PROCESS | 16945 | 19:40:54 INFO - PROCESS | 16945 | Cycle 1(1): loaded http://localhost:47864/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47864/tests/dromaeo/cssquery-mootools.html) 19:40:55 INFO - PROCESS | 16945 | RSS: Main: 199733248 19:40:55 INFO - PROCESS | 16945 | 19:43:57 INFO - PROCESS | 16945 | Cycle 1(1): loaded http://localhost:47864/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47864/tests/dromaeo/cssquery-prototype.html) 19:43:57 INFO - PROCESS | 16945 | RSS: Main: 196280320 19:43:57 INFO - PROCESS | 16945 | 19:47:00 INFO - PROCESS | 16945 | Cycle 1(1): loaded http://localhost:47864/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47864/tests/dromaeo/cssquery-yui.html) 19:47:01 INFO - PROCESS | 16945 | RSS: Main: 199553024 19:47:01 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | Cycle 1(1): loaded http://localhost:47864/tests/dromaeo/cssquery-yui.html (next: http://localhost:47864/tests/dromaeo/cssquery-dojo.html) 19:50:04 INFO - PROCESS | 16945 | RSS: Main: 199569408 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | __start_tp_report 19:50:04 INFO - PROCESS | 16945 | _x_x_mozilla_page_load 19:50:04 INFO - PROCESS | 16945 | _x_x_mozilla_page_load_details 19:50:04 INFO - PROCESS | 16945 | |i|pagename|runs| 19:50:04 INFO - PROCESS | 16945 | |0;dojo.html;2565.781908537774;2568.640390345352;2569.8329608575455;2606.6481025061616;2614.6078088286745;4545.181867263891;4648.395708557891;4670.2761072033845;4675.088357770236;4689.57793798558;4591.793369298382;4718.339432479455;4768.570828625423;4789.994101238735;4849.345338379318;4265.87202383929;4318.1363727254675;4366.476022877259;4435.157320109169;4472.53038430965;3963.6483083324274;4298.355246713002;4428.734275943454;4491.910161796762;4507.864764057067;4206.642435392995;4295.806688699016;4335.609795118423;4382.6055654991205;4475.888102797439;4315.654747620183;4319.244132276839;4327.545607711208;4347.956520434786;4354.216241076605;4291.849785257532;4308.9353659695125;4325;4340.457442819647;4357.934630980538;4607.262837945946;4622.976885115553;4624.514425985257;4706;4707.8587642370785;5017.322661440695;5034.823781167678;5036.521530454601;5041.873953151164;5061.569766569846;4981.701097934136;5024.120778863684;5024.748762561894;5037.622178336639;5090.694558326512;4718.4809670936165;4725;4725.267583524559;4753.809847606126;4764.6664733469015;5132.538071573502;5152.4847515248175;5189.766460509286;5191.169412893919;5200.8959820803375;4874.073925954128;4885.267209918541;4923;4931.112399768004;4998.950010499849;4819.807207711652;4955;5022.698638081727;5075.2387141929;5087;4946.5053494650965;5035.118854200574;5076.060928728123;5083.771230294646;5124.436312005676;5019.548240658358;5034.723090230073;5039.899202015939;5043.167877300204;5091.541761241506;4226.1336426032585;4364.672649551297;4393.560643935581;4407.867763967086;4422.071365013383;3713.7400381973002;3758.4362345647824;3766.8304926278383;3820.006798232424;3846.1538461538416;4401.295792673157;4404.889877753082;4405.405270288534;4446.3552784846015;4451.265541185733;5059.468755780664;5072.492750724898;5073.3911930568565;5093.2360145977655;5094.898102037939;4281.678874084394;4288.078063216423;4326.935095973563;4366.519682834885;4386.385905973102;4519.41247637805;4578.267477203632;4587.059652771174;4597.356370108188;4606.470255920545;4712.458067322302;4712.929306060343;4714.269288260325;4749.501302363271;4757.666963312535;5050.267711181785;5063.26582645507;5067.87330316745;5073.518015788494;5104.923426148536;4602.056578401352;4660.790264438177;4663.253879379283;4711;4756.357891684578;4909.1654418748185;4969.254611808113;4972.577330926767;4983.526564976321;4998.850034498971;5012.598992080552;5040.873978150576;5044.445111037856;5058.974705126451;5112.769925353442;4801.591864691541;4857.611391088775;4943.530364615356;4943.975280123576;4989.850304490871;4855.174620314484;4878.926816097691;4910.165271903714;4944.505549445027;5008.749562521933;4709.222978208557;4808.254720518185;4817.084753896748;4844.636652251025;4876.390451193601;4892.0705066037335;4916.729579872998;4943.209086546135;4957.578605818401;4982.8754281143265;4777.522247775195;4814.903701925872;4821.879453013703;4835.903281934271;4874.926876096791 19:50:04 INFO - PROCESS | 16945 | |1;ext.html;523.3797949429926;540.83504531118;549.8487915823149;552.3675391676528;558.6843433460094;37093;38532.614673853255;38544.61455385445;38613.613863861356;38640.61359386409;38384;38905.41641875374;38931.22137557254;38937.61062389375;39007.60992390075;7451.590162541058;7570.12943511495;7582.734604288851;7594.392448604099;7604.467687261867;7461.067366579177;7494.5503269803985;7532.209118042609;7540.660670269851;7547.924520754805;7485.663145158481;7499.325060744532;7514.0607424071995;7533.096028476591;7590.3548198403205;7396.593187374692;7455.4408419368765;7468.55188688675;7472;7499.812504687399;7423.220561840983;7482.176960534337;7484.214157513437;7486.700531978769;7522.548647081193;36413.630364356184;36742.81628591866;36753.816230918674;36777.448338274946;37018;2991.4316279906748;3009.653889802657;3020.7885448018646;3043.3913217356617;3099.0547882895708;26346.604800928002;26955.59566606483;27269;27806.443871122665;28246.293842653893;3104.9534256986162;3129.937401251985;3133.075742655922;3133.1697100268448;3193.2655489237604;166698.1665091679;166988;167266;167753;168850.36094946717;47849.5215047852;48104.5189548107;48190;48329.75835120802;48349.274760878616;31251.687483125334;32014;32073.35853282968;51604.483955159965;51698;11800.291982481078;12108.757824843453;12111.45498452554;12119.515219391125;12127;8917.821643567093;9036.8644470333;9044.773880653036;9044.8643270351;9085.545722713838;17211.31154753796;17324.566885827957;17332.91333543324;17363;17396.39112631052;6488.902666460007;6558.278589355167;6638;6744.966275168691;7003.369696727319;779.6920216514559;907.8184363127401;948.7011591348703;960.4285450157146;1011.1960991012163;25691.87154064255;26552.60171097435;26969.325766855593;27031.594526082125;27216;847.8728190771434;925.4169872979979;926.5598840550684;1000.8198524265703;1018.6027449294781;13303;14189.503367382093;14244.359003844851;14820.258987050604;16170.595735106717;332842;335720;335897;336004;336307;47290.5270947293;47429.76285118621;47552;47583;47944.760276198394;1121.4897221764077;1165.4988355007258;1166.020542744099;1199.7540504196618;1202.110438275687;26329.736702633494;27295.727042730112;27821.72178278191;28138;28230;40551.391729124676;44362.334564980905;45533.54466455293;45861.77069114633;50444.74777626235;324146;327806;327870;328321;329578;35022.82488587541;35029;35481.64518354887;35497.645023549434;35993;40057.79971100126;40552.59447405488;40739.38890916698;40933.1813363737;40950.385744213265;34413.65586344105;34813;34836.651633484355;34901.301973960886;35000.64999349974;33603.83198083994;33890.49164262489;34405.82797085999;34628.480572790926;34679;30670.539941901337;31727.365452690356;33936;34118.14704632404;34247;27152.321191970357;30781.846090769403;31864.840675796473;31975.200619984687;31979.200519987186;24762.628560571968;24981.87509062443;25007.87496062581;25142.371440713396;25271.36821579475 19:50:04 INFO - PROCESS | 16945 | |2;jquery.html;336.50365710576904;338.362187276983;341.97435192360564;359.14344288871035;371.57454714352053;15309.234538273084;16002.91998540007;16249.431269905555;16782.83217167828;16797.160141992914;15565.455209067684;15754.921225393886;16181.91909040456;16193.757093643604;16203.35186592535;4775.044991001796;4808.797800549863;4951.950480495203;4998.750062496879;5005;4918.975405122969;5005.174146265862;5008.549230569248;5015.473375295596;5018.146915024455;4887.3890763654545;4965.503449655042;5014.24786282057;5207.401148867872;5225.712585807798;5204.089284375238;5236.24074509194;5247.291615631898;5271.604629652791;5286.735663216843;4990.525900039491;5132.897342053176;5170.397176875181;5217.895642087137;5219.973900130513;15613.843861561352;15855.60360990973;16158.353665853469;18805.905970470198;19078.618427631507;1793.4888556761261;1865.2911893480525;1865.4123950955407;1962.1464662871554;1962.3622322745166;8614.566158413578;8931.821363572757;8988.325875559294;9206.907930920672;9388.577514011886;1576.4167258114571;1655.5778276539527;1676.5724740191174;1678.5209092901391;1770.194561474526;58980;65487.3451265486;65849.99999999952;65907.67046164787;66293;7916.485428447248;8497;8589.141085891486;8606.225439710455;8742.91257087421;11200.719982000352;11267.774644507064;11296.943515282372;11302.660920172408;11373.090152787758;5692.9146062809095;5901.881962360814;5988.9101663475085;6006;6055.666938318434;5671.1493276008105;5719.428057194247;5841.094630332305;5862.970685146547;5867.70661466925;3538.486919396673;3588.2105936693883;3602.2615363850346;3653.926921461556;3705.5923848376656;1766.3199668127863;1785.4286628278826;1799.9460016199534;1830.6796310645584;1843.4746097362456;797.8484088023257;829.2578142562494;834.4200780457523;863.5164307987548;877.3419935048713;16186.271617776993;16754.581135471468;17214.483565493054;17354.739678904825;17379.304827806747;814.7922279818608;834.3241974001079;860.7159637319669;862.7627402464248;868.847951608466;7569.561783261162;9172.220361269234;9619.807603847883;9915.355501892354;9970.850437243447;364377;374724;375971;388260;389310;75424.62287688526;75684.62157689287;76466.6176669113;76709.41132358456;77656.61171694218;861.8491763941286;911.6717981526778;926.7219834049758;936.091990768953;940.7836197674436;15268.160251186291;15336.923315383352;15503.5348939532;15565.14391708467;16205.351785928431;34936.12659683528;35639;35801.82099089592;36227.45658815173;37213.81393093017;47719.522804772896;50875.74562127166;52023.2196517045;52167;52508.737456312476;7087.114110736158;7282.12614486265;7343.816404589715;7476.102867655916;7598.062494063978;10691.5188816505;10995.560177592806;11280.49237784318;11523.193376463567;11635.592754253561;9859.950700246452;9956.601735930482;10014.949925250326;10082.445465499468;10529.631462898762;9819.263555233243;10069.345492542961;10160.085592296433;10197.54111064989;10455.738606534898;10014.499275036073;10071;10107.3430227035;10622.20333474977;10730;7041.43668506508;7145.4998150128995;7277.490575659653;7485.214052524407;7548.622568871425;8208.917910820815;9988.900110999088;10000.2999790014;10096.48552717069;10414.895851041696 19:50:04 INFO - PROCESS | 16945 | |3;mootools.html;1329.268902103843;1345.17944054127;1413.5971248194267;1618.1181256215361;1633.2568681250025;6038.637681739098;6237.968810155954;6541.280459149496;6981.266966968471;7003.964980175098;6350.206224221973;6537.80386588402;6593.67031648418;6747.39273465388;6755.5271131020845;1932.3043704266488;1995.5011247188204;2003.629328574211;2008.5581172142106;2009.0457032909396;2025.9189632414686;2049.180327868857;2051.302557130575;2089.5298557824444;2092.7697953225133;1981.8414526837819;2003.2287569285857;2024.6355655981918;2025.9797402026013;2026.2604149485478;1935.4967708395848;1963.1950900130878;1975.861689681723;1977.0806574942576;1982.7422435083347;1970.8916009619466;1983.2166294313665;1986.5629561496448;1994.4016794961453;1997.6803711406105;6744.561603495807;6803.761868334634;6862.279460656659;6905.585664860074;6938.826529336807;3937.3503371943593;4084.387341898739;4086.5504794472586;4090.1819636072605;4093.4678491796176;2551.400420901087;2659.361753179223;2672.3586339278627;2719.6600424946882;2732.8223665461683;818.7502811642447;843.1821133500495;852.5012867472536;863.896332440105;877.9122087791234;8361.331093512505;8778.780530486725;8784.38509304349;8796.164364385373;8843.20411162992;3561.44797556374;3666.358387282215;3675.044488433027;3678.834452449646;3696.7597106188014;7207.5675459472595;7223.205447400782;7225.494215404976;7240.9637951810955;7258.129024517092;4049.5747946465785;4050.10897602527;4050.311447054008;4062.1266427718183;4063.9796801015805;3202.487601983718;3559.8042107684328;3701.0747313171705;3776.8489260429274;3797.1076796952693;2972.6135602371555;3004.248937765559;3047.8476076196544;3081.645610754747;3089.9845500772803;872.8516152254132;878.8066625342415;882.0341725810227;884.1600479544459;895.3777124898263;769.4383100336673;799.7360870912585;801.8636831738619;814.5723495165086;840.0675250471971;4474.395956545824;4620.976895115503;4642;4668.5798278155125;4857.684250523705;374.0872271657148;374.2141502844006;375.7388614912664;377.82997651056587;389.6493156159479;3193.584833971569;3224.5808044954006;3278.0493656839726;3313.784604000732;3346.5816772903386;7446.73936412223;7633.961830190813;7763.573003484749;7768.53388796674;7790.8575141836445;7742.341900938483;7754.302112809874;7755.495892766952;7756.263155000266;7762.7671169865;6292.653904035231;6449.967750161313;6454.160959075384;6455.289918109004;6477.481801455872;4451.3545535896465;4514.503404625554;4539.636829053734;4577.6795624307315;4577.793999270108;7339.1926888043345;7348.448866335153;7511.887321690069;7519.473636845369;7566.205548417337;7528.397728181622;7540.698372065275;7601.201873803392;7602.1257555379625;7609.162992070978;5534;5552.555795536428;5557.833265002057;5575.163725441216;5615;6261.96869015652;6346.397092276226;6360.650164241011;6362.204724409449;6364.490840732823;5396.676199428047;5428.321459817523;5462.262594549685;5500.559955203494;5576.1356989666665;5690.914636280542;5859.619124756877;5876.823695289148;5908.143319218775;5930.347661757117;5598.888022239451;5612.635178713534;5721.427857214246;5781.82654520365;5787;3956.327424337927;3991.7405368650943;4011.4383986241364;4024.416459613281;4051.1290072634524;3902.902427439337;4114.876553703393;4129.752214867118;4269.594388533084;4299.527052024212 19:50:04 INFO - PROCESS | 16945 | |4;prototype.html;283.9148255523343;289.45726762320646;291.1324253723904;293.9323955490236;296.70922495953977;4871.244957031657;4890.972895691904;4897.510248975105;4925.556699897009;4952.356193694824;4621.214393553096;4869.537393947569;4887.193613053851;4923.6307276954285;4936.617747030838;3708.425194094913;3737.9252414951684;3772.547294324685;3811.6760075393627;3821.14024344523;3804.4293355996547;3805.7145714071416;3809.561900381464;3812.5234345706785;3814.8146297841336;3799.25914446683;3801.6388443098;3829.9234015319676;3834.8082595870233;3838.2899163654674;3748;3751.5498140223076;3783.375743002401;3827.827747751358;3843.13529455873;3306.354916067137;3311.8840840570706;3312.2216279174377;3313.6355000949875;3315.7347412206964;4783.952160478386;4808.543188397097;4833.903321933577;4854.83008094715;4857.319975203474;4219.493660760698;4319.179355922364;4354.847580334705;4359.476862776455;4369;5032.169692000815;5038.773255203488;5065.1895696688725;5067.61992850534;5068.746562671851;3580.3197392495604;3618.620044895301;3646.3436581415335;3659.8170091495317;3665.633436656313;5435.619506634498;5435.755391007375;5436.891262174774;5439.129739241742;5446.618736688433;3594.6405359463843;3691.9446208306895;3715.9442608360896;3717.442383642421;3722.3671975764187;3752.249550089993;3777.0557360659836;3784.243151369737;3800.2209547043344;3818.770873747584;4349.956500434955;4353.281708518122;4357.520672725997;4360.607545320936;4363.2364336241035;4812.8796780080775;5083.906960003617;5179.378474582999;5180.119379705459;5205.609579281569;1235.9073069519823;1240.9069319801051;1246.6945598328468;1246.9812952805714;1250.781113305168;807.3057170833079;830.3647709502236;834.7287131682106;850.5322072859902;851.344464762142;4277.443932288783;4342.717723347972;4355.194289056535;4356.780101571565;4370.2352088384405;5098.643094983389;5110.744462776846;5112.616553758483;5116.283720279164;5126.846194614093;4307.956920430755;4346.457007762262;4347.043650396908;4364.869053928387;4376.402613046279;2565.987170064175;2654.469106178772;2695.2183866678834;2711.6306265336275;2712.9788307710883;4718.31584420264;4719.9292010619865;4740.762961851894;4748.548887855648;4750.477447480775;5012.899742005139;5171.405288391883;5174.301469301671;5184.429712731597;5221.582273418117;4639.816846704069;4670.276107203389;4678.789454474557;4682.735661371411;4695.178343789823;5042.672226305279;5046.873828154326;5087.616734871269;5124.333836601218;5149.253358263106;4699.389079419653;5029.119904016856;5034.148876109706;5041.823536176216;5066.441447069206;4652.953470465252;4661.394018777537;4693.272542755878;4693.929591056205;4740.241561350167;3498.7026102781547;3511.086457880512;3514;3530.2586456843324;3536.876209332661;5116.4139116873885;5124.256982737556;5136.486351364833;5163.974180129226;5170.37955445349;4705;4896.2410826321975;4922.286268491121;4938.456769755252;4943.802247910044;4849.466558678613;4861.416630004281;4869.95130048695;4884.462709102067;4919.163742163769;4855.9074208302845;4861.27080937848;4867.58625516835;4894.486078961658;4900.436449808318;4764.475907650225;4947.777350019186;4997.300377947017;5001.824936127218;5010.448850626355;4845.8061677532505;4856.878578035577;4896.510348965217;4911.631627628014;4926.5073492650445 19:50:04 INFO - PROCESS | 16945 | |5;yui.html;622.6606499457795;676.0501495398967;683.2654895986816;698.94757893158;720.0998751560551;12063.2762034278;12783.29691866947;12809.10336276461;12822.48710051598;12903.741925161492;11827.822582661245;11920.403979800996;11935.04519638429;11987.520499180022;12009.219400738968;734.7832389445126;738.830069084111;751.3313151295324;769.8075481129717;778.5717855179657;771.3173841150594;771.6064806948468;772.7334069745929;772.7565816767728;772.8531579;808.5876203136413;809.3565615335792;809.9716509922154;810.667626273228;811.3995643224001;804.7022601637432;805.6656487557657;805.9879101813448;806.5201205282876;807.1363640904235;588.7792077970761;589.1045610671798;590.7075997381323;593.6141508019822;593.6319481921194;12834.743305133938;12916.22502649844;12964.740705185843;12969.221846689228;12977.156484828456;11628.953394194563;11908.16642835002;12038.69903252417;12146.817797733042;12289.75420491594;9283.489408082552;9467.763305917339;9621.470819104947;9703.854442183372;9797.62833203352;3179.4118088153764;3208.246062175387;3216.4371235033777;3228.499582564706;3231.046841181857;49018;49056;49502.2574661384;50165.749171254276;51383.74308128473;8756.605952732143;8842.557872106368;9040.909590904006;9047;9134.588943497558;16607.3357065716;16728.996260224427;16772.664546709;16861;16883.24025418859;6383.39357761012;6397.200349956255;6457.483401327882;6462.418382345518;6507.251666058369;3490.7905525668543;3510.78935263885;3522.647735226457;3607.206414588786;3651.087228192952;2719.4697034078163;2783.4293969736154;2795.0636536760007;2808.5506318989273;2825.6891741908375;469.3452633576142;471.83957454465644;474.7222874618318;477.9928301075487;480.5458841394848;540.694507603203;543.7063985447813;561.3123923194137;567.1889198446262;574.130192757972;6964.094667693167;7052.753153639701;7086.964565177141;7123.82190445243;7250.456215783837;536.5948708724887;544.7957016118955;552.3013388064102;553.4880235781966;581.128307538692;3199.472087105648;3403.387390269775;3406.5571475707998;3516.929661406809;3529.1530032791943;55166;57160.71419642875;57889.421105789246;61161.69419152876;67923.66038169777;53651.46348536465;55380.44619553753;56830.715846420506;57068.714656426455;57287.427125729046;48522.514774852505;48671.5132848667;50346.496535034916;50420;52130;6776.254611992578;7243;7407.851842963219;7412.110546734426;7420.406367490696;38619.613803862725;39930.80034599808;40087.79956100201;40526.59473405228;41283.1743365137;48640.51359486501;48803.75598121987;51942;52077.7396113017;53167.21495065463;10790.73023174427;10893.400862952614;10984.286021408583;11110.555577776799;11245.437728113726;11452.656420307405;11484.655460336204;11615.88384116148;11737.237079589799;11889.762204756029;9929.156021738234;10297.53661085238;10670.57317707283;11002.394868282321;11127;10718.303310284806;11143.777124457627;11297.548098075986;11521.251118677259;11575.247608905394;9976.750581235527;10401.115905148146;10712.089472394933;10801.567937282422;10893.782124357627;8630.654773808978;8787.956060219658;8959.328050396376;9138.68014619485;9485;8603.82792344162;9043.909560904307;9054.456732596065;9064.546772661472;9341.159295663423 19:50:04 INFO - PROCESS | 16945 | __end_tp_report 19:50:04 INFO - PROCESS | 16945 | __start_cc_report 19:50:04 INFO - PROCESS | 16945 | _x_x_mozilla_cycle_collect,344 19:50:04 INFO - PROCESS | 16945 | __end_cc_report 19:50:04 INFO - PROCESS | 16945 | __startTimestamp1479786604523__endTimestamp 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | ------- Summary: start ------- 19:50:04 INFO - PROCESS | 16945 | Number of tests: 6 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | [#0] dojo.html Cycles:165 Average:4660.11 Median:4764.67 stddev:489.47 (10.3%) stddev-sans-first:462.57 19:50:04 INFO - PROCESS | 16945 | Values: 2565.8 2568.6 2569.8 2606.6 2614.6 4545.2 4648.4 4670.3 4675.1 4689.6 4591.8 4718.3 4768.6 4790.0 4849.3 4265.9 4318.1 4366.5 4435.2 4472.5 3963.6 4298.4 4428.7 4491.9 4507.9 4206.6 4295.8 4335.6 4382.6 4475.9 4315.7 4319.2 4327.5 4348.0 4354.2 4291.8 4308.9 4325.0 4340.5 4357.9 4607.3 4623.0 4624.5 4706.0 4707.9 5017.3 5034.8 5036.5 5041.9 5061.6 4981.7 5024.1 5024.7 5037.6 5090.7 4718.5 4725.0 4725.3 4753.8 4764.7 5132.5 5152.5 5189.8 5191.2 5200.9 4874.1 4885.3 4923.0 4931.1 4999.0 4819.8 4955.0 5022.7 5075.2 5087.0 4946.5 5035.1 5076.1 5083.8 5124.4 5019.5 5034.7 5039.9 5043.2 5091.5 4226.1 4364.7 4393.6 4407.9 4422.1 3713.7 3758.4 3766.8 3820.0 3846.2 4401.3 4404.9 4405.4 4446.4 4451.3 5059.5 5072.5 5073.4 5093.2 5094.9 4281.7 4288.1 4326.9 4366.5 4386.4 4519.4 4578.3 4587.1 4597.4 4606.5 4712.5 4712.9 4714.3 4749.5 4757.7 5050.3 5063.3 5067.9 5073.5 5104.9 4602.1 4660.8 4663.3 4711.0 4756.4 4909.2 4969.3 4972.6 4983.5 4998.9 5012.6 5040.9 5044.4 5059.0 5112.8 4801.6 4857.6 4943.5 4944.0 4989.9 4855.2 4878.9 4910.2 4944.5 5008.7 4709.2 4808.3 4817.1 4844.6 4876.4 4892.1 4916.7 4943.2 4957.6 4982.9 4777.5 4814.9 4821.9 4835.9 4874.9 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | [#1] ext.html Cycles:180 Average:42983.09 Median:35011.74 stddev:75710.38 (216.2%) stddev-sans-first:75855.65 19:50:04 INFO - PROCESS | 16945 | Values: 523.4 540.8 549.8 552.4 558.7 37093.0 38532.6 38544.6 38613.6 38640.6 38384.0 38905.4 38931.2 38937.6 39007.6 7451.6 7570.1 7582.7 7594.4 7604.5 7461.1 7494.6 7532.2 7540.7 7547.9 7485.7 7499.3 7514.1 7533.1 7590.4 7396.6 7455.4 7468.6 7472.0 7499.8 7423.2 7482.2 7484.2 7486.7 7522.5 36413.6 36742.8 36753.8 36777.4 37018.0 2991.4 3009.7 3020.8 3043.4 3099.1 26346.6 26955.6 27269.0 27806.4 28246.3 3105.0 3129.9 3133.1 3133.2 3193.3 166698.2 166988.0 167266.0 167753.0 168850.4 47849.5 48104.5 48190.0 48329.8 48349.3 31251.7 32014.0 32073.4 51604.5 51698.0 11800.3 12108.8 12111.5 12119.5 12127.0 8917.8 9036.9 9044.8 9044.9 9085.5 17211.3 17324.6 17332.9 17363.0 17396.4 6488.9 6558.3 6638.0 6745.0 7003.4 779.7 907.8 948.7 960.4 1011.2 25691.9 26552.6 26969.3 27031.6 27216.0 847.9 925.4 926.6 1000.8 1018.6 13303.0 14189.5 14244.4 14820.3 16170.6 332842.0 335720.0 335897.0 336004.0 336307.0 47290.5 47429.8 47552.0 47583.0 47944.8 1121.5 1165.5 1166.0 1199.8 1202.1 26329.7 27295.7 27821.7 28138.0 28230.0 40551.4 44362.3 45533.5 45861.8 50444.7 324146.0 327806.0 327870.0 328321.0 329578.0 35022.8 35029.0 35481.6 35497.6 35993.0 40057.8 40552.6 40739.4 40933.2 40950.4 34413.7 34813.0 34836.7 34901.3 35000.6 33603.8 33890.5 34405.8 34628.5 34679.0 30670.5 31727.4 33936.0 34118.1 34247.0 27152.3 30781.8 31864.8 31975.2 31979.2 24762.6 24981.9 25007.9 25142.4 25271.4 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | [#2] jquery.html Cycles:180 Average:23375.55 Median:4958.73 stddev:62575.63 (1261.9%) stddev-sans-first:62727.26 19:50:04 INFO - PROCESS | 16945 | Values: 336.5 338.4 342.0 359.1 371.6 15309.2 16002.9 16249.4 16782.8 16797.2 15565.5 15754.9 16181.9 16193.8 16203.4 4775.0 4808.8 4952.0 4998.8 5005.0 4919.0 5005.2 5008.5 5015.5 5018.1 4887.4 4965.5 5014.2 5207.4 5225.7 5204.1 5236.2 5247.3 5271.6 5286.7 4990.5 5132.9 5170.4 5217.9 5220.0 15613.8 15855.6 16158.4 18805.9 19078.6 1793.5 1865.3 1865.4 1962.1 1962.4 8614.6 8931.8 8988.3 9206.9 9388.6 1576.4 1655.6 1676.6 1678.5 1770.2 58980.0 65487.3 65850.0 65907.7 66293.0 7916.5 8497.0 8589.1 8606.2 8742.9 11200.7 11267.8 11296.9 11302.7 11373.1 5692.9 5901.9 5988.9 6006.0 6055.7 5671.1 5719.4 5841.1 5863.0 5867.7 3538.5 3588.2 3602.3 3653.9 3705.6 1766.3 1785.4 1799.9 1830.7 1843.5 797.8 829.3 834.4 863.5 877.3 16186.3 16754.6 17214.5 17354.7 17379.3 814.8 834.3 860.7 862.8 868.8 7569.6 9172.2 9619.8 9915.4 9970.9 364377.0 374724.0 375971.0 388260.0 389310.0 75424.6 75684.6 76466.6 76709.4 77656.6 861.8 911.7 926.7 936.1 940.8 15268.2 15336.9 15503.5 15565.1 16205.4 34936.1 35639.0 35801.8 36227.5 37213.8 47719.5 50875.7 52023.2 52167.0 52508.7 7087.1 7282.1 7343.8 7476.1 7598.1 10691.5 10995.6 11280.5 11523.2 11635.6 9860.0 9956.6 10014.9 10082.4 10529.6 9819.3 10069.3 10160.1 10197.5 10455.7 10014.5 10071.0 10107.3 10622.2 10730.0 7041.4 7145.5 7277.5 7485.2 7548.6 8208.9 9988.9 10000.3 10096.5 10414.9 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | [#3] mootools.html Cycles:180 Average:4385.31 Median:5412.50 stddev:2347.88 (43.4%) stddev-sans-first:2343.24 19:50:04 INFO - PROCESS | 16945 | Values: 1329.3 1345.2 1413.6 1618.1 1633.3 6038.6 6238.0 6541.3 6981.3 7004.0 6350.2 6537.8 6593.7 6747.4 6755.5 1932.3 1995.5 2003.6 2008.6 2009.0 2025.9 2049.2 2051.3 2089.5 2092.8 1981.8 2003.2 2024.6 2026.0 2026.3 1935.5 1963.2 1975.9 1977.1 1982.7 1970.9 1983.2 1986.6 1994.4 1997.7 6744.6 6803.8 6862.3 6905.6 6938.8 3937.4 4084.4 4086.6 4090.2 4093.5 2551.4 2659.4 2672.4 2719.7 2732.8 818.8 843.2 852.5 863.9 877.9 8361.3 8778.8 8784.4 8796.2 8843.2 3561.4 3666.4 3675.0 3678.8 3696.8 7207.6 7223.2 7225.5 7241.0 7258.1 4049.6 4050.1 4050.3 4062.1 4064.0 3202.5 3559.8 3701.1 3776.8 3797.1 2972.6 3004.2 3047.8 3081.6 3090.0 872.9 878.8 882.0 884.2 895.4 769.4 799.7 801.9 814.6 840.1 4474.4 4621.0 4642.0 4668.6 4857.7 374.1 374.2 375.7 377.8 389.6 3193.6 3224.6 3278.0 3313.8 3346.6 7446.7 7634.0 7763.6 7768.5 7790.9 7742.3 7754.3 7755.5 7756.3 7762.8 6292.7 6450.0 6454.2 6455.3 6477.5 4451.4 4514.5 4539.6 4577.7 4577.8 7339.2 7348.4 7511.9 7519.5 7566.2 7528.4 7540.7 7601.2 7602.1 7609.2 5534.0 5552.6 5557.8 5575.2 5615.0 6262.0 6346.4 6360.7 6362.2 6364.5 5396.7 5428.3 5462.3 5500.6 5576.1 5690.9 5859.6 5876.8 5908.1 5930.3 5598.9 5612.6 5721.4 5781.8 5787.0 3956.3 3991.7 4011.4 4024.4 4051.1 3902.9 4114.9 4129.8 4269.6 4299.5 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | [#4] prototype.html Cycles:180 Average:4159.54 Median:4702.19 stddev:1205.38 (25.6%) stddev-sans-first:1173.14 19:50:04 INFO - PROCESS | 16945 | Values: 283.9 289.5 291.1 293.9 296.7 4871.2 4891.0 4897.5 4925.6 4952.4 4621.2 4869.5 4887.2 4923.6 4936.6 3708.4 3737.9 3772.5 3811.7 3821.1 3804.4 3805.7 3809.6 3812.5 3814.8 3799.3 3801.6 3829.9 3834.8 3838.3 3748.0 3751.5 3783.4 3827.8 3843.1 3306.4 3311.9 3312.2 3313.6 3315.7 4784.0 4808.5 4833.9 4854.8 4857.3 4219.5 4319.2 4354.8 4359.5 4369.0 5032.2 5038.8 5065.2 5067.6 5068.7 3580.3 3618.6 3646.3 3659.8 3665.6 5435.6 5435.8 5436.9 5439.1 5446.6 3594.6 3691.9 3715.9 3717.4 3722.4 3752.2 3777.1 3784.2 3800.2 3818.8 4350.0 4353.3 4357.5 4360.6 4363.2 4812.9 5083.9 5179.4 5180.1 5205.6 1235.9 1240.9 1246.7 1247.0 1250.8 807.3 830.4 834.7 850.5 851.3 4277.4 4342.7 4355.2 4356.8 4370.2 5098.6 5110.7 5112.6 5116.3 5126.8 4308.0 4346.5 4347.0 4364.9 4376.4 2566.0 2654.5 2695.2 2711.6 2713.0 4718.3 4719.9 4740.8 4748.5 4750.5 5012.9 5171.4 5174.3 5184.4 5221.6 4639.8 4670.3 4678.8 4682.7 4695.2 5042.7 5046.9 5087.6 5124.3 5149.3 4699.4 5029.1 5034.1 5041.8 5066.4 4653.0 4661.4 4693.3 4693.9 4740.2 3498.7 3511.1 3514.0 3530.3 3536.9 5116.4 5124.3 5136.5 5164.0 5170.4 4705.0 4896.2 4922.3 4938.5 4943.8 4849.5 4861.4 4870.0 4884.5 4919.2 4855.9 4861.3 4867.6 4894.5 4900.4 4764.5 4947.8 4997.3 5001.8 5010.4 4845.8 4856.9 4896.5 4911.6 4926.5 19:50:04 INFO - PROCESS | 16945 | 19:50:04 INFO - PROCESS | 16945 | [#5] yui.html Cycles:180 Average:14012.58 Median:52103.87 stddev:17447.51 (33.5%) stddev-sans-first:17467.48 19:50:04 INFO - PROCESS | 16945 | Values: 622.7 676.1 683.3 698.9 720.1 12063.3 12783.3 12809.1 12822.5 12903.7 11827.8 11920.4 11935.0 11987.5 12009.2 734.8 738.8 751.3 769.8 778.6 771.3 771.6 772.7 772.8 772.9 808.6 809.4 810.0 810.7 811.4 804.7 805.7 806.0 806.5 807.1 588.8 589.1 590.7 593.6 593.6 12834.7 12916.2 12964.7 12969.2 12977.2 11629.0 11908.2 12038.7 12146.8 12289.8 9283.5 9467.8 9621.5 9703.9 9797.6 3179.4 3208.2 3216.4 3228.5 3231.0 49018.0 49056.0 49502.3 50165.7 51383.7 8756.6 8842.6 9040.9 9047.0 9134.6 16607.3 16729.0 16772.7 16861.0 16883.2 6383.4 6397.2 6457.5 6462.4 6507.3 3490.8 3510.8 3522.6 3607.2 3651.1 2719.5 2783.4 2795.1 2808.6 2825.7 469.3 471.8 474.7 478.0 480.5 540.7 543.7 561.3 567.2 574.1 6964.1 7052.8 7087.0 7123.8 7250.5 536.6 544.8 552.3 553.5 581.1 3199.5 3403.4 3406.6 3516.9 3529.2 55166.0 57160.7 57889.4 61161.7 67923.7 53651.5 55380.4 56830.7 57068.7 57287.4 48522.5 48671.5 50346.5 50420.0 52130.0 6776.3 7243.0 7407.9 7412.1 7420.4 38619.6 39930.8 40087.8 40526.6 41283.2 48640.5 48803.8 51942.0 52077.7 53167.2 10790.7 10893.4 10984.3 11110.6 11245.4 11452.7 11484.7 11615.9 11737.2 11889.8 9929.2 10297.5 10670.6 11002.4 11127.0 10718.3 11143.8 11297.5 11521.3 11575.2 9976.8 10401.1 10712.1 10801.6 10893.8 8630.7 8788.0 8959.3 9138.7 9485.0 8603.8 9043.9 9054.5 9064.5 9341.2 19:50:04 INFO - PROCESS | 16945 | -------- Summary: end -------- 19:50:04 INFO - PROCESS | 16945 | 19:50:05 INFO - TEST-INFO | 16945: exit 0 19:50:05 INFO - TEST-OK | dromaeo_css | took 1120794ms 19:50:05 INFO - TEST-START | kraken 19:50:05 INFO - operating with platform_type : linux_ 19:50:05 INFO - Initialising browser for kraken test... 19:50:05 INFO - TEST-INFO | started process 17300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzDxQfQ/profile http://localhost:47864/getInfo.html) 19:50:10 INFO - PROCESS | 17300 | __metrics Screen width/height:1600/1200 19:50:10 INFO - PROCESS | 17300 | colorDepth:24 19:50:10 INFO - PROCESS | 17300 | Browser inner width/height: 1024/697 19:50:10 INFO - PROCESS | 17300 | __metrics 19:50:11 ERROR - PROCESS | 17300 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 19:50:12 INFO - TEST-INFO | 17300: exit 0 19:50:12 INFO - Browser initialized. 19:50:12 INFO - Running cycle 1/1 for kraken test... 19:50:12 INFO - TEST-INFO | started process 17423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzDxQfQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:50:24 INFO - PROCESS | 17423 | RSS: Main: 187305984 19:50:24 INFO - PROCESS | 17423 | 19:50:27 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47864/tests/kraken/driver.html?testName=audio-beat-detection) 19:50:28 INFO - PROCESS | 17423 | RSS: Main: 200069120 19:50:28 INFO - PROCESS | 17423 | 19:50:31 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47864/tests/kraken/driver.html?testName=audio-dft) 19:50:32 INFO - PROCESS | 17423 | RSS: Main: 198242304 19:50:32 INFO - PROCESS | 17423 | 19:50:35 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47864/tests/kraken/driver.html?testName=audio-fft) 19:50:35 INFO - PROCESS | 17423 | RSS: Main: 194883584 19:50:35 INFO - PROCESS | 17423 | 19:50:37 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47864/tests/kraken/driver.html?testName=audio-oscillator) 19:50:38 INFO - PROCESS | 17423 | RSS: Main: 195338240 19:50:38 INFO - PROCESS | 17423 | 19:50:40 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47864/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:50:41 INFO - PROCESS | 17423 | RSS: Main: 195739648 19:50:41 INFO - PROCESS | 17423 | 19:50:44 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47864/tests/kraken/driver.html?testName=imaging-darkroom) 19:50:45 INFO - PROCESS | 17423 | RSS: Main: 201523200 19:50:45 INFO - PROCESS | 17423 | 19:50:48 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47864/tests/kraken/driver.html?testName=imaging-desaturate) 19:50:49 INFO - PROCESS | 17423 | RSS: Main: 197218304 19:50:49 INFO - PROCESS | 17423 | 19:50:52 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47864/tests/kraken/driver.html?testName=json-parse-financial) 19:50:52 INFO - PROCESS | 17423 | RSS: Main: 198115328 19:50:52 INFO - PROCESS | 17423 | 19:50:54 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47864/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:50:55 INFO - PROCESS | 17423 | RSS: Main: 198864896 19:50:55 INFO - PROCESS | 17423 | 19:50:57 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:50:57 INFO - PROCESS | 17423 | RSS: Main: 198856704 19:50:57 INFO - PROCESS | 17423 | 19:51:00 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:51:00 INFO - PROCESS | 17423 | RSS: Main: 199184384 19:51:00 INFO - PROCESS | 17423 | 19:51:03 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:51:04 INFO - PROCESS | 17423 | RSS: Main: 199487488 19:51:04 INFO - PROCESS | 17423 | 19:51:07 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:51:08 INFO - PROCESS | 17423 | RSS: Main: 199340032 19:51:08 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | Cycle 1(1): loaded http://localhost:47864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47864/tests/kraken/driver.html?testName=ai-astar) 19:51:10 INFO - PROCESS | 17423 | RSS: Main: 202260480 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | __start_tp_report 19:51:10 INFO - PROCESS | 17423 | _x_x_mozilla_page_load 19:51:10 INFO - PROCESS | 17423 | _x_x_mozilla_page_load_details 19:51:10 INFO - PROCESS | 17423 | |i|pagename|runs| 19:51:10 INFO - PROCESS | 17423 | |0;ai-astar;109;115;117;116;116;116;118;116;115;115 19:51:10 INFO - PROCESS | 17423 | |1;audio-beat-detection;165;134;132;190;135;131;133;132;163;131 19:51:10 INFO - PROCESS | 17423 | |2;audio-dft;174;164;163;164;165;165;165;167;166;163 19:51:10 INFO - PROCESS | 17423 | |3;audio-fft;77;76;77;117;81;78;77;76;103;76 19:51:10 INFO - PROCESS | 17423 | |4;audio-oscillator;84;83;110;85;84;84;115;85;83;112 19:51:10 INFO - PROCESS | 17423 | |5;imaging-gaussian-blur;118;119;121;118;117;117;118;120;119;118 19:51:10 INFO - PROCESS | 17423 | |6;imaging-darkroom;147;148;149;150;148;147;148;148;150;151 19:51:10 INFO - PROCESS | 17423 | |7;imaging-desaturate;96;96;97;97;97;96;96;96;97;96 19:51:10 INFO - PROCESS | 17423 | |8;json-parse-financial;64;64;67;64;65;65;65;66;66;66 19:51:10 INFO - PROCESS | 17423 | |9;json-stringify-tinderbox;67;67;67;68;68;66;67;68;67;66 19:51:10 INFO - PROCESS | 17423 | |10;stanford-crypto-aes;86;85;91;93;92;88;89;86;87;86 19:51:10 INFO - PROCESS | 17423 | |11;stanford-crypto-ccm;154;150;155;147;160;147;148;156;235;159 19:51:10 INFO - PROCESS | 17423 | |12;stanford-crypto-pbkdf2;185;190;182;183;182;181;178;180;179;185 19:51:10 INFO - PROCESS | 17423 | |13;stanford-crypto-sha256-iterative;72;75;73;73;72;69;73;70;70;71 19:51:10 INFO - PROCESS | 17423 | __end_tp_report 19:51:10 INFO - PROCESS | 17423 | __start_cc_report 19:51:10 INFO - PROCESS | 17423 | _x_x_mozilla_cycle_collect,879 19:51:10 INFO - PROCESS | 17423 | __end_cc_report 19:51:10 INFO - PROCESS | 17423 | __startTimestamp1479786670317__endTimestamp 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | ------- Summary: start ------- 19:51:10 INFO - PROCESS | 17423 | Number of tests: 14 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:2.41 (2.1%) stddev-sans-first:1.00 19:51:10 INFO - PROCESS | 17423 | Values: 109.0 115.0 117.0 116.0 116.0 116.0 118.0 116.0 115.0 115.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:134.50 stddev:20.66 (15.4%) stddev-sans-first:20.55 19:51:10 INFO - PROCESS | 17423 | Values: 165.0 134.0 132.0 190.0 135.0 131.0 133.0 132.0 163.0 131.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.00 stddev:3.20 (1.9%) stddev-sans-first:1.32 19:51:10 INFO - PROCESS | 17423 | Values: 174.0 164.0 163.0 164.0 165.0 165.0 165.0 167.0 166.0 163.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#3] audio-fft Cycles:10 Average:83.80 Median:77.00 stddev:14.27 (18.5%) stddev-sans-first:14.93 19:51:10 INFO - PROCESS | 17423 | Values: 77.0 76.0 77.0 117.0 81.0 78.0 77.0 76.0 103.0 76.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#4] audio-oscillator Cycles:10 Average:92.50 Median:84.00 stddev:13.75 (16.4%) stddev-sans-first:14.24 19:51:10 INFO - PROCESS | 17423 | Values: 84.0 83.0 110.0 85.0 84.0 84.0 115.0 85.0 83.0 112.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:118.50 stddev:1.27 (1.1%) stddev-sans-first:1.33 19:51:10 INFO - PROCESS | 17423 | Values: 118.0 119.0 121.0 118.0 117.0 117.0 118.0 120.0 119.0 118.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.35 (0.9%) stddev-sans-first:1.30 19:51:10 INFO - PROCESS | 17423 | Values: 147.0 148.0 149.0 150.0 148.0 147.0 148.0 148.0 150.0 151.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:51:10 INFO - PROCESS | 17423 | Values: 96.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.50 stddev:1.03 (1.6%) stddev-sans-first:1.00 19:51:10 INFO - PROCESS | 17423 | Values: 64.0 64.0 67.0 64.0 65.0 65.0 65.0 66.0 66.0 66.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 19:51:10 INFO - PROCESS | 17423 | Values: 67.0 67.0 67.0 68.0 68.0 66.0 67.0 68.0 67.0 66.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#10] stanford-crypto-aes Cycles:10 Average:88.30 Median:88.50 stddev:2.83 (3.2%) stddev-sans-first:2.88 19:51:10 INFO - PROCESS | 17423 | Values: 86.0 85.0 91.0 93.0 92.0 88.0 89.0 86.0 87.0 86.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#11] stanford-crypto-ccm Cycles:10 Average:161.10 Median:155.50 stddev:26.40 (17.0%) stddev-sans-first:27.88 19:51:10 INFO - PROCESS | 17423 | Values: 154.0 150.0 155.0 147.0 160.0 147.0 148.0 156.0 235.0 159.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.50 Median:182.50 stddev:3.50 (1.9%) stddev-sans-first:3.60 19:51:10 INFO - PROCESS | 17423 | Values: 185.0 190.0 182.0 183.0 182.0 181.0 178.0 180.0 179.0 185.0 19:51:10 INFO - PROCESS | 17423 | 19:51:10 INFO - PROCESS | 17423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.50 stddev:1.81 (2.5%) stddev-sans-first:1.92 19:51:10 INFO - PROCESS | 17423 | Values: 72.0 75.0 73.0 73.0 72.0 69.0 73.0 70.0 70.0 71.0 19:51:10 INFO - PROCESS | 17423 | -------- Summary: end -------- 19:51:10 INFO - PROCESS | 17423 | 19:51:11 INFO - TEST-INFO | 17423: exit 0 19:51:11 INFO - TEST-OK | kraken | took 66133ms 19:51:11 INFO - SUITE-END | took 1186s 19:51:11 INFO - Completed test suite (00:19:47) 19:51:11 INFO - javascript benchmark 19:51:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6008.842140955485, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2565.781908537774, 2568.640390345352, 2569.8329608575455, 2606.6481025061616, 2614.6078088286745, 4545.181867263891, 4648.395708557891, 4670.2761072033845, 4675.088357770236, 4689.57793798558, 4591.793369298382, 4718.339432479455, 4768.570828625423, 4789.994101238735, 4849.345338379318, 4265.87202383929, 4318.1363727254675, 4366.476022877259, 4435.157320109169, 4472.53038430965, 3963.6483083324274, 4298.355246713002, 4428.734275943454, 4491.910161796762, 4507.864764057067, 4206.642435392995, 4295.806688699016, 4335.609795118423, 4382.6055654991205, 4475.888102797439, 4315.654747620183, 4319.244132276839, 4327.545607711208, 4347.956520434786, 4354.216241076605, 4291.849785257532, 4308.9353659695125, 4325.0, 4340.457442819647, 4357.934630980538, 4607.262837945946, 4622.976885115553, 4624.514425985257, 4706.0, 4707.8587642370785, 5017.322661440695, 5034.823781167678, 5036.521530454601, 5041.873953151164, 5061.569766569846, 4981.701097934136, 5024.120778863684, 5024.748762561894, 5037.622178336639, 5090.694558326512, 4718.4809670936165, 4725.0, 4725.267583524559, 4753.809847606126, 4764.6664733469015, 5132.538071573502, 5152.4847515248175, 5189.766460509286, 5191.169412893919, 5200.8959820803375, 4874.073925954128, 4885.267209918541, 4923.0, 4931.112399768004, 4998.950010499849, 4819.807207711652, 4955.0, 5022.698638081727, 5075.2387141929, 5087.0, 4946.5053494650965, 5035.118854200574, 5076.060928728123, 5083.771230294646, 5124.436312005676, 5019.548240658358, 5034.723090230073, 5039.899202015939, 5043.167877300204, 5091.541761241506, 4226.1336426032585, 4364.672649551297, 4393.560643935581, 4407.867763967086, 4422.071365013383, 3713.7400381973002, 3758.4362345647824, 3766.8304926278383, 3820.006798232424, 3846.1538461538416, 4401.295792673157, 4404.889877753082, 4405.405270288534, 4446.3552784846015, 4451.265541185733, 5059.468755780664, 5072.492750724898, 5073.3911930568565, 5093.2360145977655, 5094.898102037939, 4281.678874084394, 4288.078063216423, 4326.935095973563, 4366.519682834885, 4386.385905973102, 4519.41247637805, 4578.267477203632, 4587.059652771174, 4597.356370108188, 4606.470255920545, 4712.458067322302, 4712.929306060343, 4714.269288260325, 4749.501302363271, 4757.666963312535, 5050.267711181785, 5063.26582645507, 5067.87330316745, 5073.518015788494, 5104.923426148536, 4602.056578401352, 4660.790264438177, 4663.253879379283, 4711.0, 4756.357891684578, 4909.1654418748185, 4969.254611808113, 4972.577330926767, 4983.526564976321, 4998.850034498971, 5012.598992080552, 5040.873978150576, 5044.445111037856, 5058.974705126451, 5112.769925353442, 4801.591864691541, 4857.611391088775, 4943.530364615356, 4943.975280123576, 4989.850304490871, 4855.174620314484, 4878.926816097691, 4910.165271903714, 4944.505549445027, 5008.749562521933, 4709.222978208557, 4808.254720518185, 4817.084753896748, 4844.636652251025, 4876.390451193601, 4892.0705066037335, 4916.729579872998, 4943.209086546135, 4957.578605818401, 4982.8754281143265, 4777.522247775195, 4814.903701925872, 4821.879453013703, 4835.903281934271, 4874.926876096791], "value": 4628.533245526854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.3797949429926, 540.83504531118, 549.8487915823149, 552.3675391676528, 558.6843433460094, 37093.0, 38532.614673853255, 38544.61455385445, 38613.613863861356, 38640.61359386409, 38384.0, 38905.41641875374, 38931.22137557254, 38937.61062389375, 39007.60992390075, 7451.590162541058, 7570.12943511495, 7582.734604288851, 7594.392448604099, 7604.467687261867, 7461.067366579177, 7494.5503269803985, 7532.209118042609, 7540.660670269851, 7547.924520754805, 7485.663145158481, 7499.325060744532, 7514.0607424071995, 7533.096028476591, 7590.3548198403205, 7396.593187374692, 7455.4408419368765, 7468.55188688675, 7472.0, 7499.812504687399, 7423.220561840983, 7482.176960534337, 7484.214157513437, 7486.700531978769, 7522.548647081193, 36413.630364356184, 36742.81628591866, 36753.816230918674, 36777.448338274946, 37018.0, 2991.4316279906748, 3009.653889802657, 3020.7885448018646, 3043.3913217356617, 3099.0547882895708, 26346.604800928002, 26955.59566606483, 27269.0, 27806.443871122665, 28246.293842653893, 3104.9534256986162, 3129.937401251985, 3133.075742655922, 3133.1697100268448, 3193.2655489237604, 166698.1665091679, 166988.0, 167266.0, 167753.0, 168850.36094946717, 47849.5215047852, 48104.5189548107, 48190.0, 48329.75835120802, 48349.274760878616, 31251.687483125334, 32014.0, 32073.35853282968, 51604.483955159965, 51698.0, 11800.291982481078, 12108.757824843453, 12111.45498452554, 12119.515219391125, 12127.0, 8917.821643567093, 9036.8644470333, 9044.773880653036, 9044.8643270351, 9085.545722713838, 17211.31154753796, 17324.566885827957, 17332.91333543324, 17363.0, 17396.39112631052, 6488.902666460007, 6558.278589355167, 6638.0, 6744.966275168691, 7003.369696727319, 779.6920216514559, 907.8184363127401, 948.7011591348703, 960.4285450157146, 1011.1960991012163, 25691.87154064255, 26552.60171097435, 26969.325766855593, 27031.594526082125, 27216.0, 847.8728190771434, 925.4169872979979, 926.5598840550684, 1000.8198524265703, 1018.6027449294781, 13303.0, 14189.503367382093, 14244.359003844851, 14820.258987050604, 16170.595735106717, 332842.0, 335720.0, 335897.0, 336004.0, 336307.0, 47290.5270947293, 47429.76285118621, 47552.0, 47583.0, 47944.760276198394, 1121.4897221764077, 1165.4988355007258, 1166.020542744099, 1199.7540504196618, 1202.110438275687, 26329.736702633494, 27295.727042730112, 27821.72178278191, 28138.0, 28230.0, 40551.391729124676, 44362.334564980905, 45533.54466455293, 45861.77069114633, 50444.74777626235, 324146.0, 327806.0, 327870.0, 328321.0, 329578.0, 35022.82488587541, 35029.0, 35481.64518354887, 35497.645023549434, 35993.0, 40057.79971100126, 40552.59447405488, 40739.38890916698, 40933.1813363737, 40950.385744213265, 34413.65586344105, 34813.0, 34836.651633484355, 34901.301973960886, 35000.64999349974, 33603.83198083994, 33890.49164262489, 34405.82797085999, 34628.480572790926, 34679.0, 30670.539941901337, 31727.365452690356, 33936.0, 34118.14704632404, 34247.0, 27152.321191970357, 30781.846090769403, 31864.840675796473, 31975.200619984687, 31979.200519987186, 24762.628560571968, 24981.87509062443, 25007.87496062581, 25142.371440713396, 25271.36821579475], "value": 16601.472626979088, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.50365710576904, 338.362187276983, 341.97435192360564, 359.14344288871035, 371.57454714352053, 15309.234538273084, 16002.91998540007, 16249.431269905555, 16782.83217167828, 16797.160141992914, 15565.455209067684, 15754.921225393886, 16181.91909040456, 16193.757093643604, 16203.35186592535, 4775.044991001796, 4808.797800549863, 4951.950480495203, 4998.750062496879, 5005.0, 4918.975405122969, 5005.174146265862, 5008.549230569248, 5015.473375295596, 5018.146915024455, 4887.3890763654545, 4965.503449655042, 5014.24786282057, 5207.401148867872, 5225.712585807798, 5204.089284375238, 5236.24074509194, 5247.291615631898, 5271.604629652791, 5286.735663216843, 4990.525900039491, 5132.897342053176, 5170.397176875181, 5217.895642087137, 5219.973900130513, 15613.843861561352, 15855.60360990973, 16158.353665853469, 18805.905970470198, 19078.618427631507, 1793.4888556761261, 1865.2911893480525, 1865.4123950955407, 1962.1464662871554, 1962.3622322745166, 8614.566158413578, 8931.821363572757, 8988.325875559294, 9206.907930920672, 9388.577514011886, 1576.4167258114571, 1655.5778276539527, 1676.5724740191174, 1678.5209092901391, 1770.194561474526, 58980.0, 65487.3451265486, 65849.99999999952, 65907.67046164787, 66293.0, 7916.485428447248, 8497.0, 8589.141085891486, 8606.225439710455, 8742.91257087421, 11200.719982000352, 11267.774644507064, 11296.943515282372, 11302.660920172408, 11373.090152787758, 5692.9146062809095, 5901.881962360814, 5988.9101663475085, 6006.0, 6055.666938318434, 5671.1493276008105, 5719.428057194247, 5841.094630332305, 5862.970685146547, 5867.70661466925, 3538.486919396673, 3588.2105936693883, 3602.2615363850346, 3653.926921461556, 3705.5923848376656, 1766.3199668127863, 1785.4286628278826, 1799.9460016199534, 1830.6796310645584, 1843.4746097362456, 797.8484088023257, 829.2578142562494, 834.4200780457523, 863.5164307987548, 877.3419935048713, 16186.271617776993, 16754.581135471468, 17214.483565493054, 17354.739678904825, 17379.304827806747, 814.7922279818608, 834.3241974001079, 860.7159637319669, 862.7627402464248, 868.847951608466, 7569.561783261162, 9172.220361269234, 9619.807603847883, 9915.355501892354, 9970.850437243447, 364377.0, 374724.0, 375971.0, 388260.0, 389310.0, 75424.62287688526, 75684.62157689287, 76466.6176669113, 76709.41132358456, 77656.61171694218, 861.8491763941286, 911.6717981526778, 926.7219834049758, 936.091990768953, 940.7836197674436, 15268.160251186291, 15336.923315383352, 15503.5348939532, 15565.14391708467, 16205.351785928431, 34936.12659683528, 35639.0, 35801.82099089592, 36227.45658815173, 37213.81393093017, 47719.522804772896, 50875.74562127166, 52023.2196517045, 52167.0, 52508.737456312476, 7087.114110736158, 7282.12614486265, 7343.816404589715, 7476.102867655916, 7598.062494063978, 10691.5188816505, 10995.560177592806, 11280.49237784318, 11523.193376463567, 11635.592754253561, 9859.950700246452, 9956.601735930482, 10014.949925250326, 10082.445465499468, 10529.631462898762, 9819.263555233243, 10069.345492542961, 10160.085592296433, 10197.54111064989, 10455.738606534898, 10014.499275036073, 10071.0, 10107.3430227035, 10622.20333474977, 10730.0, 7041.43668506508, 7145.4998150128995, 7277.490575659653, 7485.214052524407, 7548.622568871425, 8208.917910820815, 9988.900110999088, 10000.2999790014, 10096.48552717069, 10414.895851041696], "value": 7759.6526555851415, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.268902103843, 1345.17944054127, 1413.5971248194267, 1618.1181256215361, 1633.2568681250025, 6038.637681739098, 6237.968810155954, 6541.280459149496, 6981.266966968471, 7003.964980175098, 6350.206224221973, 6537.80386588402, 6593.67031648418, 6747.39273465388, 6755.5271131020845, 1932.3043704266488, 1995.5011247188204, 2003.629328574211, 2008.5581172142106, 2009.0457032909396, 2025.9189632414686, 2049.180327868857, 2051.302557130575, 2089.5298557824444, 2092.7697953225133, 1981.8414526837819, 2003.2287569285857, 2024.6355655981918, 2025.9797402026013, 2026.2604149485478, 1935.4967708395848, 1963.1950900130878, 1975.861689681723, 1977.0806574942576, 1982.7422435083347, 1970.8916009619466, 1983.2166294313665, 1986.5629561496448, 1994.4016794961453, 1997.6803711406105, 6744.561603495807, 6803.761868334634, 6862.279460656659, 6905.585664860074, 6938.826529336807, 3937.3503371943593, 4084.387341898739, 4086.5504794472586, 4090.1819636072605, 4093.4678491796176, 2551.400420901087, 2659.361753179223, 2672.3586339278627, 2719.6600424946882, 2732.8223665461683, 818.7502811642447, 843.1821133500495, 852.5012867472536, 863.896332440105, 877.9122087791234, 8361.331093512505, 8778.780530486725, 8784.38509304349, 8796.164364385373, 8843.20411162992, 3561.44797556374, 3666.358387282215, 3675.044488433027, 3678.834452449646, 3696.7597106188014, 7207.5675459472595, 7223.205447400782, 7225.494215404976, 7240.9637951810955, 7258.129024517092, 4049.5747946465785, 4050.10897602527, 4050.311447054008, 4062.1266427718183, 4063.9796801015805, 3202.487601983718, 3559.8042107684328, 3701.0747313171705, 3776.8489260429274, 3797.1076796952693, 2972.6135602371555, 3004.248937765559, 3047.8476076196544, 3081.645610754747, 3089.9845500772803, 872.8516152254132, 878.8066625342415, 882.0341725810227, 884.1600479544459, 895.3777124898263, 769.4383100336673, 799.7360870912585, 801.8636831738619, 814.5723495165086, 840.0675250471971, 4474.395956545824, 4620.976895115503, 4642.0, 4668.5798278155125, 4857.684250523705, 374.0872271657148, 374.2141502844006, 375.7388614912664, 377.82997651056587, 389.6493156159479, 3193.584833971569, 3224.5808044954006, 3278.0493656839726, 3313.784604000732, 3346.5816772903386, 7446.73936412223, 7633.961830190813, 7763.573003484749, 7768.53388796674, 7790.8575141836445, 7742.341900938483, 7754.302112809874, 7755.495892766952, 7756.263155000266, 7762.7671169865, 6292.653904035231, 6449.967750161313, 6454.160959075384, 6455.289918109004, 6477.481801455872, 4451.3545535896465, 4514.503404625554, 4539.636829053734, 4577.6795624307315, 4577.793999270108, 7339.1926888043345, 7348.448866335153, 7511.887321690069, 7519.473636845369, 7566.205548417337, 7528.397728181622, 7540.698372065275, 7601.201873803392, 7602.1257555379625, 7609.162992070978, 5534.0, 5552.555795536428, 5557.833265002057, 5575.163725441216, 5615.0, 6261.96869015652, 6346.397092276226, 6360.650164241011, 6362.204724409449, 6364.490840732823, 5396.676199428047, 5428.321459817523, 5462.262594549685, 5500.559955203494, 5576.1356989666665, 5690.914636280542, 5859.619124756877, 5876.823695289148, 5908.143319218775, 5930.347661757117, 5598.888022239451, 5612.635178713534, 5721.427857214246, 5781.82654520365, 5787.0, 3956.327424337927, 3991.7405368650943, 4011.4383986241364, 4024.416459613281, 4051.1290072634524, 3902.902427439337, 4114.876553703393, 4129.752214867118, 4269.594388533084, 4299.527052024212], "value": 3538.276774990944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.9148255523343, 289.45726762320646, 291.1324253723904, 293.9323955490236, 296.70922495953977, 4871.244957031657, 4890.972895691904, 4897.510248975105, 4925.556699897009, 4952.356193694824, 4621.214393553096, 4869.537393947569, 4887.193613053851, 4923.6307276954285, 4936.617747030838, 3708.425194094913, 3737.9252414951684, 3772.547294324685, 3811.6760075393627, 3821.14024344523, 3804.4293355996547, 3805.7145714071416, 3809.561900381464, 3812.5234345706785, 3814.8146297841336, 3799.25914446683, 3801.6388443098, 3829.9234015319676, 3834.8082595870233, 3838.2899163654674, 3748.0, 3751.5498140223076, 3783.375743002401, 3827.827747751358, 3843.13529455873, 3306.354916067137, 3311.8840840570706, 3312.2216279174377, 3313.6355000949875, 3315.7347412206964, 4783.952160478386, 4808.543188397097, 4833.903321933577, 4854.83008094715, 4857.319975203474, 4219.493660760698, 4319.179355922364, 4354.847580334705, 4359.476862776455, 4369.0, 5032.169692000815, 5038.773255203488, 5065.1895696688725, 5067.61992850534, 5068.746562671851, 3580.3197392495604, 3618.620044895301, 3646.3436581415335, 3659.8170091495317, 3665.633436656313, 5435.619506634498, 5435.755391007375, 5436.891262174774, 5439.129739241742, 5446.618736688433, 3594.6405359463843, 3691.9446208306895, 3715.9442608360896, 3717.442383642421, 3722.3671975764187, 3752.249550089993, 3777.0557360659836, 3784.243151369737, 3800.2209547043344, 3818.770873747584, 4349.956500434955, 4353.281708518122, 4357.520672725997, 4360.607545320936, 4363.2364336241035, 4812.8796780080775, 5083.906960003617, 5179.378474582999, 5180.119379705459, 5205.609579281569, 1235.9073069519823, 1240.9069319801051, 1246.6945598328468, 1246.9812952805714, 1250.781113305168, 807.3057170833079, 830.3647709502236, 834.7287131682106, 850.5322072859902, 851.344464762142, 4277.443932288783, 4342.717723347972, 4355.194289056535, 4356.780101571565, 4370.2352088384405, 5098.643094983389, 5110.744462776846, 5112.616553758483, 5116.283720279164, 5126.846194614093, 4307.956920430755, 4346.457007762262, 4347.043650396908, 4364.869053928387, 4376.402613046279, 2565.987170064175, 2654.469106178772, 2695.2183866678834, 2711.6306265336275, 2712.9788307710883, 4718.31584420264, 4719.9292010619865, 4740.762961851894, 4748.548887855648, 4750.477447480775, 5012.899742005139, 5171.405288391883, 5174.301469301671, 5184.429712731597, 5221.582273418117, 4639.816846704069, 4670.276107203389, 4678.789454474557, 4682.735661371411, 4695.178343789823, 5042.672226305279, 5046.873828154326, 5087.616734871269, 5124.333836601218, 5149.253358263106, 4699.389079419653, 5029.119904016856, 5034.148876109706, 5041.823536176216, 5066.441447069206, 4652.953470465252, 4661.394018777537, 4693.272542755878, 4693.929591056205, 4740.241561350167, 3498.7026102781547, 3511.086457880512, 3514.0, 3530.2586456843324, 3536.876209332661, 5116.4139116873885, 5124.256982737556, 5136.486351364833, 5163.974180129226, 5170.37955445349, 4705.0, 4896.2410826321975, 4922.286268491121, 4938.456769755252, 4943.802247910044, 4849.466558678613, 4861.416630004281, 4869.95130048695, 4884.462709102067, 4919.163742163769, 4855.9074208302845, 4861.27080937848, 4867.58625516835, 4894.486078961658, 4900.436449808318, 4764.475907650225, 4947.777350019186, 4997.300377947017, 5001.824936127218, 5010.448850626355, 4845.8061677532505, 4856.878578035577, 4896.510348965217, 4911.631627628014, 4926.5073492650445], "value": 3771.5411305552484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.6606499457795, 676.0501495398967, 683.2654895986816, 698.94757893158, 720.0998751560551, 12063.2762034278, 12783.29691866947, 12809.10336276461, 12822.48710051598, 12903.741925161492, 11827.822582661245, 11920.403979800996, 11935.04519638429, 11987.520499180022, 12009.219400738968, 734.7832389445126, 738.830069084111, 751.3313151295324, 769.8075481129717, 778.5717855179657, 771.3173841150594, 771.6064806948468, 772.7334069745929, 772.7565816767728, 772.8531579, 808.5876203136413, 809.3565615335792, 809.9716509922154, 810.667626273228, 811.3995643224001, 804.7022601637432, 805.6656487557657, 805.9879101813448, 806.5201205282876, 807.1363640904235, 588.7792077970761, 589.1045610671798, 590.7075997381323, 593.6141508019822, 593.6319481921194, 12834.743305133938, 12916.22502649844, 12964.740705185843, 12969.221846689228, 12977.156484828456, 11628.953394194563, 11908.16642835002, 12038.69903252417, 12146.817797733042, 12289.75420491594, 9283.489408082552, 9467.763305917339, 9621.470819104947, 9703.854442183372, 9797.62833203352, 3179.4118088153764, 3208.246062175387, 3216.4371235033777, 3228.499582564706, 3231.046841181857, 49018.0, 49056.0, 49502.2574661384, 50165.749171254276, 51383.74308128473, 8756.605952732143, 8842.557872106368, 9040.909590904006, 9047.0, 9134.588943497558, 16607.3357065716, 16728.996260224427, 16772.664546709, 16861.0, 16883.24025418859, 6383.39357761012, 6397.200349956255, 6457.483401327882, 6462.418382345518, 6507.251666058369, 3490.7905525668543, 3510.78935263885, 3522.647735226457, 3607.206414588786, 3651.087228192952, 2719.4697034078163, 2783.4293969736154, 2795.0636536760007, 2808.5506318989273, 2825.6891741908375, 469.3452633576142, 471.83957454465644, 474.7222874618318, 477.9928301075487, 480.5458841394848, 540.694507603203, 543.7063985447813, 561.3123923194137, 567.1889198446262, 574.130192757972, 6964.094667693167, 7052.753153639701, 7086.964565177141, 7123.82190445243, 7250.456215783837, 536.5948708724887, 544.7957016118955, 552.3013388064102, 553.4880235781966, 581.128307538692, 3199.472087105648, 3403.387390269775, 3406.5571475707998, 3516.929661406809, 3529.1530032791943, 55166.0, 57160.71419642875, 57889.421105789246, 61161.69419152876, 67923.66038169777, 53651.46348536465, 55380.44619553753, 56830.715846420506, 57068.714656426455, 57287.427125729046, 48522.514774852505, 48671.5132848667, 50346.496535034916, 50420.0, 52130.0, 6776.254611992578, 7243.0, 7407.851842963219, 7412.110546734426, 7420.406367490696, 38619.613803862725, 39930.80034599808, 40087.79956100201, 40526.59473405228, 41283.1743365137, 48640.51359486501, 48803.75598121987, 51942.0, 52077.7396113017, 53167.21495065463, 10790.73023174427, 10893.400862952614, 10984.286021408583, 11110.555577776799, 11245.437728113726, 11452.656420307405, 11484.655460336204, 11615.88384116148, 11737.237079589799, 11889.762204756029, 9929.156021738234, 10297.53661085238, 10670.57317707283, 11002.394868282321, 11127.0, 10718.303310284806, 11143.777124457627, 11297.548098075986, 11521.251118677259, 11575.247608905394, 9976.750581235527, 10401.115905148146, 10712.089472394933, 10801.567937282422, 10893.782124357627, 8630.654773808978, 8787.956060219658, 8959.328050396376, 9138.68014619485, 9485.0, 8603.82792344162, 9043.909560904307, 9054.456732596065, 9064.546772661472, 9341.159295663423], "value": 5914.911276329445, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 117.0, 116.0, 116.0, 116.0, 118.0, 116.0, 115.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 134.0, 132.0, 190.0, 135.0, 131.0, 133.0, 132.0, 163.0, 131.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 164.0, 163.0, 164.0, 165.0, 165.0, 165.0, 167.0, 166.0, 163.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 117.0, 81.0, 78.0, 77.0, 76.0, 103.0, 76.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 110.0, 85.0, 84.0, 84.0, 115.0, 85.0, 83.0, 112.0], "value": 92.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 121.0, 118.0, 117.0, 117.0, 118.0, 120.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 150.0, 148.0, 147.0, 148.0, 148.0, 150.0, 151.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 64.0, 65.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 66.0, 67.0, 68.0, 67.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 91.0, 93.0, 92.0, 88.0, 89.0, 86.0, 87.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 155.0, 147.0, 160.0, 147.0, 148.0, 156.0, 235.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 190.0, 182.0, 183.0, 182.0, 181.0, 178.0, 180.0, 179.0, 185.0], "value": 182.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 73.0, 73.0, 72.0, 69.0, 73.0, 70.0, 70.0, 71.0], "value": 71.8, "unit": "score"}]}]} 19:51:12 INFO - Return code: 0 19:51:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:51:12 ERROR - # TBPL SUCCESS # 19:51:12 INFO - Running post-action listener: _resource_record_post_action 19:51:12 INFO - [mozharness: 2016-11-22 03:51:12.136051Z] Finished run-tests step (success) 19:51:12 INFO - Running post-run listener: _resource_record_post_run 19:51:12 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 388055040; Read time: 8; Write time: 228980 19:51:12 INFO - TinderboxPrint: CPU usage
13.5% 19:51:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:51:12 INFO - TinderboxPrint: I/O write bytes / time
388,055,040 / 228,980 19:51:12 INFO - TinderboxPrint: CPU idle
8,305.1 (86.5%) 19:51:12 INFO - TinderboxPrint: CPU user
1,232.9 (12.8%) 19:51:12 INFO - TinderboxPrint: Swap in / out
0 / 0 19:51:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99442688; Read time: 0; Write time: 78516 19:51:12 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 288612352; Read time: 0; Write time: 150464 19:51:12 INFO - Running post-run listener: _upload_blobber_files 19:51:12 INFO - Blob upload gear active. 19:51:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:51:12 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:12 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:12 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:13 INFO - (blobuploader) - INFO - Open directory for files ... 19:51:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:51:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:51:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:51:16 INFO - (blobuploader) - INFO - Done attempting. 19:51:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:51:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:51:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:51:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: 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-e10s_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-e10s_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 - Iteration through files over. 19:51:18 INFO - Return code: 0 19:51:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:51:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:51:18 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8df92b1f5a94fc953d55538e894e43d18a4c9ac5725279de1fdbce6e98e9b4752a0761ffeaa55cf16111144a6175fcc2f2f45590b1a5929b7bbf95727553e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10feefbf793225beafe80863dbd6c5b64bf8e36dd82c34ec2af831ae5af6f1ea75f393eee87bc7bfd5d9825c1f5e430b471df7d973c155389f3cead5e1bf50d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/67b6df3e700c744e9f0b69ad3e92aba96cc9de367fd5c9f9398e3fcd75ce540e307b1307aeac1d4926aff1daa39296c06e97cecb308c512cac94ea23ebeb29f1"} 19:51:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:51:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:51:18 INFO - Contents: 19:51:18 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8df92b1f5a94fc953d55538e894e43d18a4c9ac5725279de1fdbce6e98e9b4752a0761ffeaa55cf16111144a6175fcc2f2f45590b1a5929b7bbf95727553e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10feefbf793225beafe80863dbd6c5b64bf8e36dd82c34ec2af831ae5af6f1ea75f393eee87bc7bfd5d9825c1f5e430b471df7d973c155389f3cead5e1bf50d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/67b6df3e700c744e9f0b69ad3e92aba96cc9de367fd5c9f9398e3fcd75ce540e307b1307aeac1d4926aff1daa39296c06e97cecb308c512cac94ea23ebeb29f1"} 19:51:18 INFO - Running post-run listener: copy_logs_to_upload_dir 19:51:18 INFO - Copying logs to upload dir... 19:51:18 INFO - mkdir: /builds/slave/test/build/upload/logs 19:51:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.517270 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-11-21 19:51:18.154600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:18.157685) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8df92b1f5a94fc953d55538e894e43d18a4c9ac5725279de1fdbce6e98e9b4752a0761ffeaa55cf16111144a6175fcc2f2f45590b1a5929b7bbf95727553e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10feefbf793225beafe80863dbd6c5b64bf8e36dd82c34ec2af831ae5af6f1ea75f393eee87bc7bfd5d9825c1f5e430b471df7d973c155389f3cead5e1bf50d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/67b6df3e700c744e9f0b69ad3e92aba96cc9de367fd5c9f9398e3fcd75ce540e307b1307aeac1d4926aff1daa39296c06e97cecb308c512cac94ea23ebeb29f1"} 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.011417 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8df92b1f5a94fc953d55538e894e43d18a4c9ac5725279de1fdbce6e98e9b4752a0761ffeaa55cf16111144a6175fcc2f2f45590b1a5929b7bbf95727553e02e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/10feefbf793225beafe80863dbd6c5b64bf8e36dd82c34ec2af831ae5af6f1ea75f393eee87bc7bfd5d9825c1f5e430b471df7d973c155389f3cead5e1bf50d3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/67b6df3e700c744e9f0b69ad3e92aba96cc9de367fd5c9f9398e3fcd75ce540e307b1307aeac1d4926aff1daa39296c06e97cecb308c512cac94ea23ebeb29f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:18.182725) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:18.183034) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1479784617.40404-681197219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 19:51:18.267093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 19:51:18.267431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 19:51:18.267730) ========= ========= Total master_lag: 0.19 =========