builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1479935520.0 results: success (0) buildid: 20161123103008 builduid: 397d02e7247a4a0cacd3d4430261ebad revision: 47f42f21541b9b98ad7db82edb996b29065debd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 13:11:59.997592) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 13:11:59.998059) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 13:11:59.998583) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:00.329050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:00.329329) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 13:12:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-11-23 13:12:00 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138080 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:00.490590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:00.490895) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:00.539937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:00.543314) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47f42f21541b9b98ad7db82edb996b29065debd0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 47f42f21541b9b98ad7db82edb996b29065debd0 --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=337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 13:12:00,884 truncating revision to first 12 chars 2016-11-23 13:12:00,884 Setting DEBUG logging. 2016-11-23 13:12:00,884 attempt 1/10 2016-11-23 13:12:00,884 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47f42f21541b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 13:12:01,174 unpacking tar archive at: mozilla-central-47f42f21541b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.584040 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:01.213041) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:01.213346) ========= script_repo_revision: 47f42f21541b9b98ad7db82edb996b29065debd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:01.213737) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:01.214003) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 13:12:01.229071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-23 13:12:01.229368) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:12:01 INFO - MultiFileLogger online at 20161123 13:12:01 in /builds/slave/test 13:12:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:12:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:12:01 INFO - {'append_to_log': False, 13:12:01 INFO - 'base_work_dir': '/builds/slave/test', 13:12:01 INFO - 'blob_upload_branch': 'Firefox', 13:12:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:12:01 INFO - 'branch': 'Firefox', 13:12:01 INFO - 'buildbot_json_path': 'buildprops.json', 13:12:01 INFO - 'config_files': ('talos/linux_config.py',), 13:12:01 INFO - 'default_actions': ('clobber', 13:12:01 INFO - 'read-buildbot-config', 13:12:01 INFO - 'download-and-extract', 13:12:01 INFO - 'populate-webroot', 13:12:01 INFO - 'create-virtualenv', 13:12:01 INFO - 'install', 13:12:01 INFO - 'run-tests'), 13:12:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:12:01 INFO - 'download_minidump_stackwalk': True, 13:12:01 INFO - 'download_symbols': 'ondemand', 13:12:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:12:01 INFO - 'tooltool.py': '/tools/tooltool.py', 13:12:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:12:01 INFO - '/tools/misc-python/virtualenv.py')}, 13:12:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:12:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:12:01 INFO - 'installer_path': 'installer.exe', 13:12:01 INFO - 'log_level': 'info', 13:12:01 INFO - 'log_name': 'talos', 13:12:01 INFO - 'log_to_console': True, 13:12:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:12:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:12:01 INFO - 'opt_config_files': (), 13:12:01 INFO - 'pip_index': False, 13:12:01 INFO - 'sps_profile': False, 13:12:01 INFO - 'sps_profile_interval': 0, 13:12:01 INFO - 'suite': 'dromaeojs', 13:12:01 INFO - 'system_bits': '32', 13:12:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:12:01 INFO - 'title': 'talos-linux64-ix-060', 13:12:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:12:01 INFO - 'use_talos_json': True, 13:12:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:12:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:12:01 INFO - 'work_dir': 'build'} 13:12:01 INFO - [mozharness: 2016-11-23 21:12:01.668830Z] Running clobber step. 13:12:01 INFO - Running pre-action listener: _resource_record_pre_action 13:12:01 INFO - Running main action method: clobber 13:12:01 INFO - rmtree: /builds/slave/test/build 13:12:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:12:02 INFO - Running post-action listener: _resource_record_post_action 13:12:02 INFO - [mozharness: 2016-11-23 21:12:02.140853Z] Finished clobber step (success) 13:12:02 INFO - [mozharness: 2016-11-23 21:12:02.140953Z] Running read-buildbot-config step. 13:12:02 INFO - Running pre-action listener: _resource_record_pre_action 13:12:02 INFO - Running main action method: read_buildbot_config 13:12:02 INFO - Using buildbot properties: 13:12:02 INFO - { 13:12:02 INFO - "project": "", 13:12:02 INFO - "product": "firefox", 13:12:02 INFO - "script_repo_revision": "production", 13:12:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 13:12:02 INFO - "repository": "", 13:12:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 13:12:02 INFO - "buildid": "20161123103008", 13:12:02 INFO - "pgo_build": "True", 13:12:02 INFO - "basedir": "/builds/slave/test", 13:12:02 INFO - "buildnumber": 3, 13:12:02 INFO - "slavename": "talos-linux64-ix-060", 13:12:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:12:02 INFO - "platform": "ubuntu64_hw", 13:12:02 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 13:12:02 INFO - "branch": "mozilla-central", 13:12:02 INFO - "repo_path": "mozilla-central", 13:12:02 INFO - "revision": "47f42f21541b9b98ad7db82edb996b29065debd0", 13:12:02 INFO - "stage_platform": "linux64-pgo", 13:12:02 INFO - "builduid": "397d02e7247a4a0cacd3d4430261ebad", 13:12:02 INFO - "slavebuilddir": "test" 13:12:02 INFO - } 13:12:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 13:12:02 INFO - Running post-action listener: _resource_record_post_action 13:12:02 INFO - [mozharness: 2016-11-23 21:12:02.143343Z] Finished read-buildbot-config step (success) 13:12:02 INFO - [mozharness: 2016-11-23 21:12:02.143430Z] Running download-and-extract step. 13:12:02 INFO - Running pre-action listener: _resource_record_pre_action 13:12:02 INFO - Running main action method: download_and_extract 13:12:02 INFO - mkdir: /builds/slave/test/build/tests 13:12:02 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')]} 13:12:02 INFO - trying https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:12:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/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 13:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/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 13:12:02 INFO - Downloaded 1361 bytes. 13:12:02 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 13:12:02 INFO - Using the following test package requirements: 13:12:02 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:12:02 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:12:02 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:12:02 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'jsshell-linux-x86_64.zip'], 13:12:02 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:12:02 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 13:12:02 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:12:02 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:12:02 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:12:02 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 13:12:02 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:12:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:12:03 INFO - Http code: 200 13:12:03 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 13:12:03 INFO - x-amz-cf-id: eo352HtYORttxD_WPNIbLuirtwtAkg4yzIXGbX4neuq2NuRlKCPMHA== 13:12:03 INFO - x-amz-version-id: 5MDKTbw9imrO7_8zAxPfYIev9KqU2yjB 13:12:03 INFO - Expected file size: 21763979 13:12:03 INFO - Obtained file size: 21763979 13:12:07 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 13:12:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 13:12:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:12:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:12:08 INFO - Http code: 200 13:12:08 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 13:12:08 INFO - x-amz-cf-id: 6HgZTGZ3-34kq1foG20IJEWQA-blQ-KoFvdrWytoy0RH4wUCWuOb6A== 13:12:08 INFO - x-amz-version-id: 5MDKTbw9imrO7_8zAxPfYIev9KqU2yjB 13:12:08 INFO - Expected file size: 21763979 13:12:08 INFO - Obtained file size: 21763979 13:12:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 13:12:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:12:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:12:13 INFO - Http code: 200 13:12:13 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 13:12:13 INFO - x-amz-cf-id: 4n0YYFEVtBLZJOgsxubTFqIgpaq4wHK7pGYDaxIb37qEwvIVH6F22g== 13:12:13 INFO - x-amz-version-id: zc8P3Mtag0.qXlfb7_DFwZwJnttDhBwy 13:12:14 INFO - Expected file size: 14409506 13:12:14 INFO - Obtained file size: 14409506 13:12:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:14 INFO - trying https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:12:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/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 13:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/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 13:12:16 INFO - Downloaded 59728463 bytes. 13:12:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:12:16 INFO - mkdir: /builds/slave/test/properties 13:12:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:12:16 INFO - Writing to file /builds/slave/test/properties/build_url 13:12:16 INFO - Contents: 13:12:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 13:12:16 INFO - Running post-action listener: _resource_record_post_action 13:12:16 INFO - Running post-action listener: set_extra_try_arguments 13:12:16 INFO - [mozharness: 2016-11-23 21:12:16.903258Z] Finished download-and-extract step (success) 13:12:16 INFO - [mozharness: 2016-11-23 21:12:16.903481Z] Running populate-webroot step. 13:12:16 INFO - Running pre-action listener: _resource_record_pre_action 13:12:16 INFO - Running main action method: populate_webroot 13:12:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:12:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:12:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:12:16 INFO - '--tppagecycles', 13:12:16 INFO - '7'], 13:12:16 INFO - 'tests': ['tsvgm']}}, 13:12:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:12:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:12:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:12:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:12:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:12:16 INFO - 'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:12:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:12:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:12:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:12:16 INFO - 'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['damp', 'tps']}, 13:12:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:12:16 INFO - 'tests': ['damp', 'tps']}, 13:12:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['dromaeo_dom']}, 13:12:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:12:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['basic_compositor_video']}, 13:12:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:12:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['a11yr', 13:12:16 INFO - 'ts_paint', 13:12:16 INFO - 'tpaint', 13:12:16 INFO - 'sessionrestore', 13:12:16 INFO - 'sessionrestore_no_auto_restore', 13:12:16 INFO - 'tabpaint']}, 13:12:16 INFO - 'other-e10s': {'tests': ['a11yr', 13:12:16 INFO - 'ts_paint', 13:12:16 INFO - 'tpaint', 13:12:16 INFO - 'sessionrestore', 13:12:16 INFO - 'sessionrestore_no_auto_restore', 13:12:16 INFO - 'tabpaint']}, 13:12:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:12:16 INFO - 'ts_paint', 13:12:16 INFO - 'tpaint', 13:12:16 INFO - 'sessionrestore', 13:12:16 INFO - 'sessionrestore_no_auto_restore', 13:12:16 INFO - 'tabpaint']}, 13:12:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:12:16 INFO - 'ts_paint', 13:12:16 INFO - 'tpaint', 13:12:16 INFO - 'sessionrestore', 13:12:16 INFO - 'sessionrestore_no_auto_restore', 13:12:16 INFO - 'tabpaint']}, 13:12:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['a11yr', 13:12:16 INFO - 'ts_paint', 13:12:16 INFO - 'tpaint', 13:12:16 INFO - 'sessionrestore', 13:12:16 INFO - 'sessionrestore_no_auto_restore', 13:12:16 INFO - 'tabpaint']}, 13:12:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['a11yr', 13:12:16 INFO - 'ts_paint', 13:12:16 INFO - 'tpaint', 13:12:16 INFO - 'sessionrestore', 13:12:16 INFO - 'sessionrestore_no_auto_restore', 13:12:16 INFO - 'tabpaint']}, 13:12:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['tsvgx', 13:12:16 INFO - 'tsvgr_opacity', 13:12:16 INFO - 'tart', 13:12:16 INFO - 'tscrollx', 13:12:16 INFO - 'cart']}, 13:12:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:12:16 INFO - 'tsvgr_opacity', 13:12:16 INFO - 'tart', 13:12:16 INFO - 'tscrollx', 13:12:16 INFO - 'cart']}, 13:12:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:12:16 INFO - 'talos_options': ['--disable-e10s'], 13:12:16 INFO - 'tests': ['tp5o']}, 13:12:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:12:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:12:16 INFO - 'talos_options': ['--disable-e10s', 13:12:16 INFO - '--xperf_path', 13:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:12:16 INFO - 'tests': ['tp5n']}, 13:12:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:12:16 INFO - 'talos_options': ['--xperf_path', 13:12:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:12:16 INFO - 'tests': ['tp5n']}}, 13:12:16 INFO - 'talos.zip': {'path': '', 13:12:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:12:16 INFO - Running post-action listener: _resource_record_post_action 13:12:16 INFO - [mozharness: 2016-11-23 21:12:16.924350Z] Finished populate-webroot step (success) 13:12:16 INFO - [mozharness: 2016-11-23 21:12:16.924447Z] Running create-virtualenv step. 13:12:16 INFO - Running pre-action listener: _resource_record_pre_action 13:12:16 INFO - Running main action method: create_virtualenv 13:12:16 INFO - Creating virtualenv /builds/slave/test/build/venv 13:12:16 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 13:12:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:12:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:12:17 INFO - Using real prefix '/usr' 13:12:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:12:17 INFO - Installing distribute.............................................................................................................................................................................................done. 13:12:19 INFO - Installing pip.................done. 13:12:19 INFO - Return code: 0 13:12:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:12:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:12:19 INFO - Reading from file tmpfile_stdout 13:12:19 INFO - Output received: 13:12:19 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) 13:12:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:19 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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:19 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 13:12:19 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 13:12:19 INFO - Using env: {'DISPLAY': ':0', 13:12:19 INFO - 'HOME': '/home/cltbld', 13:12:19 INFO - 'LANG': 'en_US.UTF-8', 13:12:19 INFO - 'LANGUAGE': 'en_US:en', 13:12:19 INFO - 'LOGNAME': 'cltbld', 13:12:19 INFO - 'MAIL': '/var/mail/cltbld', 13:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:19 INFO - 'MOZ_NO_REMOTE': '1', 13:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:19 INFO - 'NO_EM_RESTART': '1', 13:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:19 INFO - 'PWD': '/builds/slave/test', 13:12:19 INFO - 'SHELL': '/bin/bash', 13:12:19 INFO - 'SHLVL': '1', 13:12:19 INFO - 'TERM': 'linux', 13:12:19 INFO - 'TMOUT': '86400', 13:12:19 INFO - 'USER': 'cltbld', 13:12:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:19 INFO - '_': '/tools/buildbot/bin/python'} 13:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:19 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 13:12:19 INFO - Cleaning up... 13:12:19 INFO - Return code: 0 13:12:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:19 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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:19 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 13:12:19 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 13:12:19 INFO - Using env: {'DISPLAY': ':0', 13:12:19 INFO - 'HOME': '/home/cltbld', 13:12:19 INFO - 'LANG': 'en_US.UTF-8', 13:12:19 INFO - 'LANGUAGE': 'en_US:en', 13:12:19 INFO - 'LOGNAME': 'cltbld', 13:12:19 INFO - 'MAIL': '/var/mail/cltbld', 13:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:19 INFO - 'MOZ_NO_REMOTE': '1', 13:12:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:19 INFO - 'NO_EM_RESTART': '1', 13:12:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:19 INFO - 'PWD': '/builds/slave/test', 13:12:19 INFO - 'SHELL': '/bin/bash', 13:12:19 INFO - 'SHLVL': '1', 13:12:19 INFO - 'TERM': 'linux', 13:12:19 INFO - 'TMOUT': '86400', 13:12:19 INFO - 'USER': 'cltbld', 13:12:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:19 INFO - '_': '/tools/buildbot/bin/python'} 13:12:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:20 INFO - Downloading/unpacking psutil>=3.1.1 13:12:20 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 13:12:20 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 13:12:20 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 13:12:20 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 13:12:20 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 13:12:20 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 13:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:12:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:12:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:12:22 INFO - Installing collected packages: psutil 13:12:22 INFO - Running setup.py install for psutil 13:12:22 INFO - building 'psutil._psutil_linux' extension 13:12:22 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 13:12:22 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 13:12:22 INFO - building 'psutil._psutil_posix' extension 13:12:22 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 13:12:22 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 13:12:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:12:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:12:22 INFO - Successfully installed psutil 13:12:22 INFO - Cleaning up... 13:12:22 INFO - Return code: 0 13:12:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:12:22 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')]} 13:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:22 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')]} 13:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:22 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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:22 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 13:12:22 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 13:12:22 INFO - Using env: {'DISPLAY': ':0', 13:12:22 INFO - 'HOME': '/home/cltbld', 13:12:22 INFO - 'LANG': 'en_US.UTF-8', 13:12:22 INFO - 'LANGUAGE': 'en_US:en', 13:12:22 INFO - 'LOGNAME': 'cltbld', 13:12:22 INFO - 'MAIL': '/var/mail/cltbld', 13:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:22 INFO - 'MOZ_NO_REMOTE': '1', 13:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:22 INFO - 'NO_EM_RESTART': '1', 13:12:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:22 INFO - 'PWD': '/builds/slave/test', 13:12:22 INFO - 'SHELL': '/bin/bash', 13:12:22 INFO - 'SHLVL': '1', 13:12:22 INFO - 'TERM': 'linux', 13:12:22 INFO - 'TMOUT': '86400', 13:12:22 INFO - 'USER': 'cltbld', 13:12:22 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:22 INFO - '_': '/tools/buildbot/bin/python'} 13:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:12:24 INFO - Installing collected packages: mozsystemmonitor 13:12:24 INFO - Running setup.py install for mozsystemmonitor 13:12:25 INFO - Successfully installed mozsystemmonitor 13:12:25 INFO - Cleaning up... 13:12:25 INFO - Return code: 0 13:12:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:12:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:12:25 INFO - Using env: {'DISPLAY': ':0', 13:12:25 INFO - 'HOME': '/home/cltbld', 13:12:25 INFO - 'LANG': 'en_US.UTF-8', 13:12:25 INFO - 'LANGUAGE': 'en_US:en', 13:12:25 INFO - 'LOGNAME': 'cltbld', 13:12:25 INFO - 'MAIL': '/var/mail/cltbld', 13:12:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:25 INFO - 'MOZ_NO_REMOTE': '1', 13:12:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:25 INFO - 'NO_EM_RESTART': '1', 13:12:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:25 INFO - 'PWD': '/builds/slave/test', 13:12:25 INFO - 'SHELL': '/bin/bash', 13:12:25 INFO - 'SHLVL': '1', 13:12:25 INFO - 'TERM': 'linux', 13:12:25 INFO - 'TMOUT': '86400', 13:12:25 INFO - 'USER': 'cltbld', 13:12:25 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:25 INFO - '_': '/tools/buildbot/bin/python'} 13:12:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:25 INFO - Downloading/unpacking jsonschema==2.5.1 13:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:12:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12:27 INFO - Downloading functools32-3.2.3-2.tar.gz 13:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:12:27 INFO - warning: no files found matching '*.txt' 13:12:27 INFO - no previously-included directories found matching 'build' 13:12:27 INFO - no previously-included directories found matching 'dist' 13:12:27 INFO - no previously-included directories found matching '.git*' 13:12:27 INFO - Installing collected packages: jsonschema, functools32 13:12:27 INFO - Running setup.py install for functools32 13:12:27 INFO - warning: no files found matching '*.txt' 13:12:27 INFO - no previously-included directories found matching 'build' 13:12:27 INFO - no previously-included directories found matching 'dist' 13:12:27 INFO - no previously-included directories found matching '.git*' 13:12:27 INFO - Successfully installed jsonschema functools32 13:12:27 INFO - Cleaning up... 13:12:27 INFO - Return code: 0 13:12:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:12: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')]} 13:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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')]} 13:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12: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', '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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:12: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 functools32==3.2.3-2 13:12:27 INFO - Using env: {'DISPLAY': ':0', 13:12:27 INFO - 'HOME': '/home/cltbld', 13:12:27 INFO - 'LANG': 'en_US.UTF-8', 13:12:27 INFO - 'LANGUAGE': 'en_US:en', 13:12:27 INFO - 'LOGNAME': 'cltbld', 13:12:27 INFO - 'MAIL': '/var/mail/cltbld', 13:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:27 INFO - 'MOZ_NO_REMOTE': '1', 13:12:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:27 INFO - 'NO_EM_RESTART': '1', 13:12:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:27 INFO - 'PWD': '/builds/slave/test', 13:12:27 INFO - 'SHELL': '/bin/bash', 13:12:27 INFO - 'SHLVL': '1', 13:12:27 INFO - 'TERM': 'linux', 13:12:27 INFO - 'TMOUT': '86400', 13:12:27 INFO - 'USER': 'cltbld', 13:12:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:27 INFO - '_': '/tools/buildbot/bin/python'} 13:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:12:27 INFO - Cleaning up... 13:12:28 INFO - Return code: 0 13:12:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:12:28 INFO - Using env: {'DISPLAY': ':0', 13:12:28 INFO - 'HOME': '/home/cltbld', 13:12:28 INFO - 'LANG': 'en_US.UTF-8', 13:12:28 INFO - 'LANGUAGE': 'en_US:en', 13:12:28 INFO - 'LOGNAME': 'cltbld', 13:12:28 INFO - 'MAIL': '/var/mail/cltbld', 13:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:28 INFO - 'MOZ_NO_REMOTE': '1', 13:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:28 INFO - 'NO_EM_RESTART': '1', 13:12:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:28 INFO - 'PWD': '/builds/slave/test', 13:12:28 INFO - 'SHELL': '/bin/bash', 13:12:28 INFO - 'SHLVL': '1', 13:12:28 INFO - 'TERM': 'linux', 13:12:28 INFO - 'TMOUT': '86400', 13:12:28 INFO - 'USER': 'cltbld', 13:12:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:28 INFO - '_': '/tools/buildbot/bin/python'} 13:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:28 INFO - Downloading/unpacking blobuploader==1.2.4 13:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:30 INFO - Downloading blobuploader-1.2.4.tar.gz 13:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:12:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:12:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12: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 13:12:30 INFO - Downloading docopt-0.6.1.tar.gz 13:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:12:30 INFO - Installing collected packages: blobuploader, requests, docopt 13:12:30 INFO - Running setup.py install for blobuploader 13:12:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:12:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:12:31 INFO - Running setup.py install for requests 13:12:31 INFO - Running setup.py install for docopt 13:12:31 INFO - Successfully installed blobuploader requests docopt 13:12:31 INFO - Cleaning up... 13:12:31 INFO - Return code: 0 13:12:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:31 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')]} 13:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:31 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')]} 13:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:31 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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:31 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 13:12:31 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 13:12:31 INFO - Using env: {'DISPLAY': ':0', 13:12:31 INFO - 'HOME': '/home/cltbld', 13:12:31 INFO - 'LANG': 'en_US.UTF-8', 13:12:31 INFO - 'LANGUAGE': 'en_US:en', 13:12:31 INFO - 'LOGNAME': 'cltbld', 13:12:31 INFO - 'MAIL': '/var/mail/cltbld', 13:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:31 INFO - 'MOZ_NO_REMOTE': '1', 13:12:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:31 INFO - 'NO_EM_RESTART': '1', 13:12:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:31 INFO - 'PWD': '/builds/slave/test', 13:12:31 INFO - 'SHELL': '/bin/bash', 13:12:31 INFO - 'SHLVL': '1', 13:12:31 INFO - 'TERM': 'linux', 13:12:31 INFO - 'TMOUT': '86400', 13:12:31 INFO - 'USER': 'cltbld', 13:12:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:31 INFO - '_': '/tools/buildbot/bin/python'} 13:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:31 INFO - Running setup.py (path:/tmp/pip-BJeQeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:31 INFO - Running setup.py (path:/tmp/pip-b5m6E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:31 INFO - Running setup.py (path:/tmp/pip-_dfZpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:31 INFO - Running setup.py (path:/tmp/pip-mXv7Yi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:32 INFO - Running setup.py (path:/tmp/pip-fvv7dE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:32 INFO - Running setup.py (path:/tmp/pip-UmTSBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:32 INFO - Running setup.py (path:/tmp/pip-dmtRAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:32 INFO - Running setup.py (path:/tmp/pip-PuzF0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:32 INFO - Running setup.py (path:/tmp/pip-4hJkGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:32 INFO - Running setup.py (path:/tmp/pip-YemU6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:32 INFO - Running setup.py (path:/tmp/pip-2D8TWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:32 INFO - Running setup.py (path:/tmp/pip-xwhBu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:32 INFO - Running setup.py (path:/tmp/pip-JVbxUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:32 INFO - Running setup.py (path:/tmp/pip-W4azZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:32 INFO - Running setup.py (path:/tmp/pip-TuW1ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:32 INFO - Running setup.py (path:/tmp/pip-tInRae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:32 INFO - Running setup.py (path:/tmp/pip-tOtl3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:12:33 INFO - Running setup.py install for manifestparser 13:12:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Running setup.py install for mozcrash 13:12:33 INFO - Running setup.py install for mozdebug 13:12:33 INFO - Running setup.py install for mozdevice 13:12:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Running setup.py install for mozfile 13:12:33 INFO - Running setup.py install for mozhttpd 13:12:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Running setup.py install for mozinfo 13:12:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Running setup.py install for mozInstall 13:12:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:12:33 INFO - Running setup.py install for mozleak 13:12:33 INFO - Running setup.py install for mozlog 13:12:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:12:34 INFO - Running setup.py install for moznetwork 13:12:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:12:34 INFO - Running setup.py install for mozprocess 13:12:34 INFO - Running setup.py install for mozprofile 13:12:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:12:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:12:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:12:34 INFO - Running setup.py install for mozrunner 13:12:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:12:34 INFO - Running setup.py install for mozscreenshot 13:12:34 INFO - Running setup.py install for moztest 13:12:34 INFO - Running setup.py install for mozversion 13:12:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:12:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:12:34 INFO - Cleaning up... 13:12:34 INFO - Return code: 0 13:12:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:34 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')]} 13:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 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')]} 13:12:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:34 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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:34 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 13:12:34 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 13:12:34 INFO - Using env: {'DISPLAY': ':0', 13:12:34 INFO - 'HOME': '/home/cltbld', 13:12:34 INFO - 'LANG': 'en_US.UTF-8', 13:12:34 INFO - 'LANGUAGE': 'en_US:en', 13:12:34 INFO - 'LOGNAME': 'cltbld', 13:12:34 INFO - 'MAIL': '/var/mail/cltbld', 13:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:34 INFO - 'MOZ_NO_REMOTE': '1', 13:12:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:34 INFO - 'NO_EM_RESTART': '1', 13:12:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:34 INFO - 'PWD': '/builds/slave/test', 13:12:34 INFO - 'SHELL': '/bin/bash', 13:12:34 INFO - 'SHLVL': '1', 13:12:34 INFO - 'TERM': 'linux', 13:12:34 INFO - 'TMOUT': '86400', 13:12:34 INFO - 'USER': 'cltbld', 13:12:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:34 INFO - '_': '/tools/buildbot/bin/python'} 13:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:12:35 INFO - Running setup.py (path:/tmp/pip-FHl87K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:12:35 INFO - Running setup.py (path:/tmp/pip-9oD7UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:12:35 INFO - Running setup.py (path:/tmp/pip-g9hFqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:12:35 INFO - Running setup.py (path:/tmp/pip-VXIYM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:12:35 INFO - Running setup.py (path:/tmp/pip-j2CISo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:12:35 INFO - Running setup.py (path:/tmp/pip-oiWpN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:12:35 INFO - Running setup.py (path:/tmp/pip-58yBcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:12:35 INFO - Running setup.py (path:/tmp/pip-Yn3AIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:12:35 INFO - Running setup.py (path:/tmp/pip-pwLAoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:12:35 INFO - Running setup.py (path:/tmp/pip-HIC80B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:12:35 INFO - Running setup.py (path:/tmp/pip-y3iSfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:12:35 INFO - Running setup.py (path:/tmp/pip-8WSku6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:12:35 INFO - Running setup.py (path:/tmp/pip-HSR94e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:12:35 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)) 13:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:12:35 INFO - Running setup.py (path:/tmp/pip-kLlNm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:12:36 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)) 13:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:36 INFO - Running setup.py (path:/tmp/pip-49_nm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:12:36 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)) 13:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:12:36 INFO - Running setup.py (path:/tmp/pip-3dXzeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:12:36 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)) 13:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:12:36 INFO - Running setup.py (path:/tmp/pip-KFEl8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:12:36 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)) 13:12:36 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)) 13:12:36 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)) 13:12:36 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)) 13:12:36 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)) 13:12:36 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)) 13:12:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:12:38 INFO - Downloading blessings-1.6.tar.gz 13:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:12:38 INFO - Installing collected packages: blessings 13:12:38 INFO - Running setup.py install for blessings 13:12:38 INFO - Successfully installed blessings 13:12:38 INFO - Cleaning up... 13:12:38 INFO - Return code: 0 13:12:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:38 INFO - Reading from file tmpfile_stdout 13:12:38 INFO - Current package versions: 13:12:38 INFO - argparse == 1.2.1 13:12:38 INFO - blessings == 1.6 13:12:38 INFO - blobuploader == 1.2.4 13:12:38 INFO - docopt == 0.6.1 13:12:38 INFO - functools32 == 3.2.3-2 13:12:38 INFO - jsonschema == 2.5.1 13:12:38 INFO - manifestparser == 1.1 13:12:38 INFO - mozInstall == 1.12 13:12:38 INFO - mozcrash == 1.0 13:12:38 INFO - mozdebug == 0.1 13:12:38 INFO - mozdevice == 0.49 13:12:38 INFO - mozfile == 1.2 13:12:38 INFO - mozhttpd == 0.7 13:12:38 INFO - mozinfo == 0.9 13:12:38 INFO - mozleak == 0.1 13:12:38 INFO - mozlog == 3.4 13:12:38 INFO - moznetwork == 0.27 13:12:38 INFO - mozprocess == 0.23 13:12:38 INFO - mozprofile == 0.28 13:12:38 INFO - mozrunner == 6.13 13:12:38 INFO - mozscreenshot == 0.1 13:12:38 INFO - mozsystemmonitor == 0.3 13:12:38 INFO - moztest == 0.7 13:12:38 INFO - mozversion == 1.4 13:12:38 INFO - psutil == 3.1.1 13:12:38 INFO - requests == 1.2.3 13:12:38 INFO - wsgiref == 0.1.2 13:12:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:38 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')]} 13:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:38 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')]} 13:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:38 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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:38 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 13:12:38 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 13:12:38 INFO - Using env: {'DISPLAY': ':0', 13:12:38 INFO - 'HOME': '/home/cltbld', 13:12:38 INFO - 'LANG': 'en_US.UTF-8', 13:12:38 INFO - 'LANGUAGE': 'en_US:en', 13:12:38 INFO - 'LOGNAME': 'cltbld', 13:12:38 INFO - 'MAIL': '/var/mail/cltbld', 13:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:38 INFO - 'MOZ_NO_REMOTE': '1', 13:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:38 INFO - 'NO_EM_RESTART': '1', 13:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:38 INFO - 'PWD': '/builds/slave/test', 13:12:38 INFO - 'SHELL': '/bin/bash', 13:12:38 INFO - 'SHLVL': '1', 13:12:38 INFO - 'TERM': 'linux', 13:12:38 INFO - 'TMOUT': '86400', 13:12:38 INFO - 'USER': 'cltbld', 13:12:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:38 INFO - '_': '/tools/buildbot/bin/python'} 13:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 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)) 13:12:38 INFO - Cleaning up... 13:12:38 INFO - Return code: 0 13:12:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:12:38 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')]} 13:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:38 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')]} 13:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:38 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 0x7f0c3115fe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29a6b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b42130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, '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': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', '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 13:12:38 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 13:12:38 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 13:12:38 INFO - Using env: {'DISPLAY': ':0', 13:12:38 INFO - 'HOME': '/home/cltbld', 13:12:38 INFO - 'LANG': 'en_US.UTF-8', 13:12:38 INFO - 'LANGUAGE': 'en_US:en', 13:12:38 INFO - 'LOGNAME': 'cltbld', 13:12:38 INFO - 'MAIL': '/var/mail/cltbld', 13:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:38 INFO - 'MOZ_NO_REMOTE': '1', 13:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:38 INFO - 'NO_EM_RESTART': '1', 13:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:38 INFO - 'PWD': '/builds/slave/test', 13:12:38 INFO - 'SHELL': '/bin/bash', 13:12:38 INFO - 'SHLVL': '1', 13:12:38 INFO - 'TERM': 'linux', 13:12:38 INFO - 'TMOUT': '86400', 13:12:38 INFO - 'USER': 'cltbld', 13:12:38 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:38 INFO - '_': '/tools/buildbot/bin/python'} 13:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:12:39 INFO - Cleaning up... 13:12:39 INFO - Return code: 0 13:12:39 INFO - Running post-action listener: _resource_record_post_action 13:12:39 INFO - Running post-action listener: _start_resource_monitoring 13:12:39 INFO - Starting resource monitoring. 13:12:39 INFO - [mozharness: 2016-11-23 21:12:39.169150Z] Finished create-virtualenv step (success) 13:12:39 INFO - [mozharness: 2016-11-23 21:12:39.169625Z] Running install step. 13:12:39 INFO - Running pre-action listener: _resource_record_pre_action 13:12:39 INFO - Running main action method: install 13:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:39 INFO - Reading from file tmpfile_stdout 13:12:39 INFO - Detecting whether we're running mozinstall >=1.0... 13:12:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:12:39 INFO - Reading from file tmpfile_stdout 13:12:39 INFO - Output received: 13:12:39 INFO - Usage: mozinstall [options] installer 13:12:39 INFO - Options: 13:12:39 INFO - -h, --help show this help message and exit 13:12:39 INFO - -d DEST, --destination=DEST 13:12:39 INFO - Directory to install application into. [default: 13:12:39 INFO - "/builds/slave/test"] 13:12:39 INFO - --app=APP Application being installed. [default: firefox] 13:12:39 INFO - mkdir: /builds/slave/test/build/application 13:12:39 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'] 13:12:39 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 13:12:56 INFO - Reading from file tmpfile_stdout 13:12:56 INFO - Output received: 13:12:56 INFO - /builds/slave/test/build/application/firefox/firefox 13:12:56 INFO - Running post-action listener: _resource_record_post_action 13:12:56 INFO - [mozharness: 2016-11-23 21:12:56.590456Z] Finished install step (success) 13:12:56 INFO - [mozharness: 2016-11-23 21:12:56.590708Z] Running run-tests step. 13:12:56 INFO - Running pre-action listener: _resource_record_pre_action 13:12:56 INFO - Running main action method: run_tests 13:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:12:56 INFO - Python 2.7.3 13:12:56 INFO - Return code: 0 13:12:56 INFO - grabbing minidump binary from tooltool 13:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:56 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 0x2bd0fc0>, '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 0x2bd1ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bd2350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:12:56 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 13:12:56 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 13:12:56 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 13:12:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:12:56 INFO - Return code: 0 13:12:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:12:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:12:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:12:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:12:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:12:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:12:56 INFO - Using env: {'DISPLAY': ':0', 13:12:56 INFO - 'HOME': '/home/cltbld', 13:12:56 INFO - 'LANG': 'en_US.UTF-8', 13:12:56 INFO - 'LANGUAGE': 'en_US:en', 13:12:56 INFO - 'LOGNAME': 'cltbld', 13:12:56 INFO - 'MAIL': '/var/mail/cltbld', 13:12:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:12:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:56 INFO - 'MOZ_NO_REMOTE': '1', 13:12:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:12:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:56 INFO - 'NO_EM_RESTART': '1', 13:12:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:56 INFO - 'PWD': '/builds/slave/test', 13:12:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:12:56 INFO - 'SHELL': '/bin/bash', 13:12:56 INFO - 'SHLVL': '1', 13:12:56 INFO - 'TERM': 'linux', 13:12:56 INFO - 'TMOUT': '86400', 13:12:56 INFO - 'USER': 'cltbld', 13:12:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329', 13:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:56 INFO - '_': '/tools/buildbot/bin/python'} 13:12:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:12:56 INFO - mozversion application_buildid: 20161123103008 13:12:56 INFO - mozversion application_changeset: 47f42f21541b9b98ad7db82edb996b29065debd0 13:12:56 INFO - mozversion application_display_name: Nightly 13:12:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:12:56 INFO - mozversion application_name: Firefox 13:12:56 INFO - mozversion application_remotingname: firefox 13:12:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:12:56 INFO - mozversion application_vendor: Mozilla 13:12:56 INFO - mozversion application_version: 53.0a1 13:12:56 INFO - mozversion platform_buildid: 20161123103008 13:12:56 INFO - mozversion platform_changeset: 47f42f21541b9b98ad7db82edb996b29065debd0 13:12:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:12:56 INFO - mozversion platform_version: 53.0a1 13:12:56 INFO - using testdate: 1479935576 13:12:56 INFO - actual date: 1479935576 13:12:56 INFO - starting webserver on 'localhost:45324' 13:12:56 INFO - SUITE-START | Running 2 tests 13:12:56 INFO - TEST-START | dromaeo_css 13:12:56 INFO - operating with platform_type : linux_ 13:12:56 INFO - Initialising browser for dromaeo_css test... 13:12:56 INFO - TEST-INFO | started process 25713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrly2t/profile http://localhost:45324/getInfo.html) 13:13:00 INFO - PROCESS | 25713 | __metrics Screen width/height:1600/1200 13:13:00 INFO - PROCESS | 25713 | colorDepth:24 13:13:00 INFO - PROCESS | 25713 | Browser inner width/height: 1024/697 13:13:00 INFO - PROCESS | 25713 | __metrics 13:13:01 INFO - PROCESS | 25713 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:13:01 INFO - PROCESS | 25713 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:02 INFO - PROCESS | 25713 | console.error: PushService: 13:13:02 INFO - PROCESS | 25713 | stateChangeProcessEnqueue: Error transitioning state 13:13:02 INFO - PROCESS | 25713 | UnknownError 13:13:02 INFO - TEST-INFO | 25713: exit 0 13:13:02 INFO - Browser initialized. 13:13:02 INFO - Running cycle 1/1 for dromaeo_css test... 13:13:02 INFO - TEST-INFO | started process 25798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrly2t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:15 INFO - PROCESS | 25798 | RSS: Main: 172933120 13:13:15 INFO - PROCESS | 25798 | 13:14:06 INFO - PROCESS | 25798 | 1479935646727 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] 13:16:17 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:45324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45324/tests/dromaeo/cssquery-ext.html) 13:16:19 INFO - PROCESS | 25798 | RSS: Main: 313372672 13:16:19 INFO - PROCESS | 25798 | 13:19:21 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:45324/tests/dromaeo/cssquery-ext.html (next: http://localhost:45324/tests/dromaeo/cssquery-jquery.html) 13:19:22 INFO - PROCESS | 25798 | RSS: Main: 291782656 13:19:22 INFO - PROCESS | 25798 | 13:22:24 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:45324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45324/tests/dromaeo/cssquery-mootools.html) 13:22:25 INFO - PROCESS | 25798 | RSS: Main: 222347264 13:22:25 INFO - PROCESS | 25798 | 13:25:27 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:45324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45324/tests/dromaeo/cssquery-prototype.html) 13:25:27 INFO - PROCESS | 25798 | RSS: Main: 231223296 13:25:27 INFO - PROCESS | 25798 | 13:28:30 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:45324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45324/tests/dromaeo/cssquery-yui.html) 13:28:31 INFO - PROCESS | 25798 | RSS: Main: 221073408 13:28:31 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | Cycle 1(1): loaded http://localhost:45324/tests/dromaeo/cssquery-yui.html (next: http://localhost:45324/tests/dromaeo/cssquery-dojo.html) 13:31:34 INFO - PROCESS | 25798 | RSS: Main: 309248000 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | __start_tp_report 13:31:34 INFO - PROCESS | 25798 | _x_x_mozilla_page_load 13:31:34 INFO - PROCESS | 25798 | _x_x_mozilla_page_load_details 13:31:34 INFO - PROCESS | 25798 | |i|pagename|runs| 13:31:34 INFO - PROCESS | 25798 | |0;dojo.html;3026.1375507980224;3049.95425068624;3057.3732384861105;3073.6772638872903;3098.4732595458768;5307.65500242484;5329.040772660919;5378.408375078739;5405.54052905503;5417.729113544322;5364.1149210380245;5376.91934620981;5427.294451721281;5432.70120143392;5483.725813709309;4842.588379987706;4864.7567621618955;4914.3119963205;4935.802567897298;4962.602991760668;5003;5050.3434553508;5070.74646267687;5074.416442109149;5123.795048198068;4987.077390682735;4997.700137991696;5041.571466425358;5064.670796398241;5096.031753966735;4867.099586576494;4902.2401527762895;4905.6320775941595;4908.7300198489065;4928.063667903087;4919.631027672903;4924.4583095859425;4931.087748766489;4989.151844186461;5003.799848006075;5391.299131112969;5426.21319908615;5427.945720542783;5446.782128714846;5454.481824226732;5644.4073372295725;5685.744141513642;5742.994975879246;5800.187973683687;5823.912641310384;5804.361520232771;5855.590108692393;5858.209141765849;5887.941120588825;5898.852528686817;5431.375391829911;5438.972805135949;5439.646422982533;5440.537554307849;5441.29263195786;5774.509166720875;5843.094320380348;5900.734466948998;5955.315138759098;5964.731587078505;5644.125160600113;5665.518430933417;5693.17448969897;5696.060150075274;5796.536277097822;5747.827565173052;5792.652440853562;5812.070068789058;5815.185873977646;5817.214676018768;5761.48146666802;5771.249737534177;5778.393268706809;5789.189513468118;5793.971030144822;5541.27963364768;5559.777608895599;5577.05190117681;5664.971675141598;5670.291213598301;4285.507166675872;4293.463317085364;4295;4319.438472998553;4326.069894972596;3929;3942.940855887164;3958.267720471722;3973.920521589552;4005.919881602352;5393.27190829233;5429;5434.891302174014;5441.646292990943;5445.83662490126;5671.688057156896;5705.857353566194;5838.38696936824;5842.094475356326;5847.883042339215;5434.755436005389;5446.128619420873;5457.045017121988;5461.781528738806;5463.098588732814;4828.61371090312;4862.05189987949;4868.464468908417;4872.220444728897;4874.2201247800895;5957.523398128226;5994.640321580632;6001.639901605918;6014.51883849291;6015.6691381974415;5741.684207368635;5750.539956803529;5764.99112655292;5774.711264436845;5779.855503612275;6062.060380641008;6066.029435290332;6083.057126145454;6087.391260873877;6090.9390906090375;5589.552835773047;5659.462351076641;5712.65724056558;5722.570807189394;5751.1373294006235;5778.682172480386;5780.797672081457;5811.941880581309;5814.622049566765;5834.008218602932;5704.1443783432815;5727.799527016535;5729.369769325454;5729.885402292014;5736.397678243724;5512.80705175317;5560.36055853582;5618.073017952155;5637.126245431965;5654.123610840326;5642.294713160855;5665.943340566707;5673.74468148926;5677.120046392815;5722.685252311163;5690.061139911868;5695.373508914099;5697.487226149667;5701.201831743476;5702.6863522506665;5413.188021796762;5464.617476776746;5484.670919744828;5586;5598.916016259678 13:31:34 INFO - PROCESS | 25798 | |1;ext.html;559.1780083277582;574.342377977216;591.3170288316995;598.9460948514638;599.9670018149;34932.4760128598;41315.38026929599;42366.78816605917;42635.3604695929;46536;44229.336559951626;44889;45074.549254507445;45203.547964520345;45237.547624523744;7804.687812487494;8461.407701460901;8617.310615150773;8619.956900215522;8620.224179823814;7959.602019899011;9988.700338989842;10215.642452514163;10234.846477302846;10613.150947924187;10101.292909496338;10141.239407044464;10144.49277536124;10145.289829711923;10154.187664986783;10318.484075796181;10360.274780765349;10371.325863818904;10377.221708371864;10390.376577405304;10187.796244075076;10246.692599222035;10260.589576417009;10262.127719143882;10268.64059757905;41604.58395416037;41686.166276674296;41927.16145677069;41968.1606367874;42013.78993105046;3445.3349825189666;3500.982495087508;3517.9472307915403;3555.0579096539436;3557.4308110702423;31390;32082.518762218584;32194.195145121324;32200.194995125075;32272.838635806904;4213.641840443566;4356.346548017791;4361.869143925687;4434.423524941737;4485.573870482299;340149;342741.2984571695;345172;348597;349593;58508.70745646244;58879;58944;58955.70522147362;58974;62119.37880621136;62759.6862015687;62793.37206627875;62799.37200628027;62925;17482.475525734248;17718.822811771974;17740.29038838458;17742.112894355232;17743.467695969142;11791.823122653168;11871.584494542822;13256.53602123921;13516.39176237052;13585.52450664222;19067.474602031805;19215.231390744495;19744.124308190698;19970.60058798816;19993.800061999485;7099;7138.214796372395;7169.462290328246;7229.277072292729;7292.124945006633;945.413843417072;1006.2050979726081;1048.4705223862054;1073.1361254190297;1101.9063379612824;32319.676803231665;32831.83584082064;32889;32921.67078329234;33377.49933750996;1100.8128618134936;1190.2025642819158;1190.3810018790355;1208.172401904698;1208.5347141350644;16860.241289142017;17444.651106977788;17483.388081417088;17550.912245438692;17560;521567;524653;526517;527761;528264;60241;60512.394876050676;60643.39356606377;60669.69665151646;60792.69603652042;1232.5254776910954;1271.0340141492532;1309.1032642639632;1328.1499840102342;1361.4213959067356;29218;33622;33790.15524611806;33794.49308260427;34571.30857382889;51951.74024130006;52475.47524524706;52519.21221181762;52543.73728131335;52548.47451525589;384592;384711;387186;387742;388974;43300.35049474197;43382.78308608437;43971;44363.33454998113;44491.332630011224;46826.76586617045;47787.76106119447;47829;47966;48261.27608085952;40174.59825401709;40956.59043409528;41171.38242926419;41415.79292103641;42635.78682106694;42266.57733422626;42473.15053698847;42520.5747942529;42538.57461425346;42874.57125428706;41558.376624351265;42045;42386.788066059475;42706.57293427026;42716.786416068964;33542.664573353955;36808.81595592005;37038.62961370352;37636.24727505489;37835.43246851354;27695.44609107847;28250;28287.2928176789;28320.71679283181;28365.432691345646 13:31:34 INFO - PROCESS | 25798 | |2;jquery.html;376.12363193758546;395.20958083832335;404.17346526353606;411.21458015190984;426.4967338540523;13626.318684065795;15574.14342211178;18921.99999999998;19074.141663625134;19523.316683916066;16498.75251871223;16844.32622695094;16918;17006.06466644334;17026.14869256535;5486.396496385404;5713.914291285634;5717.142428635717;5722.256106706143;5722.284714410699;5361.892762144755;5701.0878259478495;5729.684867332295;5734.741936612862;5735.2544169257935;5687.601867869251;5693.572982026344;5698.202251684746;5704.543636509069;5705.5720820938595;5462.945370546284;5729.455701708331;5753.395893431171;5760.942390576082;5800.651960882318;5515.70380960474;5640.605157638967;5645.068563686987;5647.152927060933;5711.400302968212;13956.651083722887;14158.221297828615;14230;14238.501652442115;14245.358958846877;2282.5777231212114;2378.3340664613934;2503.6244563315468;2704.2698471412805;2838.2194896403653;10085.747856303578;10113.292069555135;10144.137748291405;10561.260711750181;10791;1836.8438682711985;1841.9539511512319;1856.4059500959697;1893.2521653946615;1981.73246611707;81665.59167204186;83139.5843020781;83356.58321708413;83742.16257837405;85998.99999999937;10845.023947844731;10972.122230221563;11158.218924675357;11166.888331116585;11314.490847911864;15379.538613841603;15382;15414.537563873102;15417.614559635875;15450;7657.617119144021;8184.836303273901;8250.669973201006;8474.364422668325;8475.618597163142;7798.532088074734;7831.921680783119;7902.762917112381;8092.757217283491;8155.388345874083;4695.835645752382;4721.1501929652995;4752.524747525289;4756.714597124114;4884.682495637843;1876.8217019383137;1959.1673538745977;1974.1511150205263;1980.4751740788702;2006.4582562707988;928.7770934975557;939.5818860607101;983.9114479696862;1013.7313611892854;1033.0908800255727;18963;19049.80950190508;19199.136038878285;19285.325013624737;19443.51391215231;930.6742640075919;973.6640858903667;976.511744127936;1000.0999100809184;1043.4834756795283;9614.895558558408;10601.522931468102;10610.787784244272;10663.84004239937;10678.145748340114;465374;475222.3405372173;475439;478480;487894;91236;91495.54252228829;94159;96194;96371;939.9013103624021;980.7057882635323;1017.0947856407803;1039.3192458939407;1049.1449468683;16269.3492260313;16433.342666293214;16774.49676509707;17052;17081.74377384365;40725;41009.58990410177;41021.58978410297;41166.79416603017;42621;51476;52890.2066469011;59043;59751.40248597632;61021.38978610335;10779.19156063314;11851.525938962344;12131.393430328624;12359.752804943671;12514.15628539077;13486.86513134856;13754.793678095037;13913;13921.79117313221;14431.42274309058;11142.554297827995;11615.477303521193;11871.643850684493;11890.762184756084;12557.372131393211;12023.699407514881;12348.506059757508;12356.25862448256;12384.380780960735;12697.492100315883;12196.390180491117;12223;12319.384030798245;12471;12609.369531523571;12049.518019279481;12343.567975120828;12413.627591172279;12670.149216426598;12712.745745084861;12116.878831211927;12168.634940951786;12244.877551224374;12306.323152226714;12571.685707857378 13:31:34 INFO - PROCESS | 25798 | |3;mootools.html;1339.5352551305607;1434.6843694387235;1460.2771628044115;1565.632076462032;1732.7487514310426;7400.333969942711;8171.346292296616;8473.110323416046;8475.364347673925;8656;8422.789430264247;8440.704575339865;8458.154184581539;8500.91499085009;8504.489730616151;1993.232605446906;2083.7082808406835;2284.132029828663;2284.908603655852;2318.246569864792;2223.4219103033165;2304.51605162916;2304.5506126305377;2321.442853715105;2327.2552783109413;2267.6598510223516;2285.074544809355;2287.279506955312;2293.472501324696;2303.0442366417915;2264.6376579747243;2268.4669102760836;2270.727512698487;2275.9089636414524;2281.406834223097;2222.844400891938;2265;2270.1600407849037;2272.1479445208047;2275.328778010491;8322.958385208096;8482.98204215492;8485.872711909326;8500.404971651988;8501.659933602648;4943.530364615356;5090.134677104901;5099.36257967754;5100.285959965608;5101.617378696613;3171.8255495947715;3321.4021476134285;3323.7008669219645;3325.5177999190223;3486.9128271793156;1103.9779204415868;1151.7503508693078;1175.7295821960997;1206.7827790997617;1231.7105480212142;11666.766664666658;11669.124815638861;11712.648620541397;11746.471408786625;11767.352795596324;4450.844220452269;4560.521145279764;4632.791524381343;4643.048175124091;4736.526347365236;9998.300118991601;9998.700038998843;10016.348937319051;10018.499075046218;10020.64927727526;5191.662541934762;5198.402183748842;5200.739963001911;5201.6358854880555;5203.739813009334;4713.599344055725;4749.525047495292;4753.47711751707;4782.306565547976;4829.613630909519;3810.704360517382;3838.7504812187676;3888.1446081861945;3888.7083468739957;3991.880243592697;1303.8174655548041;1306.1575283941995;1310.5740634293702;1321.966950826237;1333.6199183232927;800.415696541528;821.37575442664;912.9224015958586;925.6436272035315;959.6785076999143;5549;5588;5637.182608521742;5762.423757624288;5785.479306862402;874.3486102853287;886.4371124336093;919.5080631862055;937.3204426790522;940.3699521320732;3782;3819.52255968004;3820.121372084436;3828.6554210120667;3852.8844134676006;10321.277510574339;10618.044376006043;10723.410212438235;10725.624603138853;10729.89270107289;10585.947070264754;10592.417417041983;10603.893961060445;10652.520636571373;10654.680359589225;7787.922120778833;7912.0901096374655;7920.4455688102435;7920.801979950547;7932.167122452175;5460.372057213472;5513.924784666951;5528.364238112668;5667.206591077335;5759.452851979056;9475.147236748726;9518.619255229713;9546.331756776959;9554.092361225672;9666.854997174907;8736.170063843925;9385.483798391155;9729.562169702522;9807.117359437685;9808.215342772419;6960.860782784417;7218.747343842941;7390.187079421152;7513.812154696177;7683.731069412544;8197.590120493833;8201.58992050407;8202.917970820215;8212.589370531568;8297.585120743817;7116.679749411185;7155.105611798525;7163;7179.210286868545;7252.311030452099;7319.74380896666;7371.631418429164;7391.371733402506;7483.625818708934;7640.961795190989;6849.828754280983;6868.450523958171;6894.689738961859;6932.722691092502;6933.479989000744;4527.615152712056;4749.26386410107;4758.476567577494;4837.854864354075;4874.683145595525;4936.7284799336385;4969.279454479008;4996.100701873697;5012.122878496321;5216.374035115658 13:31:34 INFO - PROCESS | 25798 | |4;prototype.html;330.7061665808547;341.62591961801826;345.2766454278288;347.3123216032256;351.2851347507822;5106.489351064901;5206.24509446131;5277.1556550951855;5290.867728306799;5298.20526920962;5041.319421878045;5105.259737338084;5108.310378098956;5140.7172605506685;5174.456682048387;4085.2238074765846;4090.611391917778;4115.753054816706;4129.504459464868;4131.483564554431;3997.5202975642965;4083.3670781028986;4105.589441055886;4120.278951183546;4122.2579935611575;4073.30753771858;4087.8758341456187;4090.447789548403;4094.6314831665145;4107.7535347879075;4068.389741538793;4082.387641853716;4091.6112969267874;4094.8362065517344;4099.8930288822;3657.305112028706;3660.5790334111653;3663.5970043295215;3681.5214022176947;3694.1503454205413;4859.927101093486;4966.453690094087;4985.1774457214515;5020.924686129711;5028.673136246132;4658.34783130362;4668.813247470097;4672.906541869178;4675.2052151134385;4680.765961701902;5338.733063346817;5341.599380046512;5366.409694933554;5369.892602147936;5371.435999220064;3930.960690393088;3982.8406863725418;3991.860284890044;4002.6197511236387;4028.47629808126;5509.944900550983;5519.034169020405;5535.6955367454775;5536.99999999996;5540.806071787509;4043.73715708478;4058.2492238935893;4061.3501839705505;4071.7353372030725;4077.1641813428178;4030.8636422696018;4115.032967252693;4134.359174327984;4148.444333374984;4175.97912010438;4631.606313463393;4634.9536504634525;4641.052931388593;4668.486466488684;4677.695949763254;5381.54256888161;5386.407495175527;5400.675959442446;5411.269478620415;5457.399686034533;1334.1461464662623;1354.0995238166706;1383.8616138386283;1386.7642500774894;1388.167099740148;956.861255118004;977.8728765260613;982.268210183418;982.7395740128871;992.7220378294089;5018.899622007612;5032.345795046621;5081.517255860687;5101.69389836611;5113.514216149534;5315.149576067811;5320.132079147536;5377.327834020747;5377.838664840061;5378.515933565998;4924.778384972685;5056.544910958031;5078.7460626968505;5090.643654944119;5091.592672586185;2798.580212968071;2818.3799564095866;2819.6898341182455;2822.5907243449997;2824.263078206888;5515.283013208257;5534.916976245279;5555.694436805934;5557.722113894289;5575.048732943437;5287.7884884604955;5305.734713264322;5323.334583177103;5347.705876176769;5409.540189083972;5451.591130665216;5496.697681627549;5503.587230957694;5512.80705175317;5525.502704756431;5262.789628356023;5271.499207575274;5297.311349524537;5318.547923426398;5365.436629153883;5237.528622424;5441.319835020622;5486.49121491593;5516.531094856982;5518.227448157341;5822.10781496007;5825.84443755813;5827.621204621686;5828.679422631796;5853.473187413153;3828.980855095707;4018.216447792652;4029.6903506359963;4031.334829753058;4038.6769058474665;5304.655197412156;5483.698396588066;5495.873345964148;5500.559955203494;5538.196961440649;5223.007628550563;5264.973675131753;5436.293281873332;5438.592105592017;5444.700541470257;5405.702576404933;5417.891642167214;5420;5420.728963551728;5422.539084177889;5317.6543524672325;5403.729813509231;5405.162199859028;5405.675609475704;5444.156155795858;5425.972870135782;5442.619016668795;5444.128939369682;5448.754806033818;5452.890942181055;5340.759665815125;5342.729340030549;5353.9732301338245;5371.274877891435;5386.299781028441 13:31:34 INFO - PROCESS | 25798 | |5;yui.html;720.7441358317794;745.496789666975;790.9520627614028;804.0994086622982;816.8529664660359;12887;13926;13926.373313200906;13930.791038134435;14008.167182322095;13778.448862045507;14005.92997035016;14010.579682609512;14016.719665606683;14021.369038393272;654.7119267522274;675.9826461175948;756.7011030642893;768.2893323675592;781.0276206123384;766.3409467857638;776.7941495503696;778.4861991085885;778.852018116556;780.2080887898787;836.3016880904452;837.5686521441462;837.9790505237357;838.053000109875;838.0571856661256;689.0663151429791;702.9859402811915;806.5886397937036;830.6179157587517;831.9251267385933;607.0954278125605;607.8541150123982;611.0528680545137;611.4252602553586;611.4527497889364;13265.27041012744;13355.599332020054;13374.465021399132;13375.732485350238;13446.529371471952;13277.46890124394;13367.532136375277;13400.39698213573;13457.058005939589;13605.455781768718;12527.310997895112;12575.622731318075;12588;12808.615741527768;12896.935515322364;4256.787160641956;4273.9358909616385;4283.528811830696;4293.24868148076;4489.281714925629;53594.73202634001;56360.71819640876;56427.71786141043;63936;64064;10889.183311251687;10980.560777568808;11043.171762117874;11047.392393418439;11289;19422.320218792276;19434.902825486064;19435.416937491616;19448.805511944982;19492.415227543195;7860.5676687782725;8079.919200807916;8243.422960392714;8356.28971537414;8371.409432207862;4428.202923473806;4509.526499717483;4511.436070491189;4570;4590.196715574761;3265.8203798791296;3311.586051743532;3316.817575033396;3335.5663763710563;3355.2282974915906;618.9226346706662;622.1507642068544;629.298332359416;632.9936700633027;636.5862189576812;594.8572342637735;671.5936858200815;701.708790851801;704.021699025729;706.3113464372196;8899.777505562413;8943.552822358855;8997.595108220146;9037.412568183046;9041.367104302635;556.9832905012856;584.8742520358144;693.7641201991347;734.5739471106853;735.8932954721536;4130.442390277274;4421.40311058003;4478.731276123443;4568.33759104928;4663.533646635309;52492.73753631284;56167.71916140393;68906.65546672334;70315.64842175756;71098.2890171102;42814.357784633256;43608.3458748119;56107.158392624144;62046.0693089604;68031.65984170047;62061.68969155216;63224.68387658124;63864;64897.999999999054;66263;8649.697260595849;9144.679936202201;9259.444433334022;9309;9319.394239374418;34823.825880870434;39265.411018835315;43854.78072609616;44925.32612010757;46044.30933536067;49340.013199736524;56782;58536;59393.40606593879;59769.701151493966;12028.819567706667;12118;12150.696232594255;12240.87759122433;12455.377231138587;13364.799528007283;13669.726605468033;14254.947700357832;14348.139111653334;14372.209528476034;12556.686082848002;13329.866701332863;13431.261280629658;13472.663183420102;13769.173849569059;12903.354832258161;13174.40715167839;13291.601251962456;13480.123791953492;13910.151402333086;12443.315617641116;12698.873011269769;12924.741505169655;12924.806127907901;12987.480500779862;10221.182305415698;10286.537105830404;10424.583016679248;10565.20760942917;10646.361218326925;10204.846927296245;10746.408947507962;10807.67576972692;10904.400257985886;10962.616308429167 13:31:34 INFO - PROCESS | 25798 | __end_tp_report 13:31:34 INFO - PROCESS | 25798 | __start_cc_report 13:31:34 INFO - PROCESS | 25798 | _x_x_mozilla_cycle_collect,1338 13:31:34 INFO - PROCESS | 25798 | __end_cc_report 13:31:34 INFO - PROCESS | 25798 | __startTimestamp1479936694622__endTimestamp 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | ------- Summary: start ------- 13:31:34 INFO - PROCESS | 25798 | Number of tests: 6 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | [#0] dojo.html Cycles:165 Average:5371.64 Median:5577.05 stddev:621.12 (11.1%) stddev-sans-first:595.14 13:31:34 INFO - PROCESS | 25798 | Values: 3026.1 3050.0 3057.4 3073.7 3098.5 5307.7 5329.0 5378.4 5405.5 5417.7 5364.1 5376.9 5427.3 5432.7 5483.7 4842.6 4864.8 4914.3 4935.8 4962.6 5003.0 5050.3 5070.7 5074.4 5123.8 4987.1 4997.7 5041.6 5064.7 5096.0 4867.1 4902.2 4905.6 4908.7 4928.1 4919.6 4924.5 4931.1 4989.2 5003.8 5391.3 5426.2 5427.9 5446.8 5454.5 5644.4 5685.7 5743.0 5800.2 5823.9 5804.4 5855.6 5858.2 5887.9 5898.9 5431.4 5439.0 5439.6 5440.5 5441.3 5774.5 5843.1 5900.7 5955.3 5964.7 5644.1 5665.5 5693.2 5696.1 5796.5 5747.8 5792.7 5812.1 5815.2 5817.2 5761.5 5771.2 5778.4 5789.2 5794.0 5541.3 5559.8 5577.1 5665.0 5670.3 4285.5 4293.5 4295.0 4319.4 4326.1 3929.0 3942.9 3958.3 3973.9 4005.9 5393.3 5429.0 5434.9 5441.6 5445.8 5671.7 5705.9 5838.4 5842.1 5847.9 5434.8 5446.1 5457.0 5461.8 5463.1 4828.6 4862.1 4868.5 4872.2 4874.2 5957.5 5994.6 6001.6 6014.5 6015.7 5741.7 5750.5 5765.0 5774.7 5779.9 6062.1 6066.0 6083.1 6087.4 6090.9 5589.6 5659.5 5712.7 5722.6 5751.1 5778.7 5780.8 5811.9 5814.6 5834.0 5704.1 5727.8 5729.4 5729.9 5736.4 5512.8 5560.4 5618.1 5637.1 5654.1 5642.3 5665.9 5673.7 5677.1 5722.7 5690.1 5695.4 5697.5 5701.2 5702.7 5413.2 5464.6 5484.7 5586.0 5598.9 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | [#1] ext.html Cycles:180 Average:59346.29 Median:387464.00 stddev:112640.78 (29.1%) stddev-sans-first:112870.29 13:31:34 INFO - PROCESS | 25798 | Values: 559.2 574.3 591.3 598.9 600.0 34932.5 41315.4 42366.8 42635.4 46536.0 44229.3 44889.0 45074.5 45203.5 45237.5 7804.7 8461.4 8617.3 8620.0 8620.2 7959.6 9988.7 10215.6 10234.8 10613.2 10101.3 10141.2 10144.5 10145.3 10154.2 10318.5 10360.3 10371.3 10377.2 10390.4 10187.8 10246.7 10260.6 10262.1 10268.6 41604.6 41686.2 41927.2 41968.2 42013.8 3445.3 3501.0 3517.9 3555.1 3557.4 31390.0 32082.5 32194.2 32200.2 32272.8 4213.6 4356.3 4361.9 4434.4 4485.6 340149.0 342741.3 345172.0 348597.0 349593.0 58508.7 58879.0 58944.0 58955.7 58974.0 62119.4 62759.7 62793.4 62799.4 62925.0 17482.5 17718.8 17740.3 17742.1 17743.5 11791.8 11871.6 13256.5 13516.4 13585.5 19067.5 19215.2 19744.1 19970.6 19993.8 7099.0 7138.2 7169.5 7229.3 7292.1 945.4 1006.2 1048.5 1073.1 1101.9 32319.7 32831.8 32889.0 32921.7 33377.5 1100.8 1190.2 1190.4 1208.2 1208.5 16860.2 17444.7 17483.4 17550.9 17560.0 521567.0 524653.0 526517.0 527761.0 528264.0 60241.0 60512.4 60643.4 60669.7 60792.7 1232.5 1271.0 1309.1 1328.1 1361.4 29218.0 33622.0 33790.2 33794.5 34571.3 51951.7 52475.5 52519.2 52543.7 52548.5 384592.0 384711.0 387186.0 387742.0 388974.0 43300.4 43382.8 43971.0 44363.3 44491.3 46826.8 47787.8 47829.0 47966.0 48261.3 40174.6 40956.6 41171.4 41415.8 42635.8 42266.6 42473.2 42520.6 42538.6 42874.6 41558.4 42045.0 42386.8 42706.6 42716.8 33542.7 36808.8 37038.6 37636.2 37835.4 27695.4 28250.0 28287.3 28320.7 28365.4 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | [#2] jquery.html Cycles:180 Average:28604.98 Median:10741.24 stddev:78716.08 (732.8%) stddev-sans-first:78908.36 13:31:34 INFO - PROCESS | 25798 | Values: 376.1 395.2 404.2 411.2 426.5 13626.3 15574.1 18922.0 19074.1 19523.3 16498.8 16844.3 16918.0 17006.1 17026.1 5486.4 5713.9 5717.1 5722.3 5722.3 5361.9 5701.1 5729.7 5734.7 5735.3 5687.6 5693.6 5698.2 5704.5 5705.6 5462.9 5729.5 5753.4 5760.9 5800.7 5515.7 5640.6 5645.1 5647.2 5711.4 13956.7 14158.2 14230.0 14238.5 14245.4 2282.6 2378.3 2503.6 2704.3 2838.2 10085.7 10113.3 10144.1 10561.3 10791.0 1836.8 1842.0 1856.4 1893.3 1981.7 81665.6 83139.6 83356.6 83742.2 85999.0 10845.0 10972.1 11158.2 11166.9 11314.5 15379.5 15382.0 15414.5 15417.6 15450.0 7657.6 8184.8 8250.7 8474.4 8475.6 7798.5 7831.9 7902.8 8092.8 8155.4 4695.8 4721.2 4752.5 4756.7 4884.7 1876.8 1959.2 1974.2 1980.5 2006.5 928.8 939.6 983.9 1013.7 1033.1 18963.0 19049.8 19199.1 19285.3 19443.5 930.7 973.7 976.5 1000.1 1043.5 9614.9 10601.5 10610.8 10663.8 10678.1 465374.0 475222.3 475439.0 478480.0 487894.0 91236.0 91495.5 94159.0 96194.0 96371.0 939.9 980.7 1017.1 1039.3 1049.1 16269.3 16433.3 16774.5 17052.0 17081.7 40725.0 41009.6 41021.6 41166.8 42621.0 51476.0 52890.2 59043.0 59751.4 61021.4 10779.2 11851.5 12131.4 12359.8 12514.2 13486.9 13754.8 13913.0 13921.8 14431.4 11142.6 11615.5 11871.6 11890.8 12557.4 12023.7 12348.5 12356.3 12384.4 12697.5 12196.4 12223.0 12319.4 12471.0 12609.4 12049.5 12343.6 12413.6 12670.1 12712.7 12116.9 12168.6 12244.9 12306.3 12571.7 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | [#3] mootools.html Cycles:180 Average:5581.79 Median:4982.69 stddev:3143.71 (63.1%) stddev-sans-first:3136.36 13:31:34 INFO - PROCESS | 25798 | Values: 1339.5 1434.7 1460.3 1565.6 1732.7 7400.3 8171.3 8473.1 8475.4 8656.0 8422.8 8440.7 8458.2 8500.9 8504.5 1993.2 2083.7 2284.1 2284.9 2318.2 2223.4 2304.5 2304.6 2321.4 2327.3 2267.7 2285.1 2287.3 2293.5 2303.0 2264.6 2268.5 2270.7 2275.9 2281.4 2222.8 2265.0 2270.2 2272.1 2275.3 8323.0 8483.0 8485.9 8500.4 8501.7 4943.5 5090.1 5099.4 5100.3 5101.6 3171.8 3321.4 3323.7 3325.5 3486.9 1104.0 1151.8 1175.7 1206.8 1231.7 11666.8 11669.1 11712.6 11746.5 11767.4 4450.8 4560.5 4632.8 4643.0 4736.5 9998.3 9998.7 10016.3 10018.5 10020.6 5191.7 5198.4 5200.7 5201.6 5203.7 4713.6 4749.5 4753.5 4782.3 4829.6 3810.7 3838.8 3888.1 3888.7 3991.9 1303.8 1306.2 1310.6 1322.0 1333.6 800.4 821.4 912.9 925.6 959.7 5549.0 5588.0 5637.2 5762.4 5785.5 874.3 886.4 919.5 937.3 940.4 3782.0 3819.5 3820.1 3828.7 3852.9 10321.3 10618.0 10723.4 10725.6 10729.9 10585.9 10592.4 10603.9 10652.5 10654.7 7787.9 7912.1 7920.4 7920.8 7932.2 5460.4 5513.9 5528.4 5667.2 5759.5 9475.1 9518.6 9546.3 9554.1 9666.9 8736.2 9385.5 9729.6 9807.1 9808.2 6960.9 7218.7 7390.2 7513.8 7683.7 8197.6 8201.6 8202.9 8212.6 8297.6 7116.7 7155.1 7163.0 7179.2 7252.3 7319.7 7371.6 7391.4 7483.6 7641.0 6849.8 6868.5 6894.7 6932.7 6933.5 4527.6 4749.3 4758.5 4837.9 4874.7 4936.7 4969.3 4996.1 5012.1 5216.4 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | [#4] prototype.html Cycles:180 Average:4542.20 Median:5190.35 stddev:1302.35 (25.1%) stddev-sans-first:1267.06 13:31:34 INFO - PROCESS | 25798 | Values: 330.7 341.6 345.3 347.3 351.3 5106.5 5206.2 5277.2 5290.9 5298.2 5041.3 5105.3 5108.3 5140.7 5174.5 4085.2 4090.6 4115.8 4129.5 4131.5 3997.5 4083.4 4105.6 4120.3 4122.3 4073.3 4087.9 4090.4 4094.6 4107.8 4068.4 4082.4 4091.6 4094.8 4099.9 3657.3 3660.6 3663.6 3681.5 3694.2 4859.9 4966.5 4985.2 5020.9 5028.7 4658.3 4668.8 4672.9 4675.2 4680.8 5338.7 5341.6 5366.4 5369.9 5371.4 3931.0 3982.8 3991.9 4002.6 4028.5 5509.9 5519.0 5535.7 5537.0 5540.8 4043.7 4058.2 4061.4 4071.7 4077.2 4030.9 4115.0 4134.4 4148.4 4176.0 4631.6 4635.0 4641.1 4668.5 4677.7 5381.5 5386.4 5400.7 5411.3 5457.4 1334.1 1354.1 1383.9 1386.8 1388.2 956.9 977.9 982.3 982.7 992.7 5018.9 5032.3 5081.5 5101.7 5113.5 5315.1 5320.1 5377.3 5377.8 5378.5 4924.8 5056.5 5078.7 5090.6 5091.6 2798.6 2818.4 2819.7 2822.6 2824.3 5515.3 5534.9 5555.7 5557.7 5575.0 5287.8 5305.7 5323.3 5347.7 5409.5 5451.6 5496.7 5503.6 5512.8 5525.5 5262.8 5271.5 5297.3 5318.5 5365.4 5237.5 5441.3 5486.5 5516.5 5518.2 5822.1 5825.8 5827.6 5828.7 5853.5 3829.0 4018.2 4029.7 4031.3 4038.7 5304.7 5483.7 5495.9 5500.6 5538.2 5223.0 5265.0 5436.3 5438.6 5444.7 5405.7 5417.9 5420.0 5420.7 5422.5 5317.7 5403.7 5405.2 5405.7 5444.2 5426.0 5442.6 5444.1 5448.8 5452.9 5340.8 5342.7 5354.0 5371.3 5386.3 13:31:34 INFO - PROCESS | 25798 | 13:31:34 INFO - PROCESS | 25798 | [#5] yui.html Cycles:180 Average:15934.95 Median:4510.48 stddev:19384.30 (429.8%) stddev-sans-first:19405.01 13:31:34 INFO - PROCESS | 25798 | Values: 720.7 745.5 791.0 804.1 816.9 12887.0 13926.0 13926.4 13930.8 14008.2 13778.4 14005.9 14010.6 14016.7 14021.4 654.7 676.0 756.7 768.3 781.0 766.3 776.8 778.5 778.9 780.2 836.3 837.6 838.0 838.1 838.1 689.1 703.0 806.6 830.6 831.9 607.1 607.9 611.1 611.4 611.5 13265.3 13355.6 13374.5 13375.7 13446.5 13277.5 13367.5 13400.4 13457.1 13605.5 12527.3 12575.6 12588.0 12808.6 12896.9 4256.8 4273.9 4283.5 4293.2 4489.3 53594.7 56360.7 56427.7 63936.0 64064.0 10889.2 10980.6 11043.2 11047.4 11289.0 19422.3 19434.9 19435.4 19448.8 19492.4 7860.6 8079.9 8243.4 8356.3 8371.4 4428.2 4509.5 4511.4 4570.0 4590.2 3265.8 3311.6 3316.8 3335.6 3355.2 618.9 622.2 629.3 633.0 636.6 594.9 671.6 701.7 704.0 706.3 8899.8 8943.6 8997.6 9037.4 9041.4 557.0 584.9 693.8 734.6 735.9 4130.4 4421.4 4478.7 4568.3 4663.5 52492.7 56167.7 68906.7 70315.6 71098.3 42814.4 43608.3 56107.2 62046.1 68031.7 62061.7 63224.7 63864.0 64898.0 66263.0 8649.7 9144.7 9259.4 9309.0 9319.4 34823.8 39265.4 43854.8 44925.3 46044.3 49340.0 56782.0 58536.0 59393.4 59769.7 12028.8 12118.0 12150.7 12240.9 12455.4 13364.8 13669.7 14254.9 14348.1 14372.2 12556.7 13329.9 13431.3 13472.7 13769.2 12903.4 13174.4 13291.6 13480.1 13910.2 12443.3 12698.9 12924.7 12924.8 12987.5 10221.2 10286.5 10424.6 10565.2 10646.4 10204.8 10746.4 10807.7 10904.4 10962.6 13:31:34 INFO - PROCESS | 25798 | -------- Summary: end -------- 13:31:34 INFO - PROCESS | 25798 | 13:31:35 INFO - TEST-INFO | 25798: exit 0 13:31:35 INFO - TEST-OK | dromaeo_css | took 1118696ms 13:31:35 INFO - TEST-START | kraken 13:31:35 INFO - operating with platform_type : linux_ 13:31:35 INFO - Initialising browser for kraken test... 13:31:35 INFO - TEST-INFO | started process 26102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEl6tgT/profile http://localhost:45324/getInfo.html) 13:31:39 INFO - PROCESS | 26102 | __metrics Screen width/height:1600/1200 13:31:39 INFO - PROCESS | 26102 | colorDepth:24 13:31:39 INFO - PROCESS | 26102 | Browser inner width/height: 1024/697 13:31:39 INFO - PROCESS | 26102 | __metrics 13:31:40 INFO - PROCESS | 26102 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:31:40 INFO - PROCESS | 26102 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:31:40 INFO - PROCESS | 26102 | console.error: PushService: 13:31:40 INFO - PROCESS | 26102 | stateChangeProcessEnqueue: Error transitioning state 13:31:40 INFO - PROCESS | 26102 | UnknownError 13:31:41 INFO - TEST-INFO | 26102: exit 0 13:31:41 INFO - Browser initialized. 13:31:41 INFO - Running cycle 1/1 for kraken test... 13:31:41 INFO - TEST-INFO | started process 26187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEl6tgT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:53 INFO - PROCESS | 26187 | RSS: Main: 173182976 13:31:53 INFO - PROCESS | 26187 | 13:31:56 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45324/tests/kraken/driver.html?testName=audio-beat-detection) 13:31:56 INFO - PROCESS | 26187 | RSS: Main: 238481408 13:31:56 INFO - PROCESS | 26187 | 13:31:59 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45324/tests/kraken/driver.html?testName=audio-dft) 13:32:00 INFO - PROCESS | 26187 | RSS: Main: 216879104 13:32:00 INFO - PROCESS | 26187 | 13:32:03 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45324/tests/kraken/driver.html?testName=audio-fft) 13:32:03 INFO - PROCESS | 26187 | RSS: Main: 298397696 13:32:03 INFO - PROCESS | 26187 | 13:32:05 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45324/tests/kraken/driver.html?testName=audio-oscillator) 13:32:06 INFO - PROCESS | 26187 | RSS: Main: 208785408 13:32:06 INFO - PROCESS | 26187 | 13:32:08 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:32:09 INFO - PROCESS | 26187 | RSS: Main: 214007808 13:32:09 INFO - PROCESS | 26187 | 13:32:12 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45324/tests/kraken/driver.html?testName=imaging-darkroom) 13:32:12 INFO - PROCESS | 26187 | RSS: Main: 252485632 13:32:12 INFO - PROCESS | 26187 | 13:32:16 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45324/tests/kraken/driver.html?testName=imaging-desaturate) 13:32:16 INFO - PROCESS | 26187 | RSS: Main: 252645376 13:32:16 INFO - PROCESS | 26187 | 13:32:19 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45324/tests/kraken/driver.html?testName=json-parse-financial) 13:32:20 INFO - PROCESS | 26187 | RSS: Main: 251666432 13:32:20 INFO - PROCESS | 26187 | 13:32:21 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:32:22 INFO - PROCESS | 26187 | RSS: Main: 213901312 13:32:22 INFO - PROCESS | 26187 | 13:32:24 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:32:24 INFO - PROCESS | 26187 | RSS: Main: 221048832 13:32:24 INFO - PROCESS | 26187 | 13:32:26 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:32:27 INFO - PROCESS | 26187 | RSS: Main: 229994496 13:32:27 INFO - PROCESS | 26187 | 13:32:30 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:32:30 INFO - PROCESS | 26187 | RSS: Main: 238075904 13:32:30 INFO - PROCESS | 26187 | 13:32:33 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:32:34 INFO - PROCESS | 26187 | RSS: Main: 235171840 13:32:34 INFO - PROCESS | 26187 | 13:32:35 INFO - PROCESS | 26187 | Cycle 1(1): loaded http://localhost:45324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45324/tests/kraken/driver.html?testName=ai-astar) 13:32:36 INFO - PROCESS | 26187 | RSS: Main: 286085120 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | __start_tp_report 13:32:36 INFO - PROCESS | 26187 | _x_x_mozilla_page_load 13:32:36 INFO - PROCESS | 26187 | _x_x_mozilla_page_load_details 13:32:36 INFO - PROCESS | 26187 | |i|pagename|runs| 13:32:36 INFO - PROCESS | 26187 | |0;ai-astar;113;114;113;110;112;113;112;112;113;111 13:32:36 INFO - PROCESS | 26187 | |1;audio-beat-detection;158;125;128;176;124;123;128;125;139;127 13:32:36 INFO - PROCESS | 26187 | |2;audio-dft;160;161;161;160;161;163;161;160;161;161 13:32:36 INFO - PROCESS | 26187 | |3;audio-fft;74;76;75;106;77;75;75;76;99;75 13:32:36 INFO - PROCESS | 26187 | |4;audio-oscillator;82;82;103;83;83;83;105;83;83;110 13:32:36 INFO - PROCESS | 26187 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 13:32:36 INFO - PROCESS | 26187 | |6;imaging-darkroom;147;146;145;146;146;146;146;146;145;145 13:32:36 INFO - PROCESS | 26187 | |7;imaging-desaturate;95;95;96;95;95;96;95;95;96;95 13:32:36 INFO - PROCESS | 26187 | |8;json-parse-financial;53;50;50;52;52;51;52;52;51;52 13:32:36 INFO - PROCESS | 26187 | |9;json-stringify-tinderbox;62;63;62;62;63;62;62;63;63;72 13:32:36 INFO - PROCESS | 26187 | |10;stanford-crypto-aes;84;88;80;81;80;82;81;81;80;80 13:32:36 INFO - PROCESS | 26187 | |11;stanford-crypto-ccm;144;130;142;135;135;133;133;142;177;137 13:32:36 INFO - PROCESS | 26187 | |12;stanford-crypto-pbkdf2;166;166;162;163;169;164;163;162;172;170 13:32:36 INFO - PROCESS | 26187 | |13;stanford-crypto-sha256-iterative;65;63;65;65;64;65;66;63;66;64 13:32:36 INFO - PROCESS | 26187 | __end_tp_report 13:32:36 INFO - PROCESS | 26187 | __start_cc_report 13:32:36 INFO - PROCESS | 26187 | _x_x_mozilla_cycle_collect,1668 13:32:36 INFO - PROCESS | 26187 | __end_cc_report 13:32:36 INFO - PROCESS | 26187 | __startTimestamp1479936756108__endTimestamp 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | ------- Summary: start ------- 13:32:36 INFO - PROCESS | 26187 | Number of tests: 14 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.16 (1.0%) stddev-sans-first:1.20 13:32:36 INFO - PROCESS | 26187 | Values: 113.0 114.0 113.0 110.0 112.0 113.0 112.0 112.0 113.0 111.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:128.00 stddev:17.80 (13.9%) stddev-sans-first:16.88 13:32:36 INFO - PROCESS | 26187 | Values: 158.0 125.0 128.0 176.0 124.0 123.0 128.0 125.0 139.0 127.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 13:32:36 INFO - PROCESS | 26187 | Values: 160.0 161.0 161.0 160.0 161.0 163.0 161.0 160.0 161.0 161.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:11.58 (15.3%) stddev-sans-first:12.02 13:32:36 INFO - PROCESS | 26187 | Values: 74.0 76.0 75.0 106.0 77.0 75.0 75.0 76.0 99.0 75.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:11.38 (13.7%) stddev-sans-first:11.73 13:32:36 INFO - PROCESS | 26187 | Values: 82.0 82.0 103.0 83.0 83.0 83.0 105.0 83.0 83.0 110.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:32:36 INFO - PROCESS | 26187 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 13:32:36 INFO - PROCESS | 26187 | Values: 147.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:32:36 INFO - PROCESS | 26187 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:0.97 (1.9%) stddev-sans-first:0.87 13:32:36 INFO - PROCESS | 26187 | Values: 53.0 50.0 50.0 52.0 52.0 51.0 52.0 52.0 51.0 52.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#9] json-stringify-tinderbox Cycles:10 Average:63.40 Median:63.00 stddev:3.06 (4.9%) stddev-sans-first:3.21 13:32:36 INFO - PROCESS | 26187 | Values: 62.0 63.0 62.0 62.0 63.0 62.0 62.0 63.0 63.0 72.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.00 stddev:2.54 (3.1%) stddev-sans-first:2.55 13:32:36 INFO - PROCESS | 26187 | Values: 84.0 88.0 80.0 81.0 80.0 82.0 81.0 81.0 80.0 80.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:139.50 stddev:13.51 (9.7%) stddev-sans-first:14.28 13:32:36 INFO - PROCESS | 26187 | Values: 144.0 130.0 142.0 135.0 135.0 133.0 133.0 142.0 177.0 137.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:3.56 (2.1%) stddev-sans-first:3.77 13:32:36 INFO - PROCESS | 26187 | Values: 166.0 166.0 162.0 163.0 169.0 164.0 163.0 162.0 172.0 170.0 13:32:36 INFO - PROCESS | 26187 | 13:32:36 INFO - PROCESS | 26187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 13:32:36 INFO - PROCESS | 26187 | Values: 65.0 63.0 65.0 65.0 64.0 65.0 66.0 63.0 66.0 64.0 13:32:36 INFO - PROCESS | 26187 | -------- Summary: end -------- 13:32:36 INFO - PROCESS | 26187 | 13:32:37 INFO - TEST-INFO | 26187: exit 0 13:32:37 INFO - TEST-OK | kraken | took 61759ms 13:32:37 INFO - SUITE-END | took 1180s 13:32:37 INFO - Completed test suite (00:19:40) 13:32:37 INFO - javascript benchmark 13:32:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3026.1375507980224, 3049.95425068624, 3057.3732384861105, 3073.6772638872903, 3098.4732595458768, 5307.65500242484, 5329.040772660919, 5378.408375078739, 5405.54052905503, 5417.729113544322, 5364.1149210380245, 5376.91934620981, 5427.294451721281, 5432.70120143392, 5483.725813709309, 4842.588379987706, 4864.7567621618955, 4914.3119963205, 4935.802567897298, 4962.602991760668, 5003.0, 5050.3434553508, 5070.74646267687, 5074.416442109149, 5123.795048198068, 4987.077390682735, 4997.700137991696, 5041.571466425358, 5064.670796398241, 5096.031753966735, 4867.099586576494, 4902.2401527762895, 4905.6320775941595, 4908.7300198489065, 4928.063667903087, 4919.631027672903, 4924.4583095859425, 4931.087748766489, 4989.151844186461, 5003.799848006075, 5391.299131112969, 5426.21319908615, 5427.945720542783, 5446.782128714846, 5454.481824226732, 5644.4073372295725, 5685.744141513642, 5742.994975879246, 5800.187973683687, 5823.912641310384, 5804.361520232771, 5855.590108692393, 5858.209141765849, 5887.941120588825, 5898.852528686817, 5431.375391829911, 5438.972805135949, 5439.646422982533, 5440.537554307849, 5441.29263195786, 5774.509166720875, 5843.094320380348, 5900.734466948998, 5955.315138759098, 5964.731587078505, 5644.125160600113, 5665.518430933417, 5693.17448969897, 5696.060150075274, 5796.536277097822, 5747.827565173052, 5792.652440853562, 5812.070068789058, 5815.185873977646, 5817.214676018768, 5761.48146666802, 5771.249737534177, 5778.393268706809, 5789.189513468118, 5793.971030144822, 5541.27963364768, 5559.777608895599, 5577.05190117681, 5664.971675141598, 5670.291213598301, 4285.507166675872, 4293.463317085364, 4295.0, 4319.438472998553, 4326.069894972596, 3929.0, 3942.940855887164, 3958.267720471722, 3973.920521589552, 4005.919881602352, 5393.27190829233, 5429.0, 5434.891302174014, 5441.646292990943, 5445.83662490126, 5671.688057156896, 5705.857353566194, 5838.38696936824, 5842.094475356326, 5847.883042339215, 5434.755436005389, 5446.128619420873, 5457.045017121988, 5461.781528738806, 5463.098588732814, 4828.61371090312, 4862.05189987949, 4868.464468908417, 4872.220444728897, 4874.2201247800895, 5957.523398128226, 5994.640321580632, 6001.639901605918, 6014.51883849291, 6015.6691381974415, 5741.684207368635, 5750.539956803529, 5764.99112655292, 5774.711264436845, 5779.855503612275, 6062.060380641008, 6066.029435290332, 6083.057126145454, 6087.391260873877, 6090.9390906090375, 5589.552835773047, 5659.462351076641, 5712.65724056558, 5722.570807189394, 5751.1373294006235, 5778.682172480386, 5780.797672081457, 5811.941880581309, 5814.622049566765, 5834.008218602932, 5704.1443783432815, 5727.799527016535, 5729.369769325454, 5729.885402292014, 5736.397678243724, 5512.80705175317, 5560.36055853582, 5618.073017952155, 5637.126245431965, 5654.123610840326, 5642.294713160855, 5665.943340566707, 5673.74468148926, 5677.120046392815, 5722.685252311163, 5690.061139911868, 5695.373508914099, 5697.487226149667, 5701.201831743476, 5702.6863522506665, 5413.188021796762, 5464.617476776746, 5484.670919744828, 5586.0, 5598.916016259678], "value": 5328.377578470031, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1780083277582, 574.342377977216, 591.3170288316995, 598.9460948514638, 599.9670018149, 34932.4760128598, 41315.38026929599, 42366.78816605917, 42635.3604695929, 46536.0, 44229.336559951626, 44889.0, 45074.549254507445, 45203.547964520345, 45237.547624523744, 7804.687812487494, 8461.407701460901, 8617.310615150773, 8619.956900215522, 8620.224179823814, 7959.602019899011, 9988.700338989842, 10215.642452514163, 10234.846477302846, 10613.150947924187, 10101.292909496338, 10141.239407044464, 10144.49277536124, 10145.289829711923, 10154.187664986783, 10318.484075796181, 10360.274780765349, 10371.325863818904, 10377.221708371864, 10390.376577405304, 10187.796244075076, 10246.692599222035, 10260.589576417009, 10262.127719143882, 10268.64059757905, 41604.58395416037, 41686.166276674296, 41927.16145677069, 41968.1606367874, 42013.78993105046, 3445.3349825189666, 3500.982495087508, 3517.9472307915403, 3555.0579096539436, 3557.4308110702423, 31390.0, 32082.518762218584, 32194.195145121324, 32200.194995125075, 32272.838635806904, 4213.641840443566, 4356.346548017791, 4361.869143925687, 4434.423524941737, 4485.573870482299, 340149.0, 342741.2984571695, 345172.0, 348597.0, 349593.0, 58508.70745646244, 58879.0, 58944.0, 58955.70522147362, 58974.0, 62119.37880621136, 62759.6862015687, 62793.37206627875, 62799.37200628027, 62925.0, 17482.475525734248, 17718.822811771974, 17740.29038838458, 17742.112894355232, 17743.467695969142, 11791.823122653168, 11871.584494542822, 13256.53602123921, 13516.39176237052, 13585.52450664222, 19067.474602031805, 19215.231390744495, 19744.124308190698, 19970.60058798816, 19993.800061999485, 7099.0, 7138.214796372395, 7169.462290328246, 7229.277072292729, 7292.124945006633, 945.413843417072, 1006.2050979726081, 1048.4705223862054, 1073.1361254190297, 1101.9063379612824, 32319.676803231665, 32831.83584082064, 32889.0, 32921.67078329234, 33377.49933750996, 1100.8128618134936, 1190.2025642819158, 1190.3810018790355, 1208.172401904698, 1208.5347141350644, 16860.241289142017, 17444.651106977788, 17483.388081417088, 17550.912245438692, 17560.0, 521567.0, 524653.0, 526517.0, 527761.0, 528264.0, 60241.0, 60512.394876050676, 60643.39356606377, 60669.69665151646, 60792.69603652042, 1232.5254776910954, 1271.0340141492532, 1309.1032642639632, 1328.1499840102342, 1361.4213959067356, 29218.0, 33622.0, 33790.15524611806, 33794.49308260427, 34571.30857382889, 51951.74024130006, 52475.47524524706, 52519.21221181762, 52543.73728131335, 52548.47451525589, 384592.0, 384711.0, 387186.0, 387742.0, 388974.0, 43300.35049474197, 43382.78308608437, 43971.0, 44363.33454998113, 44491.332630011224, 46826.76586617045, 47787.76106119447, 47829.0, 47966.0, 48261.27608085952, 40174.59825401709, 40956.59043409528, 41171.38242926419, 41415.79292103641, 42635.78682106694, 42266.57733422626, 42473.15053698847, 42520.5747942529, 42538.57461425346, 42874.57125428706, 41558.376624351265, 42045.0, 42386.788066059475, 42706.57293427026, 42716.786416068964, 33542.664573353955, 36808.81595592005, 37038.62961370352, 37636.24727505489, 37835.43246851354, 27695.44609107847, 28250.0, 28287.2928176789, 28320.71679283181, 28365.432691345646], "value": 20735.896322008484, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.12363193758546, 395.20958083832335, 404.17346526353606, 411.21458015190984, 426.4967338540523, 13626.318684065795, 15574.14342211178, 18921.99999999998, 19074.141663625134, 19523.316683916066, 16498.75251871223, 16844.32622695094, 16918.0, 17006.06466644334, 17026.14869256535, 5486.396496385404, 5713.914291285634, 5717.142428635717, 5722.256106706143, 5722.284714410699, 5361.892762144755, 5701.0878259478495, 5729.684867332295, 5734.741936612862, 5735.2544169257935, 5687.601867869251, 5693.572982026344, 5698.202251684746, 5704.543636509069, 5705.5720820938595, 5462.945370546284, 5729.455701708331, 5753.395893431171, 5760.942390576082, 5800.651960882318, 5515.70380960474, 5640.605157638967, 5645.068563686987, 5647.152927060933, 5711.400302968212, 13956.651083722887, 14158.221297828615, 14230.0, 14238.501652442115, 14245.358958846877, 2282.5777231212114, 2378.3340664613934, 2503.6244563315468, 2704.2698471412805, 2838.2194896403653, 10085.747856303578, 10113.292069555135, 10144.137748291405, 10561.260711750181, 10791.0, 1836.8438682711985, 1841.9539511512319, 1856.4059500959697, 1893.2521653946615, 1981.73246611707, 81665.59167204186, 83139.5843020781, 83356.58321708413, 83742.16257837405, 85998.99999999937, 10845.023947844731, 10972.122230221563, 11158.218924675357, 11166.888331116585, 11314.490847911864, 15379.538613841603, 15382.0, 15414.537563873102, 15417.614559635875, 15450.0, 7657.617119144021, 8184.836303273901, 8250.669973201006, 8474.364422668325, 8475.618597163142, 7798.532088074734, 7831.921680783119, 7902.762917112381, 8092.757217283491, 8155.388345874083, 4695.835645752382, 4721.1501929652995, 4752.524747525289, 4756.714597124114, 4884.682495637843, 1876.8217019383137, 1959.1673538745977, 1974.1511150205263, 1980.4751740788702, 2006.4582562707988, 928.7770934975557, 939.5818860607101, 983.9114479696862, 1013.7313611892854, 1033.0908800255727, 18963.0, 19049.80950190508, 19199.136038878285, 19285.325013624737, 19443.51391215231, 930.6742640075919, 973.6640858903667, 976.511744127936, 1000.0999100809184, 1043.4834756795283, 9614.895558558408, 10601.522931468102, 10610.787784244272, 10663.84004239937, 10678.145748340114, 465374.0, 475222.3405372173, 475439.0, 478480.0, 487894.0, 91236.0, 91495.54252228829, 94159.0, 96194.0, 96371.0, 939.9013103624021, 980.7057882635323, 1017.0947856407803, 1039.3192458939407, 1049.1449468683, 16269.3492260313, 16433.342666293214, 16774.49676509707, 17052.0, 17081.74377384365, 40725.0, 41009.58990410177, 41021.58978410297, 41166.79416603017, 42621.0, 51476.0, 52890.2066469011, 59043.0, 59751.40248597632, 61021.38978610335, 10779.19156063314, 11851.525938962344, 12131.393430328624, 12359.752804943671, 12514.15628539077, 13486.86513134856, 13754.793678095037, 13913.0, 13921.79117313221, 14431.42274309058, 11142.554297827995, 11615.477303521193, 11871.643850684493, 11890.762184756084, 12557.372131393211, 12023.699407514881, 12348.506059757508, 12356.25862448256, 12384.380780960735, 12697.492100315883, 12196.390180491117, 12223.0, 12319.384030798245, 12471.0, 12609.369531523571, 12049.518019279481, 12343.567975120828, 12413.627591172279, 12670.149216426598, 12712.745745084861, 12116.878831211927, 12168.634940951786, 12244.877551224374, 12306.323152226714, 12571.685707857378], "value": 9273.1257896937, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.5352551305607, 1434.6843694387235, 1460.2771628044115, 1565.632076462032, 1732.7487514310426, 7400.333969942711, 8171.346292296616, 8473.110323416046, 8475.364347673925, 8656.0, 8422.789430264247, 8440.704575339865, 8458.154184581539, 8500.91499085009, 8504.489730616151, 1993.232605446906, 2083.7082808406835, 2284.132029828663, 2284.908603655852, 2318.246569864792, 2223.4219103033165, 2304.51605162916, 2304.5506126305377, 2321.442853715105, 2327.2552783109413, 2267.6598510223516, 2285.074544809355, 2287.279506955312, 2293.472501324696, 2303.0442366417915, 2264.6376579747243, 2268.4669102760836, 2270.727512698487, 2275.9089636414524, 2281.406834223097, 2222.844400891938, 2265.0, 2270.1600407849037, 2272.1479445208047, 2275.328778010491, 8322.958385208096, 8482.98204215492, 8485.872711909326, 8500.404971651988, 8501.659933602648, 4943.530364615356, 5090.134677104901, 5099.36257967754, 5100.285959965608, 5101.617378696613, 3171.8255495947715, 3321.4021476134285, 3323.7008669219645, 3325.5177999190223, 3486.9128271793156, 1103.9779204415868, 1151.7503508693078, 1175.7295821960997, 1206.7827790997617, 1231.7105480212142, 11666.766664666658, 11669.124815638861, 11712.648620541397, 11746.471408786625, 11767.352795596324, 4450.844220452269, 4560.521145279764, 4632.791524381343, 4643.048175124091, 4736.526347365236, 9998.300118991601, 9998.700038998843, 10016.348937319051, 10018.499075046218, 10020.64927727526, 5191.662541934762, 5198.402183748842, 5200.739963001911, 5201.6358854880555, 5203.739813009334, 4713.599344055725, 4749.525047495292, 4753.47711751707, 4782.306565547976, 4829.613630909519, 3810.704360517382, 3838.7504812187676, 3888.1446081861945, 3888.7083468739957, 3991.880243592697, 1303.8174655548041, 1306.1575283941995, 1310.5740634293702, 1321.966950826237, 1333.6199183232927, 800.415696541528, 821.37575442664, 912.9224015958586, 925.6436272035315, 959.6785076999143, 5549.0, 5588.0, 5637.182608521742, 5762.423757624288, 5785.479306862402, 874.3486102853287, 886.4371124336093, 919.5080631862055, 937.3204426790522, 940.3699521320732, 3782.0, 3819.52255968004, 3820.121372084436, 3828.6554210120667, 3852.8844134676006, 10321.277510574339, 10618.044376006043, 10723.410212438235, 10725.624603138853, 10729.89270107289, 10585.947070264754, 10592.417417041983, 10603.893961060445, 10652.520636571373, 10654.680359589225, 7787.922120778833, 7912.0901096374655, 7920.4455688102435, 7920.801979950547, 7932.167122452175, 5460.372057213472, 5513.924784666951, 5528.364238112668, 5667.206591077335, 5759.452851979056, 9475.147236748726, 9518.619255229713, 9546.331756776959, 9554.092361225672, 9666.854997174907, 8736.170063843925, 9385.483798391155, 9729.562169702522, 9807.117359437685, 9808.215342772419, 6960.860782784417, 7218.747343842941, 7390.187079421152, 7513.812154696177, 7683.731069412544, 8197.590120493833, 8201.58992050407, 8202.917970820215, 8212.589370531568, 8297.585120743817, 7116.679749411185, 7155.105611798525, 7163.0, 7179.210286868545, 7252.311030452099, 7319.74380896666, 7371.631418429164, 7391.371733402506, 7483.625818708934, 7640.961795190989, 6849.828754280983, 6868.450523958171, 6894.689738961859, 6932.722691092502, 6933.479989000744, 4527.615152712056, 4749.26386410107, 4758.476567577494, 4837.854864354075, 4874.683145595525, 4936.7284799336385, 4969.279454479008, 4996.100701873697, 5012.122878496321, 5216.374035115658], "value": 4488.046060078509, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.7061665808547, 341.62591961801826, 345.2766454278288, 347.3123216032256, 351.2851347507822, 5106.489351064901, 5206.24509446131, 5277.1556550951855, 5290.867728306799, 5298.20526920962, 5041.319421878045, 5105.259737338084, 5108.310378098956, 5140.7172605506685, 5174.456682048387, 4085.2238074765846, 4090.611391917778, 4115.753054816706, 4129.504459464868, 4131.483564554431, 3997.5202975642965, 4083.3670781028986, 4105.589441055886, 4120.278951183546, 4122.2579935611575, 4073.30753771858, 4087.8758341456187, 4090.447789548403, 4094.6314831665145, 4107.7535347879075, 4068.389741538793, 4082.387641853716, 4091.6112969267874, 4094.8362065517344, 4099.8930288822, 3657.305112028706, 3660.5790334111653, 3663.5970043295215, 3681.5214022176947, 3694.1503454205413, 4859.927101093486, 4966.453690094087, 4985.1774457214515, 5020.924686129711, 5028.673136246132, 4658.34783130362, 4668.813247470097, 4672.906541869178, 4675.2052151134385, 4680.765961701902, 5338.733063346817, 5341.599380046512, 5366.409694933554, 5369.892602147936, 5371.435999220064, 3930.960690393088, 3982.8406863725418, 3991.860284890044, 4002.6197511236387, 4028.47629808126, 5509.944900550983, 5519.034169020405, 5535.6955367454775, 5536.99999999996, 5540.806071787509, 4043.73715708478, 4058.2492238935893, 4061.3501839705505, 4071.7353372030725, 4077.1641813428178, 4030.8636422696018, 4115.032967252693, 4134.359174327984, 4148.444333374984, 4175.97912010438, 4631.606313463393, 4634.9536504634525, 4641.052931388593, 4668.486466488684, 4677.695949763254, 5381.54256888161, 5386.407495175527, 5400.675959442446, 5411.269478620415, 5457.399686034533, 1334.1461464662623, 1354.0995238166706, 1383.8616138386283, 1386.7642500774894, 1388.167099740148, 956.861255118004, 977.8728765260613, 982.268210183418, 982.7395740128871, 992.7220378294089, 5018.899622007612, 5032.345795046621, 5081.517255860687, 5101.69389836611, 5113.514216149534, 5315.149576067811, 5320.132079147536, 5377.327834020747, 5377.838664840061, 5378.515933565998, 4924.778384972685, 5056.544910958031, 5078.7460626968505, 5090.643654944119, 5091.592672586185, 2798.580212968071, 2818.3799564095866, 2819.6898341182455, 2822.5907243449997, 2824.263078206888, 5515.283013208257, 5534.916976245279, 5555.694436805934, 5557.722113894289, 5575.048732943437, 5287.7884884604955, 5305.734713264322, 5323.334583177103, 5347.705876176769, 5409.540189083972, 5451.591130665216, 5496.697681627549, 5503.587230957694, 5512.80705175317, 5525.502704756431, 5262.789628356023, 5271.499207575274, 5297.311349524537, 5318.547923426398, 5365.436629153883, 5237.528622424, 5441.319835020622, 5486.49121491593, 5516.531094856982, 5518.227448157341, 5822.10781496007, 5825.84443755813, 5827.621204621686, 5828.679422631796, 5853.473187413153, 3828.980855095707, 4018.216447792652, 4029.6903506359963, 4031.334829753058, 4038.6769058474665, 5304.655197412156, 5483.698396588066, 5495.873345964148, 5500.559955203494, 5538.196961440649, 5223.007628550563, 5264.973675131753, 5436.293281873332, 5438.592105592017, 5444.700541470257, 5405.702576404933, 5417.891642167214, 5420.0, 5420.728963551728, 5422.539084177889, 5317.6543524672325, 5403.729813509231, 5405.162199859028, 5405.675609475704, 5444.156155795858, 5425.972870135782, 5442.619016668795, 5444.128939369682, 5448.754806033818, 5452.890942181055, 5340.759665815125, 5342.729340030549, 5353.9732301338245, 5371.274877891435, 5386.299781028441], "value": 4134.139503859066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.7441358317794, 745.496789666975, 790.9520627614028, 804.0994086622982, 816.8529664660359, 12887.0, 13926.0, 13926.373313200906, 13930.791038134435, 14008.167182322095, 13778.448862045507, 14005.92997035016, 14010.579682609512, 14016.719665606683, 14021.369038393272, 654.7119267522274, 675.9826461175948, 756.7011030642893, 768.2893323675592, 781.0276206123384, 766.3409467857638, 776.7941495503696, 778.4861991085885, 778.852018116556, 780.2080887898787, 836.3016880904452, 837.5686521441462, 837.9790505237357, 838.053000109875, 838.0571856661256, 689.0663151429791, 702.9859402811915, 806.5886397937036, 830.6179157587517, 831.9251267385933, 607.0954278125605, 607.8541150123982, 611.0528680545137, 611.4252602553586, 611.4527497889364, 13265.27041012744, 13355.599332020054, 13374.465021399132, 13375.732485350238, 13446.529371471952, 13277.46890124394, 13367.532136375277, 13400.39698213573, 13457.058005939589, 13605.455781768718, 12527.310997895112, 12575.622731318075, 12588.0, 12808.615741527768, 12896.935515322364, 4256.787160641956, 4273.9358909616385, 4283.528811830696, 4293.24868148076, 4489.281714925629, 53594.73202634001, 56360.71819640876, 56427.71786141043, 63936.0, 64064.0, 10889.183311251687, 10980.560777568808, 11043.171762117874, 11047.392393418439, 11289.0, 19422.320218792276, 19434.902825486064, 19435.416937491616, 19448.805511944982, 19492.415227543195, 7860.5676687782725, 8079.919200807916, 8243.422960392714, 8356.28971537414, 8371.409432207862, 4428.202923473806, 4509.526499717483, 4511.436070491189, 4570.0, 4590.196715574761, 3265.8203798791296, 3311.586051743532, 3316.817575033396, 3335.5663763710563, 3355.2282974915906, 618.9226346706662, 622.1507642068544, 629.298332359416, 632.9936700633027, 636.5862189576812, 594.8572342637735, 671.5936858200815, 701.708790851801, 704.021699025729, 706.3113464372196, 8899.777505562413, 8943.552822358855, 8997.595108220146, 9037.412568183046, 9041.367104302635, 556.9832905012856, 584.8742520358144, 693.7641201991347, 734.5739471106853, 735.8932954721536, 4130.442390277274, 4421.40311058003, 4478.731276123443, 4568.33759104928, 4663.533646635309, 52492.73753631284, 56167.71916140393, 68906.65546672334, 70315.64842175756, 71098.2890171102, 42814.357784633256, 43608.3458748119, 56107.158392624144, 62046.0693089604, 68031.65984170047, 62061.68969155216, 63224.68387658124, 63864.0, 64897.999999999054, 66263.0, 8649.697260595849, 9144.679936202201, 9259.444433334022, 9309.0, 9319.394239374418, 34823.825880870434, 39265.411018835315, 43854.78072609616, 44925.32612010757, 46044.30933536067, 49340.013199736524, 56782.0, 58536.0, 59393.40606593879, 59769.701151493966, 12028.819567706667, 12118.0, 12150.696232594255, 12240.87759122433, 12455.377231138587, 13364.799528007283, 13669.726605468033, 14254.947700357832, 14348.139111653334, 14372.209528476034, 12556.686082848002, 13329.866701332863, 13431.261280629658, 13472.663183420102, 13769.173849569059, 12903.354832258161, 13174.40715167839, 13291.601251962456, 13480.123791953492, 13910.151402333086, 12443.315617641116, 12698.873011269769, 12924.741505169655, 12924.806127907901, 12987.480500779862, 10221.182305415698, 10286.537105830404, 10424.583016679248, 10565.20760942917, 10646.361218326925, 10204.846927296245, 10746.408947507962, 10807.67576972692, 10904.400257985886, 10962.616308429167], "value": 6847.778305928838, "unit": "score"}], "name": "dromaeo_css", "value": 7119.192917247375, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 110.0, 112.0, 113.0, 112.0, 112.0, 113.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 128.0, 176.0, 124.0, 123.0, 128.0, 125.0, 139.0, 127.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 163.0, 161.0, 160.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 106.0, 77.0, 75.0, 75.0, 76.0, 99.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 103.0, 83.0, 83.0, 83.0, 105.0, 83.0, 83.0, 110.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 50.0, 52.0, 52.0, 51.0, 52.0, 52.0, 51.0, 52.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0, 72.0], "value": 63.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 80.0, 81.0, 80.0, 82.0, 81.0, 81.0, 80.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 130.0, 142.0, 135.0, 135.0, 133.0, 133.0, 142.0, 177.0, 137.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 162.0, 163.0, 169.0, 164.0, 163.0, 162.0, 172.0, 170.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 65.0, 65.0, 64.0, 65.0, 66.0, 63.0, 66.0, 64.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1504.6, "alertThreshold": 2.0}]} 13:32:37 INFO - Return code: 0 13:32:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:32:37 INFO - # TBPL SUCCESS # 13:32:37 INFO - Running post-action listener: _resource_record_post_action 13:32:37 INFO - [mozharness: 2016-11-23 21:32:37.891894Z] Finished run-tests step (success) 13:32:37 INFO - Running post-run listener: _resource_record_post_run 13:32:37 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395829248; Read time: 12; Write time: 302104 13:32:37 INFO - TinderboxPrint: CPU usage
13.1% 13:32:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 13:32:37 INFO - TinderboxPrint: I/O write bytes / time
395,829,248 / 302,104 13:32:37 INFO - TinderboxPrint: CPU idle
8,303.7 (86.9%) 13:32:37 INFO - TinderboxPrint: CPU user
1,203.3 (12.6%) 13:32:37 INFO - TinderboxPrint: Swap in / out
0 / 0 13:32:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107909120; Read time: 0; Write time: 91196 13:32:37 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287920128; Read time: 0; Write time: 210908 13:32:38 INFO - Running post-run listener: _upload_blobber_files 13:32:38 INFO - Blob upload gear active. 13:32:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:38 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 13:32:38 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:32:38 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:32:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:32:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:32:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:39 INFO - (blobuploader) - INFO - Done attempting. 13:32:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:32:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:32:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:41 INFO - (blobuploader) - INFO - Done attempting. 13:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:32:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:44 INFO - (blobuploader) - INFO - Done attempting. 13:32:44 INFO - (blobuploader) - INFO - Iteration through files over. 13:32:44 INFO - Return code: 0 13:32:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:32:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:32:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b853acbca7086ac0b45e52218a4a4b0bb417b705135eaa5a95d30c9bd156363d8055bdc6ce42304e4c8e87eee693dedaf70e6e90b9092fbb0d3072e8cc5c84cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd397ceb7403c3e0a2270075c559d63af2d9f03f1e42bde832affde16c66bcc0bf02af182ad3a313cc90d79d6f56f6333b5e571b51219d3faa0209566a1682d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6920dd0ec054d42b817cbef7db769221d8d288cbe4367683ef846fa777158d459e1a1576a5b9c2982b78749a055fc29b6b53aeccdbc020acfe733b7f63c037ce"} 13:32:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:32:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:32:44 INFO - Contents: 13:32:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b853acbca7086ac0b45e52218a4a4b0bb417b705135eaa5a95d30c9bd156363d8055bdc6ce42304e4c8e87eee693dedaf70e6e90b9092fbb0d3072e8cc5c84cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd397ceb7403c3e0a2270075c559d63af2d9f03f1e42bde832affde16c66bcc0bf02af182ad3a313cc90d79d6f56f6333b5e571b51219d3faa0209566a1682d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6920dd0ec054d42b817cbef7db769221d8d288cbe4367683ef846fa777158d459e1a1576a5b9c2982b78749a055fc29b6b53aeccdbc020acfe733b7f63c037ce"} 13:32:44 INFO - Running post-run listener: copy_logs_to_upload_dir 13:32:44 INFO - Copying logs to upload dir... 13:32:44 INFO - mkdir: /builds/slave/test/build/upload/logs 13:32:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.855662 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-23 13:32:44.099440) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 13:32:44.102748) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b853acbca7086ac0b45e52218a4a4b0bb417b705135eaa5a95d30c9bd156363d8055bdc6ce42304e4c8e87eee693dedaf70e6e90b9092fbb0d3072e8cc5c84cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd397ceb7403c3e0a2270075c559d63af2d9f03f1e42bde832affde16c66bcc0bf02af182ad3a313cc90d79d6f56f6333b5e571b51219d3faa0209566a1682d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6920dd0ec054d42b817cbef7db769221d8d288cbe4367683ef846fa777158d459e1a1576a5b9c2982b78749a055fc29b6b53aeccdbc020acfe733b7f63c037ce"} build_url:https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/Vk27Jd9eTFiktZy2_b8inw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b853acbca7086ac0b45e52218a4a4b0bb417b705135eaa5a95d30c9bd156363d8055bdc6ce42304e4c8e87eee693dedaf70e6e90b9092fbb0d3072e8cc5c84cf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd397ceb7403c3e0a2270075c559d63af2d9f03f1e42bde832affde16c66bcc0bf02af182ad3a313cc90d79d6f56f6333b5e571b51219d3faa0209566a1682d9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6920dd0ec054d42b817cbef7db769221d8d288cbe4367683ef846fa777158d459e1a1576a5b9c2982b78749a055fc29b6b53aeccdbc020acfe733b7f63c037ce"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 13:32:44.127696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:32:44.128025) ========= 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=337fe3f4b1febe37b85fccc40000019e-1479935457.658623-540714329 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:32:44.211458) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 13:32:44.211791) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 13:32:44.212126) ========= ========= Total master_lag: 0.24 =========