builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-064 starttime: 1479833944.08 results: success (0) buildid: 20161122080051 builduid: 26307b912cfa4309950486d45f79a099 revision: 5c755c22be9668a5e8d60e520c68601635243142 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.084941) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.085447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.085723) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.130896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.131350) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-22 08:59:04-- 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% 212K=0.06s 2016-11-22 08:59:04 (212 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175688 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.324772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.325057) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016103 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.373714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 08:59:04.374037) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 5c755c22be9668a5e8d60e520c68601635243142 --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 5c755c22be9668a5e8d60e520c68601635243142 --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=a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-22 08:59:04,685 truncating revision to first 12 chars 2016-11-22 08:59:04,685 Setting DEBUG logging. 2016-11-22 08:59:04,685 attempt 1/10 2016-11-22 08:59:04,685 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/5c755c22be96?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-22 08:59:05,621 unpacking tar archive at: graphics-5c755c22be96/testing/mozharness/ program finished with exit code 0 elapsedTime=1.303887 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-22 08:59:05.691375) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.691678) ========= script_repo_revision: 5c755c22be9668a5e8d60e520c68601635243142 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.692087) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.692367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.702664) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-22 08:59:05.703044) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:06 INFO - MultiFileLogger online at 20161122 08:59:06 in /builds/slave/test 08:59:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 08:59:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:06 INFO - {'append_to_log': False, 08:59:06 INFO - 'base_work_dir': '/builds/slave/test', 08:59:06 INFO - 'blob_upload_branch': 'Graphics', 08:59:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:06 INFO - 'branch': 'Graphics', 08:59:06 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:06 INFO - 'config_files': ('talos/linux_config.py',), 08:59:06 INFO - 'default_actions': ('clobber', 08:59:06 INFO - 'read-buildbot-config', 08:59:06 INFO - 'download-and-extract', 08:59:06 INFO - 'populate-webroot', 08:59:06 INFO - 'create-virtualenv', 08:59:06 INFO - 'install', 08:59:06 INFO - 'run-tests'), 08:59:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:06 INFO - 'download_minidump_stackwalk': True, 08:59:06 INFO - 'download_symbols': 'ondemand', 08:59:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:06 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:06 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:06 INFO - 'installer_path': 'installer.exe', 08:59:06 INFO - 'log_level': 'info', 08:59:06 INFO - 'log_name': 'talos', 08:59:06 INFO - 'log_to_console': True, 08:59:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:06 INFO - 'opt_config_files': (), 08:59:06 INFO - 'pip_index': False, 08:59:06 INFO - 'sps_profile': False, 08:59:06 INFO - 'sps_profile_interval': 0, 08:59:06 INFO - 'suite': 'dromaeojs', 08:59:06 INFO - 'system_bits': '32', 08:59:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:06 INFO - 'title': 'talos-linux64-ix-064', 08:59:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:06 INFO - 'use_talos_json': True, 08:59:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:06 INFO - 'work_dir': 'build'} 08:59:06 INFO - [mozharness: 2016-11-22 16:59:06.116700Z] Running clobber step. 08:59:06 INFO - Running pre-action listener: _resource_record_pre_action 08:59:06 INFO - Running main action method: clobber 08:59:06 INFO - rmtree: /builds/slave/test/build 08:59:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:07 INFO - Running post-action listener: _resource_record_post_action 08:59:07 INFO - [mozharness: 2016-11-22 16:59:07.092448Z] Finished clobber step (success) 08:59:07 INFO - [mozharness: 2016-11-22 16:59:07.092546Z] Running read-buildbot-config step. 08:59:07 INFO - Running pre-action listener: _resource_record_pre_action 08:59:07 INFO - Running main action method: read_buildbot_config 08:59:07 INFO - Using buildbot properties: 08:59:07 INFO - { 08:59:07 INFO - "project": "", 08:59:07 INFO - "product": "firefox", 08:59:07 INFO - "script_repo_revision": "default", 08:59:07 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 08:59:07 INFO - "repository": "", 08:59:07 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 08:59:07 INFO - "buildid": "20161122080051", 08:59:07 INFO - "pgo_build": "False", 08:59:07 INFO - "basedir": "/builds/slave/test", 08:59:07 INFO - "buildnumber": 8, 08:59:07 INFO - "slavename": "talos-linux64-ix-064", 08:59:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:59:07 INFO - "platform": "ubuntu64_hw", 08:59:07 INFO - "scheduler": "tests-graphics-linux64-talos", 08:59:07 INFO - "branch": "graphics", 08:59:07 INFO - "repo_path": "projects/graphics", 08:59:07 INFO - "revision": "5c755c22be9668a5e8d60e520c68601635243142", 08:59:07 INFO - "stage_platform": "linux64", 08:59:07 INFO - "builduid": "26307b912cfa4309950486d45f79a099", 08:59:07 INFO - "slavebuilddir": "test" 08:59:07 INFO - } 08:59:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:59:07 INFO - Running post-action listener: _resource_record_post_action 08:59:07 INFO - [mozharness: 2016-11-22 16:59:07.095032Z] Finished read-buildbot-config step (success) 08:59:07 INFO - [mozharness: 2016-11-22 16:59:07.095133Z] Running download-and-extract step. 08:59:07 INFO - Running pre-action listener: _resource_record_pre_action 08:59:07 INFO - Running main action method: download_and_extract 08:59:07 INFO - mkdir: /builds/slave/test/build/tests 08:59: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')]} 08:59:07 INFO - trying https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:59:07 INFO - Downloading https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/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 08:59:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/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 08:59:07 INFO - Downloaded 1361 bytes. 08:59:07 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:59:07 INFO - Using the following test package requirements: 08:59:07 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:07 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:59:07 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:59:07 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'jsshell-linux-x86_64.zip'], 08:59:07 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:59:07 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:07 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:59:07 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:59:07 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:59:07 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:07 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:59:07 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:59:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:59:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:59:07 INFO - Fetch https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:59:08 INFO - Http code: 200 08:59:08 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:59:08 INFO - x-amz-cf-id: Nn9X64YkAuWPczF-7iTPvEkNlL5j9J2ndEl3MXjsM1HqdyeaqJPKqw== 08:59:08 INFO - x-amz-version-id: ApqCidDeF.bt_wCaOGwqOnFVh0kJ9spP 08:59:08 INFO - Expected file size: 20183379 08:59:08 INFO - Obtained file size: 20183379 08:59:12 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 08:59:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:59:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:59:12 INFO - Fetch https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:59:13 INFO - Http code: 200 08:59:13 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 08:59:13 INFO - x-amz-cf-id: ZhyiygITovyrGbf520-sOy0oQIkMVXM2CJTpfpqZUsb5s8lRx9vJDQ== 08:59:13 INFO - x-amz-version-id: ApqCidDeF.bt_wCaOGwqOnFVh0kJ9spP 08:59:13 INFO - Expected file size: 20183379 08:59:13 INFO - Obtained file size: 20183379 08:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:59:18 INFO - Http code: 200 08:59:18 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 08:59:18 INFO - x-amz-cf-id: 1pRX4uK1QRYPSMmn7Bcrv0fxPdmYfXO87UI-hjOQXgveKDZXr7HahQ== 08:59:18 INFO - x-amz-version-id: _1bup5WAhDJRDC70BB7.DXxUukzLHCR4 08:59:19 INFO - Expected file size: 14409392 08:59:19 INFO - Obtained file size: 14409392 08:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:19 INFO - trying https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:59:19 INFO - Downloading https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/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 08:59:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/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 08:59:22 INFO - Downloaded 55600245 bytes. 08:59:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:59:22 INFO - mkdir: /builds/slave/test/properties 08:59:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:22 INFO - Contents: 08:59:22 INFO - build_url:https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:59:22 INFO - Running post-action listener: _resource_record_post_action 08:59:22 INFO - Running post-action listener: set_extra_try_arguments 08:59:22 INFO - [mozharness: 2016-11-22 16:59:22.704880Z] Finished download-and-extract step (success) 08:59:22 INFO - [mozharness: 2016-11-22 16:59:22.705106Z] Running populate-webroot step. 08:59:22 INFO - Running pre-action listener: _resource_record_pre_action 08:59:22 INFO - Running main action method: populate_webroot 08:59:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:22 INFO - '--tppagecycles', 08:59:22 INFO - '7'], 08:59:22 INFO - 'tests': ['tsvgm']}}, 08:59:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['damp', 'tps']}, 08:59:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:59:22 INFO - 'tests': ['damp', 'tps']}, 08:59:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['dromaeo_dom']}, 08:59:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['basic_compositor_video']}, 08:59:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['a11yr', 08:59:22 INFO - 'ts_paint', 08:59:22 INFO - 'tpaint', 08:59:22 INFO - 'sessionrestore', 08:59:22 INFO - 'sessionrestore_no_auto_restore', 08:59:22 INFO - 'tabpaint']}, 08:59:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tsvgx', 08:59:22 INFO - 'tsvgr_opacity', 08:59:22 INFO - 'tart', 08:59:22 INFO - 'tscrollx', 08:59:22 INFO - 'cart']}, 08:59:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:22 INFO - 'tsvgr_opacity', 08:59:22 INFO - 'tart', 08:59:22 INFO - 'tscrollx', 08:59:22 INFO - 'cart']}, 08:59:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s'], 08:59:22 INFO - 'tests': ['tp5o']}, 08:59:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:59:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:59:22 INFO - 'talos_options': ['--disable-e10s', 08:59:22 INFO - '--xperf_path', 08:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:22 INFO - 'tests': ['tp5n']}, 08:59:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:59:22 INFO - 'talos_options': ['--xperf_path', 08:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:22 INFO - 'tests': ['tp5n']}}, 08:59:22 INFO - 'talos.zip': {'path': '', 08:59:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:22 INFO - Running post-action listener: _resource_record_post_action 08:59:22 INFO - [mozharness: 2016-11-22 16:59:22.719968Z] Finished populate-webroot step (success) 08:59:22 INFO - [mozharness: 2016-11-22 16:59:22.720056Z] Running create-virtualenv step. 08:59:22 INFO - Running pre-action listener: _resource_record_pre_action 08:59:22 INFO - Running main action method: create_virtualenv 08:59:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:22 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 08:59:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:22 INFO - Using real prefix '/usr' 08:59:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:25 INFO - Installing pip.................done. 08:59:25 INFO - Return code: 0 08:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:25 INFO - Reading from file tmpfile_stdout 08:59:25 INFO - Output received: 08:59:25 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) 08:59:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:59:25 INFO - Using env: {'DISPLAY': ':0', 08:59:25 INFO - 'HOME': '/home/cltbld', 08:59:25 INFO - 'LANG': 'en_US.UTF-8', 08:59:25 INFO - 'LANGUAGE': 'en_US:en', 08:59:25 INFO - 'LOGNAME': 'cltbld', 08:59:25 INFO - 'MAIL': '/var/mail/cltbld', 08:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:25 INFO - 'MOZ_NO_REMOTE': '1', 08:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:25 INFO - 'NO_EM_RESTART': '1', 08:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:25 INFO - 'PWD': '/builds/slave/test', 08:59:25 INFO - 'SHELL': '/bin/bash', 08:59:25 INFO - 'SHLVL': '1', 08:59:25 INFO - 'TERM': 'linux', 08:59:25 INFO - 'TMOUT': '86400', 08:59:25 INFO - 'USER': 'cltbld', 08:59:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:25 INFO - '_': '/tools/buildbot/bin/python'} 08:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:25 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 08:59:25 INFO - Cleaning up... 08:59:25 INFO - Return code: 0 08:59:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:59:25 INFO - Using env: {'DISPLAY': ':0', 08:59:25 INFO - 'HOME': '/home/cltbld', 08:59:25 INFO - 'LANG': 'en_US.UTF-8', 08:59:25 INFO - 'LANGUAGE': 'en_US:en', 08:59:25 INFO - 'LOGNAME': 'cltbld', 08:59:25 INFO - 'MAIL': '/var/mail/cltbld', 08:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:25 INFO - 'MOZ_NO_REMOTE': '1', 08:59:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:25 INFO - 'NO_EM_RESTART': '1', 08:59:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:25 INFO - 'PWD': '/builds/slave/test', 08:59:25 INFO - 'SHELL': '/bin/bash', 08:59:25 INFO - 'SHLVL': '1', 08:59:25 INFO - 'TERM': 'linux', 08:59:25 INFO - 'TMOUT': '86400', 08:59:25 INFO - 'USER': 'cltbld', 08:59:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:25 INFO - '_': '/tools/buildbot/bin/python'} 08:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:25 INFO - Downloading/unpacking psutil>=3.1.1 08:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:28 INFO - Installing collected packages: psutil 08:59:28 INFO - Running setup.py install for psutil 08:59:28 INFO - building 'psutil._psutil_linux' extension 08:59:28 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 08:59:28 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 08:59:28 INFO - building 'psutil._psutil_posix' extension 08:59:28 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 08:59:28 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 08:59:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:28 INFO - Successfully installed psutil 08:59:28 INFO - Cleaning up... 08:59:28 INFO - Return code: 0 08:59:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:59:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:59:28 INFO - Using env: {'DISPLAY': ':0', 08:59:28 INFO - 'HOME': '/home/cltbld', 08:59:28 INFO - 'LANG': 'en_US.UTF-8', 08:59:28 INFO - 'LANGUAGE': 'en_US:en', 08:59:28 INFO - 'LOGNAME': 'cltbld', 08:59:28 INFO - 'MAIL': '/var/mail/cltbld', 08:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:28 INFO - 'MOZ_NO_REMOTE': '1', 08:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:28 INFO - 'NO_EM_RESTART': '1', 08:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:28 INFO - 'PWD': '/builds/slave/test', 08:59:28 INFO - 'SHELL': '/bin/bash', 08:59:28 INFO - 'SHLVL': '1', 08:59:28 INFO - 'TERM': 'linux', 08:59:28 INFO - 'TMOUT': '86400', 08:59:28 INFO - 'USER': 'cltbld', 08:59:28 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:28 INFO - '_': '/tools/buildbot/bin/python'} 08:59:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:59:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:59:30 INFO - Installing collected packages: mozsystemmonitor 08:59:30 INFO - Running setup.py install for mozsystemmonitor 08:59:30 INFO - Successfully installed mozsystemmonitor 08:59:30 INFO - Cleaning up... 08:59:30 INFO - Return code: 0 08:59:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:59: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')]} 08:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59: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')]} 08:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:30 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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:30 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 08:59:30 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 08:59:30 INFO - Using env: {'DISPLAY': ':0', 08:59:30 INFO - 'HOME': '/home/cltbld', 08:59:30 INFO - 'LANG': 'en_US.UTF-8', 08:59:30 INFO - 'LANGUAGE': 'en_US:en', 08:59:30 INFO - 'LOGNAME': 'cltbld', 08:59:30 INFO - 'MAIL': '/var/mail/cltbld', 08:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:30 INFO - 'MOZ_NO_REMOTE': '1', 08:59:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:30 INFO - 'NO_EM_RESTART': '1', 08:59:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:30 INFO - 'PWD': '/builds/slave/test', 08:59:30 INFO - 'SHELL': '/bin/bash', 08:59:30 INFO - 'SHLVL': '1', 08:59:30 INFO - 'TERM': 'linux', 08:59:30 INFO - 'TMOUT': '86400', 08:59:30 INFO - 'USER': 'cltbld', 08:59:30 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:30 INFO - '_': '/tools/buildbot/bin/python'} 08:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:31 INFO - Downloading/unpacking jsonschema==2.5.1 08:59:31 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 08:59:31 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 08:59:31 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 08:59:31 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 08:59:31 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 08:59:31 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 08:59:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:59:33 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 08:59:33 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 08:59:33 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 08:59:33 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 08:59:33 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 08:59:33 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 08:59:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:33 INFO - warning: no files found matching '*.txt' 08:59:33 INFO - no previously-included directories found matching 'build' 08:59:33 INFO - no previously-included directories found matching 'dist' 08:59:33 INFO - no previously-included directories found matching '.git*' 08:59:33 INFO - Installing collected packages: jsonschema, functools32 08:59:33 INFO - Running setup.py install for functools32 08:59:33 INFO - warning: no files found matching '*.txt' 08:59:33 INFO - no previously-included directories found matching 'build' 08:59:33 INFO - no previously-included directories found matching 'dist' 08:59:33 INFO - no previously-included directories found matching '.git*' 08:59:33 INFO - Successfully installed jsonschema functools32 08:59:33 INFO - Cleaning up... 08:59:33 INFO - Return code: 0 08:59:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:59:33 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')]} 08:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:33 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')]} 08:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:33 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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:33 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 08:59:33 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 08:59:33 INFO - Using env: {'DISPLAY': ':0', 08:59:33 INFO - 'HOME': '/home/cltbld', 08:59:33 INFO - 'LANG': 'en_US.UTF-8', 08:59:33 INFO - 'LANGUAGE': 'en_US:en', 08:59:33 INFO - 'LOGNAME': 'cltbld', 08:59:33 INFO - 'MAIL': '/var/mail/cltbld', 08:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:33 INFO - 'MOZ_NO_REMOTE': '1', 08:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:33 INFO - 'NO_EM_RESTART': '1', 08:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:33 INFO - 'PWD': '/builds/slave/test', 08:59:33 INFO - 'SHELL': '/bin/bash', 08:59:33 INFO - 'SHLVL': '1', 08:59:33 INFO - 'TERM': 'linux', 08:59:33 INFO - 'TMOUT': '86400', 08:59:33 INFO - 'USER': 'cltbld', 08:59:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:33 INFO - '_': '/tools/buildbot/bin/python'} 08:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:59:33 INFO - Cleaning up... 08:59:33 INFO - Return code: 0 08:59:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:33 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')]} 08:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:33 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')]} 08:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:33 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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:33 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 08:59:33 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 08:59:33 INFO - Using env: {'DISPLAY': ':0', 08:59:33 INFO - 'HOME': '/home/cltbld', 08:59:33 INFO - 'LANG': 'en_US.UTF-8', 08:59:33 INFO - 'LANGUAGE': 'en_US:en', 08:59:33 INFO - 'LOGNAME': 'cltbld', 08:59:33 INFO - 'MAIL': '/var/mail/cltbld', 08:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:33 INFO - 'MOZ_NO_REMOTE': '1', 08:59:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:33 INFO - 'NO_EM_RESTART': '1', 08:59:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:33 INFO - 'PWD': '/builds/slave/test', 08:59:33 INFO - 'SHELL': '/bin/bash', 08:59:33 INFO - 'SHLVL': '1', 08:59:33 INFO - 'TERM': 'linux', 08:59:33 INFO - 'TMOUT': '86400', 08:59:33 INFO - 'USER': 'cltbld', 08:59:33 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:33 INFO - '_': '/tools/buildbot/bin/python'} 08:59:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:33 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:33 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 08:59:34 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 08:59:34 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 08:59:34 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 08:59:34 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 08:59:34 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 08:59:35 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:36 INFO - Downloading docopt-0.6.1.tar.gz 08:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:36 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:36 INFO - Running setup.py install for blobuploader 08:59:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:37 INFO - Running setup.py install for requests 08:59:37 INFO - Running setup.py install for docopt 08:59:37 INFO - Successfully installed blobuploader requests docopt 08:59:37 INFO - Cleaning up... 08:59:37 INFO - Return code: 0 08:59:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:37 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')]} 08:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:37 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')]} 08:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:37 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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:37 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 08:59:37 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 08:59:37 INFO - Using env: {'DISPLAY': ':0', 08:59:37 INFO - 'HOME': '/home/cltbld', 08:59:37 INFO - 'LANG': 'en_US.UTF-8', 08:59:37 INFO - 'LANGUAGE': 'en_US:en', 08:59:37 INFO - 'LOGNAME': 'cltbld', 08:59:37 INFO - 'MAIL': '/var/mail/cltbld', 08:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:37 INFO - 'MOZ_NO_REMOTE': '1', 08:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:37 INFO - 'NO_EM_RESTART': '1', 08:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:37 INFO - 'PWD': '/builds/slave/test', 08:59:37 INFO - 'SHELL': '/bin/bash', 08:59:37 INFO - 'SHLVL': '1', 08:59:37 INFO - 'TERM': 'linux', 08:59:37 INFO - 'TMOUT': '86400', 08:59:37 INFO - 'USER': 'cltbld', 08:59:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:37 INFO - '_': '/tools/buildbot/bin/python'} 08:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:37 INFO - Running setup.py (path:/tmp/pip-PjtlpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:37 INFO - Running setup.py (path:/tmp/pip-56pIHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:37 INFO - Running setup.py (path:/tmp/pip-TFiCIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:38 INFO - Running setup.py (path:/tmp/pip-tpHSJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:38 INFO - Running setup.py (path:/tmp/pip-U_K7zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:38 INFO - Running setup.py (path:/tmp/pip-Xb88df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:38 INFO - Running setup.py (path:/tmp/pip-iY9lJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:38 INFO - Running setup.py (path:/tmp/pip-jlMvRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:38 INFO - Running setup.py (path:/tmp/pip-t428PZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:38 INFO - Running setup.py (path:/tmp/pip-4DL3vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:38 INFO - Running setup.py (path:/tmp/pip-QwbOnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:38 INFO - Running setup.py (path:/tmp/pip-f3lFid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:38 INFO - Running setup.py (path:/tmp/pip-qn8keQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:38 INFO - Running setup.py (path:/tmp/pip-XALt3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:38 INFO - Running setup.py (path:/tmp/pip-j2Gfy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:38 INFO - Running setup.py (path:/tmp/pip-97yDLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:38 INFO - Running setup.py (path:/tmp/pip-4l7Ke4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:39 INFO - Running setup.py install for manifestparser 08:59:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Running setup.py install for mozcrash 08:59:39 INFO - Running setup.py install for mozdebug 08:59:39 INFO - Running setup.py install for mozdevice 08:59:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Running setup.py install for mozfile 08:59:39 INFO - Running setup.py install for mozhttpd 08:59:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Running setup.py install for mozinfo 08:59:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Running setup.py install for mozInstall 08:59:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:39 INFO - Running setup.py install for mozleak 08:59:39 INFO - Running setup.py install for mozlog 08:59:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Running setup.py install for moznetwork 08:59:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Running setup.py install for mozprocess 08:59:40 INFO - Running setup.py install for mozprofile 08:59:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Running setup.py install for mozrunner 08:59:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Running setup.py install for mozscreenshot 08:59:40 INFO - Running setup.py install for moztest 08:59:40 INFO - Running setup.py install for mozversion 08:59:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:40 INFO - Cleaning up... 08:59:40 INFO - Return code: 0 08:59:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:40 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')]} 08:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:40 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')]} 08:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:40 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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:40 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 08:59:40 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 08:59:40 INFO - Using env: {'DISPLAY': ':0', 08:59:40 INFO - 'HOME': '/home/cltbld', 08:59:40 INFO - 'LANG': 'en_US.UTF-8', 08:59:40 INFO - 'LANGUAGE': 'en_US:en', 08:59:40 INFO - 'LOGNAME': 'cltbld', 08:59:40 INFO - 'MAIL': '/var/mail/cltbld', 08:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:40 INFO - 'MOZ_NO_REMOTE': '1', 08:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:40 INFO - 'NO_EM_RESTART': '1', 08:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:40 INFO - 'PWD': '/builds/slave/test', 08:59:40 INFO - 'SHELL': '/bin/bash', 08:59:40 INFO - 'SHLVL': '1', 08:59:40 INFO - 'TERM': 'linux', 08:59:40 INFO - 'TMOUT': '86400', 08:59:40 INFO - 'USER': 'cltbld', 08:59:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:40 INFO - '_': '/tools/buildbot/bin/python'} 08:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:41 INFO - Running setup.py (path:/tmp/pip-Bu0cUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:41 INFO - Running setup.py (path:/tmp/pip-NhpOPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:41 INFO - Running setup.py (path:/tmp/pip-X_cHOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:41 INFO - Running setup.py (path:/tmp/pip-sdS31X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:41 INFO - Running setup.py (path:/tmp/pip-HtUtFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:41 INFO - Running setup.py (path:/tmp/pip-efbQ7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:41 INFO - Running setup.py (path:/tmp/pip-3LDi38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:41 INFO - Running setup.py (path:/tmp/pip-QOqDI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:41 INFO - Running setup.py (path:/tmp/pip-jnLju4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:41 INFO - Running setup.py (path:/tmp/pip-oZuAfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:41 INFO - Running setup.py (path:/tmp/pip-fAO0LE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:41 INFO - Running setup.py (path:/tmp/pip-UTlk0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:41 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)) 08:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:41 INFO - Running setup.py (path:/tmp/pip-qubTSL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:42 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)) 08:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:42 INFO - Running setup.py (path:/tmp/pip-G0aTIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:42 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)) 08:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:42 INFO - Running setup.py (path:/tmp/pip-3lCY0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:42 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)) 08:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:42 INFO - Running setup.py (path:/tmp/pip-vHKvis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:42 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)) 08:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:42 INFO - Running setup.py (path:/tmp/pip-gFOGKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:42 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)) 08:59:42 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)) 08:59:42 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)) 08:59:42 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)) 08:59:42 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)) 08:59:42 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)) 08:59:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:42 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 08:59:42 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 08:59:42 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 08:59:42 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 08:59:42 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 08:59:42 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 08:59:44 INFO - Downloading blessings-1.6.tar.gz 08:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:44 INFO - Installing collected packages: blessings 08:59:44 INFO - Running setup.py install for blessings 08:59:44 INFO - Successfully installed blessings 08:59:44 INFO - Cleaning up... 08:59:44 INFO - Return code: 0 08:59:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:44 INFO - Reading from file tmpfile_stdout 08:59:44 INFO - Current package versions: 08:59:44 INFO - argparse == 1.2.1 08:59:44 INFO - blessings == 1.6 08:59:44 INFO - blobuploader == 1.2.4 08:59:44 INFO - docopt == 0.6.1 08:59:44 INFO - functools32 == 3.2.3-2 08:59:44 INFO - jsonschema == 2.5.1 08:59:44 INFO - manifestparser == 1.1 08:59:44 INFO - mozInstall == 1.12 08:59:44 INFO - mozcrash == 1.0 08:59:44 INFO - mozdebug == 0.1 08:59:44 INFO - mozdevice == 0.49 08:59:44 INFO - mozfile == 1.2 08:59:44 INFO - mozhttpd == 0.7 08:59:44 INFO - mozinfo == 0.9 08:59:44 INFO - mozleak == 0.1 08:59:44 INFO - mozlog == 3.4 08:59:44 INFO - moznetwork == 0.27 08:59:44 INFO - mozprocess == 0.23 08:59:44 INFO - mozprofile == 0.28 08:59:44 INFO - mozrunner == 6.13 08:59:44 INFO - mozscreenshot == 0.1 08:59:44 INFO - mozsystemmonitor == 0.3 08:59:44 INFO - moztest == 0.7 08:59:44 INFO - mozversion == 1.4 08:59:44 INFO - psutil == 3.1.1 08:59:44 INFO - requests == 1.2.3 08:59:44 INFO - wsgiref == 0.1.2 08:59:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:44 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')]} 08:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:44 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')]} 08:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:44 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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:44 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 08:59:44 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 08:59:44 INFO - Using env: {'DISPLAY': ':0', 08:59:44 INFO - 'HOME': '/home/cltbld', 08:59:44 INFO - 'LANG': 'en_US.UTF-8', 08:59:44 INFO - 'LANGUAGE': 'en_US:en', 08:59:44 INFO - 'LOGNAME': 'cltbld', 08:59:44 INFO - 'MAIL': '/var/mail/cltbld', 08:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:44 INFO - 'MOZ_NO_REMOTE': '1', 08:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:44 INFO - 'NO_EM_RESTART': '1', 08:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:44 INFO - 'PWD': '/builds/slave/test', 08:59:44 INFO - 'SHELL': '/bin/bash', 08:59:44 INFO - 'SHLVL': '1', 08:59:44 INFO - 'TERM': 'linux', 08:59:44 INFO - 'TMOUT': '86400', 08:59:44 INFO - 'USER': 'cltbld', 08:59:44 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:44 INFO - '_': '/tools/buildbot/bin/python'} 08:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 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)) 08:59:44 INFO - Cleaning up... 08:59:45 INFO - Return code: 0 08:59:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:45 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')]} 08:59:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:45 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')]} 08:59:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:45 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 0x7f069ec7ae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117f130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', '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 08:59:45 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 08:59:45 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 08:59:45 INFO - Using env: {'DISPLAY': ':0', 08:59:45 INFO - 'HOME': '/home/cltbld', 08:59:45 INFO - 'LANG': 'en_US.UTF-8', 08:59:45 INFO - 'LANGUAGE': 'en_US:en', 08:59:45 INFO - 'LOGNAME': 'cltbld', 08:59:45 INFO - 'MAIL': '/var/mail/cltbld', 08:59:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:45 INFO - 'MOZ_NO_REMOTE': '1', 08:59:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:45 INFO - 'NO_EM_RESTART': '1', 08:59:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:45 INFO - 'PWD': '/builds/slave/test', 08:59:45 INFO - 'SHELL': '/bin/bash', 08:59:45 INFO - 'SHLVL': '1', 08:59:45 INFO - 'TERM': 'linux', 08:59:45 INFO - 'TMOUT': '86400', 08:59:45 INFO - 'USER': 'cltbld', 08:59:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 08:59:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:45 INFO - '_': '/tools/buildbot/bin/python'} 08:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:59:45 INFO - Cleaning up... 08:59:45 INFO - Return code: 0 08:59:45 INFO - Running post-action listener: _resource_record_post_action 08:59:45 INFO - Running post-action listener: _start_resource_monitoring 08:59:45 INFO - Starting resource monitoring. 08:59:45 INFO - [mozharness: 2016-11-22 16:59:45.265301Z] Finished create-virtualenv step (success) 08:59:45 INFO - [mozharness: 2016-11-22 16:59:45.265770Z] Running install step. 08:59:45 INFO - Running pre-action listener: _resource_record_pre_action 08:59:45 INFO - Running main action method: install 08:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:45 INFO - Reading from file tmpfile_stdout 08:59:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:45 INFO - Reading from file tmpfile_stdout 08:59:45 INFO - Output received: 08:59:45 INFO - Usage: mozinstall [options] installer 08:59:45 INFO - Options: 08:59:45 INFO - -h, --help show this help message and exit 08:59:45 INFO - -d DEST, --destination=DEST 08:59:45 INFO - Directory to install application into. [default: 08:59:45 INFO - "/builds/slave/test"] 08:59:45 INFO - --app=APP Application being installed. [default: firefox] 08:59:45 INFO - mkdir: /builds/slave/test/build/application 08:59:45 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'] 08:59:45 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 09:00:01 INFO - Reading from file tmpfile_stdout 09:00:01 INFO - Output received: 09:00:01 INFO - /builds/slave/test/build/application/firefox/firefox 09:00:01 INFO - Running post-action listener: _resource_record_post_action 09:00:01 INFO - [mozharness: 2016-11-22 17:00:01.564473Z] Finished install step (success) 09:00:01 INFO - [mozharness: 2016-11-22 17:00:01.564726Z] Running run-tests step. 09:00:01 INFO - Running pre-action listener: _resource_record_pre_action 09:00:01 INFO - Running main action method: run_tests 09:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:01 INFO - Python 2.7.3 09:00:01 INFO - Return code: 0 09:00:01 INFO - grabbing minidump binary from tooltool 09:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:01 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 0x120dfc0>, '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 0x120eec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x120f350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:01 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 09:00:01 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 09:00:01 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 09:00:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:01 INFO - Return code: 0 09:00:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:00:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:00:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:00:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:00:01 INFO - Using env: {'DISPLAY': ':0', 09:00:01 INFO - 'HOME': '/home/cltbld', 09:00:01 INFO - 'LANG': 'en_US.UTF-8', 09:00:01 INFO - 'LANGUAGE': 'en_US:en', 09:00:01 INFO - 'LOGNAME': 'cltbld', 09:00:01 INFO - 'MAIL': '/var/mail/cltbld', 09:00:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:01 INFO - 'MOZ_NO_REMOTE': '1', 09:00:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:01 INFO - 'NO_EM_RESTART': '1', 09:00:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:01 INFO - 'PWD': '/builds/slave/test', 09:00:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:01 INFO - 'SHELL': '/bin/bash', 09:00:01 INFO - 'SHLVL': '1', 09:00:01 INFO - 'TERM': 'linux', 09:00:01 INFO - 'TMOUT': '86400', 09:00:01 INFO - 'USER': 'cltbld', 09:00:01 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564', 09:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:01 INFO - '_': '/tools/buildbot/bin/python'} 09:00:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:00:01 INFO - mozversion application_buildid: 20161122080051 09:00:01 INFO - mozversion application_changeset: 5c755c22be9668a5e8d60e520c68601635243142 09:00:01 INFO - mozversion application_display_name: Nightly 09:00:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:01 INFO - mozversion application_name: Firefox 09:00:01 INFO - mozversion application_remotingname: firefox 09:00:01 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:00:01 INFO - mozversion application_vendor: Mozilla 09:00:01 INFO - mozversion application_version: 53.0a1 09:00:01 INFO - mozversion platform_buildid: 20161122080051 09:00:01 INFO - mozversion platform_changeset: 5c755c22be9668a5e8d60e520c68601635243142 09:00:01 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:00:01 INFO - mozversion platform_version: 53.0a1 09:00:01 INFO - using testdate: 1479834001 09:00:01 INFO - actual date: 1479834001 09:00:01 INFO - starting webserver on 'localhost:43193' 09:00:01 INFO - SUITE-START | Running 2 tests 09:00:01 INFO - TEST-START | dromaeo_css 09:00:01 INFO - operating with platform_type : linux_ 09:00:01 INFO - Initialising browser for dromaeo_css test... 09:00:01 INFO - TEST-INFO | started process 31945 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJADnFd/profile http://localhost:43193/getInfo.html) 09:00:06 INFO - PROCESS | 31945 | __metrics Screen width/height:1600/1200 09:00:06 INFO - PROCESS | 31945 | colorDepth:24 09:00:06 INFO - PROCESS | 31945 | Browser inner width/height: 1024/697 09:00:06 INFO - PROCESS | 31945 | __metrics 09:00:07 INFO - PROCESS | 31945 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:00:07 INFO - PROCESS | 31945 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:08 INFO - TEST-INFO | 31945: exit 0 09:00:08 INFO - Browser initialized. 09:00:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:08 INFO - TEST-INFO | started process 32029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJADnFd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:20 INFO - PROCESS | 32029 | RSS: Main: 174444544 09:00:20 INFO - PROCESS | 32029 | 09:01:11 INFO - PROCESS | 32029 | 1479834071639 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] 09:03:25 INFO - PROCESS | 32029 | Cycle 1(1): loaded http://localhost:43193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43193/tests/dromaeo/cssquery-ext.html) 09:03:27 INFO - PROCESS | 32029 | RSS: Main: 381128704 09:03:27 INFO - PROCESS | 32029 | 09:06:30 INFO - PROCESS | 32029 | Cycle 1(1): loaded http://localhost:43193/tests/dromaeo/cssquery-ext.html (next: http://localhost:43193/tests/dromaeo/cssquery-jquery.html) 09:06:31 INFO - PROCESS | 32029 | RSS: Main: 279220224 09:06:31 INFO - PROCESS | 32029 | 09:09:33 INFO - PROCESS | 32029 | Cycle 1(1): loaded http://localhost:43193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43193/tests/dromaeo/cssquery-mootools.html) 09:09:34 INFO - PROCESS | 32029 | RSS: Main: 219885568 09:09:34 INFO - PROCESS | 32029 | 09:12:36 INFO - PROCESS | 32029 | Cycle 1(1): loaded http://localhost:43193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43193/tests/dromaeo/cssquery-prototype.html) 09:12:36 INFO - PROCESS | 32029 | RSS: Main: 219828224 09:12:36 INFO - PROCESS | 32029 | 09:15:40 INFO - PROCESS | 32029 | Cycle 1(1): loaded http://localhost:43193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43193/tests/dromaeo/cssquery-yui.html) 09:15:40 INFO - PROCESS | 32029 | RSS: Main: 218701824 09:15:40 INFO - PROCESS | 32029 | 09:18:43 INFO - PROCESS | 32029 | Cycle 1(1): loaded http://localhost:43193/tests/dromaeo/cssquery-yui.html (next: http://localhost:43193/tests/dromaeo/cssquery-dojo.html) 09:18:44 INFO - PROCESS | 32029 | RSS: Main: 315019264 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | __start_tp_report 09:18:44 INFO - PROCESS | 32029 | _x_x_mozilla_page_load 09:18:44 INFO - PROCESS | 32029 | _x_x_mozilla_page_load_details 09:18:44 INFO - PROCESS | 32029 | |i|pagename|runs| 09:18:44 INFO - PROCESS | 32029 | |0;dojo.html;2584.896604135835;2595.7534034266737;2609.673790776153;2617.9345516362087;2623.34416395901;4514.52597477265;4622.260438329868;4659.697119687218;4674.766261686915;4693.8122475101;4592.816287348511;4633.351330813681;4646.395968524095;4681.64887633428;4701.388819453467;4281.850135245267;4304.375865499501;4360.236958532244;4385.035292235703;4408.757518336491;4406.669499787513;4420.889477763049;4427.358033085201;4427.822887084529;4432.224360736875;4375.409319741858;4394.890127746816;4416.4258646375765;4442.511323754401;4472.30679244716;4231.87304380869;4285.078708077778;4294;4303.483581970152;4343.391925130484;4351.129774045172;4364.6508279337895;4397.604215620578;4399.7360158390275;4420.889477763049;4714.717116972958;4723.36234608327;4728;4756.143894099061;4797.376341075673;4881;4931.5315045070665;4935.925961110586;5071.873203169914;5079.949200507985;5018.974905125488;5058.038972595195;5079.847604571869;5096.108181068298;5139.794408223666;4707.435107787088;4713.198756211452;4716.551927566876;4719.716816990992;4750.07373562152;4989.25161225819;5176.456472070378;5180.378354597397;5184.300119483822;5228.764705588258;4822.252550854623;4865.440474345425;4932.03825254072;4975.0796102721115;4986.15235409974;5086.059079070384;5086.516780905808;5095.0574143783515;5095.847124586268;5120.641555091108;5016.573591244712;5060.468650791688;5066.771995260222;5067.391912970394;5099.719515426613;4861.6353773467135;4922.483139270396;4930.260460930889;4989.875253118701;5028.371453568304;4267.359896015622;4268.701190916606;4274.059706864485;4275.144971005811;4278;3681.5766186888313;3723.236736469017;3778.508793856781;3791.0711875590105;3791.8862434127022;4351.26028575143;4352.586504282088;4387.122575484916;4387.429634147604;4393.165298593257;5079.466656001141;5083.567896728746;5085.821996230115;5087.186050231945;5100.872478188001;4245.80893859777;4269.61573458384;4314.9784251078545;4337.934930976038;4344.6089851913475;4514.074614704044;4542.841000564964;4544.886377840514;4562.0191658792855;4576.656750743708;4723.574878260973;4725.69282996611;4729.172394830822;4731.101090792738;4761.833335833229;4923.8276660316715;4938.802447902043;5047.545720885138;5050.621203409685;5095.515925987025;4672.74299913508;4703.576678098988;4743.027679325799;4787.01866117452;4788.736619485822;5038.899222015612;5039.722815245197;5041.42023667283;5044.243363495505;5088.745562721775;5108.66793658411;5111.616628752933;5111.87220319495;5112.463191365002;5113.335266415343;4782.976085119552;4828.058528587032;4831.782569784298;4896.975515122402;4905.117078925828;4849.709017458964;4886.364772579542;4904.852854414374;4907.77914993819;4918.901621967612;4774.976125119352;4777.95222047775;4780.569748722632;4785.138675038526;4790.568848803624;4880.560749532559;4905;4922.212446008764;4931.408231012301;4931.605471562339;4804;4830.058138662927;4861.756912154449;4921.335619691439;4927.876803079952 09:18:44 INFO - PROCESS | 32029 | |1;ext.html;540.3218960204944;546.330744837574;547.7316115103599;563.7434967089972;566.0829456280826;27494.862525687393;38168.809155954215;39520.40719389211;39646.60353396472;43216.56783432165;38907.416388754194;39376.212475750464;39408;39535.60464395355;39542.60457395425;7117.074780278556;7249.275072492748;7433.5911524866115;7439.404847612205;7442.851142977137;7242.601656908868;7462.626868656573;7469.141048779378;7470.439717021218;9539.141477267045;9359.48522831244;9628.903710962872;9643;9650.517474126265;9654.275929305295;9658.420494770337;9704.417734935927;9710.563024663872;9718.951405242928;9729.318947673666;9587.376820506644;9663.420194788336;9663.468509231989;9667.661631842922;9668.806623867553;37511;37757.392456320034;37796.43305350422;37815;37865.24269514594;2924.6344206974127;3013.6835632258735;3164.5411415344647;3266.7386609071455;3603.963960360389;27431.86284068567;27785.583216251773;28039.719602803914;28676.856615716995;28924.855375723197;3174.539691744684;3251.6585758495253;3299.488579270217;3390.237196630763;3430.2110514581786;245666;245681;245812;245829;245850;30316.242093947385;52164.47835521672;52621.473785262424;52625.473745262825;52637.7368113157;31013.844930775653;32477;32655;32697.50953735696;32702.509462358084;13653.453861845415;13809.654758631115;13819.723605527834;13821.861781382258;13824.723505529833;11345.94327028376;11457.255278407043;11460.312381257152;11463.598774042868;11466.713332166595;6995.93004069963;7328.487005909642;7398.556086634819;7689.923100769032;7802.102758182768;3038.1645047612083;3040.8783648653807;3096;3107.937841243208;3132.592762940803;818.7871153500133;899.6896070855545;928.7832938850128;931.2957288162646;970.1317320997808;26711.732882670924;27036.32409189786;27274.181774546796;27630.447391052065;27663.30841728973;914.2366124286162;926.9536523173814;971.6016433262329;980.4558470049049;984.2372161574837;13653.590392288248;14430.579155169562;14530.346134423977;14745.631359215891;14817.851821481863;355263;360169;360950;361066;361624;46400.3759868403;46753.766231169306;47553.76223118862;47618.761906190244;48392.75803620959;1136.8806275341135;1196.497471062156;1203.3862730007759;1203.7652657731658;1207;26928;27775;27802.4081691816;28228;28306.575401368584;40290.798546007085;40693.79653101716;40757.59242407657;40802;41051;366785;379008;380939;547566;547838;34107.65892341045;34144.829275854456;34157;34289.14277143091;34668.13329666779;38276.6172338273;38333.233335333694;38426.23147537089;38429.423558646085;38728.806355969165;33238;33427.49858752072;33639;33653;33672.919038772656;32675;33249.33501329912;33797;34222.82888585541;34424.655753442144;33120.834395827864;33531.66468335383;33755;33822.49266261057;33828.83085584556;28683.70530357608;29722.851385743797;30116.247093821952;30217.244568885955;30365.392692146474;23926.282211533682;24188.395290117183;26869.731302686723;26965.191044268704;27225.183244502696 09:18:44 INFO - PROCESS | 32029 | |2;jquery.html;344.0950300709135;367.245310886129;367.3167907691693;372.7819225752934;389.41198789827354;12715.872841271585;12750.553730619431;13596.660083497929;14362.210078445682;17272.740908886375;16576;16737.163141842888;17270.395536156237;17352.913235433803;17374.82625173748;4821.927671084928;5099.15863882459;5146.716930568818;5171.715555644438;5177.783220943094;3629.8203083997805;5035.798568057273;5121.615878809104;5122.026814905156;5124.974375128119;3812.294725475782;3852.5376954765466;3909.2181563687236;5916.112583112546;5983.521318294548;5788.479036886658;5970.134330522072;5970.223870896777;5970.97014514929;5976.7908123215475;5317.282166907496;5346.331708536433;5352.357717073937;5352.812651557177;5355;20760.377188684364;20878.37364879056;21123.683144752842;21184.576308473745;21196;1723.336515441564;1793.820617938209;1889.631521853239;1925.643755905162;1988.1550341105117;8468.66125354985;9107.08929107084;9212.401193922373;11041.116710663127;13426.395812188377;1628.4219102218779;1708.5728567858037;1785.973210401845;1804.7744031996;1889.7826749923797;64217;68089.31910680929;69230;69809;71595.2101197469;9055.637774488947;9075.364724469357;9435.952820235854;9641.807163856683;9827.262955278382;12401.689957751129;12436;12449.93775031119;12454.003679705602;12457.1902826316;6953.687084081229;6954.826129346807;7078.115235595551;7091.645417729196;7180.31786980236;6497.415232629086;6515.120458738104;6530.738770449224;6690.29751876046;6698.665066746643;3837.4435706822915;3870.9419358709642;3873.302805495038;3893.3575959966856;3970.344893092665;1647.7198876191076;1674.355373181334;1697.1344614246577;1703.2080082761574;1707.7523759054868;818.1491249100868;833.3749687734199;876.1413814461736;903.290916630442;904.8461761500561;15226.847731522765;16229.675406491804;16421.507354779376;16807.747883781754;17096.658066838594;812.5165526511717;835.6406745099544;849.3884403229665;850.6214734443237;854.7521218846589;9036.23192028685;9649.324547281763;9673.516324183904;9766.267529935283;9771.706848794547;357608;372992;378202;379205;380182;59171.70414147988;70359.29640703528;71058;76117;79007.60496197482;877.7717793373641;879.5734068976669;919.2278486071732;919.3794188922451;922.4557511068367;15537.22313884324;15601;16204.837951620333;16267.709328239489;16432.096234707205;24699.259022229362;25822.354441139123;36574;37059;37470.250594988494;49791;50670.74664626653;50750.492495076054;51137.744311278206;51738.48261517487;10001.249906257206;10379.896201038195;10605.787884242427;10778.622748203776;10955.726106847393;6916.23921368639;9962.50187490608;12081.369015183189;12409;12548.623541293775;10985;11022.50398732043;11097.667069987914;11505.942470287595;11577.710557236136;10734;10864.076553493042;10962.287451315959;11100.333979961228;11475.483603237708;10693.304935179189;10820;11022.50398732043;11137.665870023913;11537.423128843691;10835.404052777172;10886.564537418415;10955.123590112613;11475.081993440337;11673.883261167279;10726.678199654023;10879.129669626253;10914.290571112851;11334.489947952197;11698 09:18:44 INFO - PROCESS | 32029 | |3;mootools.html;1329.747348003879;1369.110078449008;1440.3950340856838;1664.676582117216;1665.2756051117758;6164.691765411734;6369.936300637004;6377.649229292387;6786.626735529544;6791.558548694331;6455.386738259858;6751.696173672184;6753.932460675392;6891.793246202609;6902.275261097575;2058.6397380458397;2086.791320867916;2087.4572611121143;2089.320970684526;2094.7486301643826;1821.271491403436;1883.1714045819795;2050.4668786115644;2073.7718850926385;2074.771775104737;1983.077868791012;2041.4284000479815;2060.979390206101;2069.627467055929;2077.013418626148;2054.085931760367;2075.553755942472;2088.634488964425;2092.9581408371746;2094.6543820269712;2074;2099.9685004724943;2100.758412782519;2101.443117573844;2102.0120543344606;6722.966385168092;6768.052472653832;6818.931810681879;6947.444204463682;6952.5480843745;3915.7846318452475;3963.3064213762477;4071.9592804071876;4075.4294398784195;4227.598378154071;2634.855082970436;2751.683556391021;2863.6993115722967;2876.3528206153655;2883.870225839842;889.8353804546115;901.7745563609097;903.8553831387012;908.0420156734642;924.8982611912684;9061.7281481555;9071.727848164566;9078.09219078087;9102.362834601581;9115.58979845902;3778;3864.3623802072907;3933.4296527003426;3937.1535119948776;4004.3392840181627;7879.960600196962;7952.085510166289;7957.6021198939825;7959;7965.56189409588;4308.3968244445805;4308.763018033976;4309.870703878826;4310.439642846472;4311.50417701962;3758.4174452959833;3779.244151169722;3825.4261860720558;3840.5007349045004;3849.364854798983;3235.514672799099;3271.6237632672073;3361.8655253789575;3371.17406235469;3482.077249528877;1037.2428127466992;1082.3614067700096;1112.5382966068992;1146.564305563897;1153.0429743313198;624.8312955501989;740.7444332009045;764.8890910818011;778.8473059871422;779.7699678594828;4381.605655491021;4419.359192917073;4428.867133985986;4480.686351955332;4576.153411618861;776.6699152860012;797.7327595255539;799.7840583042662;824.983500330002;864.6325311742485;3098.209956461088;3121.8907338243507;3127.9687203128133;3135.3415782685433;3243.5459035735016;7417.295356941082;7788.104367997753;7793.220677932161;7802.648880800378;7809.297163255334;7762.7671169865;7766.223377662189;7768.378529717609;7769.961150194213;7770.378369730408;6151.7539298428455;6254.843628909222;6256.998880179241;6259.186305780219;6264.937350626436;4287.335463003239;4404.273294906305;4643.512431194676;4647.070585882904;4705.223638099676;7426.962865185639;7486.363659089038;7520.172780993977;7557.6221188939235;7571.053618297713;7320.377767889789;7482.476226664299;7483.588402637907;7485.026946496921;7490.662920168715;5723.370429252695;5812.128180772918;5824.213731146241;5826.854328641818;5827.912581311199;6305.1172835803945;6508.511861610304;6543.901841472477;6576.638284894377;6580.5722628029025;6130.264368275835;6147.44672979434;6204.162438070803;6290.622562646256;6304.747810087729;5920.319163296276;6000.129981152621;6021.157038014594;6040.426159514839;6058.12157237207;5443.727813609383;5466.562674986071;5484.451554844483;5499.092649712753;5608.523275521627;4003.159336539359;4050.210209009215;4099.323611604052;4140.565240649809;4205.726627769185;3823.9808800955816;3979;4121.670266378743;4132.958670413378;4166.833326667021 09:18:44 INFO - PROCESS | 32029 | |4;prototype.html;290.72962145204957;300.5281707718881;301.3656253586201;303.40078345268097;308.0527378311692;4764.642651801116;4779.713217206966;4813.927791083128;4840;4844.757762111898;4752.619790416767;4757.571818536331;4758.8102974256435;4762.880313394723;4778.71327720337;3552.1474846036895;3696.297703436352;3817.5302508534273;3819.2170605025904;3841.8847434577006;3702.777833330009;3798.6011468795655;3802.4866643003256;3811.4663947047434;3813.9237215255816;3756.9104959561696;3778.6977041836585;3784.3566593679143;3784.735068545203;3798.2593394288124;3580.3018411409785;3702;3786.413105968579;3788.677962373202;3798.0694729791103;3226.2095786532213;3277.918052048694;3279.754018448602;3327.1534298464344;3361.478970759536;4601.619514145743;4627.190241707688;4639.837605683785;4647.722615918209;4652.673987913428;4281.293586558214;4287.528371879091;4289.506706728735;4294.184105020036;4297.226499230137;4782.928256076161;4931.432885218174;4940.703557786508;4946.5795407390415;4985.626078044125;3628;3632.4732913727626;3633.7274704397278;3634.963650363489;3635.6727894489622;5197.974010129963;5209.270702101747;5211.270422140903;5220.867479512262;5225.477452254744;3602.7750564807566;3687.6128006558924;3694.7413681042067;3729.310077635646;3735.6077611850906;3771.9622803771613;3776.999095239764;3781.4138808484176;3785.7539259948016;3788.3749181384765;4249.344159900063;4254;4254.829806807693;4275.5296917339065;4283.657307415399;4744;4948.70307781527;4970.826021089245;4975.950240497621;4980.77586508608;1254.6763164861159;1274.9409703329243;1278.9808152877715;1284.7880099783617;1286.4339690536135;831.9209675080857;856.734412332179;860.9195459698165;863.6933888469503;865.34233982174;4242.681798865097;4244.469441319835;4246.936295955563;4258.872233832928;4272.700910936204;5055.443901170868;5074.3657042869645;5075.670081444694;5081.771320290596;5084.6440749147205;4290.485141782943;4360.277690312372;4412.492563355255;4427.490838553543;4428.158649856517;2574.9356266093123;2637.947241055168;2649.297936046949;2660.7649574357633;2667.719494642544;4684.882877928079;4714.575688188011;4719.5752382285755;4751.572358487752;4768.426419281629;5137.51193636604;5139.152039913447;5171.612129090333;5177.23018185269;5177.456367081478;4614.723116613014;4728.203282752601;4738.815296175956;4755.145493257633;4764.976175119172;5192.74036298176;5199.688018718889;5208.213605720921;5209.869753256047;5220.216967454912;5119.564836988898;5120.030382378137;5127.2565478004735;5136.691798491953;5136.815174591777;4645.790939407667;4862.781174847069;4893.8042478301895;4895.730734809477;4897.987737541315;3618.366785812525;3629.546306711661;3630.203049490519;3635.927281454409;3654.378755611606;5220.243064755513;5260.421353651019;5264.6838290427395;5266.578673706018;5278.76245568958;4954.241244358201;5085.7457127144235;5100.821471248637;5110.642255042111;5122.1548444507725;5050.383877159421;5051.3433253676785;5057.089723849743;5061.493850614909;5069.377799104252;4941.827036053721;4946.579540739078;4967.4535801062575;4967.726775027264;4980.925286120783;4993.520940808322;5016.936281611906;5024.5881976652145;5096;5112.258722485293;4719.268513380294;4841.661083724246;4845.224764037737;4893.877653058702;4939.382577177853 09:18:44 INFO - PROCESS | 32029 | |5;yui.html;634.8476365672238;680.8297925518617;697.8534507753371;706.1420374245291;750.448420410998;11318.773624527505;11957.940210298937;12297.754044919107;12301.569445069425;13016.47934082638;12044.759104817898;12106.878931210686;12123.939380303109;12133.878661213384;12139.08956828237;615.9260888693341;760.9695612175507;777.5529070784294;779.6569509415867;779.7076096463826;638.8339031851706;646.1309538670481;646.9676516174172;648.1347401219377;766.6588368176164;825.0223485170063;833.7207035643066;837.3719710217337;837.6063250272392;838.1785849867134;826.6032304493847;828.3745771942205;830.767385132164;832.097174565597;832.629479881453;484.4114401002763;492.68468180364596;607.1045208317696;607.1530215349562;608.3642593489814;11646.24299420535;12085.15403921726;12107.39463026845;12580.748385032339;12599.622011339583;12764.680882977907;13010.479580816756;13344.666383340396;13360.265185414799;13565.864341356657;10111.292209545334;10209.336393134497;10248.948755256177;10250.79498410035;10511.63209287679;3203.951940720891;3212.3414699986447;3240.270939038721;3255.5279484474618;3270.3132342208164;48160.75919620415;50025.24962125571;50218.49781502175;50459.49540504585;51466.22800657993;9441.905580944103;9657.275704322063;9877.506124693737;10074.294799363974;10210.387376757419;18419.355322563646;18537.5365615858;18733.126687331158;18918.621627567645;19001.714974275397;6482.67586620667;6645.833854153685;6716;6769.120014398195;6803.727850885909;3405.233822389992;3413.5562376891344;3510.438329867209;3559.715222782171;3571.196480791853;2769.487644785721;2835.17779843843;2842.465068862832;2855.500287449688;2882.798204125733;472.1949076824007;473.40351157541744;477.7109848541652;480.17170381092336;484.1478996965296;594.7799314253754;599.4904331318345;607.4897086447405;621.1769405537681;629.8299459146004;7703.730369437155;7850.725224617111;7865.882011769828;7878.487898286593;8661.30709543235;528.8307741522752;548.6159688218263;561.831450564829;631.0691729698658;631.8136149835809;3551.5915669698315;3742.401215805458;3824.349860523718;3876.5348158221195;4016.8393264269102;62096;62298.37701622926;63834.6131364247;64078.35921640724;64824.24872642227;36462.45306320407;41844.372334415006;52161.7391913038;54948.45051549433;57090.714546427;50548.74725626349;51341.22988155181;51930.5086864142;53139.20291195635;53152.46847531552;7567.243275672388;7595.505842504579;7739.883901741591;7769.844603107793;7872.547308584062;31982.52026219562;35686.64313356833;37346.27767001857;37926;37982;43979;50264;50358.2446263299;50708.492915070376;51700.74149629228;9600.615975361186;9627.374220675634;9664.516774161404;9756.463394513086;9954.651587194414;10476.319039262424;10599.947000264949;10650.467476626292;10810.891891080988;11152.776944461228;10149;10380.688579342632;10453.634122805664;10819.513121909691;10829.891701082888;10035.24735644844;10469.68590942273;10665.626703065356;10672.786544269227;11000.119990400588;11226.943865280622;11287.322760634388;11295.491702873225;11575.189736718348;11869.109816763605;9139.63441462334;9275.67535136267;9617.519124043909;9690.273229507957;9757.414555126716;9367.203787678123;9586.808263834824;9624.133827955518;9750.561224745046;9833 09:18:44 INFO - PROCESS | 32029 | __end_tp_report 09:18:44 INFO - PROCESS | 32029 | __start_cc_report 09:18:44 INFO - PROCESS | 32029 | _x_x_mozilla_cycle_collect,2442 09:18:44 INFO - PROCESS | 32029 | __end_cc_report 09:18:44 INFO - PROCESS | 32029 | __startTimestamp1479835124145__endTimestamp 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | ------- Summary: start ------- 09:18:44 INFO - PROCESS | 32029 | Number of tests: 6 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | [#0] dojo.html Cycles:165 Average:4659.10 Median:4774.98 stddev:487.80 (10.2%) stddev-sans-first:461.36 09:18:44 INFO - PROCESS | 32029 | Values: 2584.9 2595.8 2609.7 2617.9 2623.3 4514.5 4622.3 4659.7 4674.8 4693.8 4592.8 4633.4 4646.4 4681.6 4701.4 4281.9 4304.4 4360.2 4385.0 4408.8 4406.7 4420.9 4427.4 4427.8 4432.2 4375.4 4394.9 4416.4 4442.5 4472.3 4231.9 4285.1 4294.0 4303.5 4343.4 4351.1 4364.7 4397.6 4399.7 4420.9 4714.7 4723.4 4728.0 4756.1 4797.4 4881.0 4931.5 4935.9 5071.9 5079.9 5019.0 5058.0 5079.8 5096.1 5139.8 4707.4 4713.2 4716.6 4719.7 4750.1 4989.3 5176.5 5180.4 5184.3 5228.8 4822.3 4865.4 4932.0 4975.1 4986.2 5086.1 5086.5 5095.1 5095.8 5120.6 5016.6 5060.5 5066.8 5067.4 5099.7 4861.6 4922.5 4930.3 4989.9 5028.4 4267.4 4268.7 4274.1 4275.1 4278.0 3681.6 3723.2 3778.5 3791.1 3791.9 4351.3 4352.6 4387.1 4387.4 4393.2 5079.5 5083.6 5085.8 5087.2 5100.9 4245.8 4269.6 4315.0 4337.9 4344.6 4514.1 4542.8 4544.9 4562.0 4576.7 4723.6 4725.7 4729.2 4731.1 4761.8 4923.8 4938.8 5047.5 5050.6 5095.5 4672.7 4703.6 4743.0 4787.0 4788.7 5038.9 5039.7 5041.4 5044.2 5088.7 5108.7 5111.6 5111.9 5112.5 5113.3 4783.0 4828.1 4831.8 4897.0 4905.1 4849.7 4886.4 4904.9 4907.8 4918.9 4775.0 4778.0 4780.6 4785.1 4790.6 4880.6 4905.0 4922.2 4931.4 4931.6 4804.0 4830.1 4861.8 4921.3 4927.9 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | [#1] ext.html Cycles:180 Average:48611.18 Median:194965.57 stddev:96319.01 (49.4%) stddev-sans-first:96521.59 09:18:44 INFO - PROCESS | 32029 | Values: 540.3 546.3 547.7 563.7 566.1 27494.9 38168.8 39520.4 39646.6 43216.6 38907.4 39376.2 39408.0 39535.6 39542.6 7117.1 7249.3 7433.6 7439.4 7442.9 7242.6 7462.6 7469.1 7470.4 9539.1 9359.5 9628.9 9643.0 9650.5 9654.3 9658.4 9704.4 9710.6 9719.0 9729.3 9587.4 9663.4 9663.5 9667.7 9668.8 37511.0 37757.4 37796.4 37815.0 37865.2 2924.6 3013.7 3164.5 3266.7 3604.0 27431.9 27785.6 28039.7 28676.9 28924.9 3174.5 3251.7 3299.5 3390.2 3430.2 245666.0 245681.0 245812.0 245829.0 245850.0 30316.2 52164.5 52621.5 52625.5 52637.7 31013.8 32477.0 32655.0 32697.5 32702.5 13653.5 13809.7 13819.7 13821.9 13824.7 11345.9 11457.3 11460.3 11463.6 11466.7 6995.9 7328.5 7398.6 7689.9 7802.1 3038.2 3040.9 3096.0 3107.9 3132.6 818.8 899.7 928.8 931.3 970.1 26711.7 27036.3 27274.2 27630.4 27663.3 914.2 927.0 971.6 980.5 984.2 13653.6 14430.6 14530.3 14745.6 14817.9 355263.0 360169.0 360950.0 361066.0 361624.0 46400.4 46753.8 47553.8 47618.8 48392.8 1136.9 1196.5 1203.4 1203.8 1207.0 26928.0 27775.0 27802.4 28228.0 28306.6 40290.8 40693.8 40757.6 40802.0 41051.0 366785.0 379008.0 380939.0 547566.0 547838.0 34107.7 34144.8 34157.0 34289.1 34668.1 38276.6 38333.2 38426.2 38429.4 38728.8 33238.0 33427.5 33639.0 33653.0 33672.9 32675.0 33249.3 33797.0 34222.8 34424.7 33120.8 33531.7 33755.0 33822.5 33828.8 28683.7 29722.9 30116.2 30217.2 30365.4 23926.3 24188.4 26869.7 26965.2 27225.2 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | [#2] jquery.html Cycles:180 Average:23649.46 Median:205231.13 stddev:61642.08 (30.0%) stddev-sans-first:61790.16 09:18:44 INFO - PROCESS | 32029 | Values: 344.1 367.2 367.3 372.8 389.4 12715.9 12750.6 13596.7 14362.2 17272.7 16576.0 16737.2 17270.4 17352.9 17374.8 4821.9 5099.2 5146.7 5171.7 5177.8 3629.8 5035.8 5121.6 5122.0 5125.0 3812.3 3852.5 3909.2 5916.1 5983.5 5788.5 5970.1 5970.2 5971.0 5976.8 5317.3 5346.3 5352.4 5352.8 5355.0 20760.4 20878.4 21123.7 21184.6 21196.0 1723.3 1793.8 1889.6 1925.6 1988.2 8468.7 9107.1 9212.4 11041.1 13426.4 1628.4 1708.6 1786.0 1804.8 1889.8 64217.0 68089.3 69230.0 69809.0 71595.2 9055.6 9075.4 9436.0 9641.8 9827.3 12401.7 12436.0 12449.9 12454.0 12457.2 6953.7 6954.8 7078.1 7091.6 7180.3 6497.4 6515.1 6530.7 6690.3 6698.7 3837.4 3870.9 3873.3 3893.4 3970.3 1647.7 1674.4 1697.1 1703.2 1707.8 818.1 833.4 876.1 903.3 904.8 15226.8 16229.7 16421.5 16807.7 17096.7 812.5 835.6 849.4 850.6 854.8 9036.2 9649.3 9673.5 9766.3 9771.7 357608.0 372992.0 378202.0 379205.0 380182.0 59171.7 70359.3 71058.0 76117.0 79007.6 877.8 879.6 919.2 919.4 922.5 15537.2 15601.0 16204.8 16267.7 16432.1 24699.3 25822.4 36574.0 37059.0 37470.3 49791.0 50670.7 50750.5 51137.7 51738.5 10001.2 10379.9 10605.8 10778.6 10955.7 6916.2 9962.5 12081.4 12409.0 12548.6 10985.0 11022.5 11097.7 11505.9 11577.7 10734.0 10864.1 10962.3 11100.3 11475.5 10693.3 10820.0 11022.5 11137.7 11537.4 10835.4 10886.6 10955.1 11475.1 11673.9 10726.7 10879.1 10914.3 11334.5 11698.0 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | [#3] mootools.html Cycles:180 Average:4491.43 Median:5455.15 stddev:2363.95 (43.3%) stddev-sans-first:2358.64 09:18:44 INFO - PROCESS | 32029 | Values: 1329.7 1369.1 1440.4 1664.7 1665.3 6164.7 6369.9 6377.6 6786.6 6791.6 6455.4 6751.7 6753.9 6891.8 6902.3 2058.6 2086.8 2087.5 2089.3 2094.7 1821.3 1883.2 2050.5 2073.8 2074.8 1983.1 2041.4 2061.0 2069.6 2077.0 2054.1 2075.6 2088.6 2093.0 2094.7 2074.0 2100.0 2100.8 2101.4 2102.0 6723.0 6768.1 6818.9 6947.4 6952.5 3915.8 3963.3 4072.0 4075.4 4227.6 2634.9 2751.7 2863.7 2876.4 2883.9 889.8 901.8 903.9 908.0 924.9 9061.7 9071.7 9078.1 9102.4 9115.6 3778.0 3864.4 3933.4 3937.2 4004.3 7880.0 7952.1 7957.6 7959.0 7965.6 4308.4 4308.8 4309.9 4310.4 4311.5 3758.4 3779.2 3825.4 3840.5 3849.4 3235.5 3271.6 3361.9 3371.2 3482.1 1037.2 1082.4 1112.5 1146.6 1153.0 624.8 740.7 764.9 778.8 779.8 4381.6 4419.4 4428.9 4480.7 4576.2 776.7 797.7 799.8 825.0 864.6 3098.2 3121.9 3128.0 3135.3 3243.5 7417.3 7788.1 7793.2 7802.6 7809.3 7762.8 7766.2 7768.4 7770.0 7770.4 6151.8 6254.8 6257.0 6259.2 6264.9 4287.3 4404.3 4643.5 4647.1 4705.2 7427.0 7486.4 7520.2 7557.6 7571.1 7320.4 7482.5 7483.6 7485.0 7490.7 5723.4 5812.1 5824.2 5826.9 5827.9 6305.1 6508.5 6543.9 6576.6 6580.6 6130.3 6147.4 6204.2 6290.6 6304.7 5920.3 6000.1 6021.2 6040.4 6058.1 5443.7 5466.6 5484.5 5499.1 5608.5 4003.2 4050.2 4099.3 4140.6 4205.7 3824.0 3979.0 4121.7 4133.0 4166.8 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | [#4] prototype.html Cycles:180 Average:4158.33 Median:4723.89 stddev:1204.09 (25.5%) stddev-sans-first:1171.95 09:18:44 INFO - PROCESS | 32029 | Values: 290.7 300.5 301.4 303.4 308.1 4764.6 4779.7 4813.9 4840.0 4844.8 4752.6 4757.6 4758.8 4762.9 4778.7 3552.1 3696.3 3817.5 3819.2 3841.9 3702.8 3798.6 3802.5 3811.5 3813.9 3756.9 3778.7 3784.4 3784.7 3798.3 3580.3 3702.0 3786.4 3788.7 3798.1 3226.2 3277.9 3279.8 3327.2 3361.5 4601.6 4627.2 4639.8 4647.7 4652.7 4281.3 4287.5 4289.5 4294.2 4297.2 4782.9 4931.4 4940.7 4946.6 4985.6 3628.0 3632.5 3633.7 3635.0 3635.7 5198.0 5209.3 5211.3 5220.9 5225.5 3602.8 3687.6 3694.7 3729.3 3735.6 3772.0 3777.0 3781.4 3785.8 3788.4 4249.3 4254.0 4254.8 4275.5 4283.7 4744.0 4948.7 4970.8 4976.0 4980.8 1254.7 1274.9 1279.0 1284.8 1286.4 831.9 856.7 860.9 863.7 865.3 4242.7 4244.5 4246.9 4258.9 4272.7 5055.4 5074.4 5075.7 5081.8 5084.6 4290.5 4360.3 4412.5 4427.5 4428.2 2574.9 2637.9 2649.3 2660.8 2667.7 4684.9 4714.6 4719.6 4751.6 4768.4 5137.5 5139.2 5171.6 5177.2 5177.5 4614.7 4728.2 4738.8 4755.1 4765.0 5192.7 5199.7 5208.2 5209.9 5220.2 5119.6 5120.0 5127.3 5136.7 5136.8 4645.8 4862.8 4893.8 4895.7 4898.0 3618.4 3629.5 3630.2 3635.9 3654.4 5220.2 5260.4 5264.7 5266.6 5278.8 4954.2 5085.7 5100.8 5110.6 5122.2 5050.4 5051.3 5057.1 5061.5 5069.4 4941.8 4946.6 4967.5 4967.7 4980.9 4993.5 5016.9 5024.6 5096.0 5112.3 4719.3 4841.7 4845.2 4893.9 4939.4 09:18:44 INFO - PROCESS | 32029 | 09:18:44 INFO - PROCESS | 32029 | [#5] yui.html Cycles:180 Average:13945.28 Median:50311.12 stddev:17169.09 (34.1%) stddev-sans-first:17188.16 09:18:44 INFO - PROCESS | 32029 | Values: 634.8 680.8 697.9 706.1 750.4 11318.8 11957.9 12297.8 12301.6 13016.5 12044.8 12106.9 12123.9 12133.9 12139.1 615.9 761.0 777.6 779.7 779.7 638.8 646.1 647.0 648.1 766.7 825.0 833.7 837.4 837.6 838.2 826.6 828.4 830.8 832.1 832.6 484.4 492.7 607.1 607.2 608.4 11646.2 12085.2 12107.4 12580.7 12599.6 12764.7 13010.5 13344.7 13360.3 13565.9 10111.3 10209.3 10248.9 10250.8 10511.6 3204.0 3212.3 3240.3 3255.5 3270.3 48160.8 50025.2 50218.5 50459.5 51466.2 9441.9 9657.3 9877.5 10074.3 10210.4 18419.4 18537.5 18733.1 18918.6 19001.7 6482.7 6645.8 6716.0 6769.1 6803.7 3405.2 3413.6 3510.4 3559.7 3571.2 2769.5 2835.2 2842.5 2855.5 2882.8 472.2 473.4 477.7 480.2 484.1 594.8 599.5 607.5 621.2 629.8 7703.7 7850.7 7865.9 7878.5 8661.3 528.8 548.6 561.8 631.1 631.8 3551.6 3742.4 3824.3 3876.5 4016.8 62096.0 62298.4 63834.6 64078.4 64824.2 36462.5 41844.4 52161.7 54948.5 57090.7 50548.7 51341.2 51930.5 53139.2 53152.5 7567.2 7595.5 7739.9 7769.8 7872.5 31982.5 35686.6 37346.3 37926.0 37982.0 43979.0 50264.0 50358.2 50708.5 51700.7 9600.6 9627.4 9664.5 9756.5 9954.7 10476.3 10599.9 10650.5 10810.9 11152.8 10149.0 10380.7 10453.6 10819.5 10829.9 10035.2 10469.7 10665.6 10672.8 11000.1 11226.9 11287.3 11295.5 11575.2 11869.1 9139.6 9275.7 9617.5 9690.3 9757.4 9367.2 9586.8 9624.1 9750.6 9833.0 09:18:44 INFO - PROCESS | 32029 | -------- Summary: end -------- 09:18:44 INFO - PROCESS | 32029 | 09:18:45 INFO - TEST-INFO | 32029: exit 0 09:18:45 INFO - TEST-OK | dromaeo_css | took 1123338ms 09:18:45 INFO - TEST-START | kraken 09:18:45 INFO - operating with platform_type : linux_ 09:18:45 INFO - Initialising browser for kraken test... 09:18:45 INFO - TEST-INFO | started process 32336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplmdgIl/profile http://localhost:43193/getInfo.html) 09:18:49 INFO - PROCESS | 32336 | __metrics Screen width/height:1600/1200 09:18:49 INFO - PROCESS | 32336 | colorDepth:24 09:18:49 INFO - PROCESS | 32336 | Browser inner width/height: 1024/697 09:18:49 INFO - PROCESS | 32336 | __metrics 09:18:50 INFO - PROCESS | 32336 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:18:50 INFO - PROCESS | 32336 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:51 INFO - PROCESS | 32336 | console.error: PushService: 09:18:51 INFO - PROCESS | 32336 | stateChangeProcessEnqueue: Error transitioning state 09:18:51 INFO - PROCESS | 32336 | UnknownError 09:18:52 INFO - TEST-INFO | 32336: exit 0 09:18:52 INFO - Browser initialized. 09:18:52 INFO - Running cycle 1/1 for kraken test... 09:18:52 INFO - TEST-INFO | started process 32419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplmdgIl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:04 INFO - PROCESS | 32419 | RSS: Main: 174206976 09:19:04 INFO - PROCESS | 32419 | 09:19:07 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43193/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:08 INFO - PROCESS | 32419 | RSS: Main: 229957632 09:19:08 INFO - PROCESS | 32419 | 09:19:10 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43193/tests/kraken/driver.html?testName=audio-dft) 09:19:11 INFO - PROCESS | 32419 | RSS: Main: 218673152 09:19:11 INFO - PROCESS | 32419 | 09:19:14 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43193/tests/kraken/driver.html?testName=audio-fft) 09:19:15 INFO - PROCESS | 32419 | RSS: Main: 299765760 09:19:15 INFO - PROCESS | 32419 | 09:19:17 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43193/tests/kraken/driver.html?testName=audio-oscillator) 09:19:18 INFO - PROCESS | 32419 | RSS: Main: 210817024 09:19:18 INFO - PROCESS | 32419 | 09:19:20 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:21 INFO - PROCESS | 32419 | RSS: Main: 214228992 09:19:21 INFO - PROCESS | 32419 | 09:19:24 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43193/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:24 INFO - PROCESS | 32419 | RSS: Main: 253939712 09:19:24 INFO - PROCESS | 32419 | 09:19:28 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43193/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:28 INFO - PROCESS | 32419 | RSS: Main: 253325312 09:19:28 INFO - PROCESS | 32419 | 09:19:31 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43193/tests/kraken/driver.html?testName=json-parse-financial) 09:19:32 INFO - PROCESS | 32419 | RSS: Main: 251617280 09:19:32 INFO - PROCESS | 32419 | 09:19:34 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:34 INFO - PROCESS | 32419 | RSS: Main: 213934080 09:19:34 INFO - PROCESS | 32419 | 09:19:36 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:37 INFO - PROCESS | 32419 | RSS: Main: 221454336 09:19:37 INFO - PROCESS | 32419 | 09:19:39 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:40 INFO - PROCESS | 32419 | RSS: Main: 230502400 09:19:40 INFO - PROCESS | 32419 | 09:19:42 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:43 INFO - PROCESS | 32419 | RSS: Main: 238694400 09:19:43 INFO - PROCESS | 32419 | 09:19:46 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:47 INFO - PROCESS | 32419 | RSS: Main: 235044864 09:19:47 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | Cycle 1(1): loaded http://localhost:43193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43193/tests/kraken/driver.html?testName=ai-astar) 09:19:49 INFO - PROCESS | 32419 | RSS: Main: 286552064 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | __start_tp_report 09:19:49 INFO - PROCESS | 32419 | _x_x_mozilla_page_load 09:19:49 INFO - PROCESS | 32419 | _x_x_mozilla_page_load_details 09:19:49 INFO - PROCESS | 32419 | |i|pagename|runs| 09:19:49 INFO - PROCESS | 32419 | |0;ai-astar;107;117;115;117;116;117;118;116;116;116 09:19:49 INFO - PROCESS | 32419 | |1;audio-beat-detection;154;130;131;183;133;133;128;127;161;127 09:19:49 INFO - PROCESS | 32419 | |2;audio-dft;173;161;161;161;161;161;162;162;162;161 09:19:49 INFO - PROCESS | 32419 | |3;audio-fft;77;77;77;103;78;77;77;78;99;81 09:19:49 INFO - PROCESS | 32419 | |4;audio-oscillator;84;85;109;84;84;84;104;84;83;112 09:19:49 INFO - PROCESS | 32419 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;118 09:19:49 INFO - PROCESS | 32419 | |6;imaging-darkroom;149;148;148;148;148;146;149;149;148;147 09:19:49 INFO - PROCESS | 32419 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 09:19:49 INFO - PROCESS | 32419 | |8;json-parse-financial;65;64;63;63;65;67;66;66;66;65 09:19:49 INFO - PROCESS | 32419 | |9;json-stringify-tinderbox;65;66;66;65;66;66;66;66;66;71 09:19:49 INFO - PROCESS | 32419 | |10;stanford-crypto-aes;89;94;88;87;87;88;88;86;87;87 09:19:49 INFO - PROCESS | 32419 | |11;stanford-crypto-ccm;146;145;140;141;144;141;141;142;191;144 09:19:49 INFO - PROCESS | 32419 | |12;stanford-crypto-pbkdf2;187;187;187;183;192;195;184;184;184;184 09:19:49 INFO - PROCESS | 32419 | |13;stanford-crypto-sha256-iterative;71;71;70;70;76;74;75;69;69;69 09:19:49 INFO - PROCESS | 32419 | __end_tp_report 09:19:49 INFO - PROCESS | 32419 | __start_cc_report 09:19:49 INFO - PROCESS | 32419 | _x_x_mozilla_cycle_collect,1997 09:19:49 INFO - PROCESS | 32419 | __end_cc_report 09:19:49 INFO - PROCESS | 32419 | __startTimestamp1479835189506__endTimestamp 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | ------- Summary: start ------- 09:19:49 INFO - PROCESS | 32419 | Number of tests: 14 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#0] ai-astar Cycles:10 Average:115.50 Median:116.50 stddev:3.10 (2.7%) stddev-sans-first:0.88 09:19:49 INFO - PROCESS | 32419 | Values: 107.0 117.0 115.0 117.0 116.0 117.0 118.0 116.0 116.0 116.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#1] audio-beat-detection Cycles:10 Average:140.70 Median:133.00 stddev:18.98 (14.3%) stddev-sans-first:19.51 09:19:49 INFO - PROCESS | 32419 | Values: 154.0 130.0 131.0 183.0 133.0 133.0 128.0 127.0 161.0 127.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#2] audio-dft Cycles:10 Average:162.50 Median:161.50 stddev:3.72 (2.3%) stddev-sans-first:0.50 09:19:49 INFO - PROCESS | 32419 | Values: 173.0 161.0 161.0 161.0 161.0 161.0 162.0 162.0 162.0 161.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.50 stddev:9.92 (12.8%) stddev-sans-first:10.33 09:19:49 INFO - PROCESS | 32419 | Values: 77.0 77.0 77.0 103.0 78.0 77.0 77.0 78.0 99.0 81.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:84.00 stddev:11.92 (14.2%) stddev-sans-first:12.34 09:19:49 INFO - PROCESS | 32419 | Values: 84.0 85.0 109.0 84.0 84.0 84.0 104.0 84.0 83.0 112.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:19:49 INFO - PROCESS | 32419 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 09:19:49 INFO - PROCESS | 32419 | Values: 149.0 148.0 148.0 148.0 148.0 146.0 149.0 149.0 148.0 147.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:19:49 INFO - PROCESS | 32419 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.50 stddev:1.33 (2.0%) stddev-sans-first:1.41 09:19:49 INFO - PROCESS | 32419 | Values: 65.0 64.0 63.0 63.0 65.0 67.0 66.0 66.0 66.0 65.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.74 09:19:49 INFO - PROCESS | 32419 | Values: 65.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 66.0 71.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.00 stddev:2.23 (2.5%) stddev-sans-first:2.35 09:19:49 INFO - PROCESS | 32419 | Values: 89.0 94.0 88.0 87.0 87.0 88.0 88.0 86.0 87.0 87.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#11] stanford-crypto-ccm Cycles:10 Average:147.50 Median:144.00 stddev:15.41 (10.7%) stddev-sans-first:16.34 09:19:49 INFO - PROCESS | 32419 | Values: 146.0 145.0 140.0 141.0 144.0 141.0 141.0 142.0 191.0 144.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.70 Median:187.00 stddev:3.95 (2.1%) stddev-sans-first:4.18 09:19:49 INFO - PROCESS | 32419 | Values: 187.0 187.0 187.0 183.0 192.0 195.0 184.0 184.0 184.0 184.0 09:19:49 INFO - PROCESS | 32419 | 09:19:49 INFO - PROCESS | 32419 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:2.63 (3.7%) stddev-sans-first:2.79 09:19:49 INFO - PROCESS | 32419 | Values: 71.0 71.0 70.0 70.0 76.0 74.0 75.0 69.0 69.0 69.0 09:19:49 INFO - PROCESS | 32419 | -------- Summary: end -------- 09:19:49 INFO - PROCESS | 32419 | 09:19:50 INFO - TEST-INFO | 32419: exit 0 09:19:50 INFO - TEST-OK | kraken | took 65746ms 09:19:50 INFO - SUITE-END | took 1189s 09:19:51 INFO - Completed test suite (00:19:49) 09:19:51 INFO - javascript benchmark 09:19:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2584.896604135835, 2595.7534034266737, 2609.673790776153, 2617.9345516362087, 2623.34416395901, 4514.52597477265, 4622.260438329868, 4659.697119687218, 4674.766261686915, 4693.8122475101, 4592.816287348511, 4633.351330813681, 4646.395968524095, 4681.64887633428, 4701.388819453467, 4281.850135245267, 4304.375865499501, 4360.236958532244, 4385.035292235703, 4408.757518336491, 4406.669499787513, 4420.889477763049, 4427.358033085201, 4427.822887084529, 4432.224360736875, 4375.409319741858, 4394.890127746816, 4416.4258646375765, 4442.511323754401, 4472.30679244716, 4231.87304380869, 4285.078708077778, 4294.0, 4303.483581970152, 4343.391925130484, 4351.129774045172, 4364.6508279337895, 4397.604215620578, 4399.7360158390275, 4420.889477763049, 4714.717116972958, 4723.36234608327, 4728.0, 4756.143894099061, 4797.376341075673, 4881.0, 4931.5315045070665, 4935.925961110586, 5071.873203169914, 5079.949200507985, 5018.974905125488, 5058.038972595195, 5079.847604571869, 5096.108181068298, 5139.794408223666, 4707.435107787088, 4713.198756211452, 4716.551927566876, 4719.716816990992, 4750.07373562152, 4989.25161225819, 5176.456472070378, 5180.378354597397, 5184.300119483822, 5228.764705588258, 4822.252550854623, 4865.440474345425, 4932.03825254072, 4975.0796102721115, 4986.15235409974, 5086.059079070384, 5086.516780905808, 5095.0574143783515, 5095.847124586268, 5120.641555091108, 5016.573591244712, 5060.468650791688, 5066.771995260222, 5067.391912970394, 5099.719515426613, 4861.6353773467135, 4922.483139270396, 4930.260460930889, 4989.875253118701, 5028.371453568304, 4267.359896015622, 4268.701190916606, 4274.059706864485, 4275.144971005811, 4278.0, 3681.5766186888313, 3723.236736469017, 3778.508793856781, 3791.0711875590105, 3791.8862434127022, 4351.26028575143, 4352.586504282088, 4387.122575484916, 4387.429634147604, 4393.165298593257, 5079.466656001141, 5083.567896728746, 5085.821996230115, 5087.186050231945, 5100.872478188001, 4245.80893859777, 4269.61573458384, 4314.9784251078545, 4337.934930976038, 4344.6089851913475, 4514.074614704044, 4542.841000564964, 4544.886377840514, 4562.0191658792855, 4576.656750743708, 4723.574878260973, 4725.69282996611, 4729.172394830822, 4731.101090792738, 4761.833335833229, 4923.8276660316715, 4938.802447902043, 5047.545720885138, 5050.621203409685, 5095.515925987025, 4672.74299913508, 4703.576678098988, 4743.027679325799, 4787.01866117452, 4788.736619485822, 5038.899222015612, 5039.722815245197, 5041.42023667283, 5044.243363495505, 5088.745562721775, 5108.66793658411, 5111.616628752933, 5111.87220319495, 5112.463191365002, 5113.335266415343, 4782.976085119552, 4828.058528587032, 4831.782569784298, 4896.975515122402, 4905.117078925828, 4849.709017458964, 4886.364772579542, 4904.852854414374, 4907.77914993819, 4918.901621967612, 4774.976125119352, 4777.95222047775, 4780.569748722632, 4785.138675038526, 4790.568848803624, 4880.560749532559, 4905.0, 4922.212446008764, 4931.408231012301, 4931.605471562339, 4804.0, 4830.058138662927, 4861.756912154449, 4921.335619691439, 4927.876803079952], "value": 4627.692555565939, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.3218960204944, 546.330744837574, 547.7316115103599, 563.7434967089972, 566.0829456280826, 27494.862525687393, 38168.809155954215, 39520.40719389211, 39646.60353396472, 43216.56783432165, 38907.416388754194, 39376.212475750464, 39408.0, 39535.60464395355, 39542.60457395425, 7117.074780278556, 7249.275072492748, 7433.5911524866115, 7439.404847612205, 7442.851142977137, 7242.601656908868, 7462.626868656573, 7469.141048779378, 7470.439717021218, 9539.141477267045, 9359.48522831244, 9628.903710962872, 9643.0, 9650.517474126265, 9654.275929305295, 9658.420494770337, 9704.417734935927, 9710.563024663872, 9718.951405242928, 9729.318947673666, 9587.376820506644, 9663.420194788336, 9663.468509231989, 9667.661631842922, 9668.806623867553, 37511.0, 37757.392456320034, 37796.43305350422, 37815.0, 37865.24269514594, 2924.6344206974127, 3013.6835632258735, 3164.5411415344647, 3266.7386609071455, 3603.963960360389, 27431.86284068567, 27785.583216251773, 28039.719602803914, 28676.856615716995, 28924.855375723197, 3174.539691744684, 3251.6585758495253, 3299.488579270217, 3390.237196630763, 3430.2110514581786, 245666.0, 245681.0, 245812.0, 245829.0, 245850.0, 30316.242093947385, 52164.47835521672, 52621.473785262424, 52625.473745262825, 52637.7368113157, 31013.844930775653, 32477.0, 32655.0, 32697.50953735696, 32702.509462358084, 13653.453861845415, 13809.654758631115, 13819.723605527834, 13821.861781382258, 13824.723505529833, 11345.94327028376, 11457.255278407043, 11460.312381257152, 11463.598774042868, 11466.713332166595, 6995.93004069963, 7328.487005909642, 7398.556086634819, 7689.923100769032, 7802.102758182768, 3038.1645047612083, 3040.8783648653807, 3096.0, 3107.937841243208, 3132.592762940803, 818.7871153500133, 899.6896070855545, 928.7832938850128, 931.2957288162646, 970.1317320997808, 26711.732882670924, 27036.32409189786, 27274.181774546796, 27630.447391052065, 27663.30841728973, 914.2366124286162, 926.9536523173814, 971.6016433262329, 980.4558470049049, 984.2372161574837, 13653.590392288248, 14430.579155169562, 14530.346134423977, 14745.631359215891, 14817.851821481863, 355263.0, 360169.0, 360950.0, 361066.0, 361624.0, 46400.3759868403, 46753.766231169306, 47553.76223118862, 47618.761906190244, 48392.75803620959, 1136.8806275341135, 1196.497471062156, 1203.3862730007759, 1203.7652657731658, 1207.0, 26928.0, 27775.0, 27802.4081691816, 28228.0, 28306.575401368584, 40290.798546007085, 40693.79653101716, 40757.59242407657, 40802.0, 41051.0, 366785.0, 379008.0, 380939.0, 547566.0, 547838.0, 34107.65892341045, 34144.829275854456, 34157.0, 34289.14277143091, 34668.13329666779, 38276.6172338273, 38333.233335333694, 38426.23147537089, 38429.423558646085, 38728.806355969165, 33238.0, 33427.49858752072, 33639.0, 33653.0, 33672.919038772656, 32675.0, 33249.33501329912, 33797.0, 34222.82888585541, 34424.655753442144, 33120.834395827864, 33531.66468335383, 33755.0, 33822.49266261057, 33828.83085584556, 28683.70530357608, 29722.851385743797, 30116.247093821952, 30217.244568885955, 30365.392692146474, 23926.282211533682, 24188.395290117183, 26869.731302686723, 26965.191044268704, 27225.183244502696], "value": 16624.895373185565, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.0950300709135, 367.245310886129, 367.3167907691693, 372.7819225752934, 389.41198789827354, 12715.872841271585, 12750.553730619431, 13596.660083497929, 14362.210078445682, 17272.740908886375, 16576.0, 16737.163141842888, 17270.395536156237, 17352.913235433803, 17374.82625173748, 4821.927671084928, 5099.15863882459, 5146.716930568818, 5171.715555644438, 5177.783220943094, 3629.8203083997805, 5035.798568057273, 5121.615878809104, 5122.026814905156, 5124.974375128119, 3812.294725475782, 3852.5376954765466, 3909.2181563687236, 5916.112583112546, 5983.521318294548, 5788.479036886658, 5970.134330522072, 5970.223870896777, 5970.97014514929, 5976.7908123215475, 5317.282166907496, 5346.331708536433, 5352.357717073937, 5352.812651557177, 5355.0, 20760.377188684364, 20878.37364879056, 21123.683144752842, 21184.576308473745, 21196.0, 1723.336515441564, 1793.820617938209, 1889.631521853239, 1925.643755905162, 1988.1550341105117, 8468.66125354985, 9107.08929107084, 9212.401193922373, 11041.116710663127, 13426.395812188377, 1628.4219102218779, 1708.5728567858037, 1785.973210401845, 1804.7744031996, 1889.7826749923797, 64217.0, 68089.31910680929, 69230.0, 69809.0, 71595.2101197469, 9055.637774488947, 9075.364724469357, 9435.952820235854, 9641.807163856683, 9827.262955278382, 12401.689957751129, 12436.0, 12449.93775031119, 12454.003679705602, 12457.1902826316, 6953.687084081229, 6954.826129346807, 7078.115235595551, 7091.645417729196, 7180.31786980236, 6497.415232629086, 6515.120458738104, 6530.738770449224, 6690.29751876046, 6698.665066746643, 3837.4435706822915, 3870.9419358709642, 3873.302805495038, 3893.3575959966856, 3970.344893092665, 1647.7198876191076, 1674.355373181334, 1697.1344614246577, 1703.2080082761574, 1707.7523759054868, 818.1491249100868, 833.3749687734199, 876.1413814461736, 903.290916630442, 904.8461761500561, 15226.847731522765, 16229.675406491804, 16421.507354779376, 16807.747883781754, 17096.658066838594, 812.5165526511717, 835.6406745099544, 849.3884403229665, 850.6214734443237, 854.7521218846589, 9036.23192028685, 9649.324547281763, 9673.516324183904, 9766.267529935283, 9771.706848794547, 357608.0, 372992.0, 378202.0, 379205.0, 380182.0, 59171.70414147988, 70359.29640703528, 71058.0, 76117.0, 79007.60496197482, 877.7717793373641, 879.5734068976669, 919.2278486071732, 919.3794188922451, 922.4557511068367, 15537.22313884324, 15601.0, 16204.837951620333, 16267.709328239489, 16432.096234707205, 24699.259022229362, 25822.354441139123, 36574.0, 37059.0, 37470.250594988494, 49791.0, 50670.74664626653, 50750.492495076054, 51137.744311278206, 51738.48261517487, 10001.249906257206, 10379.896201038195, 10605.787884242427, 10778.622748203776, 10955.726106847393, 6916.23921368639, 9962.50187490608, 12081.369015183189, 12409.0, 12548.623541293775, 10985.0, 11022.50398732043, 11097.667069987914, 11505.942470287595, 11577.710557236136, 10734.0, 10864.076553493042, 10962.287451315959, 11100.333979961228, 11475.483603237708, 10693.304935179189, 10820.0, 11022.50398732043, 11137.665870023913, 11537.423128843691, 10835.404052777172, 10886.564537418415, 10955.123590112613, 11475.081993440337, 11673.883261167279, 10726.678199654023, 10879.129669626253, 10914.290571112851, 11334.489947952197, 11698.0], "value": 8198.641961986214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.747348003879, 1369.110078449008, 1440.3950340856838, 1664.676582117216, 1665.2756051117758, 6164.691765411734, 6369.936300637004, 6377.649229292387, 6786.626735529544, 6791.558548694331, 6455.386738259858, 6751.696173672184, 6753.932460675392, 6891.793246202609, 6902.275261097575, 2058.6397380458397, 2086.791320867916, 2087.4572611121143, 2089.320970684526, 2094.7486301643826, 1821.271491403436, 1883.1714045819795, 2050.4668786115644, 2073.7718850926385, 2074.771775104737, 1983.077868791012, 2041.4284000479815, 2060.979390206101, 2069.627467055929, 2077.013418626148, 2054.085931760367, 2075.553755942472, 2088.634488964425, 2092.9581408371746, 2094.6543820269712, 2074.0, 2099.9685004724943, 2100.758412782519, 2101.443117573844, 2102.0120543344606, 6722.966385168092, 6768.052472653832, 6818.931810681879, 6947.444204463682, 6952.5480843745, 3915.7846318452475, 3963.3064213762477, 4071.9592804071876, 4075.4294398784195, 4227.598378154071, 2634.855082970436, 2751.683556391021, 2863.6993115722967, 2876.3528206153655, 2883.870225839842, 889.8353804546115, 901.7745563609097, 903.8553831387012, 908.0420156734642, 924.8982611912684, 9061.7281481555, 9071.727848164566, 9078.09219078087, 9102.362834601581, 9115.58979845902, 3778.0, 3864.3623802072907, 3933.4296527003426, 3937.1535119948776, 4004.3392840181627, 7879.960600196962, 7952.085510166289, 7957.6021198939825, 7959.0, 7965.56189409588, 4308.3968244445805, 4308.763018033976, 4309.870703878826, 4310.439642846472, 4311.50417701962, 3758.4174452959833, 3779.244151169722, 3825.4261860720558, 3840.5007349045004, 3849.364854798983, 3235.514672799099, 3271.6237632672073, 3361.8655253789575, 3371.17406235469, 3482.077249528877, 1037.2428127466992, 1082.3614067700096, 1112.5382966068992, 1146.564305563897, 1153.0429743313198, 624.8312955501989, 740.7444332009045, 764.8890910818011, 778.8473059871422, 779.7699678594828, 4381.605655491021, 4419.359192917073, 4428.867133985986, 4480.686351955332, 4576.153411618861, 776.6699152860012, 797.7327595255539, 799.7840583042662, 824.983500330002, 864.6325311742485, 3098.209956461088, 3121.8907338243507, 3127.9687203128133, 3135.3415782685433, 3243.5459035735016, 7417.295356941082, 7788.104367997753, 7793.220677932161, 7802.648880800378, 7809.297163255334, 7762.7671169865, 7766.223377662189, 7768.378529717609, 7769.961150194213, 7770.378369730408, 6151.7539298428455, 6254.843628909222, 6256.998880179241, 6259.186305780219, 6264.937350626436, 4287.335463003239, 4404.273294906305, 4643.512431194676, 4647.070585882904, 4705.223638099676, 7426.962865185639, 7486.363659089038, 7520.172780993977, 7557.6221188939235, 7571.053618297713, 7320.377767889789, 7482.476226664299, 7483.588402637907, 7485.026946496921, 7490.662920168715, 5723.370429252695, 5812.128180772918, 5824.213731146241, 5826.854328641818, 5827.912581311199, 6305.1172835803945, 6508.511861610304, 6543.901841472477, 6576.638284894377, 6580.5722628029025, 6130.264368275835, 6147.44672979434, 6204.162438070803, 6290.622562646256, 6304.747810087729, 5920.319163296276, 6000.129981152621, 6021.157038014594, 6040.426159514839, 6058.12157237207, 5443.727813609383, 5466.562674986071, 5484.451554844483, 5499.092649712753, 5608.523275521627, 4003.159336539359, 4050.210209009215, 4099.323611604052, 4140.565240649809, 4205.726627769185, 3823.9808800955816, 3979.0, 4121.670266378743, 4132.958670413378, 4166.833326667021], "value": 3704.974273762668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.72962145204957, 300.5281707718881, 301.3656253586201, 303.40078345268097, 308.0527378311692, 4764.642651801116, 4779.713217206966, 4813.927791083128, 4840.0, 4844.757762111898, 4752.619790416767, 4757.571818536331, 4758.8102974256435, 4762.880313394723, 4778.71327720337, 3552.1474846036895, 3696.297703436352, 3817.5302508534273, 3819.2170605025904, 3841.8847434577006, 3702.777833330009, 3798.6011468795655, 3802.4866643003256, 3811.4663947047434, 3813.9237215255816, 3756.9104959561696, 3778.6977041836585, 3784.3566593679143, 3784.735068545203, 3798.2593394288124, 3580.3018411409785, 3702.0, 3786.413105968579, 3788.677962373202, 3798.0694729791103, 3226.2095786532213, 3277.918052048694, 3279.754018448602, 3327.1534298464344, 3361.478970759536, 4601.619514145743, 4627.190241707688, 4639.837605683785, 4647.722615918209, 4652.673987913428, 4281.293586558214, 4287.528371879091, 4289.506706728735, 4294.184105020036, 4297.226499230137, 4782.928256076161, 4931.432885218174, 4940.703557786508, 4946.5795407390415, 4985.626078044125, 3628.0, 3632.4732913727626, 3633.7274704397278, 3634.963650363489, 3635.6727894489622, 5197.974010129963, 5209.270702101747, 5211.270422140903, 5220.867479512262, 5225.477452254744, 3602.7750564807566, 3687.6128006558924, 3694.7413681042067, 3729.310077635646, 3735.6077611850906, 3771.9622803771613, 3776.999095239764, 3781.4138808484176, 3785.7539259948016, 3788.3749181384765, 4249.344159900063, 4254.0, 4254.829806807693, 4275.5296917339065, 4283.657307415399, 4744.0, 4948.70307781527, 4970.826021089245, 4975.950240497621, 4980.77586508608, 1254.6763164861159, 1274.9409703329243, 1278.9808152877715, 1284.7880099783617, 1286.4339690536135, 831.9209675080857, 856.734412332179, 860.9195459698165, 863.6933888469503, 865.34233982174, 4242.681798865097, 4244.469441319835, 4246.936295955563, 4258.872233832928, 4272.700910936204, 5055.443901170868, 5074.3657042869645, 5075.670081444694, 5081.771320290596, 5084.6440749147205, 4290.485141782943, 4360.277690312372, 4412.492563355255, 4427.490838553543, 4428.158649856517, 2574.9356266093123, 2637.947241055168, 2649.297936046949, 2660.7649574357633, 2667.719494642544, 4684.882877928079, 4714.575688188011, 4719.5752382285755, 4751.572358487752, 4768.426419281629, 5137.51193636604, 5139.152039913447, 5171.612129090333, 5177.23018185269, 5177.456367081478, 4614.723116613014, 4728.203282752601, 4738.815296175956, 4755.145493257633, 4764.976175119172, 5192.74036298176, 5199.688018718889, 5208.213605720921, 5209.869753256047, 5220.216967454912, 5119.564836988898, 5120.030382378137, 5127.2565478004735, 5136.691798491953, 5136.815174591777, 4645.790939407667, 4862.781174847069, 4893.8042478301895, 4895.730734809477, 4897.987737541315, 3618.366785812525, 3629.546306711661, 3630.203049490519, 3635.927281454409, 3654.378755611606, 5220.243064755513, 5260.421353651019, 5264.6838290427395, 5266.578673706018, 5278.76245568958, 4954.241244358201, 5085.7457127144235, 5100.821471248637, 5110.642255042111, 5122.1548444507725, 5050.383877159421, 5051.3433253676785, 5057.089723849743, 5061.493850614909, 5069.377799104252, 4941.827036053721, 4946.579540739078, 4967.4535801062575, 4967.726775027264, 4980.925286120783, 4993.520940808322, 5016.936281611906, 5024.5881976652145, 5096.0, 5112.258722485293, 4719.268513380294, 4841.661083724246, 4845.224764037737, 4893.877653058702, 4939.382577177853], "value": 3776.5541097410014, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [634.8476365672238, 680.8297925518617, 697.8534507753371, 706.1420374245291, 750.448420410998, 11318.773624527505, 11957.940210298937, 12297.754044919107, 12301.569445069425, 13016.47934082638, 12044.759104817898, 12106.878931210686, 12123.939380303109, 12133.878661213384, 12139.08956828237, 615.9260888693341, 760.9695612175507, 777.5529070784294, 779.6569509415867, 779.7076096463826, 638.8339031851706, 646.1309538670481, 646.9676516174172, 648.1347401219377, 766.6588368176164, 825.0223485170063, 833.7207035643066, 837.3719710217337, 837.6063250272392, 838.1785849867134, 826.6032304493847, 828.3745771942205, 830.767385132164, 832.097174565597, 832.629479881453, 484.4114401002763, 492.68468180364596, 607.1045208317696, 607.1530215349562, 608.3642593489814, 11646.24299420535, 12085.15403921726, 12107.39463026845, 12580.748385032339, 12599.622011339583, 12764.680882977907, 13010.479580816756, 13344.666383340396, 13360.265185414799, 13565.864341356657, 10111.292209545334, 10209.336393134497, 10248.948755256177, 10250.79498410035, 10511.63209287679, 3203.951940720891, 3212.3414699986447, 3240.270939038721, 3255.5279484474618, 3270.3132342208164, 48160.75919620415, 50025.24962125571, 50218.49781502175, 50459.49540504585, 51466.22800657993, 9441.905580944103, 9657.275704322063, 9877.506124693737, 10074.294799363974, 10210.387376757419, 18419.355322563646, 18537.5365615858, 18733.126687331158, 18918.621627567645, 19001.714974275397, 6482.67586620667, 6645.833854153685, 6716.0, 6769.120014398195, 6803.727850885909, 3405.233822389992, 3413.5562376891344, 3510.438329867209, 3559.715222782171, 3571.196480791853, 2769.487644785721, 2835.17779843843, 2842.465068862832, 2855.500287449688, 2882.798204125733, 472.1949076824007, 473.40351157541744, 477.7109848541652, 480.17170381092336, 484.1478996965296, 594.7799314253754, 599.4904331318345, 607.4897086447405, 621.1769405537681, 629.8299459146004, 7703.730369437155, 7850.725224617111, 7865.882011769828, 7878.487898286593, 8661.30709543235, 528.8307741522752, 548.6159688218263, 561.831450564829, 631.0691729698658, 631.8136149835809, 3551.5915669698315, 3742.401215805458, 3824.349860523718, 3876.5348158221195, 4016.8393264269102, 62096.0, 62298.37701622926, 63834.6131364247, 64078.35921640724, 64824.24872642227, 36462.45306320407, 41844.372334415006, 52161.7391913038, 54948.45051549433, 57090.714546427, 50548.74725626349, 51341.22988155181, 51930.5086864142, 53139.20291195635, 53152.46847531552, 7567.243275672388, 7595.505842504579, 7739.883901741591, 7769.844603107793, 7872.547308584062, 31982.52026219562, 35686.64313356833, 37346.27767001857, 37926.0, 37982.0, 43979.0, 50264.0, 50358.2446263299, 50708.492915070376, 51700.74149629228, 9600.615975361186, 9627.374220675634, 9664.516774161404, 9756.463394513086, 9954.651587194414, 10476.319039262424, 10599.947000264949, 10650.467476626292, 10810.891891080988, 11152.776944461228, 10149.0, 10380.688579342632, 10453.634122805664, 10819.513121909691, 10829.891701082888, 10035.24735644844, 10469.68590942273, 10665.626703065356, 10672.786544269227, 11000.119990400588, 11226.943865280622, 11287.322760634388, 11295.491702873225, 11575.189736718348, 11869.109816763605, 9139.63441462334, 9275.67535136267, 9617.519124043909, 9690.273229507957, 9757.414555126716, 9367.203787678123, 9586.808263834824, 9624.133827955518, 9750.561224745046, 9833.0], "value": 5977.584704088806, "unit": "score"}], "name": "dromaeo_css", "value": 6124.266065808766, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 115.0, 117.0, 116.0, 117.0, 118.0, 116.0, 116.0, 116.0], "value": 115.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 130.0, 131.0, 183.0, 133.0, 133.0, 128.0, 127.0, 161.0, 127.0], "value": 140.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 103.0, 78.0, 77.0, 77.0, 78.0, 99.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 84.0, 84.0, 84.0, 104.0, 84.0, 83.0, 112.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 148.0, 146.0, 149.0, 149.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 63.0, 65.0, 67.0, 66.0, 66.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 71.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 94.0, 88.0, 87.0, 87.0, 88.0, 88.0, 86.0, 87.0, 87.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 140.0, 141.0, 144.0, 141.0, 141.0, 142.0, 191.0, 144.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 187.0, 187.0, 183.0, 192.0, 195.0, 184.0, 184.0, 184.0, 184.0], "value": 186.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 70.0, 76.0, 74.0, 75.0, 69.0, 69.0, 69.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1577.6000000000001, "alertThreshold": 2.0}]} 09:19:51 INFO - Return code: 0 09:19:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:19:51 INFO - # TBPL SUCCESS # 09:19:51 INFO - Running post-action listener: _resource_record_post_action 09:19:51 INFO - [mozharness: 2016-11-22 17:19:51.310257Z] Finished run-tests step (success) 09:19:51 INFO - Running post-run listener: _resource_record_post_run 09:19:51 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 388194304; Read time: 12; Write time: 286060 09:19:51 INFO - TinderboxPrint: CPU usage
13.0% 09:19:51 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:19:51 INFO - TinderboxPrint: I/O write bytes / time
388,194,304 / 286,060 09:19:51 INFO - TinderboxPrint: CPU idle
8,359.0 (86.9%) 09:19:51 INFO - TinderboxPrint: CPU user
1,206.2 (12.5%) 09:19:51 INFO - TinderboxPrint: Swap in / out
0 / 0 09:19:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99688448; Read time: 0; Write time: 112424 09:19:51 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 288505856; Read time: 0; Write time: 173636 09:19:51 INFO - Running post-run listener: _upload_blobber_files 09:19:51 INFO - Blob upload gear active. 09:19:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:19:51 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 09:19:51 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'] 09:19:51 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 09:19:52 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:19:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:53 INFO - (blobuploader) - INFO - Done attempting. 09:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:56 INFO - (blobuploader) - INFO - Done attempting. 09:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:19:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:57 INFO - (blobuploader) - INFO - Done attempting. 09:19:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:57 INFO - Return code: 0 09:19:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1054401c579cd9f4349cf43fb7beb7f20dfd006390c507e607ee0bfe183400402a1f62479017d4fd521b512b1efe37ec9ac6aa2da0204c1a06115f2dfbfffd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dcfaaa27b1e0d1cedbc116b6405bd523f060627af68c64bbd271ba04ee47f78fe5237a7a8577a185ee52339d1e8ca46bc2aa7094d4fe30f0f6279e24a57eea05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a486ddffd96bad225a007c92d19333c1c4d8b982e995c062f19e2da7801043f32807f528edf9ca5df04a66515cbe4e5490523d6f0e3dcafd926f318e239f0e8"} 09:19:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:57 INFO - Contents: 09:19:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1054401c579cd9f4349cf43fb7beb7f20dfd006390c507e607ee0bfe183400402a1f62479017d4fd521b512b1efe37ec9ac6aa2da0204c1a06115f2dfbfffd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dcfaaa27b1e0d1cedbc116b6405bd523f060627af68c64bbd271ba04ee47f78fe5237a7a8577a185ee52339d1e8ca46bc2aa7094d4fe30f0f6279e24a57eea05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a486ddffd96bad225a007c92d19333c1c4d8b982e995c062f19e2da7801043f32807f528edf9ca5df04a66515cbe4e5490523d6f0e3dcafd926f318e239f0e8"} 09:19:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:57 INFO - Copying logs to upload dir... 09:19:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.654677 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-11-22 09:19:57.349473) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:57.352810) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1054401c579cd9f4349cf43fb7beb7f20dfd006390c507e607ee0bfe183400402a1f62479017d4fd521b512b1efe37ec9ac6aa2da0204c1a06115f2dfbfffd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dcfaaa27b1e0d1cedbc116b6405bd523f060627af68c64bbd271ba04ee47f78fe5237a7a8577a185ee52339d1e8ca46bc2aa7094d4fe30f0f6279e24a57eea05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a486ddffd96bad225a007c92d19333c1c4d8b982e995c062f19e2da7801043f32807f528edf9ca5df04a66515cbe4e5490523d6f0e3dcafd926f318e239f0e8"} build_url:https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/1054401c579cd9f4349cf43fb7beb7f20dfd006390c507e607ee0bfe183400402a1f62479017d4fd521b512b1efe37ec9ac6aa2da0204c1a06115f2dfbfffd1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dcfaaa27b1e0d1cedbc116b6405bd523f060627af68c64bbd271ba04ee47f78fe5237a7a8577a185ee52339d1e8ca46bc2aa7094d4fe30f0f6279e24a57eea05", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9a486ddffd96bad225a007c92d19333c1c4d8b982e995c062f19e2da7801043f32807f528edf9ca5df04a66515cbe4e5490523d6f0e3dcafd926f318e239f0e8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:57.378536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:57.378902) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1479832925.779491-354907564 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:57.460388) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 09:19:57.460827) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 09:19:57.461223) ========= ========= Total master_lag: 0.15 =========