builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1479833944.19 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.188894) ========= 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.189547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.189941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.302761) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.303016) ========= 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=52faae308a556c440401f8e5000001e8-1479833945.321331-572435751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-22 08:59:06-- 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% 33.1M=0s 2016-11-22 08:59:06 (33.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130779 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.448772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.449091) ========= 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=52faae308a556c440401f8e5000001e8-1479833945.321331-572435751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018468 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.500275) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:04.500619) ========= 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=52faae308a556c440401f8e5000001e8-1479833945.321331-572435751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-22 08:59:06,595 truncating revision to first 12 chars 2016-11-22 08:59:06,595 Setting DEBUG logging. 2016-11-22 08:59:06,596 attempt 1/10 2016-11-22 08:59:06,596 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:06,938 unpacking tar archive at: graphics-5c755c22be96/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640092 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.152721) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.153000) ========= script_repo_revision: 5c755c22be9668a5e8d60e520c68601635243142 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.153378) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.153646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-22 08:59:05.160790) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-22 08:59:05.161086) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=52faae308a556c440401f8e5000001e8-1479833945.321331-572435751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:59:07 INFO - MultiFileLogger online at 20161122 08:59:07 in /builds/slave/test 08:59:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 08:59:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:07 INFO - {'append_to_log': False, 08:59:07 INFO - 'base_work_dir': '/builds/slave/test', 08:59:07 INFO - 'blob_upload_branch': 'Graphics', 08:59:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:07 INFO - 'branch': 'Graphics', 08:59:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:07 INFO - 'config_files': ('talos/linux_config.py',), 08:59:07 INFO - 'default_actions': ('clobber', 08:59:07 INFO - 'read-buildbot-config', 08:59:07 INFO - 'download-and-extract', 08:59:07 INFO - 'populate-webroot', 08:59:07 INFO - 'create-virtualenv', 08:59:07 INFO - 'install', 08:59:07 INFO - 'run-tests'), 08:59:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:07 INFO - 'download_minidump_stackwalk': True, 08:59:07 INFO - 'download_symbols': 'ondemand', 08:59:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:07 INFO - 'installer_path': 'installer.exe', 08:59:07 INFO - 'log_level': 'info', 08:59:07 INFO - 'log_name': 'talos', 08:59:07 INFO - 'log_to_console': True, 08:59:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:59:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:59:07 INFO - 'opt_config_files': (), 08:59:07 INFO - 'pip_index': False, 08:59:07 INFO - 'sps_profile': False, 08:59:07 INFO - 'sps_profile_interval': 0, 08:59:07 INFO - 'suite': 'dromaeojs-e10s', 08:59:07 INFO - 'system_bits': '32', 08:59:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:07 INFO - 'title': 'talos-linux64-ix-056', 08:59:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:07 INFO - 'use_talos_json': True, 08:59:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:07 INFO - 'work_dir': 'build'} 08:59:07 INFO - [mozharness: 2016-11-22 16:59:07.355993Z] Running clobber step. 08:59:07 INFO - Running pre-action listener: _resource_record_pre_action 08:59:07 INFO - Running main action method: clobber 08:59:07 INFO - rmtree: /builds/slave/test/build 08:59:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:08 INFO - Running post-action listener: _resource_record_post_action 08:59:08 INFO - [mozharness: 2016-11-22 16:59:08.457323Z] Finished clobber step (success) 08:59:08 INFO - [mozharness: 2016-11-22 16:59:08.457422Z] Running read-buildbot-config step. 08:59:08 INFO - Running pre-action listener: _resource_record_pre_action 08:59:08 INFO - Running main action method: read_buildbot_config 08:59:08 INFO - Using buildbot properties: 08:59:08 INFO - { 08:59:08 INFO - "project": "", 08:59:08 INFO - "product": "firefox", 08:59:08 INFO - "script_repo_revision": "default", 08:59:08 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 08:59:08 INFO - "repository": "", 08:59:08 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 08:59:08 INFO - "buildid": "20161122080051", 08:59:08 INFO - "pgo_build": "False", 08:59:08 INFO - "basedir": "/builds/slave/test", 08:59:08 INFO - "buildnumber": 5, 08:59:08 INFO - "slavename": "talos-linux64-ix-056", 08:59:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:59:08 INFO - "platform": "ubuntu64_hw", 08:59:08 INFO - "scheduler": "tests-graphics-linux64-talos", 08:59:08 INFO - "branch": "graphics", 08:59:08 INFO - "repo_path": "projects/graphics", 08:59:08 INFO - "revision": "5c755c22be9668a5e8d60e520c68601635243142", 08:59:08 INFO - "stage_platform": "linux64", 08:59:08 INFO - "builduid": "26307b912cfa4309950486d45f79a099", 08:59:08 INFO - "slavebuilddir": "test" 08:59:08 INFO - } 08:59:08 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:08 INFO - Running post-action listener: _resource_record_post_action 08:59:08 INFO - [mozharness: 2016-11-22 16:59:08.460078Z] Finished read-buildbot-config step (success) 08:59:08 INFO - [mozharness: 2016-11-22 16:59:08.460166Z] Running download-and-extract step. 08:59:08 INFO - Running pre-action listener: _resource_record_pre_action 08:59:08 INFO - Running main action method: download_and_extract 08:59:08 INFO - mkdir: /builds/slave/test/build/tests 08:59:08 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:08 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:08 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:08 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:09 INFO - Downloaded 1361 bytes. 08:59:09 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:59:09 INFO - Using the following test package requirements: 08:59:09 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:09 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:59:09 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:59:09 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'jsshell-linux-x86_64.zip'], 08:59:09 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:59:09 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:59:09 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:59:09 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:59:09 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:59:09 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:59:09 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:59:09 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:59:09 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:09 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:09 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:09 INFO - Http code: 200 08:59:09 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 08:59:09 INFO - x-amz-cf-id: VpwkXHick99sarxiMe7SxwL7wa0-M1Gozy9cgmKHIlYAYiT7IEXrYw== 08:59:09 INFO - x-amz-version-id: ApqCidDeF.bt_wCaOGwqOnFVh0kJ9spP 08:59:10 INFO - Expected file size: 20183379 08:59:10 INFO - Obtained file size: 20183379 08:59:14 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:14 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:14 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:14 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:14 INFO - Http code: 200 08:59:14 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:59:14 INFO - x-amz-cf-id: ypU2-QBoD0o1WHVx-e6xjAevqK5fbS6br3QZA1WkEtZ0HYeTWQdUcw== 08:59:14 INFO - x-amz-version-id: ApqCidDeF.bt_wCaOGwqOnFVh0kJ9spP 08:59:15 INFO - Expected file size: 20183379 08:59:15 INFO - Obtained file size: 20183379 08:59:19 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:19 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:19 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:20 INFO - Http code: 200 08:59:20 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 08:59:20 INFO - x-amz-cf-id: s32TfAYxv3AspBSWYCsUBBiW74RylvK8LykY-JxSpgkVZ_ujvVjEzw== 08:59:20 INFO - x-amz-version-id: _1bup5WAhDJRDC70BB7.DXxUukzLHCR4 08:59:20 INFO - Expected file size: 14409392 08:59:20 INFO - Obtained file size: 14409392 08:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:21 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:21 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:21 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:23 INFO - Downloaded 55600245 bytes. 08:59:23 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:23 INFO - mkdir: /builds/slave/test/properties 08:59:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:59:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:59:23 INFO - Contents: 08:59:23 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:24 INFO - Running post-action listener: _resource_record_post_action 08:59:24 INFO - Running post-action listener: set_extra_try_arguments 08:59:24 INFO - [mozharness: 2016-11-22 16:59:24.487673Z] Finished download-and-extract step (success) 08:59:24 INFO - [mozharness: 2016-11-22 16:59:24.487897Z] Running populate-webroot step. 08:59:24 INFO - Running pre-action listener: _resource_record_pre_action 08:59:24 INFO - Running main action method: populate_webroot 08:59:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:59:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:59:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:59:24 INFO - '--tppagecycles', 08:59:24 INFO - '7'], 08:59:24 INFO - 'tests': ['tsvgm']}}, 08:59:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:59:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:59:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:59:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:59:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:59:24 INFO - 'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:59:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:59:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:59:24 INFO - 'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['damp', 'tps']}, 08:59:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:59:24 INFO - 'tests': ['damp', 'tps']}, 08:59:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['dromaeo_dom']}, 08:59:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:59:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['basic_compositor_video']}, 08:59:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:59:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['a11yr', 08:59:24 INFO - 'ts_paint', 08:59:24 INFO - 'tpaint', 08:59:24 INFO - 'sessionrestore', 08:59:24 INFO - 'sessionrestore_no_auto_restore', 08:59:24 INFO - 'tabpaint']}, 08:59:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:59:24 INFO - 'ts_paint', 08:59:24 INFO - 'tpaint', 08:59:24 INFO - 'sessionrestore', 08:59:24 INFO - 'sessionrestore_no_auto_restore', 08:59:24 INFO - 'tabpaint']}, 08:59:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:59:24 INFO - 'ts_paint', 08:59:24 INFO - 'tpaint', 08:59:24 INFO - 'sessionrestore', 08:59:24 INFO - 'sessionrestore_no_auto_restore', 08:59:24 INFO - 'tabpaint']}, 08:59:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:59:24 INFO - 'ts_paint', 08:59:24 INFO - 'tpaint', 08:59:24 INFO - 'sessionrestore', 08:59:24 INFO - 'sessionrestore_no_auto_restore', 08:59:24 INFO - 'tabpaint']}, 08:59:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['a11yr', 08:59:24 INFO - 'ts_paint', 08:59:24 INFO - 'tpaint', 08:59:24 INFO - 'sessionrestore', 08:59:24 INFO - 'sessionrestore_no_auto_restore', 08:59:24 INFO - 'tabpaint']}, 08:59:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['a11yr', 08:59:24 INFO - 'ts_paint', 08:59:24 INFO - 'tpaint', 08:59:24 INFO - 'sessionrestore', 08:59:24 INFO - 'sessionrestore_no_auto_restore', 08:59:24 INFO - 'tabpaint']}, 08:59:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['tsvgx', 08:59:24 INFO - 'tsvgr_opacity', 08:59:24 INFO - 'tart', 08:59:24 INFO - 'tscrollx', 08:59:24 INFO - 'cart']}, 08:59:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:59:24 INFO - 'tsvgr_opacity', 08:59:24 INFO - 'tart', 08:59:24 INFO - 'tscrollx', 08:59:24 INFO - 'cart']}, 08:59:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:59:24 INFO - 'talos_options': ['--disable-e10s'], 08:59:24 INFO - 'tests': ['tp5o']}, 08:59:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:59:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:59:24 INFO - 'talos_options': ['--disable-e10s', 08:59:24 INFO - '--xperf_path', 08:59:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:24 INFO - 'tests': ['tp5n']}, 08:59:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:59:24 INFO - 'talos_options': ['--xperf_path', 08:59:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:59:24 INFO - 'tests': ['tp5n']}}, 08:59:24 INFO - 'talos.zip': {'path': '', 08:59:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:59:24 INFO - Running post-action listener: _resource_record_post_action 08:59:24 INFO - [mozharness: 2016-11-22 16:59:24.507483Z] Finished populate-webroot step (success) 08:59:24 INFO - [mozharness: 2016-11-22 16:59:24.507571Z] Running create-virtualenv step. 08:59:24 INFO - Running pre-action listener: _resource_record_pre_action 08:59:24 INFO - Running main action method: create_virtualenv 08:59:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:59:24 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:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:59:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:59:24 INFO - Using real prefix '/usr' 08:59:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:59:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:59:27 INFO - Installing pip.................done. 08:59:27 INFO - Return code: 0 08:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:59:27 INFO - Reading from file tmpfile_stdout 08:59:27 INFO - Output received: 08:59:27 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:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:59:27 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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:27 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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:27 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 08:59:27 INFO - 'HOME': '/home/cltbld', 08:59:27 INFO - 'LANG': 'en_US.UTF-8', 08:59:27 INFO - 'LANGUAGE': 'en_US:en', 08:59:27 INFO - 'LOGNAME': 'cltbld', 08:59:27 INFO - 'MAIL': '/var/mail/cltbld', 08:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:27 INFO - 'MOZ_NO_REMOTE': '1', 08:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:27 INFO - 'NO_EM_RESTART': '1', 08:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:27 INFO - 'PWD': '/builds/slave/test', 08:59:27 INFO - 'SHELL': '/bin/bash', 08:59:27 INFO - 'SHLVL': '1', 08:59:27 INFO - 'TERM': 'linux', 08:59:27 INFO - 'TMOUT': '86400', 08:59:27 INFO - 'USER': 'cltbld', 08:59:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:27 INFO - '_': '/tools/buildbot/bin/python'} 08:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:27 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:27 INFO - Cleaning up... 08:59:27 INFO - Return code: 0 08:59:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:59:27 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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:27 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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:27 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 08:59:27 INFO - 'HOME': '/home/cltbld', 08:59:27 INFO - 'LANG': 'en_US.UTF-8', 08:59:27 INFO - 'LANGUAGE': 'en_US:en', 08:59:27 INFO - 'LOGNAME': 'cltbld', 08:59:27 INFO - 'MAIL': '/var/mail/cltbld', 08:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:27 INFO - 'MOZ_NO_REMOTE': '1', 08:59:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:27 INFO - 'NO_EM_RESTART': '1', 08:59:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:27 INFO - 'PWD': '/builds/slave/test', 08:59:27 INFO - 'SHELL': '/bin/bash', 08:59:27 INFO - 'SHLVL': '1', 08:59:27 INFO - 'TERM': 'linux', 08:59:27 INFO - 'TMOUT': '86400', 08:59:27 INFO - 'USER': 'cltbld', 08:59:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:27 INFO - '_': '/tools/buildbot/bin/python'} 08:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:27 INFO - Downloading/unpacking psutil>=3.1.1 08:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:29 INFO - Installing collected packages: psutil 08:59:29 INFO - Running setup.py install for psutil 08:59:29 INFO - building 'psutil._psutil_linux' extension 08:59:29 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:30 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:30 INFO - building 'psutil._psutil_posix' extension 08:59:30 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:30 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:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:59:30 INFO - Successfully installed psutil 08:59:30 INFO - Cleaning up... 08:59:30 INFO - Return code: 0 08:59:30 INFO - Installing mozsystemmonitor==0.3 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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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', 'mozsystemmonitor==0.3'] 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 mozsystemmonitor==0.3 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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:30 INFO - '_': '/tools/buildbot/bin/python'} 08:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:59:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:59:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:59:32 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:32 INFO - Installing collected packages: mozsystemmonitor 08:59:32 INFO - Running setup.py install for mozsystemmonitor 08:59:32 INFO - Successfully installed mozsystemmonitor 08:59:32 INFO - Cleaning up... 08:59:32 INFO - Return code: 0 08:59:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:59:32 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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:32 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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:32 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 08:59:32 INFO - 'HOME': '/home/cltbld', 08:59:32 INFO - 'LANG': 'en_US.UTF-8', 08:59:32 INFO - 'LANGUAGE': 'en_US:en', 08:59:32 INFO - 'LOGNAME': 'cltbld', 08:59:32 INFO - 'MAIL': '/var/mail/cltbld', 08:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:32 INFO - 'MOZ_NO_REMOTE': '1', 08:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:32 INFO - 'NO_EM_RESTART': '1', 08:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:32 INFO - 'PWD': '/builds/slave/test', 08:59:32 INFO - 'SHELL': '/bin/bash', 08:59:32 INFO - 'SHLVL': '1', 08:59:32 INFO - 'TERM': 'linux', 08:59:32 INFO - 'TMOUT': '86400', 08:59:32 INFO - 'USER': 'cltbld', 08:59:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:32 INFO - '_': '/tools/buildbot/bin/python'} 08:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:32 INFO - Downloading/unpacking jsonschema==2.5.1 08:59:32 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:32 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:32 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:32 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:32 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:32 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 - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:59:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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: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 functools32-3.2.3-2.tar.gz 08:59:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:59:35 INFO - warning: no files found matching '*.txt' 08:59:35 INFO - no previously-included directories found matching 'build' 08:59:35 INFO - no previously-included directories found matching 'dist' 08:59:35 INFO - no previously-included directories found matching '.git*' 08:59:35 INFO - Installing collected packages: jsonschema, functools32 08:59:35 INFO - Running setup.py install for functools32 08:59:35 INFO - warning: no files found matching '*.txt' 08:59:35 INFO - no previously-included directories found matching 'build' 08:59:35 INFO - no previously-included directories found matching 'dist' 08:59:35 INFO - no previously-included directories found matching '.git*' 08:59:35 INFO - Successfully installed jsonschema functools32 08:59:35 INFO - Cleaning up... 08:59:35 INFO - Return code: 0 08:59:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 08:59:35 INFO - 'HOME': '/home/cltbld', 08:59:35 INFO - 'LANG': 'en_US.UTF-8', 08:59:35 INFO - 'LANGUAGE': 'en_US:en', 08:59:35 INFO - 'LOGNAME': 'cltbld', 08:59:35 INFO - 'MAIL': '/var/mail/cltbld', 08:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:35 INFO - 'MOZ_NO_REMOTE': '1', 08:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:35 INFO - 'NO_EM_RESTART': '1', 08:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:35 INFO - 'PWD': '/builds/slave/test', 08:59:35 INFO - 'SHELL': '/bin/bash', 08:59:35 INFO - 'SHLVL': '1', 08:59:35 INFO - 'TERM': 'linux', 08:59:35 INFO - 'TMOUT': '86400', 08:59:35 INFO - 'USER': 'cltbld', 08:59:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:35 INFO - '_': '/tools/buildbot/bin/python'} 08:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:59:35 INFO - Cleaning up... 08:59:35 INFO - Return code: 0 08:59:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:35 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 08:59:35 INFO - 'HOME': '/home/cltbld', 08:59:35 INFO - 'LANG': 'en_US.UTF-8', 08:59:35 INFO - 'LANGUAGE': 'en_US:en', 08:59:35 INFO - 'LOGNAME': 'cltbld', 08:59:35 INFO - 'MAIL': '/var/mail/cltbld', 08:59:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:35 INFO - 'MOZ_NO_REMOTE': '1', 08:59:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:35 INFO - 'NO_EM_RESTART': '1', 08:59:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:35 INFO - 'PWD': '/builds/slave/test', 08:59:35 INFO - 'SHELL': '/bin/bash', 08:59:35 INFO - 'SHLVL': '1', 08:59:35 INFO - 'TERM': 'linux', 08:59:35 INFO - 'TMOUT': '86400', 08:59:35 INFO - 'USER': 'cltbld', 08:59:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:35 INFO - '_': '/tools/buildbot/bin/python'} 08:59:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:59:35 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:35 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 - 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:35 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:35 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:35 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:37 INFO - Downloading blobuploader-1.2.4.tar.gz 08:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:59:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:59:37 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:37 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:37 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:37 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:37 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:37 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:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:59:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:59:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Downloading docopt-0.6.1.tar.gz 08:59:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:59:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:59:38 INFO - Running setup.py install for blobuploader 08:59:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:59:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:59:38 INFO - Running setup.py install for requests 08:59:38 INFO - Running setup.py install for docopt 08:59:39 INFO - Successfully installed blobuploader requests docopt 08:59:39 INFO - Cleaning up... 08:59:39 INFO - Return code: 0 08:59:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:39 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:39 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:39 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:39 INFO - Using env: {'DISPLAY': ':0', 08:59:39 INFO - 'HOME': '/home/cltbld', 08:59:39 INFO - 'LANG': 'en_US.UTF-8', 08:59:39 INFO - 'LANGUAGE': 'en_US:en', 08:59:39 INFO - 'LOGNAME': 'cltbld', 08:59:39 INFO - 'MAIL': '/var/mail/cltbld', 08:59:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:39 INFO - 'MOZ_NO_REMOTE': '1', 08:59:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:39 INFO - 'NO_EM_RESTART': '1', 08:59:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:39 INFO - 'PWD': '/builds/slave/test', 08:59:39 INFO - 'SHELL': '/bin/bash', 08:59:39 INFO - 'SHLVL': '1', 08:59:39 INFO - 'TERM': 'linux', 08:59:39 INFO - 'TMOUT': '86400', 08:59:39 INFO - 'USER': 'cltbld', 08:59:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:39 INFO - '_': '/tools/buildbot/bin/python'} 08:59:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:39 INFO - Running setup.py (path:/tmp/pip-QQFpHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:39 INFO - Running setup.py (path:/tmp/pip-kjX9eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:39 INFO - Running setup.py (path:/tmp/pip-6AzEKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:39 INFO - Running setup.py (path:/tmp/pip-nmf2a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:39 INFO - Running setup.py (path:/tmp/pip-2eBavF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:39 INFO - Running setup.py (path:/tmp/pip-9TqKzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:39 INFO - Running setup.py (path:/tmp/pip-pyoOmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:39 INFO - Running setup.py (path:/tmp/pip-crXGBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:39 INFO - Running setup.py (path:/tmp/pip-01q2J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:40 INFO - Running setup.py (path:/tmp/pip-Z0GD6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:40 INFO - Running setup.py (path:/tmp/pip-OnWYS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:40 INFO - Running setup.py (path:/tmp/pip-2tdzng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:40 INFO - Running setup.py (path:/tmp/pip-ybUMUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:40 INFO - Running setup.py (path:/tmp/pip-Thz_Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:40 INFO - Running setup.py (path:/tmp/pip-FKnKVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:40 INFO - Running setup.py (path:/tmp/pip-inywPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:40 INFO - Running setup.py (path:/tmp/pip-56p9Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:59:40 INFO - Running setup.py install for manifestparser 08:59:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:59:40 INFO - Running setup.py install for mozcrash 08:59:40 INFO - Running setup.py install for mozdebug 08:59:40 INFO - Running setup.py install for mozdevice 08:59:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Running setup.py install for mozfile 08:59:41 INFO - Running setup.py install for mozhttpd 08:59:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Running setup.py install for mozinfo 08:59:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Running setup.py install for mozInstall 08:59:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Running setup.py install for mozleak 08:59:41 INFO - Running setup.py install for mozlog 08:59:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Running setup.py install for moznetwork 08:59:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Running setup.py install for mozprocess 08:59:41 INFO - Running setup.py install for mozprofile 08:59:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:59:41 INFO - Running setup.py install for mozrunner 08:59:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:59:42 INFO - Running setup.py install for mozscreenshot 08:59:42 INFO - Running setup.py install for moztest 08:59:42 INFO - Running setup.py install for mozversion 08:59:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:59:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:59:42 INFO - Cleaning up... 08:59:42 INFO - Return code: 0 08:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:42 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 08:59:42 INFO - 'HOME': '/home/cltbld', 08:59:42 INFO - 'LANG': 'en_US.UTF-8', 08:59:42 INFO - 'LANGUAGE': 'en_US:en', 08:59:42 INFO - 'LOGNAME': 'cltbld', 08:59:42 INFO - 'MAIL': '/var/mail/cltbld', 08:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:42 INFO - 'MOZ_NO_REMOTE': '1', 08:59:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:42 INFO - 'NO_EM_RESTART': '1', 08:59:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:42 INFO - 'PWD': '/builds/slave/test', 08:59:42 INFO - 'SHELL': '/bin/bash', 08:59:42 INFO - 'SHLVL': '1', 08:59:42 INFO - 'TERM': 'linux', 08:59:42 INFO - 'TMOUT': '86400', 08:59:42 INFO - 'USER': 'cltbld', 08:59:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:42 INFO - '_': '/tools/buildbot/bin/python'} 08:59:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:59:42 INFO - Running setup.py (path:/tmp/pip-PbuktN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:59:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:59:42 INFO - Running setup.py (path:/tmp/pip-ReKIMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:59:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:59:42 INFO - Running setup.py (path:/tmp/pip-dXKGv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:59:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:59:42 INFO - Running setup.py (path:/tmp/pip-7SChvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:59:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:59:42 INFO - Running setup.py (path:/tmp/pip-j3JeFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:59:43 INFO - Running setup.py (path:/tmp/pip-pss_NY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:59:43 INFO - Running setup.py (path:/tmp/pip-miQD0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:59:43 INFO - Running setup.py (path:/tmp/pip-RdEQ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:59:43 INFO - Running setup.py (path:/tmp/pip-wYwHlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:59:43 INFO - Running setup.py (path:/tmp/pip-7XIUfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:59:43 INFO - Running setup.py (path:/tmp/pip-pQUlfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:59:43 INFO - Running setup.py (path:/tmp/pip-8IFVI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:59:43 INFO - Running setup.py (path:/tmp/pip-B1YOz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:59:43 INFO - Running setup.py (path:/tmp/pip-eImSyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:43 INFO - Running setup.py (path:/tmp/pip-rVe3L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:59:43 INFO - Running setup.py (path:/tmp/pip-xHlizo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:59:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:59:43 INFO - Running setup.py (path:/tmp/pip-3_rCB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:59:43 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:43 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:43 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:43 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:43 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:43 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:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:59:43 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:43 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:43 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:43 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:43 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:43 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:45 INFO - Downloading blessings-1.6.tar.gz 08:59:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:59:45 INFO - Installing collected packages: blessings 08:59:45 INFO - Running setup.py install for blessings 08:59:46 INFO - Successfully installed blessings 08:59:46 INFO - Cleaning up... 08:59:46 INFO - Return code: 0 08:59:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:59:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:46 INFO - Reading from file tmpfile_stdout 08:59:46 INFO - Current package versions: 08:59:46 INFO - argparse == 1.2.1 08:59:46 INFO - blessings == 1.6 08:59:46 INFO - blobuploader == 1.2.4 08:59:46 INFO - docopt == 0.6.1 08:59:46 INFO - functools32 == 3.2.3-2 08:59:46 INFO - jsonschema == 2.5.1 08:59:46 INFO - manifestparser == 1.1 08:59:46 INFO - mozInstall == 1.12 08:59:46 INFO - mozcrash == 1.0 08:59:46 INFO - mozdebug == 0.1 08:59:46 INFO - mozdevice == 0.49 08:59:46 INFO - mozfile == 1.2 08:59:46 INFO - mozhttpd == 0.7 08:59:46 INFO - mozinfo == 0.9 08:59:46 INFO - mozleak == 0.1 08:59:46 INFO - mozlog == 3.4 08:59:46 INFO - moznetwork == 0.27 08:59:46 INFO - mozprocess == 0.23 08:59:46 INFO - mozprofile == 0.28 08:59:46 INFO - mozrunner == 6.13 08:59:46 INFO - mozscreenshot == 0.1 08:59:46 INFO - mozsystemmonitor == 0.3 08:59:46 INFO - moztest == 0.7 08:59:46 INFO - mozversion == 1.4 08:59:46 INFO - psutil == 3.1.1 08:59:46 INFO - requests == 1.2.3 08:59:46 INFO - wsgiref == 0.1.2 08:59:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:59:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:46 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:46 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:46 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:46 INFO - Using env: {'DISPLAY': ':0', 08:59:46 INFO - 'HOME': '/home/cltbld', 08:59:46 INFO - 'LANG': 'en_US.UTF-8', 08:59:46 INFO - 'LANGUAGE': 'en_US:en', 08:59:46 INFO - 'LOGNAME': 'cltbld', 08:59:46 INFO - 'MAIL': '/var/mail/cltbld', 08:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:46 INFO - 'MOZ_NO_REMOTE': '1', 08:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:46 INFO - 'NO_EM_RESTART': '1', 08:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:46 INFO - 'PWD': '/builds/slave/test', 08:59:46 INFO - 'SHELL': '/bin/bash', 08:59:46 INFO - 'SHLVL': '1', 08:59:46 INFO - 'TERM': 'linux', 08:59:46 INFO - 'TMOUT': '86400', 08:59:46 INFO - 'USER': 'cltbld', 08:59:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:46 INFO - '_': '/tools/buildbot/bin/python'} 08:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Cleaning up... 08:59:46 INFO - Return code: 0 08:59:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:59:46 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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:46 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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:59:46 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 0x7f787f3ffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x144fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15eb130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, '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': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', '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:46 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:46 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:46 INFO - Using env: {'DISPLAY': ':0', 08:59:46 INFO - 'HOME': '/home/cltbld', 08:59:46 INFO - 'LANG': 'en_US.UTF-8', 08:59:46 INFO - 'LANGUAGE': 'en_US:en', 08:59:46 INFO - 'LOGNAME': 'cltbld', 08:59:46 INFO - 'MAIL': '/var/mail/cltbld', 08:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:59:46 INFO - 'MOZ_NO_REMOTE': '1', 08:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:59:46 INFO - 'NO_EM_RESTART': '1', 08:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:59:46 INFO - 'PWD': '/builds/slave/test', 08:59:46 INFO - 'SHELL': '/bin/bash', 08:59:46 INFO - 'SHLVL': '1', 08:59:46 INFO - 'TERM': 'linux', 08:59:46 INFO - 'TMOUT': '86400', 08:59:46 INFO - 'USER': 'cltbld', 08:59:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 08:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:59:46 INFO - '_': '/tools/buildbot/bin/python'} 08:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:59:46 INFO - Cleaning up... 08:59:46 INFO - Return code: 0 08:59:46 INFO - Running post-action listener: _resource_record_post_action 08:59:46 INFO - Running post-action listener: _start_resource_monitoring 08:59:46 INFO - Starting resource monitoring. 08:59:46 INFO - [mozharness: 2016-11-22 16:59:46.847504Z] Finished create-virtualenv step (success) 08:59:46 INFO - [mozharness: 2016-11-22 16:59:46.848103Z] Running install step. 08:59:46 INFO - Running pre-action listener: _resource_record_pre_action 08:59:46 INFO - Running main action method: install 08:59:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:59:47 INFO - Reading from file tmpfile_stdout 08:59:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:59:47 INFO - Reading from file tmpfile_stdout 08:59:47 INFO - Output received: 08:59:47 INFO - Usage: mozinstall [options] installer 08:59:47 INFO - Options: 08:59:47 INFO - -h, --help show this help message and exit 08:59:47 INFO - -d DEST, --destination=DEST 08:59:47 INFO - Directory to install application into. [default: 08:59:47 INFO - "/builds/slave/test"] 08:59:47 INFO - --app=APP Application being installed. [default: firefox] 08:59:47 INFO - mkdir: /builds/slave/test/build/application 08:59:47 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:47 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:03 INFO - Reading from file tmpfile_stdout 09:00:03 INFO - Output received: 09:00:03 INFO - /builds/slave/test/build/application/firefox/firefox 09:00:03 INFO - Running post-action listener: _resource_record_post_action 09:00:03 INFO - [mozharness: 2016-11-22 17:00:03.498162Z] Finished install step (success) 09:00:03 INFO - [mozharness: 2016-11-22 17:00:03.498416Z] Running run-tests step. 09:00:03 INFO - Running pre-action listener: _resource_record_pre_action 09:00:03 INFO - Running main action method: run_tests 09:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:00:03 INFO - Python 2.7.3 09:00:03 INFO - Return code: 0 09:00:03 INFO - grabbing minidump binary from tooltool 09:00:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:00:03 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 0x1679fc0>, '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 0x167aec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x167b350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:00:03 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:03 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:03 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:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:00:03 INFO - Return code: 0 09:00:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:00:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:00:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:00:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:00:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:00:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:00:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:00:03 INFO - Using env: {'DISPLAY': ':0', 09:00:03 INFO - 'HOME': '/home/cltbld', 09:00:03 INFO - 'LANG': 'en_US.UTF-8', 09:00:03 INFO - 'LANGUAGE': 'en_US:en', 09:00:03 INFO - 'LOGNAME': 'cltbld', 09:00:03 INFO - 'MAIL': '/var/mail/cltbld', 09:00:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:00:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:03 INFO - 'MOZ_NO_REMOTE': '1', 09:00:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:00:03 INFO - 'NO_EM_RESTART': '1', 09:00:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:03 INFO - 'PWD': '/builds/slave/test', 09:00:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:00:03 INFO - 'SHELL': '/bin/bash', 09:00:03 INFO - 'SHLVL': '1', 09:00:03 INFO - 'TERM': 'linux', 09:00:03 INFO - 'TMOUT': '86400', 09:00:03 INFO - 'USER': 'cltbld', 09:00:03 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1479833945.321331-572435751', 09:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:03 INFO - '_': '/tools/buildbot/bin/python'} 09:00:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R87-E_obQnmawYH1QxIPtA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:00:03 INFO - mozversion application_buildid: 20161122080051 09:00:03 INFO - mozversion application_changeset: 5c755c22be9668a5e8d60e520c68601635243142 09:00:03 INFO - mozversion application_display_name: Nightly 09:00:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:00:03 INFO - mozversion application_name: Firefox 09:00:03 INFO - mozversion application_remotingname: firefox 09:00:03 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 09:00:03 INFO - mozversion application_vendor: Mozilla 09:00:03 INFO - mozversion application_version: 53.0a1 09:00:03 INFO - mozversion platform_buildid: 20161122080051 09:00:03 INFO - mozversion platform_changeset: 5c755c22be9668a5e8d60e520c68601635243142 09:00:03 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 09:00:03 INFO - mozversion platform_version: 53.0a1 09:00:03 INFO - using testdate: 1479834003 09:00:03 INFO - actual date: 1479834003 09:00:03 INFO - starting webserver on 'localhost:49387' 09:00:03 INFO - SUITE-START | Running 2 tests 09:00:03 INFO - TEST-START | dromaeo_css 09:00:03 INFO - operating with platform_type : linux_ 09:00:03 INFO - Initialising browser for dromaeo_css test... 09:00:03 INFO - TEST-INFO | started process 16437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM57e8G/profile http://localhost:49387/getInfo.html) 09:00:08 INFO - PROCESS | 16437 | __metrics Screen width/height:1600/1200 09:00:08 INFO - PROCESS | 16437 | colorDepth:24 09:00:08 INFO - PROCESS | 16437 | Browser inner width/height: 1024/697 09:00:08 INFO - PROCESS | 16437 | __metrics 09:00:09 ERROR - PROCESS | 16437 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 09:00:10 INFO - TEST-INFO | 16437: exit 0 09:00:10 INFO - Browser initialized. 09:00:10 INFO - Running cycle 1/1 for dromaeo_css test... 09:00:10 INFO - TEST-INFO | started process 16560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM57e8G/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:22 INFO - PROCESS | 16560 | RSS: Main: 186417152 09:00:22 INFO - PROCESS | 16560 | 09:01:12 INFO - PROCESS | 16560 | 1479834072452 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:26 INFO - PROCESS | 16560 | Cycle 1(1): loaded http://localhost:49387/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49387/tests/dromaeo/cssquery-ext.html) 09:03:28 INFO - PROCESS | 16560 | RSS: Main: 195567616 09:03:28 INFO - PROCESS | 16560 | 09:06:30 INFO - PROCESS | 16560 | Cycle 1(1): loaded http://localhost:49387/tests/dromaeo/cssquery-ext.html (next: http://localhost:49387/tests/dromaeo/cssquery-jquery.html) 09:06:31 INFO - PROCESS | 16560 | RSS: Main: 196661248 09:06:31 INFO - PROCESS | 16560 | 09:09:33 INFO - PROCESS | 16560 | Cycle 1(1): loaded http://localhost:49387/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49387/tests/dromaeo/cssquery-mootools.html) 09:09:33 INFO - PROCESS | 16560 | RSS: Main: 199098368 09:09:33 INFO - PROCESS | 16560 | 09:12:36 INFO - PROCESS | 16560 | Cycle 1(1): loaded http://localhost:49387/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49387/tests/dromaeo/cssquery-prototype.html) 09:12:36 INFO - PROCESS | 16560 | RSS: Main: 195637248 09:12:36 INFO - PROCESS | 16560 | 09:15:39 INFO - PROCESS | 16560 | Cycle 1(1): loaded http://localhost:49387/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49387/tests/dromaeo/cssquery-yui.html) 09:15:40 INFO - PROCESS | 16560 | RSS: Main: 199675904 09:15:40 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | Cycle 1(1): loaded http://localhost:49387/tests/dromaeo/cssquery-yui.html (next: http://localhost:49387/tests/dromaeo/cssquery-dojo.html) 09:18:43 INFO - PROCESS | 16560 | RSS: Main: 199131136 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | __start_tp_report 09:18:43 INFO - PROCESS | 16560 | _x_x_mozilla_page_load 09:18:43 INFO - PROCESS | 16560 | _x_x_mozilla_page_load_details 09:18:43 INFO - PROCESS | 16560 | |i|pagename|runs| 09:18:43 INFO - PROCESS | 16560 | |0;dojo.html;2602.3364042169246;2608.778253848423;2615.3200167956334;2626.080871694908;2646.4574762173756;4601.33280674302;4699.882502937428;4701.976490117549;4719.29210618407;4754.64340174487;4690.343351930733;4692.272697731849;4725.598324142444;4742.170120228963;4779.235322348425;4327.069680018795;4395.142947125312;4408.184485870124;4476.798544065525;4503.729776213421;3959.584243654418;4423.778811059434;4432.09142125865;4450.332450132473;4468.218061839181;4280.143971205771;4431.246688063037;4432.069265454258;4448.5773851484055;4476.373307736903;4311.33174357975;4352.412424322708;4361.062371590092;4365.257906155961;4366.01764602965;4305.935410968838;4309.698321117523;4335.6965012449145;4344.782760861945;4364.498082720496;4638.373819534353;4703.43558772946;4731.1720448921305;4739.691920025221;4751.168545504557;5080.49195080489;5083.923741143849;5084.211947148198;5084.542391184774;5099.87250318745;5063.797448102072;5111.463296353866;5127.359080114986;5132.769025393866;5153;4693.530646935279;4709.552592503706;4745.383100197021;4796.760161991956;4813.975930120327;5199.922001169985;5240.371155461369;5242.344706911636;5245.973770131125;5285.841424757264;4886.096072226649;5025.391874600166;5029.446760856303;5053.7220452875445;5058.038972595195;4987.276844857475;5010.549050585465;5032.270320803463;5035.0685123252315;5140.049090918192;5018.121828679967;5018.197088465828;5022.196448568285;5045.41977672565;5093.974530127326;4985.925211121836;5008.424031236382;5009.373828271466;5023.723695196726;5048.974755126274;4179.6029377209115;4220.936685949652;4240.791374458265;4265.4881414230495;4281.785910704452;3704.3147017801793;3742.158014446782;3747.3442147624055;3754.023953772039;3785.716071294664;4320.611144996966;4342.1532801103485;4362.411074504965;4365.105153443536;4409.867703968886;5018.698878067327;5057.494250574987;5102.591792656579;5107.948920510822;5125.15434953236;4250.06498570314;4287.099709061132;4291.699581029298;4326.956730432718;4354.499232588293;4514.909701805946;4543.386642803245;4543.61379282758;4544.2047641662575;4546.477155127137;4704.811807527729;4711.269753188193;4713.78787954536;4715.646326525456;4725.527447255247;4982.601391888567;5061.493850614909;5087.160618497906;5094.745262736922;5173.63784535094;4761.095391875532;4768.260919557474;4772.880677983078;4774.427068751772;4776.832810851603;4917.901641967069;4953.554180123806;4978.900421991612;5004.674696144739;5038.84883453497;5108.182690769459;5113.258577506315;5117.053345131163;5143.794248230029;5170.6380553362405;4951.727654978867;4953.034158339089;4957.157283261926;4965.875853103701;5008.57427118699;4838.225883858566;4900.26496025599;4901.436334821541;4937.506249375034;4946.530079642428;4725.243960966229;4792.329073929723;4805.831795887128;4808.374911261513;4859.538343857328;4863.124637565131;4890.413150421972;4895.241237608177;4938.901221975469;4978.27814966835;4783.95216047835;4793.161196790478;4832.855014349575;4838.661293709407;4906.55840974314 09:18:43 INFO - PROCESS | 16560 | |1;ext.html;511.491066388943;524.593440083935;527.243405712802;532.7762339817278;540.1034283090071;38721.225575488475;40306.59693403065;40382.79808600953;40387.99030024247;40487.392689109685;39508;39804.601953980455;39806;39919.600803991954;39928.60071399285;7487.850242995137;7512.774616761479;7537.962310188442;7579.886301705479;7602.885956710654;7388.150362708304;7433.293837085495;7443.441741869381;7468.066491688539;7469.551826890377;7452.813679657997;7457;7476.850462990737;7480.812979675497;7484.3638290745075;7416.40668746499;7432.62836858155;7462.141853686841;7463.029806125169;7464.888026679577;7472.17806041335;7489.28851759082;7508.924910750878;7552.848943021108;7554.8866766998535;37030.81484592587;37273;37276.254474910624;37344;37347.25305493902;2798.608194852722;2884.2356775454523;2917.2415172055207;3157.258044359574;3293.679816509215;24661.26016219516;28217.576736348972;28335.716642833515;28420.001996207164;28755.712442875723;3332.350191712617;3332.8333583320737;3398;3435.1927297085167;3466.4453687410146;169425.15287423483;169707;169793;170204;170910;49781.50218497841;50380.74809625928;50388.49611503911;50425.49574504208;50562.49437505578;31926.201844954063;33061.504077438854;33080.66919330824;52706;52782.20826687603;15028.924855375653;15250;15253.38986440552;15257.6185595361;15300.617484562976;10939.671809845717;11003.22977391591;11099.167562432849;11130.777384452427;11133.888661113448;17412.651746964988;17541.386051488138;17598.82401175972;17642.735358969625;17743.822561774476;6608;6787.864242715118;6825.590464572141;6869.141357330333;6999.090118284692;783.9843203135905;851.1913682002123;860.1269711243093;927.4157280913116;972.2173650211647;26860;27882.721172788417;28003.299917502227;28026.159215223575;28032.29919252035;938.1931538876561;945.6501094595044;974.5955428497094;994.7413672445216;1001.9649312274036;14386.136831789916;14725.337359818834;14735.778963315559;14875.33061012257;14973.550793476214;368646;372092;372276;372866;377130;47836;47870.76064619655;48076.7596162024;48394.75802621035;48467.27299090516;1114.5430373546808;1158.223989926751;1180.2918249050501;1184.4788293150987;1185.5909711149638;25428.364290892136;26303;26792.866035669696;27012.32469188286;27316.180514584594;40537.79731101326;40737.79631101825;40789.796051019555;40936;40969;302071;304051;304217;304524;304816;24221;24685.382865428506;24719;24721.50556988886;24760.87619561891;40041.799791000856;40869.38695919504;41455;42350.36474452824;45775;34982.65017349794;35211;35300.82349588236;35384.29231415409;35679.82160089183;35101.64898350984;35246.471302930986;35301.47047794337;35456;35459.64540354563;34037.48943765895;34141.65858341484;34759.304813904084;35076;35667.82166089153;26452.328824640637;30101.548476772427;31007.84496077505;31064.534031989086;31317.217069573442;23654.88172559126;23886.058800297757;24279;24419;24509.142180023613 09:18:43 INFO - PROCESS | 16560 | |2;jquery.html;366.36801517382503;371.6246590943147;372.6236501133855;378.9052736815796;393.6103257774802;15957.521274361774;16069.196540172989;17138.828611713896;17242.482725518224;17257.654846903053;16326.673466530692;16772;17173.313067477317;17242.39651612194;17291.654166916655;4934.457209706939;5144.408393034792;5168.5606723428555;5195.246689230078;5198.45416231296;4926.325049483175;5048.914483386071;5120.615953803461;5120.974395128038;5134.794608215686;5152.639315247934;5158.793648254065;5168.147255702824;5189.040027594888;5189.688618682872;4915.5084491550915;5036.420811606676;5094.541491265785;5098.694078355292;5100;4535.931961020588;4536.682432229745;4536.72779633223;4542.295944128666;4561.24739417999;19638.607227855508;20441.591168176554;20463.28378506745;20473.795262047486;20487;2012.426458459332;2080.6774949882642;2239.4065572623267;2447.192426499251;2448.1309135257084;11941.701457463632;12967.286799226038;13329.200247985054;13412.530561430303;14074.507392241325;1702.3445973300368;1775.2423505006577;1777.413453560335;1782.2247322414792;1796.3263776083968;68723;69458.65270673666;69915.3008469919;70310;71481;9278.768030799283;9346.672866449642;9851.359661621971;9925.950370248103;10096.758104738155;13102.475900963855;13126.868731312565;13151.553329133787;13160.670983225496;13166.275854828076;7281.235470275651;7404.333609975128;7471.9626401867645;7509.549427034286;7556.508826926232;7120.715171393086;7143;7222.125413855809;7321.267873212636;7387.409007279405;5970.164177015221;5999.820005399845;6041.486473649701;6072.60330124074;6108.3280839107665;1654.710425675502;1654.9338026479047;1688.4850120713054;1708.9401870934457;1731.1603872122012;792.3067316098413;853.5177624642057;915.6383228624655;921.8340698674303;989.8069876374038;15633;16387.426440074778;17053.48839534816;17473.47579572615;17571;858.1847245117038;864.1185990289869;882.2324577617513;893.0304795185339;946.2902822882838;9498.240140788721;9917.355371900803;10033.14718248957;10110.702951245692;10267.897321026694;362168;370264;371702;373444;375663;66807.33192668109;67780.3221967774;67868;67953.66023169852;69317.65341173262;887.4896934262824;892.4199270474114;916.876221710074;923.9076092390707;927.5779520318374;14922.85077149258;15074.472393466176;15714;15800.36798528046;15899.364025438854;35062.12344691403;35203.29593408066;35422;35444.82277588596;36108.63891361053;47664;48980.75509622429;50051;54967;55839;5326.41409444953;6213.099100630474;6339.4928405726505;7182.676779545038;7306.4520160989205;9598.42409455435;11563.537458501902;11629.534818607499;11716.824247636121;11759.764804703687;4820.734859582757;10182.389056656624;10256.333338332985;10365.481725913523;10503.949605039435;10180.083792458714;10356.896431035895;10360.896391036295;10375.636852710119;10550.314229575053;10261;10434.965181789477;10483;10563.260571759904;10742.744023755098;6766.391024807791;6771.492138089761;6804.965975170093;6923.688434020381;6984.092068031124;8067.394945379003;10210.234232432449;10472.581096756045;10518.158547316349;10621.468926553796 09:18:43 INFO - PROCESS | 16560 | |3;mootools.html;1311.429528155253;1341.9261940593267;1389.61785508985;1566.32258763186;1608.171791527363;6001.729922153502;6302.180716506848;6310.936890631092;6637.800865974028;6701.2963638817955;6358.68206589671;6575.14523111996;6580.506462015356;6607.504437167219;6696.866062678743;2008.2569449303742;2052.3535086447796;2052.9076191571417;2055.2498338106634;2056.8251698605636;2041.2549419461939;2084.2600876688784;2090.090810497431;2104.3055791588818;2112.302940029794;2031.9492012699652;2038.1337931379105;2065.215218217083;2069.2550681754556;2071.306112452323;2015.61703276377;2042.714020037196;2044.7852975437663;2047.0276618606192;2049.7745248022707;2019.989900050505;2034.7965203479534;2054.3939537836372;2061.196133507933;2062.886541240231;6562.114114594517;6581.769638062693;6596.43930265928;6608.438282745972;6651.534392592521;3975.920481590381;4125.401816736587;4145.730527515701;4172.18642364739;4178.373244013392;2563.346346681603;2712.8101032927702;2742.9862850685818;2762.2956146182796;2823.745862872351;777.529594595273;818.3902992270796;840.537704262653;844.2907957315884;845.623697454633;8779.64881404743;8810.295176385875;8828.470291782514;8866.379353445262;8925.776855578662;3582.697607540802;3654.3239500692457;3699.5930447650735;3718.758280711745;3763.736538442283;7548.622568871644;7569.848603027908;7608.125065617414;7615.124260709978;7637.847243055219;4233.729881035677;4240.957590424056;4241.1941731071;4244.660427165819;4245.724027938174;3396.9150771230916;3520.436730123219;3524;3889.416587511896;3901.7268791184347;3141.7643676724338;3189.9681003190135;3274.410606090879;3278.5901762279714;3339.3488269787645;1111.3609674437068;1134.3477500437282;1137.4312843578211;1150.206357613244;1178.876217997098;742.1279996004673;758.5827794712997;781.9022622172229;782.7866607575933;786.8819677048489;4423.248047831877;4453.77731113443;4463.285874260103;4529.38853254813;4539.7049191802425;370.34633871217324;395.7249711450514;398.85441813737776;401.77099053539786;408.58528593477644;2983.2690990707415;3034.8330841803913;3087;3137.9686203137676;3271.8527666255077;7673.769786906401;7969.242921922408;7971.521708697497;7992.960035199903;7995;7845.803854903559;7953.761387158394;7957.880631790527;7958.960205199052;7971.800704982422;6227.719752611143;6320.589161704383;6337.841553961096;6338.30278669346;6341.365863413622;4254.914901702011;4515.571020753023;4595.310703394518;4617.676762626584;4620.768961551842;7111.2533184017;7245.710171593288;7447.143578488543;7492.925070749223;7504.549727016397;7311.67097480604;7544.509606875536;7629;7630.4277179212895;7639.274268944441;5165.560927321069;5509.421510741315;5579.497845193952;5621.662700237999;5651.321841379061;5791.594588378773;6112.938870611415;6298.275698294755;6328.841778955379;6423.807285781434;5839.124131380327;5856.150858125633;5883.294004719461;5885.61743486672;5897.67562784051;5662.490375866027;5693.914591281051;5777.364489906191;5789.1605717171615;5813.186153938367;4936.111499929903;4990.476000019946;5062.088824011713;5248.422673505835;5277.973610131925;3641.10792855752;3669.5046168766876;3676.34564445995;3724.646158614927;3747.5502939646326;3923.509561304837;3959.148783011666;3992.4410582519054;4032.737872038308;4079.8776036718946 09:18:43 INFO - PROCESS | 16560 | |4;prototype.html;293.47907464250954;298.5506812247567;301.0306812065152;303.4719587917025;303.9665636779954;4884.169691152504;4904.681195722275;4921.458639549646;4923.753812309384;4942.629302802291;4775.403074615673;4846.41842978843;4846.975765121169;4859.829905953292;4871.683340582859;3556.6621170988715;3684.889453316405;3688.5389326334207;3796.734228603999;3859.5561510426237;3824.8087595620245;3824.9617503824884;3837.194189220267;3846.884593462187;3848;3800.20195758891;3800.5629352624524;3820.9426858597144;3838.2131663009154;3866.961330386688;3545.53907991962;3724.3296206682785;3834.213986132836;3840.193559352553;3851.9614803852023;3247.756418268639;3250.5697493103194;3261.804291742503;3285.211549228192;3291.374638818617;4692.530746925314;4701.976490117561;4745.786439610191;4754.453237877654;4779.330893674888;4251.6173544380845;4262.701610887239;4264.466941632296;4286.442762440894;4288.69979101463;4919;4986.925196122061;4990.777259571429;4992.400911890596;4996.750812296926;3523.224890524081;3528.3648943190215;3538.4607695652476;3542.822858857047;3544.167120726627;5192.428832828424;5262.421133675292;5295.814646487393;5298.920516192222;5305.389880163753;3499.0727457223857;3574.267275208628;3616.746827722034;3644.908877278089;3658.70730341572;3669.4404877926772;3682.6869716073898;3686.870959516458;3696.7227457940226;3703.5555733311635;4233.640140588023;4241.7879106044575;4244.405783190356;4251.149770045941;4264.402983582301;4958.454569997298;5087.524617860853;5092.719900405513;5106.825430151086;5134.743262836843;1227.7114878003663;1246.8441444819398;1254.5107408110844;1255.5229012975194;1261.0794120292237;852.6333676519156;852.6759831264204;855.8451346741239;865.4677373415304;867.6355930509201;4379.189849877719;4527.185106680829;4535.455745310584;4536.274196128669;4538.591526762607;5355.732213389393;5363.946360536423;5372.221027950925;5373.892522149535;5374.623776335698;4503.639708823286;4534.659900507475;4548.7725613719185;4555.794989225493;4585.72485650862;2624.5538258496103;2725.9182224533297;2761.6962134165224;2765.4192619549717;2772.9029483967965;4839.370881785416;4852.301694407;4853.538913803183;4858.7570621469495;4859.465458799529;5021.799128034911;5302.257683924254;5306.867328316823;5309.840704778863;5318.9628022535235;4733.2900064989835;4760.214564596803;4763.856264680908;4791.4906804356515;4793.952060479351;5168.328117344721;5177.378714554127;5180.844574662766;5192.922106168335;5199.844004679866;4904.945436730977;4994.275830004556;5078.339815823919;5102.209157580581;5115.462876397924;4746.810127594996;4752.691075080109;4754.690945088697;4762.690425122356;4799.880002999953;3544.80503572306;3556.4351685258403;3558.1816182277703;3570.821458927095;3619.5837478690287;5026.44709082008;5161.922571161511;5171.957341591918;5181.689098654093;5190.714510701948;4966.453690094159;4973.875653108701;4980.5019498049905;4980.551750342486;5023.974880125576;4952.975235123801;4962.751862406937;5010.549050585465;5055.5955523557295;5081.974590127025;4575.885602859955;4868.41579010521;4908.410990681141;4926.950730492649;4939.48135445773;4913.213885778258;4958.330625365674;4994.550490455877;5155.226715992481;5159.329287192641;5041.672291301201;5056.873578160428;5067.442581315979;5075.375879718455;5090.847274581768 09:18:43 INFO - PROCESS | 16560 | |5;yui.html;563.968981706006;591.3111225422383;648.8799572079164;658.7957733102736;659.1793217444283;11563.53745850166;12228.20516666416;12273.754524909507;12300.138990270685;12506.749865002694;11867.169298149132;11869.287842729442;11937.164398492087;11942.7611447771;11963.880361196407;765.8698021336386;772.8067983004249;773.134089819403;775.0892701076241;775.2015424113173;749.2844333661368;753.0737193252303;773.6711897443593;777.199484530934;777.7433446962489;806.9677212911477;807.1524898856206;808.870580707087;809.7004108479871;813.1868131868132;803.6142651527271;803.6865622407266;804.3082948664115;805.4603415711488;808;588.8557303460636;589.2163422647868;589.5048159545959;590.2592246730326;595.4670569839969;12352.38238088101;12367.814482782765;12391.380430978505;12442.937785311016;12455.314957677325;11196.944015279953;11212.495437705242;11297.887021129847;11714.004309633692;11931.94034029833;11065.336079835235;11113.666590002313;11124.888751112547;11143.944280278627;11405.144614153889;2964.170032390934;3068.1255842084897;3094.350186460846;3192.5530425740417;3844.5578758442857;50016;50586.241206381936;51000.97998040055;51186.48813511855;51635.22547161795;9116.225120864668;9222.677206297882;9339.439633622005;9365.953170234105;9370.424597364557;15970.9201453992;16694.58263543397;16878.156092195342;16888;16978.915105424392;6208.2239720034995;6224.906626400608;6253.468455181361;6283.842903927439;6599.868002639921;3398.0655319787256;3544.8404821783083;3642.4900513928073;3644;3670.4494325851338;2607.6088586712144;2686.9865650671622;2917.547780094089;3004.8497575121155;3049.1005153479778;524.2058281703223;535.6812696445609;538.1470369464442;541.7426722306873;548.4625067433938;522.7203446156365;532.5819231902938;552.6407834907343;559.4014404587134;561.9269494965629;7710.344620707303;7758.573278469626;7776.922230777733;7790.727324543614;7909.20907909216;504.23104765233313;506.59463524196906;509.1065180608009;513.7405610166917;524.7848382163295;3748.981255093707;3792.7534710243744;3822;3878.786666733357;3944.171723938005;57506.13740793891;67745;70847.6457617719;72172.2782772176;72728.63635681788;60929.69535152296;60979.39020609826;61598.38401615927;61815.38184618186;64663.353366466676;56119.71940140355;56332;56524.717376413675;57209.42790572041;57791.71104144453;7445.651631698022;7612.657430415534;7636.732714354971;7740.8451830964195;7788.610569471617;31587.684123158473;32318.515222272155;33109;35210.76762313307;39645.60354396419;40124;43218.35172472353;44976.32535512035;45110.32334515051;47284.52715472801;10147.819034872484;10171;10294.277875177087;10751.838722419327;10899.128069754559;11493.195476316912;11945.044396448437;12402.441890114786;12782.23306601607;12991.740165196454;11168.609098681507;11261.49323280438;11401.486933087865;11729.120315976164;11874.584389546324;11202.607908723156;11485.598004069818;11771.117166212398;11805.76388472243;12274.877251227374;9241.399309044891;9469.857952130586;9558.330916836034;9703.951480242837;9807.264455165749;9195.218406435528;9390.107939745712;9467;9711.27165462579;9938.10557049869;9472.857907131262;9675.951620241854;9762.365446246255;9812.116909478182;9833 09:18:43 INFO - PROCESS | 16560 | __end_tp_report 09:18:43 INFO - PROCESS | 16560 | __start_cc_report 09:18:43 INFO - PROCESS | 16560 | _x_x_mozilla_cycle_collect,345 09:18:43 INFO - PROCESS | 16560 | __end_cc_report 09:18:43 INFO - PROCESS | 16560 | __startTimestamp1479835123435__endTimestamp 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | ------- Summary: start ------- 09:18:43 INFO - PROCESS | 16560 | Number of tests: 6 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | [#0] dojo.html Cycles:165 Average:4675.20 Median:4776.83 stddev:498.43 (10.4%) stddev-sans-first:472.69 09:18:43 INFO - PROCESS | 16560 | Values: 2602.3 2608.8 2615.3 2626.1 2646.5 4601.3 4699.9 4702.0 4719.3 4754.6 4690.3 4692.3 4725.6 4742.2 4779.2 4327.1 4395.1 4408.2 4476.8 4503.7 3959.6 4423.8 4432.1 4450.3 4468.2 4280.1 4431.2 4432.1 4448.6 4476.4 4311.3 4352.4 4361.1 4365.3 4366.0 4305.9 4309.7 4335.7 4344.8 4364.5 4638.4 4703.4 4731.2 4739.7 4751.2 5080.5 5083.9 5084.2 5084.5 5099.9 5063.8 5111.5 5127.4 5132.8 5153.0 4693.5 4709.6 4745.4 4796.8 4814.0 5199.9 5240.4 5242.3 5246.0 5285.8 4886.1 5025.4 5029.4 5053.7 5058.0 4987.3 5010.5 5032.3 5035.1 5140.0 5018.1 5018.2 5022.2 5045.4 5094.0 4985.9 5008.4 5009.4 5023.7 5049.0 4179.6 4220.9 4240.8 4265.5 4281.8 3704.3 3742.2 3747.3 3754.0 3785.7 4320.6 4342.2 4362.4 4365.1 4409.9 5018.7 5057.5 5102.6 5107.9 5125.2 4250.1 4287.1 4291.7 4327.0 4354.5 4514.9 4543.4 4543.6 4544.2 4546.5 4704.8 4711.3 4713.8 4715.6 4725.5 4982.6 5061.5 5087.2 5094.7 5173.6 4761.1 4768.3 4772.9 4774.4 4776.8 4917.9 4953.6 4978.9 5004.7 5038.8 5108.2 5113.3 5117.1 5143.8 5170.6 4951.7 4953.0 4957.2 4965.9 5008.6 4838.2 4900.3 4901.4 4937.5 4946.5 4725.2 4792.3 4805.8 4808.4 4859.5 4863.1 4890.4 4895.2 4938.9 4978.3 4784.0 4793.2 4832.9 4838.7 4906.6 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | [#1] ext.html Cycles:180 Average:43461.38 Median:35457.82 stddev:77677.29 (219.1%) stddev-sans-first:77828.26 09:18:43 INFO - PROCESS | 16560 | Values: 511.5 524.6 527.2 532.8 540.1 38721.2 40306.6 40382.8 40388.0 40487.4 39508.0 39804.6 39806.0 39919.6 39928.6 7487.9 7512.8 7538.0 7579.9 7602.9 7388.2 7433.3 7443.4 7468.1 7469.6 7452.8 7457.0 7476.9 7480.8 7484.4 7416.4 7432.6 7462.1 7463.0 7464.9 7472.2 7489.3 7508.9 7552.8 7554.9 37030.8 37273.0 37276.3 37344.0 37347.3 2798.6 2884.2 2917.2 3157.3 3293.7 24661.3 28217.6 28335.7 28420.0 28755.7 3332.4 3332.8 3398.0 3435.2 3466.4 169425.2 169707.0 169793.0 170204.0 170910.0 49781.5 50380.7 50388.5 50425.5 50562.5 31926.2 33061.5 33080.7 52706.0 52782.2 15028.9 15250.0 15253.4 15257.6 15300.6 10939.7 11003.2 11099.2 11130.8 11133.9 17412.7 17541.4 17598.8 17642.7 17743.8 6608.0 6787.9 6825.6 6869.1 6999.1 784.0 851.2 860.1 927.4 972.2 26860.0 27882.7 28003.3 28026.2 28032.3 938.2 945.7 974.6 994.7 1002.0 14386.1 14725.3 14735.8 14875.3 14973.6 368646.0 372092.0 372276.0 372866.0 377130.0 47836.0 47870.8 48076.8 48394.8 48467.3 1114.5 1158.2 1180.3 1184.5 1185.6 25428.4 26303.0 26792.9 27012.3 27316.2 40537.8 40737.8 40789.8 40936.0 40969.0 302071.0 304051.0 304217.0 304524.0 304816.0 24221.0 24685.4 24719.0 24721.5 24760.9 40041.8 40869.4 41455.0 42350.4 45775.0 34982.7 35211.0 35300.8 35384.3 35679.8 35101.6 35246.5 35301.5 35456.0 35459.6 34037.5 34141.7 34759.3 35076.0 35667.8 26452.3 30101.5 31007.8 31064.5 31317.2 23654.9 23886.1 24279.0 24419.0 24509.1 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | [#2] jquery.html Cycles:180 Average:23524.14 Median:2464.77 stddev:61149.41 (2480.9%) stddev-sans-first:61296.23 09:18:43 INFO - PROCESS | 16560 | Values: 366.4 371.6 372.6 378.9 393.6 15957.5 16069.2 17138.8 17242.5 17257.7 16326.7 16772.0 17173.3 17242.4 17291.7 4934.5 5144.4 5168.6 5195.2 5198.5 4926.3 5048.9 5120.6 5121.0 5134.8 5152.6 5158.8 5168.1 5189.0 5189.7 4915.5 5036.4 5094.5 5098.7 5100.0 4535.9 4536.7 4536.7 4542.3 4561.2 19638.6 20441.6 20463.3 20473.8 20487.0 2012.4 2080.7 2239.4 2447.2 2448.1 11941.7 12967.3 13329.2 13412.5 14074.5 1702.3 1775.2 1777.4 1782.2 1796.3 68723.0 69458.7 69915.3 70310.0 71481.0 9278.8 9346.7 9851.4 9926.0 10096.8 13102.5 13126.9 13151.6 13160.7 13166.3 7281.2 7404.3 7472.0 7509.5 7556.5 7120.7 7143.0 7222.1 7321.3 7387.4 5970.2 5999.8 6041.5 6072.6 6108.3 1654.7 1654.9 1688.5 1708.9 1731.2 792.3 853.5 915.6 921.8 989.8 15633.0 16387.4 17053.5 17473.5 17571.0 858.2 864.1 882.2 893.0 946.3 9498.2 9917.4 10033.1 10110.7 10267.9 362168.0 370264.0 371702.0 373444.0 375663.0 66807.3 67780.3 67868.0 67953.7 69317.7 887.5 892.4 916.9 923.9 927.6 14922.9 15074.5 15714.0 15800.4 15899.4 35062.1 35203.3 35422.0 35444.8 36108.6 47664.0 48980.8 50051.0 54967.0 55839.0 5326.4 6213.1 6339.5 7182.7 7306.5 9598.4 11563.5 11629.5 11716.8 11759.8 4820.7 10182.4 10256.3 10365.5 10503.9 10180.1 10356.9 10360.9 10375.6 10550.3 10261.0 10435.0 10483.0 10563.3 10742.7 6766.4 6771.5 6805.0 6923.7 6984.1 8067.4 10210.2 10472.6 10518.2 10621.5 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | [#3] mootools.html Cycles:180 Average:4383.24 Median:4534.55 stddev:2342.86 (51.7%) stddev-sans-first:2338.06 09:18:43 INFO - PROCESS | 16560 | Values: 1311.4 1341.9 1389.6 1566.3 1608.2 6001.7 6302.2 6310.9 6637.8 6701.3 6358.7 6575.1 6580.5 6607.5 6696.9 2008.3 2052.4 2052.9 2055.2 2056.8 2041.3 2084.3 2090.1 2104.3 2112.3 2031.9 2038.1 2065.2 2069.3 2071.3 2015.6 2042.7 2044.8 2047.0 2049.8 2020.0 2034.8 2054.4 2061.2 2062.9 6562.1 6581.8 6596.4 6608.4 6651.5 3975.9 4125.4 4145.7 4172.2 4178.4 2563.3 2712.8 2743.0 2762.3 2823.7 777.5 818.4 840.5 844.3 845.6 8779.6 8810.3 8828.5 8866.4 8925.8 3582.7 3654.3 3699.6 3718.8 3763.7 7548.6 7569.8 7608.1 7615.1 7637.8 4233.7 4241.0 4241.2 4244.7 4245.7 3396.9 3520.4 3524.0 3889.4 3901.7 3141.8 3190.0 3274.4 3278.6 3339.3 1111.4 1134.3 1137.4 1150.2 1178.9 742.1 758.6 781.9 782.8 786.9 4423.2 4453.8 4463.3 4529.4 4539.7 370.3 395.7 398.9 401.8 408.6 2983.3 3034.8 3087.0 3138.0 3271.9 7673.8 7969.2 7971.5 7993.0 7995.0 7845.8 7953.8 7957.9 7959.0 7971.8 6227.7 6320.6 6337.8 6338.3 6341.4 4254.9 4515.6 4595.3 4617.7 4620.8 7111.3 7245.7 7447.1 7492.9 7504.5 7311.7 7544.5 7629.0 7630.4 7639.3 5165.6 5509.4 5579.5 5621.7 5651.3 5791.6 6112.9 6298.3 6328.8 6423.8 5839.1 5856.2 5883.3 5885.6 5897.7 5662.5 5693.9 5777.4 5789.2 5813.2 4936.1 4990.5 5062.1 5248.4 5278.0 3641.1 3669.5 3676.3 3724.6 3747.6 3923.5 3959.1 3992.4 4032.7 4079.9 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | [#4] prototype.html Cycles:180 Average:4184.32 Median:4763.27 stddev:1223.13 (25.7%) stddev-sans-first:1191.19 09:18:43 INFO - PROCESS | 16560 | Values: 293.5 298.6 301.0 303.5 304.0 4884.2 4904.7 4921.5 4923.8 4942.6 4775.4 4846.4 4847.0 4859.8 4871.7 3556.7 3684.9 3688.5 3796.7 3859.6 3824.8 3825.0 3837.2 3846.9 3848.0 3800.2 3800.6 3820.9 3838.2 3867.0 3545.5 3724.3 3834.2 3840.2 3852.0 3247.8 3250.6 3261.8 3285.2 3291.4 4692.5 4702.0 4745.8 4754.5 4779.3 4251.6 4262.7 4264.5 4286.4 4288.7 4919.0 4986.9 4990.8 4992.4 4996.8 3523.2 3528.4 3538.5 3542.8 3544.2 5192.4 5262.4 5295.8 5298.9 5305.4 3499.1 3574.3 3616.7 3644.9 3658.7 3669.4 3682.7 3686.9 3696.7 3703.6 4233.6 4241.8 4244.4 4251.1 4264.4 4958.5 5087.5 5092.7 5106.8 5134.7 1227.7 1246.8 1254.5 1255.5 1261.1 852.6 852.7 855.8 865.5 867.6 4379.2 4527.2 4535.5 4536.3 4538.6 5355.7 5363.9 5372.2 5373.9 5374.6 4503.6 4534.7 4548.8 4555.8 4585.7 2624.6 2725.9 2761.7 2765.4 2772.9 4839.4 4852.3 4853.5 4858.8 4859.5 5021.8 5302.3 5306.9 5309.8 5319.0 4733.3 4760.2 4763.9 4791.5 4794.0 5168.3 5177.4 5180.8 5192.9 5199.8 4904.9 4994.3 5078.3 5102.2 5115.5 4746.8 4752.7 4754.7 4762.7 4799.9 3544.8 3556.4 3558.2 3570.8 3619.6 5026.4 5161.9 5172.0 5181.7 5190.7 4966.5 4973.9 4980.5 4980.6 5024.0 4953.0 4962.8 5010.5 5055.6 5082.0 4575.9 4868.4 4908.4 4927.0 4939.5 4913.2 4958.3 4994.6 5155.2 5159.3 5041.7 5056.9 5067.4 5075.4 5090.8 09:18:43 INFO - PROCESS | 16560 | 09:18:43 INFO - PROCESS | 16560 | [#5] yui.html Cycles:180 Average:14374.63 Median:524.50 stddev:18408.58 (3509.8%) stddev-sans-first:18431.01 09:18:43 INFO - PROCESS | 16560 | Values: 564.0 591.3 648.9 658.8 659.2 11563.5 12228.2 12273.8 12300.1 12506.7 11867.2 11869.3 11937.2 11942.8 11963.9 765.9 772.8 773.1 775.1 775.2 749.3 753.1 773.7 777.2 777.7 807.0 807.2 808.9 809.7 813.2 803.6 803.7 804.3 805.5 808.0 588.9 589.2 589.5 590.3 595.5 12352.4 12367.8 12391.4 12442.9 12455.3 11196.9 11212.5 11297.9 11714.0 11931.9 11065.3 11113.7 11124.9 11143.9 11405.1 2964.2 3068.1 3094.4 3192.6 3844.6 50016.0 50586.2 51001.0 51186.5 51635.2 9116.2 9222.7 9339.4 9366.0 9370.4 15970.9 16694.6 16878.2 16888.0 16978.9 6208.2 6224.9 6253.5 6283.8 6599.9 3398.1 3544.8 3642.5 3644.0 3670.4 2607.6 2687.0 2917.5 3004.8 3049.1 524.2 535.7 538.1 541.7 548.5 522.7 532.6 552.6 559.4 561.9 7710.3 7758.6 7776.9 7790.7 7909.2 504.2 506.6 509.1 513.7 524.8 3749.0 3792.8 3822.0 3878.8 3944.2 57506.1 67745.0 70847.6 72172.3 72728.6 60929.7 60979.4 61598.4 61815.4 64663.4 56119.7 56332.0 56524.7 57209.4 57791.7 7445.7 7612.7 7636.7 7740.8 7788.6 31587.7 32318.5 33109.0 35210.8 39645.6 40124.0 43218.4 44976.3 45110.3 47284.5 10147.8 10171.0 10294.3 10751.8 10899.1 11493.2 11945.0 12402.4 12782.2 12991.7 11168.6 11261.5 11401.5 11729.1 11874.6 11202.6 11485.6 11771.1 11805.8 12274.9 9241.4 9469.9 9558.3 9704.0 9807.3 9195.2 9390.1 9467.0 9711.3 9938.1 9472.9 9676.0 9762.4 9812.1 9833.0 09:18:43 INFO - PROCESS | 16560 | -------- Summary: end -------- 09:18:43 INFO - PROCESS | 16560 | 09:18:44 INFO - TEST-INFO | 16560: exit 0 09:18:44 INFO - TEST-OK | dromaeo_css | took 1120733ms 09:18:44 INFO - TEST-START | kraken 09:18:44 INFO - operating with platform_type : linux_ 09:18:44 INFO - Initialising browser for kraken test... 09:18:44 INFO - TEST-INFO | started process 16924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUC3iWc/profile http://localhost:49387/getInfo.html) 09:18:49 INFO - PROCESS | 16924 | __metrics Screen width/height:1600/1200 09:18:49 INFO - PROCESS | 16924 | colorDepth:24 09:18:49 INFO - PROCESS | 16924 | Browser inner width/height: 1024/697 09:18:49 INFO - PROCESS | 16924 | __metrics 09:18:49 ERROR - PROCESS | 16924 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3198: TypeError: this.tabs is undefined 09:18:51 INFO - TEST-INFO | 16924: exit 0 09:18:51 INFO - Browser initialized. 09:18:51 INFO - Running cycle 1/1 for kraken test... 09:18:51 INFO - TEST-INFO | started process 17049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUC3iWc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:19:03 INFO - PROCESS | 17049 | RSS: Main: 186957824 09:19:03 INFO - PROCESS | 17049 | 09:19:06 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49387/tests/kraken/driver.html?testName=audio-beat-detection) 09:19:07 INFO - PROCESS | 17049 | RSS: Main: 199667712 09:19:07 INFO - PROCESS | 17049 | 09:19:10 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49387/tests/kraken/driver.html?testName=audio-dft) 09:19:10 INFO - PROCESS | 17049 | RSS: Main: 197447680 09:19:10 INFO - PROCESS | 17049 | 09:19:13 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49387/tests/kraken/driver.html?testName=audio-fft) 09:19:14 INFO - PROCESS | 17049 | RSS: Main: 194142208 09:19:14 INFO - PROCESS | 17049 | 09:19:16 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49387/tests/kraken/driver.html?testName=audio-oscillator) 09:19:17 INFO - PROCESS | 17049 | RSS: Main: 194396160 09:19:17 INFO - PROCESS | 17049 | 09:19:19 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49387/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:19:19 INFO - PROCESS | 17049 | RSS: Main: 194699264 09:19:19 INFO - PROCESS | 17049 | 09:19:23 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49387/tests/kraken/driver.html?testName=imaging-darkroom) 09:19:23 INFO - PROCESS | 17049 | RSS: Main: 199692288 09:19:23 INFO - PROCESS | 17049 | 09:19:27 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49387/tests/kraken/driver.html?testName=imaging-desaturate) 09:19:27 INFO - PROCESS | 17049 | RSS: Main: 195960832 09:19:27 INFO - PROCESS | 17049 | 09:19:30 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49387/tests/kraken/driver.html?testName=json-parse-financial) 09:19:31 INFO - PROCESS | 17049 | RSS: Main: 197844992 09:19:31 INFO - PROCESS | 17049 | 09:19:33 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49387/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:19:33 INFO - PROCESS | 17049 | RSS: Main: 197709824 09:19:33 INFO - PROCESS | 17049 | 09:19:35 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:19:36 INFO - PROCESS | 17049 | RSS: Main: 197783552 09:19:36 INFO - PROCESS | 17049 | 09:19:38 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:19:39 INFO - PROCESS | 17049 | RSS: Main: 197656576 09:19:39 INFO - PROCESS | 17049 | 09:19:42 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:19:43 INFO - PROCESS | 17049 | RSS: Main: 198090752 09:19:43 INFO - PROCESS | 17049 | 09:19:46 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:19:46 INFO - PROCESS | 17049 | RSS: Main: 197681152 09:19:46 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | Cycle 1(1): loaded http://localhost:49387/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49387/tests/kraken/driver.html?testName=ai-astar) 09:19:48 INFO - PROCESS | 17049 | RSS: Main: 200384512 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | __start_tp_report 09:19:48 INFO - PROCESS | 17049 | _x_x_mozilla_page_load 09:19:48 INFO - PROCESS | 17049 | _x_x_mozilla_page_load_details 09:19:48 INFO - PROCESS | 17049 | |i|pagename|runs| 09:19:48 INFO - PROCESS | 17049 | |0;ai-astar;110;120;120;119;118;117;118;118;120;119 09:19:48 INFO - PROCESS | 17049 | |1;audio-beat-detection;160;132;133;177;141;140;135;133;167;136 09:19:48 INFO - PROCESS | 17049 | |2;audio-dft;167;175;167;165;165;164;166;166;166;165 09:19:48 INFO - PROCESS | 17049 | |3;audio-fft;77;76;77;107;78;79;78;78;112;78 09:19:48 INFO - PROCESS | 17049 | |4;audio-oscillator;86;86;114;87;86;85;104;85;86;112 09:19:48 INFO - PROCESS | 17049 | |5;imaging-gaussian-blur;120;121;121;124;119;119;119;121;120;119 09:19:48 INFO - PROCESS | 17049 | |6;imaging-darkroom;150;151;148;149;150;150;149;148;150;149 09:19:48 INFO - PROCESS | 17049 | |7;imaging-desaturate;96;97;96;97;98;97;96;96;97;96 09:19:48 INFO - PROCESS | 17049 | |8;json-parse-financial;66;67;69;69;68;68;69;69;75;68 09:19:48 INFO - PROCESS | 17049 | |9;json-stringify-tinderbox;66;66;67;71;67;68;66;67;71;70 09:19:48 INFO - PROCESS | 17049 | |10;stanford-crypto-aes;88;87;88;87;86;88;87;86;88;87 09:19:48 INFO - PROCESS | 17049 | |11;stanford-crypto-ccm;171;164;159;149;157;147;160;151;185;162 09:19:48 INFO - PROCESS | 17049 | |12;stanford-crypto-pbkdf2;195;188;188;183;184;189;194;192;189;184 09:19:48 INFO - PROCESS | 17049 | |13;stanford-crypto-sha256-iterative;71;73;75;72;72;70;71;74;69;71 09:19:48 INFO - PROCESS | 17049 | __end_tp_report 09:19:48 INFO - PROCESS | 17049 | __start_cc_report 09:19:48 INFO - PROCESS | 17049 | _x_x_mozilla_cycle_collect,873 09:19:48 INFO - PROCESS | 17049 | __end_cc_report 09:19:48 INFO - PROCESS | 17049 | __startTimestamp1479835188944__endTimestamp 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | ------- Summary: start ------- 09:19:48 INFO - PROCESS | 17049 | Number of tests: 14 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#0] ai-astar Cycles:10 Average:117.90 Median:119.00 stddev:2.96 (2.5%) stddev-sans-first:1.09 09:19:48 INFO - PROCESS | 17049 | Values: 110.0 120.0 120.0 119.0 118.0 117.0 118.0 118.0 120.0 119.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:140.50 stddev:16.37 (11.6%) stddev-sans-first:16.48 09:19:48 INFO - PROCESS | 17049 | Values: 160.0 132.0 133.0 177.0 141.0 140.0 135.0 133.0 167.0 136.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#2] audio-dft Cycles:10 Average:166.60 Median:166.00 stddev:3.10 (1.9%) stddev-sans-first:3.28 09:19:48 INFO - PROCESS | 17049 | Values: 167.0 175.0 167.0 165.0 165.0 164.0 166.0 166.0 166.0 165.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#3] audio-fft Cycles:10 Average:84.00 Median:78.00 stddev:13.52 (17.3%) stddev-sans-first:14.10 09:19:48 INFO - PROCESS | 17049 | Values: 77.0 76.0 77.0 107.0 78.0 79.0 78.0 78.0 112.0 78.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:86.00 stddev:11.94 (13.9%) stddev-sans-first:12.38 09:19:48 INFO - PROCESS | 17049 | Values: 86.0 86.0 114.0 87.0 86.0 85.0 104.0 85.0 86.0 112.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#5] imaging-gaussian-blur Cycles:10 Average:120.30 Median:120.50 stddev:1.57 (1.3%) stddev-sans-first:1.66 09:19:48 INFO - PROCESS | 17049 | Values: 120.0 121.0 121.0 124.0 119.0 119.0 119.0 121.0 120.0 119.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:150.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 09:19:48 INFO - PROCESS | 17049 | Values: 150.0 151.0 148.0 149.0 150.0 150.0 149.0 148.0 150.0 149.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 09:19:48 INFO - PROCESS | 17049 | Values: 96.0 97.0 96.0 97.0 98.0 97.0 96.0 96.0 97.0 96.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:69.00 stddev:2.39 (3.5%) stddev-sans-first:2.32 09:19:48 INFO - PROCESS | 17049 | Values: 66.0 67.0 69.0 69.0 68.0 68.0 69.0 69.0 75.0 68.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:67.50 stddev:2.02 (3.0%) stddev-sans-first:2.03 09:19:48 INFO - PROCESS | 17049 | Values: 66.0 66.0 67.0 71.0 67.0 68.0 66.0 67.0 71.0 70.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:87.50 stddev:0.79 (0.9%) stddev-sans-first:0.78 09:19:48 INFO - PROCESS | 17049 | Values: 88.0 87.0 88.0 87.0 86.0 88.0 87.0 86.0 88.0 87.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#11] stanford-crypto-ccm Cycles:10 Average:160.50 Median:161.00 stddev:11.28 (7.0%) stddev-sans-first:11.30 09:19:48 INFO - PROCESS | 17049 | Values: 171.0 164.0 159.0 149.0 157.0 147.0 160.0 151.0 185.0 162.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.60 Median:189.00 stddev:4.17 (2.2%) stddev-sans-first:3.72 09:19:48 INFO - PROCESS | 17049 | Values: 195.0 188.0 188.0 183.0 184.0 189.0 194.0 192.0 189.0 184.0 09:19:48 INFO - PROCESS | 17049 | 09:19:48 INFO - PROCESS | 17049 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:1.81 (2.5%) stddev-sans-first:1.90 09:19:48 INFO - PROCESS | 17049 | Values: 71.0 73.0 75.0 72.0 72.0 70.0 71.0 74.0 69.0 71.0 09:19:48 INFO - PROCESS | 17049 | -------- Summary: end -------- 09:19:48 INFO - PROCESS | 17049 | 09:19:50 INFO - TEST-INFO | 17049: exit 0 09:19:50 INFO - TEST-OK | kraken | took 65735ms 09:19:50 INFO - SUITE-END | took 1186s 09:19:50 INFO - Completed test suite (00:19:46) 09:19:50 INFO - javascript benchmark 09:19:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6101.570659132341, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.3364042169246, 2608.778253848423, 2615.3200167956334, 2626.080871694908, 2646.4574762173756, 4601.33280674302, 4699.882502937428, 4701.976490117549, 4719.29210618407, 4754.64340174487, 4690.343351930733, 4692.272697731849, 4725.598324142444, 4742.170120228963, 4779.235322348425, 4327.069680018795, 4395.142947125312, 4408.184485870124, 4476.798544065525, 4503.729776213421, 3959.584243654418, 4423.778811059434, 4432.09142125865, 4450.332450132473, 4468.218061839181, 4280.143971205771, 4431.246688063037, 4432.069265454258, 4448.5773851484055, 4476.373307736903, 4311.33174357975, 4352.412424322708, 4361.062371590092, 4365.257906155961, 4366.01764602965, 4305.935410968838, 4309.698321117523, 4335.6965012449145, 4344.782760861945, 4364.498082720496, 4638.373819534353, 4703.43558772946, 4731.1720448921305, 4739.691920025221, 4751.168545504557, 5080.49195080489, 5083.923741143849, 5084.211947148198, 5084.542391184774, 5099.87250318745, 5063.797448102072, 5111.463296353866, 5127.359080114986, 5132.769025393866, 5153.0, 4693.530646935279, 4709.552592503706, 4745.383100197021, 4796.760161991956, 4813.975930120327, 5199.922001169985, 5240.371155461369, 5242.344706911636, 5245.973770131125, 5285.841424757264, 4886.096072226649, 5025.391874600166, 5029.446760856303, 5053.7220452875445, 5058.038972595195, 4987.276844857475, 5010.549050585465, 5032.270320803463, 5035.0685123252315, 5140.049090918192, 5018.121828679967, 5018.197088465828, 5022.196448568285, 5045.41977672565, 5093.974530127326, 4985.925211121836, 5008.424031236382, 5009.373828271466, 5023.723695196726, 5048.974755126274, 4179.6029377209115, 4220.936685949652, 4240.791374458265, 4265.4881414230495, 4281.785910704452, 3704.3147017801793, 3742.158014446782, 3747.3442147624055, 3754.023953772039, 3785.716071294664, 4320.611144996966, 4342.1532801103485, 4362.411074504965, 4365.105153443536, 4409.867703968886, 5018.698878067327, 5057.494250574987, 5102.591792656579, 5107.948920510822, 5125.15434953236, 4250.06498570314, 4287.099709061132, 4291.699581029298, 4326.956730432718, 4354.499232588293, 4514.909701805946, 4543.386642803245, 4543.61379282758, 4544.2047641662575, 4546.477155127137, 4704.811807527729, 4711.269753188193, 4713.78787954536, 4715.646326525456, 4725.527447255247, 4982.601391888567, 5061.493850614909, 5087.160618497906, 5094.745262736922, 5173.63784535094, 4761.095391875532, 4768.260919557474, 4772.880677983078, 4774.427068751772, 4776.832810851603, 4917.901641967069, 4953.554180123806, 4978.900421991612, 5004.674696144739, 5038.84883453497, 5108.182690769459, 5113.258577506315, 5117.053345131163, 5143.794248230029, 5170.6380553362405, 4951.727654978867, 4953.034158339089, 4957.157283261926, 4965.875853103701, 5008.57427118699, 4838.225883858566, 4900.26496025599, 4901.436334821541, 4937.506249375034, 4946.530079642428, 4725.243960966229, 4792.329073929723, 4805.831795887128, 4808.374911261513, 4859.538343857328, 4863.124637565131, 4890.413150421972, 4895.241237608177, 4938.901221975469, 4978.27814966835, 4783.95216047835, 4793.161196790478, 4832.855014349575, 4838.661293709407, 4906.55840974314], "value": 4642.876488151641, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.491066388943, 524.593440083935, 527.243405712802, 532.7762339817278, 540.1034283090071, 38721.225575488475, 40306.59693403065, 40382.79808600953, 40387.99030024247, 40487.392689109685, 39508.0, 39804.601953980455, 39806.0, 39919.600803991954, 39928.60071399285, 7487.850242995137, 7512.774616761479, 7537.962310188442, 7579.886301705479, 7602.885956710654, 7388.150362708304, 7433.293837085495, 7443.441741869381, 7468.066491688539, 7469.551826890377, 7452.813679657997, 7457.0, 7476.850462990737, 7480.812979675497, 7484.3638290745075, 7416.40668746499, 7432.62836858155, 7462.141853686841, 7463.029806125169, 7464.888026679577, 7472.17806041335, 7489.28851759082, 7508.924910750878, 7552.848943021108, 7554.8866766998535, 37030.81484592587, 37273.0, 37276.254474910624, 37344.0, 37347.25305493902, 2798.608194852722, 2884.2356775454523, 2917.2415172055207, 3157.258044359574, 3293.679816509215, 24661.26016219516, 28217.576736348972, 28335.716642833515, 28420.001996207164, 28755.712442875723, 3332.350191712617, 3332.8333583320737, 3398.0, 3435.1927297085167, 3466.4453687410146, 169425.15287423483, 169707.0, 169793.0, 170204.0, 170910.0, 49781.50218497841, 50380.74809625928, 50388.49611503911, 50425.49574504208, 50562.49437505578, 31926.201844954063, 33061.504077438854, 33080.66919330824, 52706.0, 52782.20826687603, 15028.924855375653, 15250.0, 15253.38986440552, 15257.6185595361, 15300.617484562976, 10939.671809845717, 11003.22977391591, 11099.167562432849, 11130.777384452427, 11133.888661113448, 17412.651746964988, 17541.386051488138, 17598.82401175972, 17642.735358969625, 17743.822561774476, 6608.0, 6787.864242715118, 6825.590464572141, 6869.141357330333, 6999.090118284692, 783.9843203135905, 851.1913682002123, 860.1269711243093, 927.4157280913116, 972.2173650211647, 26860.0, 27882.721172788417, 28003.299917502227, 28026.159215223575, 28032.29919252035, 938.1931538876561, 945.6501094595044, 974.5955428497094, 994.7413672445216, 1001.9649312274036, 14386.136831789916, 14725.337359818834, 14735.778963315559, 14875.33061012257, 14973.550793476214, 368646.0, 372092.0, 372276.0, 372866.0, 377130.0, 47836.0, 47870.76064619655, 48076.7596162024, 48394.75802621035, 48467.27299090516, 1114.5430373546808, 1158.223989926751, 1180.2918249050501, 1184.4788293150987, 1185.5909711149638, 25428.364290892136, 26303.0, 26792.866035669696, 27012.32469188286, 27316.180514584594, 40537.79731101326, 40737.79631101825, 40789.796051019555, 40936.0, 40969.0, 302071.0, 304051.0, 304217.0, 304524.0, 304816.0, 24221.0, 24685.382865428506, 24719.0, 24721.50556988886, 24760.87619561891, 40041.799791000856, 40869.38695919504, 41455.0, 42350.36474452824, 45775.0, 34982.65017349794, 35211.0, 35300.82349588236, 35384.29231415409, 35679.82160089183, 35101.64898350984, 35246.471302930986, 35301.47047794337, 35456.0, 35459.64540354563, 34037.48943765895, 34141.65858341484, 34759.304813904084, 35076.0, 35667.82166089153, 26452.328824640637, 30101.548476772427, 31007.84496077505, 31064.534031989086, 31317.217069573442, 23654.88172559126, 23886.058800297757, 24279.0, 24419.0, 24509.142180023613], "value": 16744.50200718191, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.36801517382503, 371.6246590943147, 372.6236501133855, 378.9052736815796, 393.6103257774802, 15957.521274361774, 16069.196540172989, 17138.828611713896, 17242.482725518224, 17257.654846903053, 16326.673466530692, 16772.0, 17173.313067477317, 17242.39651612194, 17291.654166916655, 4934.457209706939, 5144.408393034792, 5168.5606723428555, 5195.246689230078, 5198.45416231296, 4926.325049483175, 5048.914483386071, 5120.615953803461, 5120.974395128038, 5134.794608215686, 5152.639315247934, 5158.793648254065, 5168.147255702824, 5189.040027594888, 5189.688618682872, 4915.5084491550915, 5036.420811606676, 5094.541491265785, 5098.694078355292, 5100.0, 4535.931961020588, 4536.682432229745, 4536.72779633223, 4542.295944128666, 4561.24739417999, 19638.607227855508, 20441.591168176554, 20463.28378506745, 20473.795262047486, 20487.0, 2012.426458459332, 2080.6774949882642, 2239.4065572623267, 2447.192426499251, 2448.1309135257084, 11941.701457463632, 12967.286799226038, 13329.200247985054, 13412.530561430303, 14074.507392241325, 1702.3445973300368, 1775.2423505006577, 1777.413453560335, 1782.2247322414792, 1796.3263776083968, 68723.0, 69458.65270673666, 69915.3008469919, 70310.0, 71481.0, 9278.768030799283, 9346.672866449642, 9851.359661621971, 9925.950370248103, 10096.758104738155, 13102.475900963855, 13126.868731312565, 13151.553329133787, 13160.670983225496, 13166.275854828076, 7281.235470275651, 7404.333609975128, 7471.9626401867645, 7509.549427034286, 7556.508826926232, 7120.715171393086, 7143.0, 7222.125413855809, 7321.267873212636, 7387.409007279405, 5970.164177015221, 5999.820005399845, 6041.486473649701, 6072.60330124074, 6108.3280839107665, 1654.710425675502, 1654.9338026479047, 1688.4850120713054, 1708.9401870934457, 1731.1603872122012, 792.3067316098413, 853.5177624642057, 915.6383228624655, 921.8340698674303, 989.8069876374038, 15633.0, 16387.426440074778, 17053.48839534816, 17473.47579572615, 17571.0, 858.1847245117038, 864.1185990289869, 882.2324577617513, 893.0304795185339, 946.2902822882838, 9498.240140788721, 9917.355371900803, 10033.14718248957, 10110.702951245692, 10267.897321026694, 362168.0, 370264.0, 371702.0, 373444.0, 375663.0, 66807.33192668109, 67780.3221967774, 67868.0, 67953.66023169852, 69317.65341173262, 887.4896934262824, 892.4199270474114, 916.876221710074, 923.9076092390707, 927.5779520318374, 14922.85077149258, 15074.472393466176, 15714.0, 15800.36798528046, 15899.364025438854, 35062.12344691403, 35203.29593408066, 35422.0, 35444.82277588596, 36108.63891361053, 47664.0, 48980.75509622429, 50051.0, 54967.0, 55839.0, 5326.41409444953, 6213.099100630474, 6339.4928405726505, 7182.676779545038, 7306.4520160989205, 9598.42409455435, 11563.537458501902, 11629.534818607499, 11716.824247636121, 11759.764804703687, 4820.734859582757, 10182.389056656624, 10256.333338332985, 10365.481725913523, 10503.949605039435, 10180.083792458714, 10356.896431035895, 10360.896391036295, 10375.636852710119, 10550.314229575053, 10261.0, 10434.965181789477, 10483.0, 10563.260571759904, 10742.744023755098, 6766.391024807791, 6771.492138089761, 6804.965975170093, 6923.688434020381, 6984.092068031124, 8067.394945379003, 10210.234232432449, 10472.581096756045, 10518.158547316349, 10621.468926553796], "value": 8185.9694190629225, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.429528155253, 1341.9261940593267, 1389.61785508985, 1566.32258763186, 1608.171791527363, 6001.729922153502, 6302.180716506848, 6310.936890631092, 6637.800865974028, 6701.2963638817955, 6358.68206589671, 6575.14523111996, 6580.506462015356, 6607.504437167219, 6696.866062678743, 2008.2569449303742, 2052.3535086447796, 2052.9076191571417, 2055.2498338106634, 2056.8251698605636, 2041.2549419461939, 2084.2600876688784, 2090.090810497431, 2104.3055791588818, 2112.302940029794, 2031.9492012699652, 2038.1337931379105, 2065.215218217083, 2069.2550681754556, 2071.306112452323, 2015.61703276377, 2042.714020037196, 2044.7852975437663, 2047.0276618606192, 2049.7745248022707, 2019.989900050505, 2034.7965203479534, 2054.3939537836372, 2061.196133507933, 2062.886541240231, 6562.114114594517, 6581.769638062693, 6596.43930265928, 6608.438282745972, 6651.534392592521, 3975.920481590381, 4125.401816736587, 4145.730527515701, 4172.18642364739, 4178.373244013392, 2563.346346681603, 2712.8101032927702, 2742.9862850685818, 2762.2956146182796, 2823.745862872351, 777.529594595273, 818.3902992270796, 840.537704262653, 844.2907957315884, 845.623697454633, 8779.64881404743, 8810.295176385875, 8828.470291782514, 8866.379353445262, 8925.776855578662, 3582.697607540802, 3654.3239500692457, 3699.5930447650735, 3718.758280711745, 3763.736538442283, 7548.622568871644, 7569.848603027908, 7608.125065617414, 7615.124260709978, 7637.847243055219, 4233.729881035677, 4240.957590424056, 4241.1941731071, 4244.660427165819, 4245.724027938174, 3396.9150771230916, 3520.436730123219, 3524.0, 3889.416587511896, 3901.7268791184347, 3141.7643676724338, 3189.9681003190135, 3274.410606090879, 3278.5901762279714, 3339.3488269787645, 1111.3609674437068, 1134.3477500437282, 1137.4312843578211, 1150.206357613244, 1178.876217997098, 742.1279996004673, 758.5827794712997, 781.9022622172229, 782.7866607575933, 786.8819677048489, 4423.248047831877, 4453.77731113443, 4463.285874260103, 4529.38853254813, 4539.7049191802425, 370.34633871217324, 395.7249711450514, 398.85441813737776, 401.77099053539786, 408.58528593477644, 2983.2690990707415, 3034.8330841803913, 3087.0, 3137.9686203137676, 3271.8527666255077, 7673.769786906401, 7969.242921922408, 7971.521708697497, 7992.960035199903, 7995.0, 7845.803854903559, 7953.761387158394, 7957.880631790527, 7958.960205199052, 7971.800704982422, 6227.719752611143, 6320.589161704383, 6337.841553961096, 6338.30278669346, 6341.365863413622, 4254.914901702011, 4515.571020753023, 4595.310703394518, 4617.676762626584, 4620.768961551842, 7111.2533184017, 7245.710171593288, 7447.143578488543, 7492.925070749223, 7504.549727016397, 7311.67097480604, 7544.509606875536, 7629.0, 7630.4277179212895, 7639.274268944441, 5165.560927321069, 5509.421510741315, 5579.497845193952, 5621.662700237999, 5651.321841379061, 5791.594588378773, 6112.938870611415, 6298.275698294755, 6328.841778955379, 6423.807285781434, 5839.124131380327, 5856.150858125633, 5883.294004719461, 5885.61743486672, 5897.67562784051, 5662.490375866027, 5693.914591281051, 5777.364489906191, 5789.1605717171615, 5813.186153938367, 4936.111499929903, 4990.476000019946, 5062.088824011713, 5248.422673505835, 5277.973610131925, 3641.10792855752, 3669.5046168766876, 3676.34564445995, 3724.646158614927, 3747.5502939646326, 3923.509561304837, 3959.148783011666, 3992.4410582519054, 4032.737872038308, 4079.8776036718946], "value": 3559.1101400363323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.47907464250954, 298.5506812247567, 301.0306812065152, 303.4719587917025, 303.9665636779954, 4884.169691152504, 4904.681195722275, 4921.458639549646, 4923.753812309384, 4942.629302802291, 4775.403074615673, 4846.41842978843, 4846.975765121169, 4859.829905953292, 4871.683340582859, 3556.6621170988715, 3684.889453316405, 3688.5389326334207, 3796.734228603999, 3859.5561510426237, 3824.8087595620245, 3824.9617503824884, 3837.194189220267, 3846.884593462187, 3848.0, 3800.20195758891, 3800.5629352624524, 3820.9426858597144, 3838.2131663009154, 3866.961330386688, 3545.53907991962, 3724.3296206682785, 3834.213986132836, 3840.193559352553, 3851.9614803852023, 3247.756418268639, 3250.5697493103194, 3261.804291742503, 3285.211549228192, 3291.374638818617, 4692.530746925314, 4701.976490117561, 4745.786439610191, 4754.453237877654, 4779.330893674888, 4251.6173544380845, 4262.701610887239, 4264.466941632296, 4286.442762440894, 4288.69979101463, 4919.0, 4986.925196122061, 4990.777259571429, 4992.400911890596, 4996.750812296926, 3523.224890524081, 3528.3648943190215, 3538.4607695652476, 3542.822858857047, 3544.167120726627, 5192.428832828424, 5262.421133675292, 5295.814646487393, 5298.920516192222, 5305.389880163753, 3499.0727457223857, 3574.267275208628, 3616.746827722034, 3644.908877278089, 3658.70730341572, 3669.4404877926772, 3682.6869716073898, 3686.870959516458, 3696.7227457940226, 3703.5555733311635, 4233.640140588023, 4241.7879106044575, 4244.405783190356, 4251.149770045941, 4264.402983582301, 4958.454569997298, 5087.524617860853, 5092.719900405513, 5106.825430151086, 5134.743262836843, 1227.7114878003663, 1246.8441444819398, 1254.5107408110844, 1255.5229012975194, 1261.0794120292237, 852.6333676519156, 852.6759831264204, 855.8451346741239, 865.4677373415304, 867.6355930509201, 4379.189849877719, 4527.185106680829, 4535.455745310584, 4536.274196128669, 4538.591526762607, 5355.732213389393, 5363.946360536423, 5372.221027950925, 5373.892522149535, 5374.623776335698, 4503.639708823286, 4534.659900507475, 4548.7725613719185, 4555.794989225493, 4585.72485650862, 2624.5538258496103, 2725.9182224533297, 2761.6962134165224, 2765.4192619549717, 2772.9029483967965, 4839.370881785416, 4852.301694407, 4853.538913803183, 4858.7570621469495, 4859.465458799529, 5021.799128034911, 5302.257683924254, 5306.867328316823, 5309.840704778863, 5318.9628022535235, 4733.2900064989835, 4760.214564596803, 4763.856264680908, 4791.4906804356515, 4793.952060479351, 5168.328117344721, 5177.378714554127, 5180.844574662766, 5192.922106168335, 5199.844004679866, 4904.945436730977, 4994.275830004556, 5078.339815823919, 5102.209157580581, 5115.462876397924, 4746.810127594996, 4752.691075080109, 4754.690945088697, 4762.690425122356, 4799.880002999953, 3544.80503572306, 3556.4351685258403, 3558.1816182277703, 3570.821458927095, 3619.5837478690287, 5026.44709082008, 5161.922571161511, 5171.957341591918, 5181.689098654093, 5190.714510701948, 4966.453690094159, 4973.875653108701, 4980.5019498049905, 4980.551750342486, 5023.974880125576, 4952.975235123801, 4962.751862406937, 5010.549050585465, 5055.5955523557295, 5081.974590127025, 4575.885602859955, 4868.41579010521, 4908.410990681141, 4926.950730492649, 4939.48135445773, 4913.213885778258, 4958.330625365674, 4994.550490455877, 5155.226715992481, 5159.329287192641, 5041.672291301201, 5056.873578160428, 5067.442581315979, 5075.375879718455, 5090.847274581768], "value": 3795.1140099486247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.968981706006, 591.3111225422383, 648.8799572079164, 658.7957733102736, 659.1793217444283, 11563.53745850166, 12228.20516666416, 12273.754524909507, 12300.138990270685, 12506.749865002694, 11867.169298149132, 11869.287842729442, 11937.164398492087, 11942.7611447771, 11963.880361196407, 765.8698021336386, 772.8067983004249, 773.134089819403, 775.0892701076241, 775.2015424113173, 749.2844333661368, 753.0737193252303, 773.6711897443593, 777.199484530934, 777.7433446962489, 806.9677212911477, 807.1524898856206, 808.870580707087, 809.7004108479871, 813.1868131868132, 803.6142651527271, 803.6865622407266, 804.3082948664115, 805.4603415711488, 808.0, 588.8557303460636, 589.2163422647868, 589.5048159545959, 590.2592246730326, 595.4670569839969, 12352.38238088101, 12367.814482782765, 12391.380430978505, 12442.937785311016, 12455.314957677325, 11196.944015279953, 11212.495437705242, 11297.887021129847, 11714.004309633692, 11931.94034029833, 11065.336079835235, 11113.666590002313, 11124.888751112547, 11143.944280278627, 11405.144614153889, 2964.170032390934, 3068.1255842084897, 3094.350186460846, 3192.5530425740417, 3844.5578758442857, 50016.0, 50586.241206381936, 51000.97998040055, 51186.48813511855, 51635.22547161795, 9116.225120864668, 9222.677206297882, 9339.439633622005, 9365.953170234105, 9370.424597364557, 15970.9201453992, 16694.58263543397, 16878.156092195342, 16888.0, 16978.915105424392, 6208.2239720034995, 6224.906626400608, 6253.468455181361, 6283.842903927439, 6599.868002639921, 3398.0655319787256, 3544.8404821783083, 3642.4900513928073, 3644.0, 3670.4494325851338, 2607.6088586712144, 2686.9865650671622, 2917.547780094089, 3004.8497575121155, 3049.1005153479778, 524.2058281703223, 535.6812696445609, 538.1470369464442, 541.7426722306873, 548.4625067433938, 522.7203446156365, 532.5819231902938, 552.6407834907343, 559.4014404587134, 561.9269494965629, 7710.344620707303, 7758.573278469626, 7776.922230777733, 7790.727324543614, 7909.20907909216, 504.23104765233313, 506.59463524196906, 509.1065180608009, 513.7405610166917, 524.7848382163295, 3748.981255093707, 3792.7534710243744, 3822.0, 3878.786666733357, 3944.171723938005, 57506.13740793891, 67745.0, 70847.6457617719, 72172.2782772176, 72728.63635681788, 60929.69535152296, 60979.39020609826, 61598.38401615927, 61815.38184618186, 64663.353366466676, 56119.71940140355, 56332.0, 56524.717376413675, 57209.42790572041, 57791.71104144453, 7445.651631698022, 7612.657430415534, 7636.732714354971, 7740.8451830964195, 7788.610569471617, 31587.684123158473, 32318.515222272155, 33109.0, 35210.76762313307, 39645.60354396419, 40124.0, 43218.35172472353, 44976.32535512035, 45110.32334515051, 47284.52715472801, 10147.819034872484, 10171.0, 10294.277875177087, 10751.838722419327, 10899.128069754559, 11493.195476316912, 11945.044396448437, 12402.441890114786, 12782.23306601607, 12991.740165196454, 11168.609098681507, 11261.49323280438, 11401.486933087865, 11729.120315976164, 11874.584389546324, 11202.607908723156, 11485.598004069818, 11771.117166212398, 11805.76388472243, 12274.877251227374, 9241.399309044891, 9469.857952130586, 9558.330916836034, 9703.951480242837, 9807.264455165749, 9195.218406435528, 9390.107939745712, 9467.0, 9711.27165462579, 9938.10557049869, 9472.857907131262, 9675.951620241854, 9762.365446246255, 9812.116909478182, 9833.0], "value": 6002.053561049017, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1618.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 120.0, 120.0, 119.0, 118.0, 117.0, 118.0, 118.0, 120.0, 119.0], "value": 117.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 133.0, 177.0, 141.0, 140.0, 135.0, 133.0, 167.0, 136.0], "value": 145.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 175.0, 167.0, 165.0, 165.0, 164.0, 166.0, 166.0, 166.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 107.0, 78.0, 79.0, 78.0, 78.0, 112.0, 78.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 114.0, 87.0, 86.0, 85.0, 104.0, 85.0, 86.0, 112.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 121.0, 124.0, 119.0, 119.0, 119.0, 121.0, 120.0, 119.0], "value": 120.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 148.0, 149.0, 150.0, 150.0, 149.0, 148.0, 150.0, 149.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 98.0, 97.0, 96.0, 96.0, 97.0, 96.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 69.0, 68.0, 68.0, 69.0, 69.0, 75.0, 68.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 71.0, 67.0, 68.0, 66.0, 67.0, 71.0, 70.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 88.0, 87.0, 86.0, 88.0, 87.0, 86.0, 88.0, 87.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 159.0, 149.0, 157.0, 147.0, 160.0, 151.0, 185.0, 162.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 188.0, 188.0, 183.0, 184.0, 189.0, 194.0, 192.0, 189.0, 184.0], "value": 188.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 75.0, 72.0, 72.0, 70.0, 71.0, 74.0, 69.0, 71.0], "value": 71.8, "unit": "score"}]}]} 09:19:50 INFO - Return code: 0 09:19:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:19:50 ERROR - # TBPL SUCCESS # 09:19:50 INFO - Running post-action listener: _resource_record_post_action 09:19:50 INFO - [mozharness: 2016-11-22 17:19:50.757996Z] Finished run-tests step (success) 09:19:50 INFO - Running post-run listener: _resource_record_post_run 09:19:50 INFO - Total resource usage - Wall time: 1203s; CPU: 14.0%; Read bytes: 4096; Write bytes: 393195520; Read time: 8; Write time: 449936 09:19:50 INFO - TinderboxPrint: CPU usage
13.5% 09:19:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:19:50 INFO - TinderboxPrint: I/O write bytes / time
393,195,520 / 449,936 09:19:50 INFO - TinderboxPrint: CPU idle
8,295.1 (86.5%) 09:19:50 INFO - TinderboxPrint: CPU user
1,232.4 (12.8%) 09:19:50 INFO - TinderboxPrint: Swap in / out
0 / 0 09:19:50 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102813696; Read time: 0; Write time: 107104 09:19:50 INFO - run-tests - Wall time: 1187s; CPU: 14.0%; Read bytes: 0; Write bytes: 290381824; Read time: 0; Write time: 342832 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:51 INFO - (blobuploader) - INFO - Open directory for files ... 09:19:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:19:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_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:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:59 INFO - (blobuploader) - INFO - Done attempting. 09:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:19:59 INFO - (blobuploader) - INFO - Done attempting. 09:19:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:19:59 INFO - Return code: 0 09:19:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:19:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:19:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dce9a48af9bc40e180a22e526d6e6069f12f2507d4ff11d071430e599bdd931dea3cbf3914777a66731bceaba58575a2bf708b727047bb7b380dad8e8c791ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e44e8af835c7647d214671279deb3e9201d4cc20c7f72852c64e046ba5d81df3e0f8f0ce9edad92e63fee08c7e4bec0739d7937c8787824c780ecb4326025cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0536e2e8cb20056ad9881de3b47a5d97d729eb199c6821c74591cabca93dae44b83dedf8e67e18b4c5b972b2e81867a0247742fef4d6ad1741fd0156e457e06f"} 09:19:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:19:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:19:59 INFO - Contents: 09:19:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dce9a48af9bc40e180a22e526d6e6069f12f2507d4ff11d071430e599bdd931dea3cbf3914777a66731bceaba58575a2bf708b727047bb7b380dad8e8c791ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e44e8af835c7647d214671279deb3e9201d4cc20c7f72852c64e046ba5d81df3e0f8f0ce9edad92e63fee08c7e4bec0739d7937c8787824c780ecb4326025cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0536e2e8cb20056ad9881de3b47a5d97d729eb199c6821c74591cabca93dae44b83dedf8e67e18b4c5b972b2e81867a0247742fef4d6ad1741fd0156e457e06f"} 09:19:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:19:59 INFO - Copying logs to upload dir... 09:19:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:19:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.792644 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-11-22 09:19:58.232589) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:58.235707) ========= 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=52faae308a556c440401f8e5000001e8-1479833945.321331-572435751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dce9a48af9bc40e180a22e526d6e6069f12f2507d4ff11d071430e599bdd931dea3cbf3914777a66731bceaba58575a2bf708b727047bb7b380dad8e8c791ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e44e8af835c7647d214671279deb3e9201d4cc20c7f72852c64e046ba5d81df3e0f8f0ce9edad92e63fee08c7e4bec0739d7937c8787824c780ecb4326025cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0536e2e8cb20056ad9881de3b47a5d97d729eb199c6821c74591cabca93dae44b83dedf8e67e18b4c5b972b2e81867a0247742fef4d6ad1741fd0156e457e06f"} 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.011395 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/9dce9a48af9bc40e180a22e526d6e6069f12f2507d4ff11d071430e599bdd931dea3cbf3914777a66731bceaba58575a2bf708b727047bb7b380dad8e8c791ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e44e8af835c7647d214671279deb3e9201d4cc20c7f72852c64e046ba5d81df3e0f8f0ce9edad92e63fee08c7e4bec0739d7937c8787824c780ecb4326025cbd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/0536e2e8cb20056ad9881de3b47a5d97d729eb199c6821c74591cabca93dae44b83dedf8e67e18b4c5b972b2e81867a0247742fef4d6ad1741fd0156e457e06f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:58.268745) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:58.269173) ========= 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=52faae308a556c440401f8e5000001e8-1479833945.321331-572435751 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004846 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-22 09:19:58.319135) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 09:19:58.322547) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-22 09:19:58.322927) ========= ========= Total master_lag: 0.41 =========