builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-014 starttime: 1479482936.83 results: success (0) buildid: 20161118061428 builduid: 174ca56a456b4e62b662e7f6923757e3 revision: 20232bd6a7fa30214e9f499597a9d5c6546ec862 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:56.829358) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:56.829774) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:56.830071) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:56.860649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:56.860916) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 07:28:57-- 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% 221M=0s 2016-11-18 07:28:57 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:56.979295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:56.979585) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019965 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:57.066801) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:57.067111) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 20232bd6a7fa30214e9f499597a9d5c6546ec862 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 20232bd6a7fa30214e9f499597a9d5c6546ec862 --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=31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 07:28:57,616 truncating revision to first 12 chars 2016-11-18 07:28:57,616 Setting DEBUG logging. 2016-11-18 07:28:57,616 attempt 1/10 2016-11-18 07:28:57,616 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/20232bd6a7fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 07:28:57,959 unpacking tar archive at: graphics-20232bd6a7fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700048 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:57.780391) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:57.780738) ========= script_repo_revision: 20232bd6a7fa30214e9f499597a9d5c6546ec862 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:57.781144) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:57.781408) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 07:28:57.791193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-18 07:28:57.791449) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:28:58 INFO - MultiFileLogger online at 20161118 07:28:58 in /builds/slave/test 07:28:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 07:28:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:28:58 INFO - {'append_to_log': False, 07:28:58 INFO - 'base_work_dir': '/builds/slave/test', 07:28:58 INFO - 'blob_upload_branch': 'Graphics', 07:28:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:28:58 INFO - 'branch': 'Graphics', 07:28:58 INFO - 'buildbot_json_path': 'buildprops.json', 07:28:58 INFO - 'config_files': ('talos/linux_config.py',), 07:28:58 INFO - 'default_actions': ('clobber', 07:28:58 INFO - 'read-buildbot-config', 07:28:58 INFO - 'download-and-extract', 07:28:58 INFO - 'populate-webroot', 07:28:58 INFO - 'create-virtualenv', 07:28:58 INFO - 'install', 07:28:58 INFO - 'run-tests'), 07:28:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:28:58 INFO - 'download_minidump_stackwalk': True, 07:28:58 INFO - 'download_symbols': 'ondemand', 07:28:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:28:58 INFO - 'tooltool.py': '/tools/tooltool.py', 07:28:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:28:58 INFO - '/tools/misc-python/virtualenv.py')}, 07:28:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:28:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:28:58 INFO - 'installer_path': 'installer.exe', 07:28:58 INFO - 'log_level': 'info', 07:28:58 INFO - 'log_name': 'talos', 07:28:58 INFO - 'log_to_console': True, 07:28:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:28:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:28:58 INFO - 'opt_config_files': (), 07:28:58 INFO - 'pip_index': False, 07:28:58 INFO - 'sps_profile': False, 07:28:58 INFO - 'sps_profile_interval': 0, 07:28:58 INFO - 'suite': 'dromaeojs', 07:28:58 INFO - 'system_bits': '32', 07:28:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:28:58 INFO - 'title': 'talos-linux64-ix-014', 07:28:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:28:58 INFO - 'use_talos_json': True, 07:28:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:28:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:28:58 INFO - 'work_dir': 'build'} 07:28:58 INFO - [mozharness: 2016-11-18 15:28:58.437320Z] Running clobber step. 07:28:58 INFO - Running pre-action listener: _resource_record_pre_action 07:28:58 INFO - Running main action method: clobber 07:28:58 INFO - rmtree: /builds/slave/test/build 07:28:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:28:58 INFO - Running post-action listener: _resource_record_post_action 07:28:58 INFO - [mozharness: 2016-11-18 15:28:58.891613Z] Finished clobber step (success) 07:28:58 INFO - [mozharness: 2016-11-18 15:28:58.891712Z] Running read-buildbot-config step. 07:28:58 INFO - Running pre-action listener: _resource_record_pre_action 07:28:58 INFO - Running main action method: read_buildbot_config 07:28:58 INFO - Using buildbot properties: 07:28:58 INFO - { 07:28:58 INFO - "project": "", 07:28:58 INFO - "product": "firefox", 07:28:58 INFO - "script_repo_revision": "default", 07:28:58 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 07:28:58 INFO - "repository": "", 07:28:58 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 07:28:58 INFO - "buildid": "20161118061428", 07:28:58 INFO - "pgo_build": "False", 07:28:58 INFO - "basedir": "/builds/slave/test", 07:28:58 INFO - "buildnumber": 9, 07:28:58 INFO - "slavename": "talos-linux64-ix-014", 07:28:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:28:58 INFO - "platform": "ubuntu64_hw", 07:28:58 INFO - "scheduler": "tests-graphics-linux64-talos", 07:28:58 INFO - "branch": "graphics", 07:28:58 INFO - "repo_path": "projects/graphics", 07:28:58 INFO - "revision": "20232bd6a7fa30214e9f499597a9d5c6546ec862", 07:28:58 INFO - "stage_platform": "linux64", 07:28:58 INFO - "builduid": "174ca56a456b4e62b662e7f6923757e3", 07:28:58 INFO - "slavebuilddir": "test" 07:28:58 INFO - } 07:28:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:28:58 INFO - Running post-action listener: _resource_record_post_action 07:28:58 INFO - [mozharness: 2016-11-18 15:28:58.894765Z] Finished read-buildbot-config step (success) 07:28:58 INFO - [mozharness: 2016-11-18 15:28:58.894853Z] Running download-and-extract step. 07:28:58 INFO - Running pre-action listener: _resource_record_pre_action 07:28:58 INFO - Running main action method: download_and_extract 07:28:58 INFO - mkdir: /builds/slave/test/build/tests 07:28:58 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')]} 07:28:58 INFO - trying https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:28:58 INFO - Downloading https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/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 07:28:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/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 07:28:59 INFO - Downloaded 1361 bytes. 07:28:59 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:28:59 INFO - Using the following test package requirements: 07:28:59 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:59 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:28:59 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:28:59 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'jsshell-linux-x86_64.zip'], 07:28:59 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:28:59 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:28:59 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:28:59 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:28:59 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:28:59 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:28:59 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:28:59 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:28:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:28:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:28:59 INFO - Fetch https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:00 INFO - Http code: 200 07:29:00 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 07:29:00 INFO - x-amz-cf-id: 8M9Ox0lc5Fm3RK_g58x4trdgVisXdsnR9e8FeFnyKextTpdtAkLC1w== 07:29:00 INFO - x-amz-version-id: 6DwxaA5Y.fxjpmZPuJss0XcygmzuDs_F 07:29:01 INFO - Expected file size: 20361480 07:29:01 INFO - Obtained file size: 20361480 07:29:05 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 07:29:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:29:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:29:05 INFO - Fetch https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:29:05 INFO - Http code: 200 07:29:05 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 07:29:05 INFO - x-amz-cf-id: MxbNJuEPalZ_nizYRb5E2rJEkQhmE2Go7c5slBbLaEY6H_-J1S-ReA== 07:29:05 INFO - x-amz-version-id: 6DwxaA5Y.fxjpmZPuJss0XcygmzuDs_F 07:29:05 INFO - Expected file size: 20361480 07:29:05 INFO - Obtained file size: 20361480 07:29:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:29:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:29:10 INFO - Fetch https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:29:11 INFO - Http code: 200 07:29:11 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 07:29:11 INFO - x-amz-cf-id: tTTTYmkvf9R0pkOJOQuKj9GSawUOqfX23Yazkaim0pLBrukAQ5_wWA== 07:29:11 INFO - x-amz-version-id: lR.DLFzPQ.Wl4Fe9cwHCjQIBHPumVrDn 07:29:11 INFO - Expected file size: 14409392 07:29:11 INFO - Obtained file size: 14409392 07:29:12 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')]} 07:29:12 INFO - trying https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:12 INFO - Downloading https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/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 07:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/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 07:29:14 INFO - Downloaded 55732048 bytes. 07:29:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:14 INFO - mkdir: /builds/slave/test/properties 07:29:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:14 INFO - Contents: 07:29:14 INFO - build_url:https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:29:15 INFO - Running post-action listener: _resource_record_post_action 07:29:15 INFO - Running post-action listener: set_extra_try_arguments 07:29:15 INFO - [mozharness: 2016-11-18 15:29:15.202713Z] Finished download-and-extract step (success) 07:29:15 INFO - [mozharness: 2016-11-18 15:29:15.202985Z] Running populate-webroot step. 07:29:15 INFO - Running pre-action listener: _resource_record_pre_action 07:29:15 INFO - Running main action method: populate_webroot 07:29:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:29:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:29:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:29:15 INFO - '--tppagecycles', 07:29:15 INFO - '7'], 07:29:15 INFO - 'tests': ['tsvgm']}}, 07:29:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:29:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:29:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:29:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:29:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:29:15 INFO - 'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:29:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:29:15 INFO - 'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['damp', 'tps']}, 07:29:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:29:15 INFO - 'tests': ['damp', 'tps']}, 07:29:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['dromaeo_dom']}, 07:29:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['basic_compositor_video']}, 07:29:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:29:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['a11yr', 07:29:15 INFO - 'ts_paint', 07:29:15 INFO - 'tpaint', 07:29:15 INFO - 'sessionrestore', 07:29:15 INFO - 'sessionrestore_no_auto_restore', 07:29:15 INFO - 'tabpaint']}, 07:29:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:29:15 INFO - 'ts_paint', 07:29:15 INFO - 'tpaint', 07:29:15 INFO - 'sessionrestore', 07:29:15 INFO - 'sessionrestore_no_auto_restore', 07:29:15 INFO - 'tabpaint']}, 07:29:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:29:15 INFO - 'ts_paint', 07:29:15 INFO - 'tpaint', 07:29:15 INFO - 'sessionrestore', 07:29:15 INFO - 'sessionrestore_no_auto_restore', 07:29:15 INFO - 'tabpaint']}, 07:29:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:29:15 INFO - 'ts_paint', 07:29:15 INFO - 'tpaint', 07:29:15 INFO - 'sessionrestore', 07:29:15 INFO - 'sessionrestore_no_auto_restore', 07:29:15 INFO - 'tabpaint']}, 07:29:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['a11yr', 07:29:15 INFO - 'ts_paint', 07:29:15 INFO - 'tpaint', 07:29:15 INFO - 'sessionrestore', 07:29:15 INFO - 'sessionrestore_no_auto_restore', 07:29:15 INFO - 'tabpaint']}, 07:29:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['a11yr', 07:29:15 INFO - 'ts_paint', 07:29:15 INFO - 'tpaint', 07:29:15 INFO - 'sessionrestore', 07:29:15 INFO - 'sessionrestore_no_auto_restore', 07:29:15 INFO - 'tabpaint']}, 07:29:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['tsvgx', 07:29:15 INFO - 'tsvgr_opacity', 07:29:15 INFO - 'tart', 07:29:15 INFO - 'tscrollx', 07:29:15 INFO - 'cart']}, 07:29:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:29:15 INFO - 'tsvgr_opacity', 07:29:15 INFO - 'tart', 07:29:15 INFO - 'tscrollx', 07:29:15 INFO - 'cart']}, 07:29:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:29:15 INFO - 'talos_options': ['--disable-e10s'], 07:29:15 INFO - 'tests': ['tp5o']}, 07:29:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:29:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:29:15 INFO - 'talos_options': ['--disable-e10s', 07:29:15 INFO - '--xperf_path', 07:29:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:15 INFO - 'tests': ['tp5n']}, 07:29:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:29:15 INFO - 'talos_options': ['--xperf_path', 07:29:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:15 INFO - 'tests': ['tp5n']}}, 07:29:15 INFO - 'talos.zip': {'path': '', 07:29:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:29:15 INFO - Running post-action listener: _resource_record_post_action 07:29:15 INFO - [mozharness: 2016-11-18 15:29:15.219764Z] Finished populate-webroot step (success) 07:29:15 INFO - [mozharness: 2016-11-18 15:29:15.219851Z] Running create-virtualenv step. 07:29:15 INFO - Running pre-action listener: _resource_record_pre_action 07:29:15 INFO - Running main action method: create_virtualenv 07:29:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:15 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 07:29:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:29:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:15 INFO - Using real prefix '/usr' 07:29:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:17 INFO - Installing pip.................done. 07:29:17 INFO - Return code: 0 07:29:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:29:18 INFO - Reading from file tmpfile_stdout 07:29:18 INFO - Output received: 07:29:18 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) 07:29:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29:18 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')]} 07:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:18 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')]} 07:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:18 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:18 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 07:29:18 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 07:29:18 INFO - Using env: {'DISPLAY': ':0', 07:29:18 INFO - 'HOME': '/home/cltbld', 07:29:18 INFO - 'LANG': 'en_US.UTF-8', 07:29:18 INFO - 'LANGUAGE': 'en_US:en', 07:29:18 INFO - 'LOGNAME': 'cltbld', 07:29:18 INFO - 'MAIL': '/var/mail/cltbld', 07:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:18 INFO - 'MOZ_NO_REMOTE': '1', 07:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:18 INFO - 'NO_EM_RESTART': '1', 07:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:18 INFO - 'PWD': '/builds/slave/test', 07:29:18 INFO - 'SHELL': '/bin/bash', 07:29:18 INFO - 'SHLVL': '1', 07:29:18 INFO - 'TERM': 'linux', 07:29:18 INFO - 'TMOUT': '86400', 07:29:18 INFO - 'USER': 'cltbld', 07:29:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:18 INFO - '_': '/tools/buildbot/bin/python'} 07:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:18 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 07:29:18 INFO - Cleaning up... 07:29:18 INFO - Return code: 0 07:29:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:29:18 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')]} 07:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:18 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')]} 07:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:18 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:18 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 07:29:18 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 07:29:18 INFO - Using env: {'DISPLAY': ':0', 07:29:18 INFO - 'HOME': '/home/cltbld', 07:29:18 INFO - 'LANG': 'en_US.UTF-8', 07:29:18 INFO - 'LANGUAGE': 'en_US:en', 07:29:18 INFO - 'LOGNAME': 'cltbld', 07:29:18 INFO - 'MAIL': '/var/mail/cltbld', 07:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:18 INFO - 'MOZ_NO_REMOTE': '1', 07:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:18 INFO - 'NO_EM_RESTART': '1', 07:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:18 INFO - 'PWD': '/builds/slave/test', 07:29:18 INFO - 'SHELL': '/bin/bash', 07:29:18 INFO - 'SHLVL': '1', 07:29:18 INFO - 'TERM': 'linux', 07:29:18 INFO - 'TMOUT': '86400', 07:29:18 INFO - 'USER': 'cltbld', 07:29:18 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:18 INFO - '_': '/tools/buildbot/bin/python'} 07:29:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:18 INFO - Downloading/unpacking psutil>=3.1.1 07:29:18 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 07:29:18 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 07:29:18 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 07:29:18 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 07:29:18 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 07:29:18 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 07:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:20 INFO - Installing collected packages: psutil 07:29:20 INFO - Running setup.py install for psutil 07:29:20 INFO - building 'psutil._psutil_linux' extension 07:29:20 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 07:29:20 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 07:29:20 INFO - building 'psutil._psutil_posix' extension 07:29:20 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 07:29:20 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 07:29:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:21 INFO - Successfully installed psutil 07:29:21 INFO - Cleaning up... 07:29:21 INFO - Return code: 0 07:29:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:21 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:21 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 07:29:21 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 07:29:21 INFO - Using env: {'DISPLAY': ':0', 07:29:21 INFO - 'HOME': '/home/cltbld', 07:29:21 INFO - 'LANG': 'en_US.UTF-8', 07:29:21 INFO - 'LANGUAGE': 'en_US:en', 07:29:21 INFO - 'LOGNAME': 'cltbld', 07:29:21 INFO - 'MAIL': '/var/mail/cltbld', 07:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:21 INFO - 'MOZ_NO_REMOTE': '1', 07:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:21 INFO - 'NO_EM_RESTART': '1', 07:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:21 INFO - 'PWD': '/builds/slave/test', 07:29:21 INFO - 'SHELL': '/bin/bash', 07:29:21 INFO - 'SHLVL': '1', 07:29:21 INFO - 'TERM': 'linux', 07:29:21 INFO - 'TMOUT': '86400', 07:29:21 INFO - 'USER': 'cltbld', 07:29:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:21 INFO - '_': '/tools/buildbot/bin/python'} 07:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:29:21 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 07:29:21 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 07:29:21 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 07:29:21 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 07:29:21 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 07:29:21 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 07:29:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:29:23 INFO - Installing collected packages: mozsystemmonitor 07:29:23 INFO - Running setup.py install for mozsystemmonitor 07:29:23 INFO - Successfully installed mozsystemmonitor 07:29:23 INFO - Cleaning up... 07:29:23 INFO - Return code: 0 07:29:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:29:23 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')]} 07:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:23 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')]} 07:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:23 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:23 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 07:29:23 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 07:29:23 INFO - Using env: {'DISPLAY': ':0', 07:29:23 INFO - 'HOME': '/home/cltbld', 07:29:23 INFO - 'LANG': 'en_US.UTF-8', 07:29:23 INFO - 'LANGUAGE': 'en_US:en', 07:29:23 INFO - 'LOGNAME': 'cltbld', 07:29:23 INFO - 'MAIL': '/var/mail/cltbld', 07:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:23 INFO - 'MOZ_NO_REMOTE': '1', 07:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:23 INFO - 'NO_EM_RESTART': '1', 07:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:23 INFO - 'PWD': '/builds/slave/test', 07:29:23 INFO - 'SHELL': '/bin/bash', 07:29:23 INFO - 'SHLVL': '1', 07:29:23 INFO - 'TERM': 'linux', 07:29:23 INFO - 'TMOUT': '86400', 07:29:23 INFO - 'USER': 'cltbld', 07:29:23 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:23 INFO - '_': '/tools/buildbot/bin/python'} 07:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:29:23 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 07:29:23 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 07:29:23 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 07:29:23 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 07:29:23 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 07:29:23 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 07:29:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:29:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:29:25 INFO - warning: no files found matching '*.txt' 07:29:25 INFO - no previously-included directories found matching 'build' 07:29:25 INFO - no previously-included directories found matching 'dist' 07:29:25 INFO - no previously-included directories found matching '.git*' 07:29:25 INFO - Installing collected packages: jsonschema, functools32 07:29:25 INFO - Running setup.py install for functools32 07:29:25 INFO - warning: no files found matching '*.txt' 07:29:25 INFO - no previously-included directories found matching 'build' 07:29:25 INFO - no previously-included directories found matching 'dist' 07:29:25 INFO - no previously-included directories found matching '.git*' 07:29:26 INFO - Successfully installed jsonschema functools32 07:29:26 INFO - Cleaning up... 07:29:26 INFO - Return code: 0 07:29:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:29:26 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')]} 07:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:26 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')]} 07:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:26 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:26 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 07:29:26 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 07:29:26 INFO - Using env: {'DISPLAY': ':0', 07:29:26 INFO - 'HOME': '/home/cltbld', 07:29:26 INFO - 'LANG': 'en_US.UTF-8', 07:29:26 INFO - 'LANGUAGE': 'en_US:en', 07:29:26 INFO - 'LOGNAME': 'cltbld', 07:29:26 INFO - 'MAIL': '/var/mail/cltbld', 07:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:26 INFO - 'MOZ_NO_REMOTE': '1', 07:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:26 INFO - 'NO_EM_RESTART': '1', 07:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:26 INFO - 'PWD': '/builds/slave/test', 07:29:26 INFO - 'SHELL': '/bin/bash', 07:29:26 INFO - 'SHLVL': '1', 07:29:26 INFO - 'TERM': 'linux', 07:29:26 INFO - 'TMOUT': '86400', 07:29:26 INFO - 'USER': 'cltbld', 07:29:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:26 INFO - '_': '/tools/buildbot/bin/python'} 07:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:29:26 INFO - Cleaning up... 07:29:26 INFO - Return code: 0 07:29:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29:26 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')]} 07:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:26 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')]} 07:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:26 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:26 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 07:29:26 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 07:29:26 INFO - Using env: {'DISPLAY': ':0', 07:29:26 INFO - 'HOME': '/home/cltbld', 07:29:26 INFO - 'LANG': 'en_US.UTF-8', 07:29:26 INFO - 'LANGUAGE': 'en_US:en', 07:29:26 INFO - 'LOGNAME': 'cltbld', 07:29:26 INFO - 'MAIL': '/var/mail/cltbld', 07:29:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:26 INFO - 'MOZ_NO_REMOTE': '1', 07:29:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:26 INFO - 'NO_EM_RESTART': '1', 07:29:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:26 INFO - 'PWD': '/builds/slave/test', 07:29:26 INFO - 'SHELL': '/bin/bash', 07:29:26 INFO - 'SHLVL': '1', 07:29:26 INFO - 'TERM': 'linux', 07:29:26 INFO - 'TMOUT': '86400', 07:29:26 INFO - 'USER': 'cltbld', 07:29:26 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:26 INFO - '_': '/tools/buildbot/bin/python'} 07:29:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:26 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 07:29:26 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 07:29:26 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 07:29:26 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 07:29:26 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 07:29:26 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 07:29:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29: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 07:29:29 INFO - Downloading docopt-0.6.1.tar.gz 07:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:29 INFO - Running setup.py install for blobuploader 07:29:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:29 INFO - Running setup.py install for requests 07:29:29 INFO - Running setup.py install for docopt 07:29:29 INFO - Successfully installed blobuploader requests docopt 07:29:29 INFO - Cleaning up... 07:29:29 INFO - Return code: 0 07:29:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:29 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:29 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 07:29:29 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 07:29:29 INFO - Using env: {'DISPLAY': ':0', 07:29:29 INFO - 'HOME': '/home/cltbld', 07:29:29 INFO - 'LANG': 'en_US.UTF-8', 07:29:29 INFO - 'LANGUAGE': 'en_US:en', 07:29:29 INFO - 'LOGNAME': 'cltbld', 07:29:29 INFO - 'MAIL': '/var/mail/cltbld', 07:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:29 INFO - 'MOZ_NO_REMOTE': '1', 07:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:29 INFO - 'NO_EM_RESTART': '1', 07:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:29 INFO - 'PWD': '/builds/slave/test', 07:29:29 INFO - 'SHELL': '/bin/bash', 07:29:29 INFO - 'SHLVL': '1', 07:29:29 INFO - 'TERM': 'linux', 07:29:29 INFO - 'TMOUT': '86400', 07:29:29 INFO - 'USER': 'cltbld', 07:29:29 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:29 INFO - '_': '/tools/buildbot/bin/python'} 07:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:30 INFO - Running setup.py (path:/tmp/pip-ncmML5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:30 INFO - Running setup.py (path:/tmp/pip-XEwSbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:30 INFO - Running setup.py (path:/tmp/pip-DN5IL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:30 INFO - Running setup.py (path:/tmp/pip-Aamk0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:30 INFO - Running setup.py (path:/tmp/pip-QzEgL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:30 INFO - Running setup.py (path:/tmp/pip-wLtNQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:30 INFO - Running setup.py (path:/tmp/pip-eGpVyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:30 INFO - Running setup.py (path:/tmp/pip-042Qrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:30 INFO - Running setup.py (path:/tmp/pip-vRcRAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:30 INFO - Running setup.py (path:/tmp/pip-rtHIW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:30 INFO - Running setup.py (path:/tmp/pip-dxzbXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:30 INFO - Running setup.py (path:/tmp/pip-kMTyhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:30 INFO - Running setup.py (path:/tmp/pip-bhNwxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:31 INFO - Running setup.py (path:/tmp/pip-20F8K_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:31 INFO - Running setup.py (path:/tmp/pip-uM_nsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:31 INFO - Running setup.py (path:/tmp/pip-AZ_PC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:31 INFO - Running setup.py (path:/tmp/pip-nF0RFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:31 INFO - Running setup.py install for manifestparser 07:29:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:31 INFO - Running setup.py install for mozcrash 07:29:31 INFO - Running setup.py install for mozdebug 07:29:31 INFO - Running setup.py install for mozdevice 07:29:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:29:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:31 INFO - Running setup.py install for mozfile 07:29:31 INFO - Running setup.py install for mozhttpd 07:29:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:31 INFO - Running setup.py install for mozinfo 07:29:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Running setup.py install for mozInstall 07:29:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Running setup.py install for mozleak 07:29:32 INFO - Running setup.py install for mozlog 07:29:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Running setup.py install for moznetwork 07:29:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Running setup.py install for mozprocess 07:29:32 INFO - Running setup.py install for mozprofile 07:29:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Running setup.py install for mozrunner 07:29:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:32 INFO - Running setup.py install for mozscreenshot 07:29:32 INFO - Running setup.py install for moztest 07:29:33 INFO - Running setup.py install for mozversion 07:29:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:33 INFO - Cleaning up... 07:29:33 INFO - Return code: 0 07:29:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:33 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:33 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 07:29:33 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 07:29:33 INFO - Using env: {'DISPLAY': ':0', 07:29:33 INFO - 'HOME': '/home/cltbld', 07:29:33 INFO - 'LANG': 'en_US.UTF-8', 07:29:33 INFO - 'LANGUAGE': 'en_US:en', 07:29:33 INFO - 'LOGNAME': 'cltbld', 07:29:33 INFO - 'MAIL': '/var/mail/cltbld', 07:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:33 INFO - 'MOZ_NO_REMOTE': '1', 07:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:33 INFO - 'NO_EM_RESTART': '1', 07:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:33 INFO - 'PWD': '/builds/slave/test', 07:29:33 INFO - 'SHELL': '/bin/bash', 07:29:33 INFO - 'SHLVL': '1', 07:29:33 INFO - 'TERM': 'linux', 07:29:33 INFO - 'TMOUT': '86400', 07:29:33 INFO - 'USER': 'cltbld', 07:29:33 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:33 INFO - '_': '/tools/buildbot/bin/python'} 07:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:33 INFO - Running setup.py (path:/tmp/pip-aorBGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:33 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:33 INFO - Running setup.py (path:/tmp/pip-PW2tTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:33 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:33 INFO - Running setup.py (path:/tmp/pip-Q0WDZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:33 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:33 INFO - Running setup.py (path:/tmp/pip-EfhyNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:33 INFO - Running setup.py (path:/tmp/pip-sCPBHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:33 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:33 INFO - Running setup.py (path:/tmp/pip-7cq006-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:33 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:33 INFO - Running setup.py (path:/tmp/pip-6UlOW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:33 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:33 INFO - Running setup.py (path:/tmp/pip-lzVZYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:33 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)) 07:29:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:33 INFO - Running setup.py (path:/tmp/pip-wl5QXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:34 INFO - Running setup.py (path:/tmp/pip-TB10YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:34 INFO - Running setup.py (path:/tmp/pip-vpfoUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:34 INFO - Running setup.py (path:/tmp/pip-jy887R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:34 INFO - Running setup.py (path:/tmp/pip-nILkaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:34 INFO - Running setup.py (path:/tmp/pip-SvPQ5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:34 INFO - Running setup.py (path:/tmp/pip-40o9Wt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:34 INFO - Running setup.py (path:/tmp/pip-2EoNTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:34 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)) 07:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:34 INFO - Running setup.py (path:/tmp/pip-LBgtgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:34 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)) 07:29:34 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)) 07:29:34 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)) 07:29:34 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)) 07:29:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:34 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:29:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:29:36 INFO - Downloading blessings-1.6.tar.gz 07:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:36 INFO - Installing collected packages: blessings 07:29:36 INFO - Running setup.py install for blessings 07:29:36 INFO - Successfully installed blessings 07:29:36 INFO - Cleaning up... 07:29:36 INFO - Return code: 0 07:29:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:37 INFO - Reading from file tmpfile_stdout 07:29:37 INFO - Current package versions: 07:29:37 INFO - argparse == 1.2.1 07:29:37 INFO - blessings == 1.6 07:29:37 INFO - blobuploader == 1.2.4 07:29:37 INFO - docopt == 0.6.1 07:29:37 INFO - functools32 == 3.2.3-2 07:29:37 INFO - jsonschema == 2.5.1 07:29:37 INFO - manifestparser == 1.1 07:29:37 INFO - mozInstall == 1.12 07:29:37 INFO - mozcrash == 1.0 07:29:37 INFO - mozdebug == 0.1 07:29:37 INFO - mozdevice == 0.48 07:29:37 INFO - mozfile == 1.2 07:29:37 INFO - mozhttpd == 0.7 07:29:37 INFO - mozinfo == 0.9 07:29:37 INFO - mozleak == 0.1 07:29:37 INFO - mozlog == 3.4 07:29:37 INFO - moznetwork == 0.27 07:29:37 INFO - mozprocess == 0.23 07:29:37 INFO - mozprofile == 0.28 07:29:37 INFO - mozrunner == 6.13 07:29:37 INFO - mozscreenshot == 0.1 07:29:37 INFO - mozsystemmonitor == 0.3 07:29:37 INFO - moztest == 0.7 07:29:37 INFO - mozversion == 1.4 07:29:37 INFO - psutil == 3.1.1 07:29:37 INFO - requests == 1.2.3 07:29:37 INFO - wsgiref == 0.1.2 07:29:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:37 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 07:29:37 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 07:29:37 INFO - Using env: {'DISPLAY': ':0', 07:29:37 INFO - 'HOME': '/home/cltbld', 07:29:37 INFO - 'LANG': 'en_US.UTF-8', 07:29:37 INFO - 'LANGUAGE': 'en_US:en', 07:29:37 INFO - 'LOGNAME': 'cltbld', 07:29:37 INFO - 'MAIL': '/var/mail/cltbld', 07:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:37 INFO - 'MOZ_NO_REMOTE': '1', 07:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:37 INFO - 'NO_EM_RESTART': '1', 07:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:37 INFO - 'PWD': '/builds/slave/test', 07:29:37 INFO - 'SHELL': '/bin/bash', 07:29:37 INFO - 'SHLVL': '1', 07:29:37 INFO - 'TERM': 'linux', 07:29:37 INFO - 'TMOUT': '86400', 07:29:37 INFO - 'USER': 'cltbld', 07:29:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:37 INFO - '_': '/tools/buildbot/bin/python'} 07:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 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)) 07:29:37 INFO - Cleaning up... 07:29:37 INFO - Return code: 0 07:29:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:29:37 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 0x7f431faffe30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1360b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14fc130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, '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': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', '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 07:29:37 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 07:29:37 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 07:29:37 INFO - Using env: {'DISPLAY': ':0', 07:29:37 INFO - 'HOME': '/home/cltbld', 07:29:37 INFO - 'LANG': 'en_US.UTF-8', 07:29:37 INFO - 'LANGUAGE': 'en_US:en', 07:29:37 INFO - 'LOGNAME': 'cltbld', 07:29:37 INFO - 'MAIL': '/var/mail/cltbld', 07:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:37 INFO - 'MOZ_NO_REMOTE': '1', 07:29:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:37 INFO - 'NO_EM_RESTART': '1', 07:29:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:37 INFO - 'PWD': '/builds/slave/test', 07:29:37 INFO - 'SHELL': '/bin/bash', 07:29:37 INFO - 'SHLVL': '1', 07:29:37 INFO - 'TERM': 'linux', 07:29:37 INFO - 'TMOUT': '86400', 07:29:37 INFO - 'USER': 'cltbld', 07:29:37 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:37 INFO - '_': '/tools/buildbot/bin/python'} 07:29:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:29:37 INFO - Cleaning up... 07:29:37 INFO - Return code: 0 07:29:37 INFO - Running post-action listener: _resource_record_post_action 07:29:37 INFO - Running post-action listener: _start_resource_monitoring 07:29:37 INFO - Starting resource monitoring. 07:29:37 INFO - [mozharness: 2016-11-18 15:29:37.533035Z] Finished create-virtualenv step (success) 07:29:37 INFO - [mozharness: 2016-11-18 15:29:37.533560Z] Running install step. 07:29:37 INFO - Running pre-action listener: _resource_record_pre_action 07:29:37 INFO - Running main action method: install 07:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:37 INFO - Reading from file tmpfile_stdout 07:29:37 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:37 INFO - Reading from file tmpfile_stdout 07:29:37 INFO - Output received: 07:29:37 INFO - Usage: mozinstall [options] installer 07:29:37 INFO - Options: 07:29:37 INFO - -h, --help show this help message and exit 07:29:37 INFO - -d DEST, --destination=DEST 07:29:37 INFO - Directory to install application into. [default: 07:29:37 INFO - "/builds/slave/test"] 07:29:37 INFO - --app=APP Application being installed. [default: firefox] 07:29:37 INFO - mkdir: /builds/slave/test/build/application 07:29:37 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'] 07:29:37 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 07:29:53 INFO - Reading from file tmpfile_stdout 07:29:53 INFO - Output received: 07:29:53 INFO - /builds/slave/test/build/application/firefox/firefox 07:29:53 INFO - Running post-action listener: _resource_record_post_action 07:29:53 INFO - [mozharness: 2016-11-18 15:29:53.911184Z] Finished install step (success) 07:29:53 INFO - [mozharness: 2016-11-18 15:29:53.911435Z] Running run-tests step. 07:29:53 INFO - Running pre-action listener: _resource_record_pre_action 07:29:53 INFO - Running main action method: run_tests 07:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:29:53 INFO - Python 2.7.3 07:29:53 INFO - Return code: 0 07:29:53 INFO - grabbing minidump binary from tooltool 07:29:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:29:53 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 0x158afc0>, '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 0x158bec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x158c350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:29:53 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 07:29:53 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 07:29:53 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 07:29:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:29:53 INFO - Return code: 0 07:29:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:29:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:29:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:29:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:29:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:29:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 07:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --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 07:29:53 INFO - Using env: {'DISPLAY': ':0', 07:29:53 INFO - 'HOME': '/home/cltbld', 07:29:53 INFO - 'LANG': 'en_US.UTF-8', 07:29:53 INFO - 'LANGUAGE': 'en_US:en', 07:29:53 INFO - 'LOGNAME': 'cltbld', 07:29:53 INFO - 'MAIL': '/var/mail/cltbld', 07:29:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:29:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:29:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:53 INFO - 'MOZ_NO_REMOTE': '1', 07:29:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:29:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:53 INFO - 'NO_EM_RESTART': '1', 07:29:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:53 INFO - 'PWD': '/builds/slave/test', 07:29:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:29:53 INFO - 'SHELL': '/bin/bash', 07:29:53 INFO - 'SHLVL': '1', 07:29:53 INFO - 'TERM': 'linux', 07:29:53 INFO - 'TMOUT': '86400', 07:29:53 INFO - 'USER': 'cltbld', 07:29:53 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894', 07:29:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:53 INFO - '_': '/tools/buildbot/bin/python'} 07:29:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--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 07:29:54 INFO - mozversion application_buildid: 20161118061428 07:29:54 INFO - mozversion application_changeset: 20232bd6a7fa30214e9f499597a9d5c6546ec862 07:29:54 INFO - mozversion application_display_name: Nightly 07:29:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:29:54 INFO - mozversion application_name: Firefox 07:29:54 INFO - mozversion application_remotingname: firefox 07:29:54 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 07:29:54 INFO - mozversion application_vendor: Mozilla 07:29:54 INFO - mozversion application_version: 53.0a1 07:29:54 INFO - mozversion platform_buildid: 20161118061428 07:29:54 INFO - mozversion platform_changeset: 20232bd6a7fa30214e9f499597a9d5c6546ec862 07:29:54 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 07:29:54 INFO - mozversion platform_version: 53.0a1 07:29:54 INFO - using testdate: 1479482994 07:29:54 INFO - actual date: 1479482994 07:29:54 INFO - starting webserver on 'localhost:44931' 07:29:54 INFO - SUITE-START | Running 2 tests 07:29:54 INFO - TEST-START | dromaeo_css 07:29:54 INFO - operating with platform_type : linux_ 07:29:54 INFO - Initialising browser for dromaeo_css test... 07:29:54 INFO - TEST-INFO | started process 7625 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHMRLmq/profile http://localhost:44931/getInfo.html) 07:29:58 INFO - PROCESS | 7625 | __metrics Screen width/height:1600/1200 07:29:58 INFO - PROCESS | 7625 | colorDepth:24 07:29:58 INFO - PROCESS | 7625 | Browser inner width/height: 1024/697 07:29:58 INFO - PROCESS | 7625 | __metrics 07:29:58 INFO - PROCESS | 7625 | 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" 07:29:58 INFO - PROCESS | 7625 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:29:59 INFO - PROCESS | 7625 | console.error: PushService: 07:29:59 INFO - PROCESS | 7625 | stateChangeProcessEnqueue: Error transitioning state 07:29:59 INFO - PROCESS | 7625 | UnknownError 07:30:00 INFO - TEST-INFO | 7625: exit 0 07:30:00 INFO - Browser initialized. 07:30:00 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:00 INFO - TEST-INFO | started process 7708 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHMRLmq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:12 INFO - PROCESS | 7708 | RSS: Main: 174723072 07:30:12 INFO - PROCESS | 7708 | 07:31:03 INFO - PROCESS | 7708 | 1479483063476 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] 07:33:17 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44931/tests/dromaeo/cssquery-ext.html) 07:33:18 INFO - PROCESS | 7708 | RSS: Main: 279691264 07:33:18 INFO - PROCESS | 7708 | 07:36:21 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-ext.html (next: http://localhost:44931/tests/dromaeo/cssquery-jquery.html) 07:36:22 INFO - PROCESS | 7708 | RSS: Main: 280133632 07:36:22 INFO - PROCESS | 7708 | 07:39:24 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44931/tests/dromaeo/cssquery-mootools.html) 07:39:25 INFO - PROCESS | 7708 | RSS: Main: 221716480 07:39:25 INFO - PROCESS | 7708 | 07:42:27 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44931/tests/dromaeo/cssquery-prototype.html) 07:42:27 INFO - PROCESS | 7708 | RSS: Main: 221032448 07:42:27 INFO - PROCESS | 7708 | 07:45:31 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44931/tests/dromaeo/cssquery-yui.html) 07:45:31 INFO - PROCESS | 7708 | RSS: Main: 220221440 07:45:31 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | Cycle 1(1): loaded http://localhost:44931/tests/dromaeo/cssquery-yui.html (next: http://localhost:44931/tests/dromaeo/cssquery-dojo.html) 07:48:34 INFO - PROCESS | 7708 | RSS: Main: 310276096 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | __start_tp_report 07:48:34 INFO - PROCESS | 7708 | _x_x_mozilla_page_load 07:48:34 INFO - PROCESS | 7708 | _x_x_mozilla_page_load_details 07:48:34 INFO - PROCESS | 7708 | |i|pagename|runs| 07:48:34 INFO - PROCESS | 7708 | |0;dojo.html;2535.3788321861143;2536.720960694322;2570.871456427178;2581.8967241310347;2596.7662910338067;4518.164139634162;4573.49691533931;4586.128635559246;4593.609543188829;4595.862124136277;4550.294704320827;4563.566461186182;4591.839285625004;4601.470830854452;4681.063787242548;4236.661067114624;4250.2137104635585;4266.2747332953395;4291.485021797389;4299.828006879721;4302.526722060571;4335.6531477481885;4349.717268377562;4365.257906155961;4393.560643935597;4369.038811461473;4385.4737431508265;4395.1868904252815;4422.491413487442;4438.356438316442;4200.789960501963;4230.1539692061715;4232.534421213664;4289.678274129453;4297.35539669049;4256.787160641987;4265.509466411371;4267.487901451846;4267.850625228102;4273.145370925828;4574.336721175444;4613.284940834176;4630.21286381316;4676.298555216745;4701.435827700664;4928.827491037797;4961.950380496185;4963.60291176705;4964.950350496485;4999.12515309823;4930.359053323081;4978.128827455217;4984.526469985346;4987.401511818569;5034.974825125851;4460.375547423331;4477;4486.416765820422;4581.839635612738;4658.37111989877;5119.744012799345;5121.692698438105;5157.045946499909;5161.870953226199;5162.5869930406225;4859.80560777572;4895.926561101586;4906.362172917497;4907.901841963212;4959.975200123977;4764.857054288377;4824.662273640812;4933.4819843915875;4999.10016197088;5035.647504674637;4829.985703002409;4860.052289803525;4896.559309662076;4916.336294600254;4993.825216117491;4933.876653083702;4947.826826061142;4948.480409557017;4950.232713929347;4987.975060124749;4128.277551428488;4139.19285739278;4140.37894315849;4146.896327591774;4178.561251068655;3510.596281427617;3544.5746510418917;3549.8402571884326;3562.8574857005947;3570.535830342039;4291.6137547620865;4296.398504209413;4311.849085282063;4323.7621930793475;4329.112531930947;4923.532264434873;4924.9507504924495;4928.112939670894;4928.753562321941;4973.229149481836;4188.32986722123;4222.619964203175;4224.471941007374;4282.400463935051;4286.592773686495;4363.214621368184;4392.934105988413;4402.84590039347;4455.287154055336;4465.285554311295;4653.348531205566;4656.976715116402;4656.976715116471;4691.859244222679;4707.693999889996;4959.404871415309;4960.851174464772;4965.776540055778;4969.304297398439;5014.648974571745;4503.144402563634;4537.22867112585;4543.318502224693;4596.540345965377;4599.080183963154;4821.927671084866;4827.710337379768;4828.324034635224;4829.9517004830905;4830.589399901048;4893.804247830047;4908;4919.901601968012;4970.378702662168;4975.751212439436;4815.879603009953;4859.562639362333;4862.3922009748785;4896.069746748107;4907.263910413467;4852.369192005017;4872.14737420957;4875.902481950412;4876.536729010738;4915.336429581961;4584.060267645058;4637.8144874206;4696.906061878675;4708.482066972561;4797.952020479751;4847.636427268039;4849.127157111613;4849.248366503198;4879.414470263449;4899.04468628614;4736.194846876108;4741.146593613183;4742.336072949859;4774.737389443614;4785.210440277316 07:48:34 INFO - PROCESS | 7708 | |1;ext.html;547.1246006389775;560.5991715923114;561.9466150715682;566.3289002532002;572.4647454629921;21748.238811641597;23405.648915266283;23445.648315275284;23449.531009379803;23464.8826755866;24032;24625.63061554078;28218;29066.128016159495;29144.562831557545;5384.138537833937;5509.972450137744;5514.172874068881;5515.889682206353;5516.806911758089;5486.067368547357;5563.219769673706;5563.5271001964675;5567.025770490169;5567.638103523258;5524.613277070606;5559.166125081229;5562.415946325638;5576.721163941807;5577.52591029763;5513.50378465938;5561.805336813232;5565.2486914266865;5569.081101618228;5569.192467092289;5488.4237155098535;5535.391106978229;5540.196671482612;5541.030319694038;5546.972265138648;25424.491510169693;25724.87137564319;25776.48447031049;25776.74223257762;25799.613005804928;2936.750376218024;2973.50937095379;3046.8781248750024;3110.424571454266;3305.2893627869885;18247.087645617667;18276.634467310712;18333.63332733351;18334.358297459527;18383.26466941321;2602.973970260292;2672.2250547341246;2681.4368982513697;2688.368233465134;2743.1633351827686;231359;234382;234447;234615;234729;29842.253943651584;30870.845645771627;45349;45492;45549.54450455519;32249.677503225135;32439.35121297561;32507;32513.674863251064;32527.837360813046;11583.6524904253;11684.824727629093;11690.649280521598;11698;11698.88301116995;9409.106134917172;9412.388194767318;9434.811303774024;9436.292278079172;9481.431114133036;7696.730039543412;7733.845323093619;7760.689572417153;7768;7815.960920195363;2994.895178668736;3062.617172853393;3078.5228289615147;3089.4975070193213;3127.812331260086;794.6225542867207;831.301706566487;856.1096459681986;893.2407453664463;906.6056265524518;24946.12688555892;26710.19869403921;26842.5973610396;27103.1869043929;27248.59127113095;791.600241877848;892.5581836990731;925.1812146250617;925.9722208333761;975.5805003848413;11893.108016898766;14311.78532322016;14333.856661433252;14566.854331456761;14567.562973110824;343515;345618;345961;347084;347814;42773.37012763027;43099.35350969738;43146.7842660791;43162.78418607887;43265.134697305875;1045.8640376750973;1081.0702795595782;1134.489479734123;1146.8165093585153;1185.1940680337452;23997.880010599834;26476.8676156618;28508.80251870591;28954.42091158123;29114;41719.58280417279;42542;42557.78721106375;42629.147417050866;42634;296444;300302;300317;300551;300674;23789.643155352336;24454.14410495624;24638.507229854946;24803;24804.627930581417;35692.64610308371;36163.81918090393;36230.818845905604;37067.814660926524;37111.6288837119;31096.689033110284;31501.52747708832;31601;31796;32320.676793231767;31392.843035784674;31503.684963150074;31794.6820531801;31805.681943180272;32046;31449.842750786098;31739.523907141873;31801.36397272088;32012.359752805278;32338.514922275714;27267.590986134826;29337.413251735274;29485.26286842846;29608.555871662375;30344.241393965327;22639.434014149778;23128.4217894554;23178;23316.30051098402;23622.17322393708 07:48:34 INFO - PROCESS | 7708 | |2;jquery.html;338.5801606008547;355.7189820042167;364.37145923282344;365.3113880335567;386.75441094904744;9691.563879625417;11553.826692599607;11939.164258501909;12041.879581204197;12648;14468;14664.706705865876;15146.24268786559;15710.450134245304;15711.685766284667;3981.601839816024;4211.515675697304;4213.620774130328;4217.388478670591;4218.303979843322;3535.239923416465;3770.4155855842387;3785.9432108518395;3807.485989391438;3812.3137835189655;3802.505674262342;3804.448354988525;3807.923841523168;3808.4096964970336;3808.542974843009;3639.1266096137;3714.275716235335;3806.0865392305923;3810.885673429788;3811;3661.743677942545;3662.8717994870317;3663.9450408243897;3664.523611930432;3664.76179048361;10328.741781455448;10564.683059508227;10584.312019718695;11463.484143213574;16146.192690365435;1767.6553072150937;1848.6302739452162;1855.9257629694796;1950.0542237015036;2287.9199228026937;7761.805954851117;8025.197480251986;8051.63767630458;8137.238810053192;8379.329653627696;1389.6456403617115;1469.9485518006925;1474.1523623916185;1478.3199728125076;1482.2420031698261;60386.396136038515;67963.98054029242;68249.3175068248;68590;69855.65072174657;9446.811063778687;9457.716268511957;9464.95267523658;9703.514824258758;9727.65953191635;10847.837282440769;11285.887141128647;11538.88461115395;11988.100892433102;11997.580084696994;6942.687579058955;6981.685824137926;7078.469114816409;7266.96366518164;7294.379977701955;5450.345958484928;5734.111212762028;6015.488683461867;6389.552731308857;6867.759628412981;4134.995137634686;4193.391958166048;4243.575642435731;4354.259775838115;4354.368616550582;1725.335745737875;1729.4638662014816;1737.4266492057843;1782.6078262782166;1796.1827368547279;784.4744021505605;790.7548659915444;808.6037841457761;864.7665130414753;868.1231955724637;15612.29744661493;16274.837251627332;16594.170291485378;16898.91550542264;17386.913065434845;761.1855314813207;762.7444805990056;807.3016840432983;829.3738227638095;833.6915341323628;8758.956205219061;9044.186023257938;9173.78917378912;9252.768680783034;9705.320627556144;345957;352852;353432;355106;358912;75215.62392188114;77227;78240.60879695565;79014;80438.59780701059;860.0539406652757;876.3296078499952;881.6561540999015;883.9955800221086;888.0764005434405;14364.209968451836;14845.109293442429;14897.553073407815;14967.476138335105;15521;34439;35924.281514369046;35932.281354372244;36447.453288200166;36831.526738930144;45601.71991400483;49296.50703492919;49448.50551494583;49520;49549.25676114789;6415.845147873428;6601.273859875506;6633.6019838809825;7063.434925206074;7377.594232317274;11011.779764404828;12006.63980080599;12101.394930253628;12203.328816915155;12428.937855310665;9867.555959981675;10101.393916365041;10167.79664406693;10962.945185274022;11045.447727613748;9461.290403219647;9790.461524616214;9912.553935073083;9981.251406144713;10134.189264858942;9665.855012174683;9800.31397802147;9871.062249086326;10764.677059687909;10969;6715.697793599397;6861.828454288683;6876.862462750617;7008.738427083174;7219.205887352282;7360.33756961876;10277.588896444058;10622.73443163896;10645.361278323326;10746.892531074902 07:48:34 INFO - PROCESS | 7708 | |3;mootools.html;1200.0399680255805;1317.6574090736406;1350.8108864758933;1365.7541642504352;1611.5971007248195;5453.863653408666;5816.272965879265;6037.969810150954;6039.788607398742;6200.968995155018;6157.353477884813;6213.875722485547;6215.720292586833;6220.947087461138;6227.657478838662;1678.630701245727;1712.6146617011198;1717.7251639737644;1719.6474722681883;1719.7506361577564;1703.9233234504416;1737.6524695060975;1740.4691569071429;1751.0806826416106;1766.4523997560732;1681.941132060378;1735.1324337831084;1736.1059054586897;1738;1739.3651317269168;1675.4387280261128;1687.7468379743013;1697.2023149120018;1702.6850032743982;1703.4378655043806;1663.259849367032;1670.2233461440367;1682.5204816627202;1684.553593297777;1685.7050016247108;5978.970105149447;6070.362611925772;6122.938770612326;6151.846203844895;6179.752809887599;3907.98046009771;3995.720299579031;4009.5766003069075;4014.879553613396;4014.9397759033345;2485.4672649845843;2563.9615405768927;2641;2641.4849104424643;2646.298730836311;714.253604982789;735.7424901284561;754.1101500229727;754.7320701151123;756.8183635927393;8220.177982201732;8363.790905227357;8379.37154713399;8395.874061889077;8423.999999999938;3491.6591893638947;3578.5169002184894;3589.210373717778;3642.8724994625063;3652.178259891556;6875.07186529812;6876.587404755731;6880.2431732509385;6881.071055407456;6893.7931862044215;3950.466686997276;3979.6020397959974;4006.579309172553;4012.7391719538136;4014.1770936957855;3319.9502007469905;3435.209901722568;3728.9440658390145;3747.4566187903147;3755.3991361382596;2906.9273268168463;2953.424082303973;2956.024511911064;2960.3931194105157;2974.8512574371193;859.9613017414231;873.2271939333608;873.689840106753;881.8633111867671;882.4705176893941;605.4369436424167;637.4613451633362;664.1465716554204;689.6276010954128;743.8623854586918;4330.523642399334;4377.496587892433;4438.866833994985;4454;4726.432828060586;741.423572908296;775.1550809617544;793.797581616684;837.9245867871921;863.680438237856;2960.259935016246;3028.5608586754797;3076.5385192220897;3133.1697100268448;3161.351922855809;7300.890486642705;7538.924610753932;7628.656710448043;7792.493487923381;7867.409944254204;7828.569428681477;7835.294823465915;7861.567613781297;7863.842723145505;7864.41016923733;5818.272715910512;5963.373845746221;5977.342492325841;5983.581149319506;5986.281646202484;4160.791960402028;4268.509121451073;4318.611324980767;4406.691531592758;4436.334549817553;7070.151581810215;7116.146062472537;7191.101112360955;7191.316824901626;7207.747728829466;7230.13238411394;7306.7077316906725;7393.519421237603;7399.149097853816;7423.072115985502;5631.155326701028;5668;5735.254416925773;5740.368559458373;5745.597808153389;6250.749970001331;6280.9685951569945;6285.59143655661;6327.303996560467;6340.873182536231;5715.114157305624;5724.542036637143;5787.8553036174435;5790.363060063474;5791.305043394819;5577.525910297508;5700.857478563069;5703.800366987136;5747.7413516391025;5839.649621022752;4862.732549709658;5074.137396642654;5211.9478805211465;5279.076161671769;5281.260623512788;4001.539822920285;4040.939385909155;4064;4093.201825643971;4101.692373071972;4029.879103626896;4032.0927791246736;4108.630223279919;4128.938065928954;4137.338025915839 07:48:34 INFO - PROCESS | 7708 | |4;prototype.html;279.90138705580597;286.4342922727612;290.0414131296066;293.31218293102665;295.45488573581736;4738.312944623028;4753.8811529711775;4797.832075877345;4804.543568361005;4824.951750482494;4703.2239680452685;4712.198926182548;4733.195356789345;4741.668083234175;4755.191617425037;3487.511748355232;3593.6344189208066;3644.817759112047;3693.907652308687;3705.2404257127223;3683.1032018510487;3684.705223582107;3687.1703866630064;3698.574663913644;3741.7006639468914;3667.9083022924374;3671.963280367189;3676.963230367689;3685.3919103347916;3715;3494.685478306952;3589.856405743767;3609.404448266033;3656.4880916671686;3664.9816750916343;3211.5022171563446;3219.517072439153;3221.1624977505785;3225.903222903317;3250.967490325114;4593.632509399274;4593.816247350102;4598.678092533524;4605.710401087701;4618.905333426612;3881.4760007399204;4106.137711080647;4204.453421055243;4206.537280899099;4214.377464676122;4917.704937703749;4938.715754023606;4943.505649435064;4944.901101977976;4949.653524253304;3440.3807314683345;3454.274602333513;3457.94813077804;3499.720022398202;3510.385682505577;5069.44236134025;5204.193350030751;5229;5247.291615631917;5251.264822924793;3405.659434056624;3457.135716070982;3464.37641224582;3473.565804274466;3478.426059700121;3506.701930335899;3512.121969507623;3515.5078289039557;3517.314123745845;3533.2403533240476;4086.4891888513935;4099.508059032935;4102.548719640837;4103.133074451118;4109.198706252252;4810.63920205986;4934.950650493521;5016.673916195436;5025.221090730943;5025.623078269071;1205.3310412721023;1214.993925030387;1215.969600759988;1217.2513903949007;1217.4399776103091;751.5227830327672;780.8360244348637;806.5684858600738;809.7611204694629;811.9675212991532;4167.74993500391;4289.63538099265;4418.072204836956;4422.29243321067;4449.599536041772;5121.820736274212;5152.871178220575;5170.630816959663;5202.661826981234;5207.635465517377;4471.709338892962;4480.395146655225;4483.170613436525;4500.797464114057;4513;2536.340551456635;2656.827306225128;2670.4258584404447;2674.826136301173;2686.1270087221733;4700.8034536514815;4730.428526462499;4730.834420795324;4735.976320118446;4756.595689366373;4963.329950456714;5130.666506677128;5142.87142821425;5144.6655967362;5160;4703.17694403478;4707.152712511781;4709.175894218498;4713.444563294173;4714.5521175488275;5038;5049.293098966221;5081.493769299172;5086.593072554261;5094.36980166358;4696.272077827942;4923.483034281492;4934.284528743384;4944.3572335596145;4972.577330926912;4627.8611641650805;4671.407368910287;4691.648126390603;4696.483386827515;4702.600278976189;3455.4989526519016;3459.3254315408253;3462.2902305026905;3471.3230919971375;3520.823958802101;5026.52248036436;5065.797368105234;5072.934683716313;5103.387593488805;5103.591712662904;4744.786484608132;4835;4866.610671146371;4872.220444728968;4880.755962201804;4825.95174048255;4884.340614017062;4887.633427493023;4889.731064791328;4902;4801.175553289728;4820.325154478446;4823.758812059313;4831.830885918976;4832.589229915497;4623.583877450911;4801.159797035435;4880.804767809248;4916.188828843344;4928.654994150375;4908.730019848943;4914.402819083741;4929.186684197068;4934.34858204933;4943.653944224014 07:48:34 INFO - PROCESS | 7708 | |5;yui.html;621.1924498152401;672.8351553869303;682.2052309059942;692.4771797293045;727.3926271563245;10905.945470272647;11401.771964560714;11416.54333826646;11424.200305978564;11440.885591144086;11241.718957026078;11343.546258149685;11349.602763903265;11426.028787553047;11428.142889283296;604.2839235505918;621.7450845153488;722.2488611843677;740.6185814305637;752.0486584470649;735.6321839080459;754.4454825703103;756.4024420707661;756.4629113329515;756.496929541854;805.963731632075;807.5074204735107;809.2271880354277;809.4010432280129;809.6437567470324;638.0716058135401;654.6006935769177;774.2683164409635;800.2197857089292;804.2359758229676;577.48892230376;580.399286738224;583.7635757518212;584.0392554248238;584.322186263936;10459.738506537322;10465.68602941913;10490.895091049068;10506.947465262625;10513.211509136845;9407.341486095977;9651.758706032335;9765.365251258645;9956.402615843073;10250.077493025588;8415.284700800377;8430.32557395407;8435.83128337436;8436.789080272982;8531.616077276538;2531.50635626053;2536.771690547841;2546.4525127097763;2559.5008973250037;2602.3103877472486;49357.753211233714;49593;50486.747566262304;50736;50821.99999999963;7227.205007449176;7266.169537331951;7273.054502914587;7360.116785985716;7600.125985511626;15299.541013769605;15446.227688615525;15566.143862087694;15628.2185890705;15656.530304090895;6308.274548426898;6444.355564443612;6534.705938232791;6613.801585952429;6614.8093343197725;3481.8607255709994;3629.8366573504254;3671.706263498914;3702.2225332680437;3719.8698045568276;2551.374913146291;2641.366072142672;2664.214056853233;2668.986655066712;2739.4247208086126;456.98629041128817;460.36699538135065;460.67062050633956;466.91362098011297;467.47409164689725;499.64774833742126;508.5346907579597;578.5776383240258;580.3963877567367;583.4107551373144;6970.198427180838;7197.4961752677855;7216.278372162742;7298.525595836254;7962.124166341698;531.7819693925472;545.0924211188407;554.6782865937746;555.0647159536195;574.7672192761938;3379.847906844198;3505.071156143624;3568.249737701808;3659.5791483979683;3686.391745361985;40492.797536012135;49379;66554;67333.32666673271;67417.66291168611;37148.44277335842;47430.52569474261;49762;60424;61236.387636123065;34985.475217871244;36597;54797.45202547924;56247.71876140675;56416.153757692846;6857.245702972768;7077.5399599025895;7103.147622285359;7213.819654508679;7226.819329516804;36219.818900905324;36671.63328366682;37449.81275093607;37588;37658.62341376551;30381.544276835422;50978.49021509886;51039.234411483114;51852.48147518627;52698.47301527089;8235.464694794819;8575.442596231225;9716.125548700651;9729.659461918798;10099.79800403973;9830.606775729177;10004.199664026715;10263.897361026593;10347.172226222036;10379.584816607252;8825.69110081144;8842.557872106241;9511.952440237754;9537.856932146162;10065.597376104874;9660.468674222986;9972.800543989224;10104.494775261355;10419.94790026045;10433.530491127765;8967.596458159269;9053.2304754094;9134.817303653757;9360.765980850534;9626.32615716893;8449.577521123796;8577.699780507652;8590.441621294596;8719;8788.736337909617;8113.310368618498;8586.78533036679;8638.913610864063;8643.827123457622;8671.783205419915 07:48:34 INFO - PROCESS | 7708 | __end_tp_report 07:48:34 INFO - PROCESS | 7708 | __start_cc_report 07:48:34 INFO - PROCESS | 7708 | _x_x_mozilla_cycle_collect,1084 07:48:34 INFO - PROCESS | 7708 | __end_cc_report 07:48:34 INFO - PROCESS | 7708 | __startTimestamp1479484114960__endTimestamp 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | ------- Summary: start ------- 07:48:34 INFO - PROCESS | 7708 | Number of tests: 6 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | [#0] dojo.html Cycles:165 Average:4570.31 Median:4676.30 stddev:488.55 (10.4%) stddev-sans-first:463.23 07:48:34 INFO - PROCESS | 7708 | Values: 2535.4 2536.7 2570.9 2581.9 2596.8 4518.2 4573.5 4586.1 4593.6 4595.9 4550.3 4563.6 4591.8 4601.5 4681.1 4236.7 4250.2 4266.3 4291.5 4299.8 4302.5 4335.7 4349.7 4365.3 4393.6 4369.0 4385.5 4395.2 4422.5 4438.4 4200.8 4230.2 4232.5 4289.7 4297.4 4256.8 4265.5 4267.5 4267.9 4273.1 4574.3 4613.3 4630.2 4676.3 4701.4 4928.8 4962.0 4963.6 4965.0 4999.1 4930.4 4978.1 4984.5 4987.4 5035.0 4460.4 4477.0 4486.4 4581.8 4658.4 5119.7 5121.7 5157.0 5161.9 5162.6 4859.8 4895.9 4906.4 4907.9 4960.0 4764.9 4824.7 4933.5 4999.1 5035.6 4830.0 4860.1 4896.6 4916.3 4993.8 4933.9 4947.8 4948.5 4950.2 4988.0 4128.3 4139.2 4140.4 4146.9 4178.6 3510.6 3544.6 3549.8 3562.9 3570.5 4291.6 4296.4 4311.8 4323.8 4329.1 4923.5 4925.0 4928.1 4928.8 4973.2 4188.3 4222.6 4224.5 4282.4 4286.6 4363.2 4392.9 4402.8 4455.3 4465.3 4653.3 4657.0 4657.0 4691.9 4707.7 4959.4 4960.9 4965.8 4969.3 5014.6 4503.1 4537.2 4543.3 4596.5 4599.1 4821.9 4827.7 4828.3 4830.0 4830.6 4893.8 4908.0 4919.9 4970.4 4975.8 4815.9 4859.6 4862.4 4896.1 4907.3 4852.4 4872.1 4875.9 4876.5 4915.3 4584.1 4637.8 4696.9 4708.5 4798.0 4847.6 4849.1 4849.2 4879.4 4899.0 4736.2 4741.1 4742.3 4774.7 4785.2 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | [#1] ext.html Cycles:180 Average:41010.31 Median:31552.34 stddev:78522.36 (248.9%) stddev-sans-first:78683.86 07:48:34 INFO - PROCESS | 7708 | Values: 547.1 560.6 561.9 566.3 572.5 21748.2 23405.6 23445.6 23449.5 23464.9 24032.0 24625.6 28218.0 29066.1 29144.6 5384.1 5510.0 5514.2 5515.9 5516.8 5486.1 5563.2 5563.5 5567.0 5567.6 5524.6 5559.2 5562.4 5576.7 5577.5 5513.5 5561.8 5565.2 5569.1 5569.2 5488.4 5535.4 5540.2 5541.0 5547.0 25424.5 25724.9 25776.5 25776.7 25799.6 2936.8 2973.5 3046.9 3110.4 3305.3 18247.1 18276.6 18333.6 18334.4 18383.3 2603.0 2672.2 2681.4 2688.4 2743.2 231359.0 234382.0 234447.0 234615.0 234729.0 29842.3 30870.8 45349.0 45492.0 45549.5 32249.7 32439.4 32507.0 32513.7 32527.8 11583.7 11684.8 11690.6 11698.0 11698.9 9409.1 9412.4 9434.8 9436.3 9481.4 7696.7 7733.8 7760.7 7768.0 7816.0 2994.9 3062.6 3078.5 3089.5 3127.8 794.6 831.3 856.1 893.2 906.6 24946.1 26710.2 26842.6 27103.2 27248.6 791.6 892.6 925.2 926.0 975.6 11893.1 14311.8 14333.9 14566.9 14567.6 343515.0 345618.0 345961.0 347084.0 347814.0 42773.4 43099.4 43146.8 43162.8 43265.1 1045.9 1081.1 1134.5 1146.8 1185.2 23997.9 26476.9 28508.8 28954.4 29114.0 41719.6 42542.0 42557.8 42629.1 42634.0 296444.0 300302.0 300317.0 300551.0 300674.0 23789.6 24454.1 24638.5 24803.0 24804.6 35692.6 36163.8 36230.8 37067.8 37111.6 31096.7 31501.5 31601.0 31796.0 32320.7 31392.8 31503.7 31794.7 31805.7 32046.0 31449.8 31739.5 31801.4 32012.4 32338.5 27267.6 29337.4 29485.3 29608.6 30344.2 22639.4 23128.4 23178.0 23316.3 23622.2 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | [#2] jquery.html Cycles:180 Average:22277.52 Median:3809.71 stddev:58713.89 (1541.2%) stddev-sans-first:58855.49 07:48:34 INFO - PROCESS | 7708 | Values: 338.6 355.7 364.4 365.3 386.8 9691.6 11553.8 11939.2 12041.9 12648.0 14468.0 14664.7 15146.2 15710.5 15711.7 3981.6 4211.5 4213.6 4217.4 4218.3 3535.2 3770.4 3785.9 3807.5 3812.3 3802.5 3804.4 3807.9 3808.4 3808.5 3639.1 3714.3 3806.1 3810.9 3811.0 3661.7 3662.9 3663.9 3664.5 3664.8 10328.7 10564.7 10584.3 11463.5 16146.2 1767.7 1848.6 1855.9 1950.1 2287.9 7761.8 8025.2 8051.6 8137.2 8379.3 1389.6 1469.9 1474.2 1478.3 1482.2 60386.4 67964.0 68249.3 68590.0 69855.7 9446.8 9457.7 9465.0 9703.5 9727.7 10847.8 11285.9 11538.9 11988.1 11997.6 6942.7 6981.7 7078.5 7267.0 7294.4 5450.3 5734.1 6015.5 6389.6 6867.8 4135.0 4193.4 4243.6 4354.3 4354.4 1725.3 1729.5 1737.4 1782.6 1796.2 784.5 790.8 808.6 864.8 868.1 15612.3 16274.8 16594.2 16898.9 17386.9 761.2 762.7 807.3 829.4 833.7 8759.0 9044.2 9173.8 9252.8 9705.3 345957.0 352852.0 353432.0 355106.0 358912.0 75215.6 77227.0 78240.6 79014.0 80438.6 860.1 876.3 881.7 884.0 888.1 14364.2 14845.1 14897.6 14967.5 15521.0 34439.0 35924.3 35932.3 36447.5 36831.5 45601.7 49296.5 49448.5 49520.0 49549.3 6415.8 6601.3 6633.6 7063.4 7377.6 11011.8 12006.6 12101.4 12203.3 12428.9 9867.6 10101.4 10167.8 10962.9 11045.4 9461.3 9790.5 9912.6 9981.3 10134.2 9665.9 9800.3 9871.1 10764.7 10969.0 6715.7 6861.8 6876.9 7008.7 7219.2 7360.3 10277.6 10622.7 10645.4 10746.9 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | [#3] mootools.html Cycles:180 Average:4214.57 Median:5515.69 stddev:2283.99 (41.4%) stddev-sans-first:2279.17 07:48:34 INFO - PROCESS | 7708 | Values: 1200.0 1317.7 1350.8 1365.8 1611.6 5453.9 5816.3 6038.0 6039.8 6201.0 6157.4 6213.9 6215.7 6220.9 6227.7 1678.6 1712.6 1717.7 1719.6 1719.8 1703.9 1737.7 1740.5 1751.1 1766.5 1681.9 1735.1 1736.1 1738.0 1739.4 1675.4 1687.7 1697.2 1702.7 1703.4 1663.3 1670.2 1682.5 1684.6 1685.7 5979.0 6070.4 6122.9 6151.8 6179.8 3908.0 3995.7 4009.6 4014.9 4014.9 2485.5 2564.0 2641.0 2641.5 2646.3 714.3 735.7 754.1 754.7 756.8 8220.2 8363.8 8379.4 8395.9 8424.0 3491.7 3578.5 3589.2 3642.9 3652.2 6875.1 6876.6 6880.2 6881.1 6893.8 3950.5 3979.6 4006.6 4012.7 4014.2 3320.0 3435.2 3728.9 3747.5 3755.4 2906.9 2953.4 2956.0 2960.4 2974.9 860.0 873.2 873.7 881.9 882.5 605.4 637.5 664.1 689.6 743.9 4330.5 4377.5 4438.9 4454.0 4726.4 741.4 775.2 793.8 837.9 863.7 2960.3 3028.6 3076.5 3133.2 3161.4 7300.9 7538.9 7628.7 7792.5 7867.4 7828.6 7835.3 7861.6 7863.8 7864.4 5818.3 5963.4 5977.3 5983.6 5986.3 4160.8 4268.5 4318.6 4406.7 4436.3 7070.2 7116.1 7191.1 7191.3 7207.7 7230.1 7306.7 7393.5 7399.1 7423.1 5631.2 5668.0 5735.3 5740.4 5745.6 6250.7 6281.0 6285.6 6327.3 6340.9 5715.1 5724.5 5787.9 5790.4 5791.3 5577.5 5700.9 5703.8 5747.7 5839.6 4862.7 5074.1 5211.9 5279.1 5281.3 4001.5 4040.9 4064.0 4093.2 4101.7 4029.9 4032.1 4108.6 4128.9 4137.3 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | [#4] prototype.html Cycles:180 Average:4075.20 Median:4698.64 stddev:1202.41 (25.6%) stddev-sans-first:1171.55 07:48:34 INFO - PROCESS | 7708 | Values: 279.9 286.4 290.0 293.3 295.5 4738.3 4753.9 4797.8 4804.5 4825.0 4703.2 4712.2 4733.2 4741.7 4755.2 3487.5 3593.6 3644.8 3693.9 3705.2 3683.1 3684.7 3687.2 3698.6 3741.7 3667.9 3672.0 3677.0 3685.4 3715.0 3494.7 3589.9 3609.4 3656.5 3665.0 3211.5 3219.5 3221.2 3225.9 3251.0 4593.6 4593.8 4598.7 4605.7 4618.9 3881.5 4106.1 4204.5 4206.5 4214.4 4917.7 4938.7 4943.5 4944.9 4949.7 3440.4 3454.3 3457.9 3499.7 3510.4 5069.4 5204.2 5229.0 5247.3 5251.3 3405.7 3457.1 3464.4 3473.6 3478.4 3506.7 3512.1 3515.5 3517.3 3533.2 4086.5 4099.5 4102.5 4103.1 4109.2 4810.6 4935.0 5016.7 5025.2 5025.6 1205.3 1215.0 1216.0 1217.3 1217.4 751.5 780.8 806.6 809.8 812.0 4167.7 4289.6 4418.1 4422.3 4449.6 5121.8 5152.9 5170.6 5202.7 5207.6 4471.7 4480.4 4483.2 4500.8 4513.0 2536.3 2656.8 2670.4 2674.8 2686.1 4700.8 4730.4 4730.8 4736.0 4756.6 4963.3 5130.7 5142.9 5144.7 5160.0 4703.2 4707.2 4709.2 4713.4 4714.6 5038.0 5049.3 5081.5 5086.6 5094.4 4696.3 4923.5 4934.3 4944.4 4972.6 4627.9 4671.4 4691.6 4696.5 4702.6 3455.5 3459.3 3462.3 3471.3 3520.8 5026.5 5065.8 5072.9 5103.4 5103.6 4744.8 4835.0 4866.6 4872.2 4880.8 4826.0 4884.3 4887.6 4889.7 4902.0 4801.2 4820.3 4823.8 4831.8 4832.6 4623.6 4801.2 4880.8 4916.2 4928.7 4908.7 4914.4 4929.2 4934.3 4943.7 07:48:34 INFO - PROCESS | 7708 | 07:48:34 INFO - PROCESS | 7708 | [#5] yui.html Cycles:180 Average:13074.35 Median:581.91 stddev:16958.96 (2914.4%) stddev-sans-first:16980.75 07:48:34 INFO - PROCESS | 7708 | Values: 621.2 672.8 682.2 692.5 727.4 10905.9 11401.8 11416.5 11424.2 11440.9 11241.7 11343.5 11349.6 11426.0 11428.1 604.3 621.7 722.2 740.6 752.0 735.6 754.4 756.4 756.5 756.5 806.0 807.5 809.2 809.4 809.6 638.1 654.6 774.3 800.2 804.2 577.5 580.4 583.8 584.0 584.3 10459.7 10465.7 10490.9 10506.9 10513.2 9407.3 9651.8 9765.4 9956.4 10250.1 8415.3 8430.3 8435.8 8436.8 8531.6 2531.5 2536.8 2546.5 2559.5 2602.3 49357.8 49593.0 50486.7 50736.0 50822.0 7227.2 7266.2 7273.1 7360.1 7600.1 15299.5 15446.2 15566.1 15628.2 15656.5 6308.3 6444.4 6534.7 6613.8 6614.8 3481.9 3629.8 3671.7 3702.2 3719.9 2551.4 2641.4 2664.2 2669.0 2739.4 457.0 460.4 460.7 466.9 467.5 499.6 508.5 578.6 580.4 583.4 6970.2 7197.5 7216.3 7298.5 7962.1 531.8 545.1 554.7 555.1 574.8 3379.8 3505.1 3568.2 3659.6 3686.4 40492.8 49379.0 66554.0 67333.3 67417.7 37148.4 47430.5 49762.0 60424.0 61236.4 34985.5 36597.0 54797.5 56247.7 56416.2 6857.2 7077.5 7103.1 7213.8 7226.8 36219.8 36671.6 37449.8 37588.0 37658.6 30381.5 50978.5 51039.2 51852.5 52698.5 8235.5 8575.4 9716.1 9729.7 10099.8 9830.6 10004.2 10263.9 10347.2 10379.6 8825.7 8842.6 9512.0 9537.9 10065.6 9660.5 9972.8 10104.5 10419.9 10433.5 8967.6 9053.2 9134.8 9360.8 9626.3 8449.6 8577.7 8590.4 8719.0 8788.7 8113.3 8586.8 8638.9 8643.8 8671.8 07:48:34 INFO - PROCESS | 7708 | -------- Summary: end -------- 07:48:34 INFO - PROCESS | 7708 | 07:48:35 INFO - TEST-INFO | 7708: exit 0 07:48:35 INFO - TEST-OK | dromaeo_css | took 1121776ms 07:48:35 INFO - TEST-START | kraken 07:48:35 INFO - operating with platform_type : linux_ 07:48:35 INFO - Initialising browser for kraken test... 07:48:35 INFO - TEST-INFO | started process 8053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZJ2po/profile http://localhost:44931/getInfo.html) 07:48:40 INFO - PROCESS | 8053 | __metrics Screen width/height:1600/1200 07:48:40 INFO - PROCESS | 8053 | colorDepth:24 07:48:40 INFO - PROCESS | 8053 | Browser inner width/height: 1024/697 07:48:40 INFO - PROCESS | 8053 | __metrics 07:48:40 INFO - PROCESS | 8053 | 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" 07:48:40 INFO - PROCESS | 8053 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:48:41 INFO - PROCESS | 8053 | console.error: PushService: 07:48:41 INFO - PROCESS | 8053 | stateChangeProcessEnqueue: Error transitioning state 07:48:41 INFO - PROCESS | 8053 | UnknownError 07:48:42 INFO - TEST-INFO | 8053: exit 0 07:48:42 INFO - Browser initialized. 07:48:42 INFO - Running cycle 1/1 for kraken test... 07:48:42 INFO - TEST-INFO | started process 8136 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmZJ2po/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:54 INFO - PROCESS | 8136 | RSS: Main: 175173632 07:48:54 INFO - PROCESS | 8136 | 07:48:57 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:58 INFO - PROCESS | 8136 | RSS: Main: 240422912 07:48:58 INFO - PROCESS | 8136 | 07:49:00 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-dft) 07:49:01 INFO - PROCESS | 8136 | RSS: Main: 218009600 07:49:01 INFO - PROCESS | 8136 | 07:49:04 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-fft) 07:49:05 INFO - PROCESS | 8136 | RSS: Main: 300036096 07:49:05 INFO - PROCESS | 8136 | 07:49:07 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44931/tests/kraken/driver.html?testName=audio-oscillator) 07:49:08 INFO - PROCESS | 8136 | RSS: Main: 208490496 07:49:08 INFO - PROCESS | 8136 | 07:49:10 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:11 INFO - PROCESS | 8136 | RSS: Main: 213987328 07:49:11 INFO - PROCESS | 8136 | 07:49:14 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44931/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:14 INFO - PROCESS | 8136 | RSS: Main: 253120512 07:49:14 INFO - PROCESS | 8136 | 07:49:18 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44931/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:18 INFO - PROCESS | 8136 | RSS: Main: 253181952 07:49:18 INFO - PROCESS | 8136 | 07:49:21 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44931/tests/kraken/driver.html?testName=json-parse-financial) 07:49:22 INFO - PROCESS | 8136 | RSS: Main: 252407808 07:49:22 INFO - PROCESS | 8136 | 07:49:24 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:24 INFO - PROCESS | 8136 | RSS: Main: 214695936 07:49:24 INFO - PROCESS | 8136 | 07:49:26 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:27 INFO - PROCESS | 8136 | RSS: Main: 221888512 07:49:27 INFO - PROCESS | 8136 | 07:49:29 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:30 INFO - PROCESS | 8136 | RSS: Main: 230756352 07:49:30 INFO - PROCESS | 8136 | 07:49:32 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:33 INFO - PROCESS | 8136 | RSS: Main: 239538176 07:49:33 INFO - PROCESS | 8136 | 07:49:36 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:37 INFO - PROCESS | 8136 | RSS: Main: 235012096 07:49:37 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | Cycle 1(1): loaded http://localhost:44931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44931/tests/kraken/driver.html?testName=ai-astar) 07:49:39 INFO - PROCESS | 8136 | RSS: Main: 283766784 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | __start_tp_report 07:49:39 INFO - PROCESS | 8136 | _x_x_mozilla_page_load 07:49:39 INFO - PROCESS | 8136 | _x_x_mozilla_page_load_details 07:49:39 INFO - PROCESS | 8136 | |i|pagename|runs| 07:49:39 INFO - PROCESS | 8136 | |0;ai-astar;108;114;117;114;115;115;116;115;115;115 07:49:39 INFO - PROCESS | 8136 | |1;audio-beat-detection;151;129;129;166;128;128;130;126;158;127 07:49:39 INFO - PROCESS | 8136 | |2;audio-dft;162;160;160;163;161;164;162;161;160;160 07:49:39 INFO - PROCESS | 8136 | |3;audio-fft;76;77;77;117;78;77;77;76;98;77 07:49:39 INFO - PROCESS | 8136 | |4;audio-oscillator;85;84;111;85;85;84;109;84;84;121 07:49:39 INFO - PROCESS | 8136 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;117;116 07:49:39 INFO - PROCESS | 8136 | |6;imaging-darkroom;147;146;147;146;147;146;147;146;147;146 07:49:39 INFO - PROCESS | 8136 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 07:49:39 INFO - PROCESS | 8136 | |8;json-parse-financial;64;68;64;65;65;66;64;65;66;65 07:49:39 INFO - PROCESS | 8136 | |9;json-stringify-tinderbox;66;67;66;67;66;66;66;67;71;66 07:49:39 INFO - PROCESS | 8136 | |10;stanford-crypto-aes;83;84;83;83;98;92;85;89;89;84 07:49:39 INFO - PROCESS | 8136 | |11;stanford-crypto-ccm;147;142;141;144;143;142;143;141;193;147 07:49:39 INFO - PROCESS | 8136 | |12;stanford-crypto-pbkdf2;182;179;183;181;177;188;182;182;178;182 07:49:39 INFO - PROCESS | 8136 | |13;stanford-crypto-sha256-iterative;69;70;70;70;69;70;69;69;69;75 07:49:39 INFO - PROCESS | 8136 | __end_tp_report 07:49:39 INFO - PROCESS | 8136 | __start_cc_report 07:49:39 INFO - PROCESS | 8136 | _x_x_mozilla_cycle_collect,1972 07:49:39 INFO - PROCESS | 8136 | __end_cc_report 07:49:39 INFO - PROCESS | 8136 | __startTimestamp1479484179452__endTimestamp 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | ------- Summary: start ------- 07:49:39 INFO - PROCESS | 8136 | Number of tests: 14 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.41 (2.1%) stddev-sans-first:0.93 07:49:39 INFO - PROCESS | 8136 | Values: 108.0 114.0 117.0 114.0 115.0 115.0 116.0 115.0 115.0 115.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:129.50 stddev:15.05 (11.6%) stddev-sans-first:15.11 07:49:39 INFO - PROCESS | 8136 | Values: 151.0 129.0 129.0 166.0 128.0 128.0 130.0 126.0 158.0 127.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.42 (0.9%) stddev-sans-first:1.48 07:49:39 INFO - PROCESS | 8136 | Values: 162.0 160.0 160.0 163.0 161.0 164.0 162.0 161.0 160.0 160.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#3] audio-fft Cycles:10 Average:83.00 Median:77.00 stddev:13.68 (17.8%) stddev-sans-first:14.27 07:49:39 INFO - PROCESS | 8136 | Values: 76.0 77.0 77.0 117.0 78.0 77.0 77.0 76.0 98.0 77.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:14.45 (17.2%) stddev-sans-first:15.02 07:49:39 INFO - PROCESS | 8136 | Values: 85.0 84.0 111.0 85.0 85.0 84.0 109.0 84.0 84.0 121.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:49:39 INFO - PROCESS | 8136 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 07:49:39 INFO - PROCESS | 8136 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 07:49:39 INFO - PROCESS | 8136 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#8] json-parse-financial Cycles:10 Average:65.20 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.22 07:49:39 INFO - PROCESS | 8136 | Values: 64.0 68.0 64.0 65.0 65.0 66.0 64.0 65.0 66.0 65.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:66.50 stddev:1.55 (2.3%) stddev-sans-first:1.62 07:49:39 INFO - PROCESS | 8136 | Values: 66.0 67.0 66.0 67.0 66.0 66.0 66.0 67.0 71.0 66.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:4.99 (5.7%) stddev-sans-first:5.08 07:49:39 INFO - PROCESS | 8136 | Values: 83.0 84.0 83.0 83.0 98.0 92.0 85.0 89.0 89.0 84.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:143.50 stddev:15.85 (11.0%) stddev-sans-first:16.81 07:49:39 INFO - PROCESS | 8136 | Values: 147.0 142.0 141.0 144.0 143.0 142.0 143.0 141.0 193.0 147.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.40 Median:182.00 stddev:3.06 (1.7%) stddev-sans-first:3.24 07:49:39 INFO - PROCESS | 8136 | Values: 182.0 179.0 183.0 181.0 177.0 188.0 182.0 182.0 178.0 182.0 07:49:39 INFO - PROCESS | 8136 | 07:49:39 INFO - PROCESS | 8136 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.83 (2.6%) stddev-sans-first:1.90 07:49:39 INFO - PROCESS | 8136 | Values: 69.0 70.0 70.0 70.0 69.0 70.0 69.0 69.0 69.0 75.0 07:49:39 INFO - PROCESS | 8136 | -------- Summary: end -------- 07:49:39 INFO - PROCESS | 8136 | 07:49:40 INFO - TEST-INFO | 8136: exit 0 07:49:40 INFO - TEST-OK | kraken | took 64861ms 07:49:40 INFO - SUITE-END | took 1186s 07:49:41 INFO - Completed test suite (00:19:46) 07:49:41 INFO - javascript benchmark 07:49:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2535.3788321861143, 2536.720960694322, 2570.871456427178, 2581.8967241310347, 2596.7662910338067, 4518.164139634162, 4573.49691533931, 4586.128635559246, 4593.609543188829, 4595.862124136277, 4550.294704320827, 4563.566461186182, 4591.839285625004, 4601.470830854452, 4681.063787242548, 4236.661067114624, 4250.2137104635585, 4266.2747332953395, 4291.485021797389, 4299.828006879721, 4302.526722060571, 4335.6531477481885, 4349.717268377562, 4365.257906155961, 4393.560643935597, 4369.038811461473, 4385.4737431508265, 4395.1868904252815, 4422.491413487442, 4438.356438316442, 4200.789960501963, 4230.1539692061715, 4232.534421213664, 4289.678274129453, 4297.35539669049, 4256.787160641987, 4265.509466411371, 4267.487901451846, 4267.850625228102, 4273.145370925828, 4574.336721175444, 4613.284940834176, 4630.21286381316, 4676.298555216745, 4701.435827700664, 4928.827491037797, 4961.950380496185, 4963.60291176705, 4964.950350496485, 4999.12515309823, 4930.359053323081, 4978.128827455217, 4984.526469985346, 4987.401511818569, 5034.974825125851, 4460.375547423331, 4477.0, 4486.416765820422, 4581.839635612738, 4658.37111989877, 5119.744012799345, 5121.692698438105, 5157.045946499909, 5161.870953226199, 5162.5869930406225, 4859.80560777572, 4895.926561101586, 4906.362172917497, 4907.901841963212, 4959.975200123977, 4764.857054288377, 4824.662273640812, 4933.4819843915875, 4999.10016197088, 5035.647504674637, 4829.985703002409, 4860.052289803525, 4896.559309662076, 4916.336294600254, 4993.825216117491, 4933.876653083702, 4947.826826061142, 4948.480409557017, 4950.232713929347, 4987.975060124749, 4128.277551428488, 4139.19285739278, 4140.37894315849, 4146.896327591774, 4178.561251068655, 3510.596281427617, 3544.5746510418917, 3549.8402571884326, 3562.8574857005947, 3570.535830342039, 4291.6137547620865, 4296.398504209413, 4311.849085282063, 4323.7621930793475, 4329.112531930947, 4923.532264434873, 4924.9507504924495, 4928.112939670894, 4928.753562321941, 4973.229149481836, 4188.32986722123, 4222.619964203175, 4224.471941007374, 4282.400463935051, 4286.592773686495, 4363.214621368184, 4392.934105988413, 4402.84590039347, 4455.287154055336, 4465.285554311295, 4653.348531205566, 4656.976715116402, 4656.976715116471, 4691.859244222679, 4707.693999889996, 4959.404871415309, 4960.851174464772, 4965.776540055778, 4969.304297398439, 5014.648974571745, 4503.144402563634, 4537.22867112585, 4543.318502224693, 4596.540345965377, 4599.080183963154, 4821.927671084866, 4827.710337379768, 4828.324034635224, 4829.9517004830905, 4830.589399901048, 4893.804247830047, 4908.0, 4919.901601968012, 4970.378702662168, 4975.751212439436, 4815.879603009953, 4859.562639362333, 4862.3922009748785, 4896.069746748107, 4907.263910413467, 4852.369192005017, 4872.14737420957, 4875.902481950412, 4876.536729010738, 4915.336429581961, 4584.060267645058, 4637.8144874206, 4696.906061878675, 4708.482066972561, 4797.952020479751, 4847.636427268039, 4849.127157111613, 4849.248366503198, 4879.414470263449, 4899.04468628614, 4736.194846876108, 4741.146593613183, 4742.336072949859, 4774.737389443614, 4785.210440277316], "value": 4538.330063837021, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.1246006389775, 560.5991715923114, 561.9466150715682, 566.3289002532002, 572.4647454629921, 21748.238811641597, 23405.648915266283, 23445.648315275284, 23449.531009379803, 23464.8826755866, 24032.0, 24625.63061554078, 28218.0, 29066.128016159495, 29144.562831557545, 5384.138537833937, 5509.972450137744, 5514.172874068881, 5515.889682206353, 5516.806911758089, 5486.067368547357, 5563.219769673706, 5563.5271001964675, 5567.025770490169, 5567.638103523258, 5524.613277070606, 5559.166125081229, 5562.415946325638, 5576.721163941807, 5577.52591029763, 5513.50378465938, 5561.805336813232, 5565.2486914266865, 5569.081101618228, 5569.192467092289, 5488.4237155098535, 5535.391106978229, 5540.196671482612, 5541.030319694038, 5546.972265138648, 25424.491510169693, 25724.87137564319, 25776.48447031049, 25776.74223257762, 25799.613005804928, 2936.750376218024, 2973.50937095379, 3046.8781248750024, 3110.424571454266, 3305.2893627869885, 18247.087645617667, 18276.634467310712, 18333.63332733351, 18334.358297459527, 18383.26466941321, 2602.973970260292, 2672.2250547341246, 2681.4368982513697, 2688.368233465134, 2743.1633351827686, 231359.0, 234382.0, 234447.0, 234615.0, 234729.0, 29842.253943651584, 30870.845645771627, 45349.0, 45492.0, 45549.54450455519, 32249.677503225135, 32439.35121297561, 32507.0, 32513.674863251064, 32527.837360813046, 11583.6524904253, 11684.824727629093, 11690.649280521598, 11698.0, 11698.88301116995, 9409.106134917172, 9412.388194767318, 9434.811303774024, 9436.292278079172, 9481.431114133036, 7696.730039543412, 7733.845323093619, 7760.689572417153, 7768.0, 7815.960920195363, 2994.895178668736, 3062.617172853393, 3078.5228289615147, 3089.4975070193213, 3127.812331260086, 794.6225542867207, 831.301706566487, 856.1096459681986, 893.2407453664463, 906.6056265524518, 24946.12688555892, 26710.19869403921, 26842.5973610396, 27103.1869043929, 27248.59127113095, 791.600241877848, 892.5581836990731, 925.1812146250617, 925.9722208333761, 975.5805003848413, 11893.108016898766, 14311.78532322016, 14333.856661433252, 14566.854331456761, 14567.562973110824, 343515.0, 345618.0, 345961.0, 347084.0, 347814.0, 42773.37012763027, 43099.35350969738, 43146.7842660791, 43162.78418607887, 43265.134697305875, 1045.8640376750973, 1081.0702795595782, 1134.489479734123, 1146.8165093585153, 1185.1940680337452, 23997.880010599834, 26476.8676156618, 28508.80251870591, 28954.42091158123, 29114.0, 41719.58280417279, 42542.0, 42557.78721106375, 42629.147417050866, 42634.0, 296444.0, 300302.0, 300317.0, 300551.0, 300674.0, 23789.643155352336, 24454.14410495624, 24638.507229854946, 24803.0, 24804.627930581417, 35692.64610308371, 36163.81918090393, 36230.818845905604, 37067.814660926524, 37111.6288837119, 31096.689033110284, 31501.52747708832, 31601.0, 31796.0, 32320.676793231767, 31392.843035784674, 31503.684963150074, 31794.6820531801, 31805.681943180272, 32046.0, 31449.842750786098, 31739.523907141873, 31801.36397272088, 32012.359752805278, 32338.514922275714, 27267.590986134826, 29337.413251735274, 29485.26286842846, 29608.555871662375, 30344.241393965327, 22639.434014149778, 23128.4217894554, 23178.0, 23316.30051098402, 23622.17322393708], "value": 13993.60560429184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.5801606008547, 355.7189820042167, 364.37145923282344, 365.3113880335567, 386.75441094904744, 9691.563879625417, 11553.826692599607, 11939.164258501909, 12041.879581204197, 12648.0, 14468.0, 14664.706705865876, 15146.24268786559, 15710.450134245304, 15711.685766284667, 3981.601839816024, 4211.515675697304, 4213.620774130328, 4217.388478670591, 4218.303979843322, 3535.239923416465, 3770.4155855842387, 3785.9432108518395, 3807.485989391438, 3812.3137835189655, 3802.505674262342, 3804.448354988525, 3807.923841523168, 3808.4096964970336, 3808.542974843009, 3639.1266096137, 3714.275716235335, 3806.0865392305923, 3810.885673429788, 3811.0, 3661.743677942545, 3662.8717994870317, 3663.9450408243897, 3664.523611930432, 3664.76179048361, 10328.741781455448, 10564.683059508227, 10584.312019718695, 11463.484143213574, 16146.192690365435, 1767.6553072150937, 1848.6302739452162, 1855.9257629694796, 1950.0542237015036, 2287.9199228026937, 7761.805954851117, 8025.197480251986, 8051.63767630458, 8137.238810053192, 8379.329653627696, 1389.6456403617115, 1469.9485518006925, 1474.1523623916185, 1478.3199728125076, 1482.2420031698261, 60386.396136038515, 67963.98054029242, 68249.3175068248, 68590.0, 69855.65072174657, 9446.811063778687, 9457.716268511957, 9464.95267523658, 9703.514824258758, 9727.65953191635, 10847.837282440769, 11285.887141128647, 11538.88461115395, 11988.100892433102, 11997.580084696994, 6942.687579058955, 6981.685824137926, 7078.469114816409, 7266.96366518164, 7294.379977701955, 5450.345958484928, 5734.111212762028, 6015.488683461867, 6389.552731308857, 6867.759628412981, 4134.995137634686, 4193.391958166048, 4243.575642435731, 4354.259775838115, 4354.368616550582, 1725.335745737875, 1729.4638662014816, 1737.4266492057843, 1782.6078262782166, 1796.1827368547279, 784.4744021505605, 790.7548659915444, 808.6037841457761, 864.7665130414753, 868.1231955724637, 15612.29744661493, 16274.837251627332, 16594.170291485378, 16898.91550542264, 17386.913065434845, 761.1855314813207, 762.7444805990056, 807.3016840432983, 829.3738227638095, 833.6915341323628, 8758.956205219061, 9044.186023257938, 9173.78917378912, 9252.768680783034, 9705.320627556144, 345957.0, 352852.0, 353432.0, 355106.0, 358912.0, 75215.62392188114, 77227.0, 78240.60879695565, 79014.0, 80438.59780701059, 860.0539406652757, 876.3296078499952, 881.6561540999015, 883.9955800221086, 888.0764005434405, 14364.209968451836, 14845.109293442429, 14897.553073407815, 14967.476138335105, 15521.0, 34439.0, 35924.281514369046, 35932.281354372244, 36447.453288200166, 36831.526738930144, 45601.71991400483, 49296.50703492919, 49448.50551494583, 49520.0, 49549.25676114789, 6415.845147873428, 6601.273859875506, 6633.6019838809825, 7063.434925206074, 7377.594232317274, 11011.779764404828, 12006.63980080599, 12101.394930253628, 12203.328816915155, 12428.937855310665, 9867.555959981675, 10101.393916365041, 10167.79664406693, 10962.945185274022, 11045.447727613748, 9461.290403219647, 9790.461524616214, 9912.553935073083, 9981.251406144713, 10134.189264858942, 9665.855012174683, 9800.31397802147, 9871.062249086326, 10764.677059687909, 10969.0, 6715.697793599397, 6861.828454288683, 6876.862462750617, 7008.738427083174, 7219.205887352282, 7360.33756961876, 10277.588896444058, 10622.73443163896, 10645.361278323326, 10746.892531074902], "value": 7308.803500058672, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1200.0399680255805, 1317.6574090736406, 1350.8108864758933, 1365.7541642504352, 1611.5971007248195, 5453.863653408666, 5816.272965879265, 6037.969810150954, 6039.788607398742, 6200.968995155018, 6157.353477884813, 6213.875722485547, 6215.720292586833, 6220.947087461138, 6227.657478838662, 1678.630701245727, 1712.6146617011198, 1717.7251639737644, 1719.6474722681883, 1719.7506361577564, 1703.9233234504416, 1737.6524695060975, 1740.4691569071429, 1751.0806826416106, 1766.4523997560732, 1681.941132060378, 1735.1324337831084, 1736.1059054586897, 1738.0, 1739.3651317269168, 1675.4387280261128, 1687.7468379743013, 1697.2023149120018, 1702.6850032743982, 1703.4378655043806, 1663.259849367032, 1670.2233461440367, 1682.5204816627202, 1684.553593297777, 1685.7050016247108, 5978.970105149447, 6070.362611925772, 6122.938770612326, 6151.846203844895, 6179.752809887599, 3907.98046009771, 3995.720299579031, 4009.5766003069075, 4014.879553613396, 4014.9397759033345, 2485.4672649845843, 2563.9615405768927, 2641.0, 2641.4849104424643, 2646.298730836311, 714.253604982789, 735.7424901284561, 754.1101500229727, 754.7320701151123, 756.8183635927393, 8220.177982201732, 8363.790905227357, 8379.37154713399, 8395.874061889077, 8423.999999999938, 3491.6591893638947, 3578.5169002184894, 3589.210373717778, 3642.8724994625063, 3652.178259891556, 6875.07186529812, 6876.587404755731, 6880.2431732509385, 6881.071055407456, 6893.7931862044215, 3950.466686997276, 3979.6020397959974, 4006.579309172553, 4012.7391719538136, 4014.1770936957855, 3319.9502007469905, 3435.209901722568, 3728.9440658390145, 3747.4566187903147, 3755.3991361382596, 2906.9273268168463, 2953.424082303973, 2956.024511911064, 2960.3931194105157, 2974.8512574371193, 859.9613017414231, 873.2271939333608, 873.689840106753, 881.8633111867671, 882.4705176893941, 605.4369436424167, 637.4613451633362, 664.1465716554204, 689.6276010954128, 743.8623854586918, 4330.523642399334, 4377.496587892433, 4438.866833994985, 4454.0, 4726.432828060586, 741.423572908296, 775.1550809617544, 793.797581616684, 837.9245867871921, 863.680438237856, 2960.259935016246, 3028.5608586754797, 3076.5385192220897, 3133.1697100268448, 3161.351922855809, 7300.890486642705, 7538.924610753932, 7628.656710448043, 7792.493487923381, 7867.409944254204, 7828.569428681477, 7835.294823465915, 7861.567613781297, 7863.842723145505, 7864.41016923733, 5818.272715910512, 5963.373845746221, 5977.342492325841, 5983.581149319506, 5986.281646202484, 4160.791960402028, 4268.509121451073, 4318.611324980767, 4406.691531592758, 4436.334549817553, 7070.151581810215, 7116.146062472537, 7191.101112360955, 7191.316824901626, 7207.747728829466, 7230.13238411394, 7306.7077316906725, 7393.519421237603, 7399.149097853816, 7423.072115985502, 5631.155326701028, 5668.0, 5735.254416925773, 5740.368559458373, 5745.597808153389, 6250.749970001331, 6280.9685951569945, 6285.59143655661, 6327.303996560467, 6340.873182536231, 5715.114157305624, 5724.542036637143, 5787.8553036174435, 5790.363060063474, 5791.305043394819, 5577.525910297508, 5700.857478563069, 5703.800366987136, 5747.7413516391025, 5839.649621022752, 4862.732549709658, 5074.137396642654, 5211.9478805211465, 5279.076161671769, 5281.260623512788, 4001.539822920285, 4040.939385909155, 4064.0, 4093.201825643971, 4101.692373071972, 4029.879103626896, 4032.0927791246736, 4108.630223279919, 4128.938065928954, 4137.338025915839], "value": 3414.476045824548, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.90138705580597, 286.4342922727612, 290.0414131296066, 293.31218293102665, 295.45488573581736, 4738.312944623028, 4753.8811529711775, 4797.832075877345, 4804.543568361005, 4824.951750482494, 4703.2239680452685, 4712.198926182548, 4733.195356789345, 4741.668083234175, 4755.191617425037, 3487.511748355232, 3593.6344189208066, 3644.817759112047, 3693.907652308687, 3705.2404257127223, 3683.1032018510487, 3684.705223582107, 3687.1703866630064, 3698.574663913644, 3741.7006639468914, 3667.9083022924374, 3671.963280367189, 3676.963230367689, 3685.3919103347916, 3715.0, 3494.685478306952, 3589.856405743767, 3609.404448266033, 3656.4880916671686, 3664.9816750916343, 3211.5022171563446, 3219.517072439153, 3221.1624977505785, 3225.903222903317, 3250.967490325114, 4593.632509399274, 4593.816247350102, 4598.678092533524, 4605.710401087701, 4618.905333426612, 3881.4760007399204, 4106.137711080647, 4204.453421055243, 4206.537280899099, 4214.377464676122, 4917.704937703749, 4938.715754023606, 4943.505649435064, 4944.901101977976, 4949.653524253304, 3440.3807314683345, 3454.274602333513, 3457.94813077804, 3499.720022398202, 3510.385682505577, 5069.44236134025, 5204.193350030751, 5229.0, 5247.291615631917, 5251.264822924793, 3405.659434056624, 3457.135716070982, 3464.37641224582, 3473.565804274466, 3478.426059700121, 3506.701930335899, 3512.121969507623, 3515.5078289039557, 3517.314123745845, 3533.2403533240476, 4086.4891888513935, 4099.508059032935, 4102.548719640837, 4103.133074451118, 4109.198706252252, 4810.63920205986, 4934.950650493521, 5016.673916195436, 5025.221090730943, 5025.623078269071, 1205.3310412721023, 1214.993925030387, 1215.969600759988, 1217.2513903949007, 1217.4399776103091, 751.5227830327672, 780.8360244348637, 806.5684858600738, 809.7611204694629, 811.9675212991532, 4167.74993500391, 4289.63538099265, 4418.072204836956, 4422.29243321067, 4449.599536041772, 5121.820736274212, 5152.871178220575, 5170.630816959663, 5202.661826981234, 5207.635465517377, 4471.709338892962, 4480.395146655225, 4483.170613436525, 4500.797464114057, 4513.0, 2536.340551456635, 2656.827306225128, 2670.4258584404447, 2674.826136301173, 2686.1270087221733, 4700.8034536514815, 4730.428526462499, 4730.834420795324, 4735.976320118446, 4756.595689366373, 4963.329950456714, 5130.666506677128, 5142.87142821425, 5144.6655967362, 5160.0, 4703.17694403478, 4707.152712511781, 4709.175894218498, 4713.444563294173, 4714.5521175488275, 5038.0, 5049.293098966221, 5081.493769299172, 5086.593072554261, 5094.36980166358, 4696.272077827942, 4923.483034281492, 4934.284528743384, 4944.3572335596145, 4972.577330926912, 4627.8611641650805, 4671.407368910287, 4691.648126390603, 4696.483386827515, 4702.600278976189, 3455.4989526519016, 3459.3254315408253, 3462.2902305026905, 3471.3230919971375, 3520.823958802101, 5026.52248036436, 5065.797368105234, 5072.934683716313, 5103.387593488805, 5103.591712662904, 4744.786484608132, 4835.0, 4866.610671146371, 4872.220444728968, 4880.755962201804, 4825.95174048255, 4884.340614017062, 4887.633427493023, 4889.731064791328, 4902.0, 4801.175553289728, 4820.325154478446, 4823.758812059313, 4831.830885918976, 4832.589229915497, 4623.583877450911, 4801.159797035435, 4880.804767809248, 4916.188828843344, 4928.654994150375, 4908.730019848943, 4914.402819083741, 4929.186684197068, 4934.34858204933, 4943.653944224014], "value": 3688.6695558915408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.1924498152401, 672.8351553869303, 682.2052309059942, 692.4771797293045, 727.3926271563245, 10905.945470272647, 11401.771964560714, 11416.54333826646, 11424.200305978564, 11440.885591144086, 11241.718957026078, 11343.546258149685, 11349.602763903265, 11426.028787553047, 11428.142889283296, 604.2839235505918, 621.7450845153488, 722.2488611843677, 740.6185814305637, 752.0486584470649, 735.6321839080459, 754.4454825703103, 756.4024420707661, 756.4629113329515, 756.496929541854, 805.963731632075, 807.5074204735107, 809.2271880354277, 809.4010432280129, 809.6437567470324, 638.0716058135401, 654.6006935769177, 774.2683164409635, 800.2197857089292, 804.2359758229676, 577.48892230376, 580.399286738224, 583.7635757518212, 584.0392554248238, 584.322186263936, 10459.738506537322, 10465.68602941913, 10490.895091049068, 10506.947465262625, 10513.211509136845, 9407.341486095977, 9651.758706032335, 9765.365251258645, 9956.402615843073, 10250.077493025588, 8415.284700800377, 8430.32557395407, 8435.83128337436, 8436.789080272982, 8531.616077276538, 2531.50635626053, 2536.771690547841, 2546.4525127097763, 2559.5008973250037, 2602.3103877472486, 49357.753211233714, 49593.0, 50486.747566262304, 50736.0, 50821.99999999963, 7227.205007449176, 7266.169537331951, 7273.054502914587, 7360.116785985716, 7600.125985511626, 15299.541013769605, 15446.227688615525, 15566.143862087694, 15628.2185890705, 15656.530304090895, 6308.274548426898, 6444.355564443612, 6534.705938232791, 6613.801585952429, 6614.8093343197725, 3481.8607255709994, 3629.8366573504254, 3671.706263498914, 3702.2225332680437, 3719.8698045568276, 2551.374913146291, 2641.366072142672, 2664.214056853233, 2668.986655066712, 2739.4247208086126, 456.98629041128817, 460.36699538135065, 460.67062050633956, 466.91362098011297, 467.47409164689725, 499.64774833742126, 508.5346907579597, 578.5776383240258, 580.3963877567367, 583.4107551373144, 6970.198427180838, 7197.4961752677855, 7216.278372162742, 7298.525595836254, 7962.124166341698, 531.7819693925472, 545.0924211188407, 554.6782865937746, 555.0647159536195, 574.7672192761938, 3379.847906844198, 3505.071156143624, 3568.249737701808, 3659.5791483979683, 3686.391745361985, 40492.797536012135, 49379.0, 66554.0, 67333.32666673271, 67417.66291168611, 37148.44277335842, 47430.52569474261, 49762.0, 60424.0, 61236.387636123065, 34985.475217871244, 36597.0, 54797.45202547924, 56247.71876140675, 56416.153757692846, 6857.245702972768, 7077.5399599025895, 7103.147622285359, 7213.819654508679, 7226.819329516804, 36219.818900905324, 36671.63328366682, 37449.81275093607, 37588.0, 37658.62341376551, 30381.544276835422, 50978.49021509886, 51039.234411483114, 51852.48147518627, 52698.47301527089, 8235.464694794819, 8575.442596231225, 9716.125548700651, 9729.659461918798, 10099.79800403973, 9830.606775729177, 10004.199664026715, 10263.897361026593, 10347.172226222036, 10379.584816607252, 8825.69110081144, 8842.557872106241, 9511.952440237754, 9537.856932146162, 10065.597376104874, 9660.468674222986, 9972.800543989224, 10104.494775261355, 10419.94790026045, 10433.530491127765, 8967.596458159269, 9053.2304754094, 9134.817303653757, 9360.765980850534, 9626.32615716893, 8449.577521123796, 8577.699780507652, 8590.441621294596, 8719.0, 8788.736337909617, 8113.310368618498, 8586.78533036679, 8638.913610864063, 8643.827123457622, 8671.783205419915], "value": 5515.510960597541, "unit": "score"}], "name": "dromaeo_css", "value": 5641.785674179463, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 117.0, 114.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 129.0, 129.0, 166.0, 128.0, 128.0, 130.0, 126.0, 158.0, 127.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 163.0, 161.0, 164.0, 162.0, 161.0, 160.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 117.0, 78.0, 77.0, 77.0, 76.0, 98.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 111.0, 85.0, 85.0, 84.0, 109.0, 84.0, 84.0, 121.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 64.0, 65.0, 65.0, 66.0, 64.0, 65.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 71.0, 66.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 83.0, 98.0, 92.0, 85.0, 89.0, 89.0, 84.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 142.0, 141.0, 144.0, 143.0, 142.0, 143.0, 141.0, 193.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 183.0, 181.0, 177.0, 188.0, 182.0, 182.0, 178.0, 182.0], "value": 181.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 70.0, 69.0, 70.0, 69.0, 69.0, 69.0, 75.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1566.3000000000002, "alertThreshold": 2.0}]} 07:49:41 INFO - Return code: 0 07:49:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:49:41 INFO - # TBPL SUCCESS # 07:49:41 INFO - Running post-action listener: _resource_record_post_action 07:49:41 INFO - [mozharness: 2016-11-18 15:49:41.244016Z] Finished run-tests step (success) 07:49:41 INFO - Running post-run listener: _resource_record_post_run 07:49:41 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 2371584; Write bytes: 392437760; Read time: 624; Write time: 199280 07:49:41 INFO - TinderboxPrint: CPU usage
13.1% 07:49:41 INFO - TinderboxPrint: I/O read bytes / time
2,371,584 / 624 07:49:41 INFO - TinderboxPrint: I/O write bytes / time
392,437,760 / 199,280 07:49:41 INFO - TinderboxPrint: CPU idle
8,341.5 (86.9%) 07:49:41 INFO - TinderboxPrint: CPU user
1,208.6 (12.6%) 07:49:41 INFO - TinderboxPrint: Swap in / out
0 / 0 07:49:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99905536; Read time: 0; Write time: 72272 07:49:41 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 2367488; Write bytes: 292532224; Read time: 612; Write time: 127008 07:49:41 INFO - Running post-run listener: _upload_blobber_files 07:49:41 INFO - Blob upload gear active. 07:49:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:49:41 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 07:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:49:42 INFO - (blobuploader) - INFO - Open directory for files ... 07:49:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:49:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:49:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:43 INFO - (blobuploader) - INFO - Done attempting. 07:49:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:49:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:49:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:46 INFO - (blobuploader) - INFO - Done attempting. 07:49:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:49:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:48 INFO - (blobuploader) - INFO - Done attempting. 07:49:48 INFO - (blobuploader) - INFO - Iteration through files over. 07:49:48 INFO - Return code: 0 07:49:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:49:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:49:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7bcde5de53b1d6392519c7ca8a500a8fc43832ecb05b94865af1931867eaa2e76e3e91bb8879eeca9c4ed5159758590dd2160109716c40af648c9e67471ab3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c6c830a4733683dd4583897c25ae522177b4cc41c90631ad5ec8f4c1a95774c5487853425c26e621166fcc2eb3bb6736b4c4be5829b353f66d10a8a842990e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3bb33fba8815601b74f43a46590118d892da234105aef275603752f6e277b92dc9004f82e39a2c8966e66625a5f0d276ff454545806e9a33c79ce1a04b3b15ca"} 07:49:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:49:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:49:48 INFO - Contents: 07:49:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7bcde5de53b1d6392519c7ca8a500a8fc43832ecb05b94865af1931867eaa2e76e3e91bb8879eeca9c4ed5159758590dd2160109716c40af648c9e67471ab3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c6c830a4733683dd4583897c25ae522177b4cc41c90631ad5ec8f4c1a95774c5487853425c26e621166fcc2eb3bb6736b4c4be5829b353f66d10a8a842990e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3bb33fba8815601b74f43a46590118d892da234105aef275603752f6e277b92dc9004f82e39a2c8966e66625a5f0d276ff454545806e9a33c79ce1a04b3b15ca"} 07:49:48 INFO - Running post-run listener: copy_logs_to_upload_dir 07:49:48 INFO - Copying logs to upload dir... 07:49:48 INFO - mkdir: /builds/slave/test/build/upload/logs 07:49:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.200673 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-18 07:49:48.179933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 07:49:48.183046) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7bcde5de53b1d6392519c7ca8a500a8fc43832ecb05b94865af1931867eaa2e76e3e91bb8879eeca9c4ed5159758590dd2160109716c40af648c9e67471ab3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c6c830a4733683dd4583897c25ae522177b4cc41c90631ad5ec8f4c1a95774c5487853425c26e621166fcc2eb3bb6736b4c4be5829b353f66d10a8a842990e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3bb33fba8815601b74f43a46590118d892da234105aef275603752f6e277b92dc9004f82e39a2c8966e66625a5f0d276ff454545806e9a33c79ce1a04b3b15ca"} build_url:https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/EkDD4hFfQKW3g3Key99pbw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/7bcde5de53b1d6392519c7ca8a500a8fc43832ecb05b94865af1931867eaa2e76e3e91bb8879eeca9c4ed5159758590dd2160109716c40af648c9e67471ab3b3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3c6c830a4733683dd4583897c25ae522177b4cc41c90631ad5ec8f4c1a95774c5487853425c26e621166fcc2eb3bb6736b4c4be5829b353f66d10a8a842990e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/3bb33fba8815601b74f43a46590118d892da234105aef275603752f6e277b92dc9004f82e39a2c8966e66625a5f0d276ff454545806e9a33c79ce1a04b3b15ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 07:49:48.214874) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:49:48.215415) ========= 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=31acecf42b6a79ec49471d4a000001bb-1479481861.144281-1917599894 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004587 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 07:49:48.523289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 07:49:48.526662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 07:49:48.527066) ========= ========= Total master_lag: 0.61 =========