builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-080 starttime: 1506594782.44 results: success (0) revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.444246) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.444680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.444968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.462912) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.463329) ========= 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=781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 03:33:02-- 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% 45.1M=0s 2017-09-28 03:33:02 (45.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.612554) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.612860) ========= 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=781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018230 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.670904) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:02.672311) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --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=781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 03:33:02,707 truncating revision to first 12 chars 2017-09-28 03:33:02,707 Setting DEBUG logging. 2017-09-28 03:33:02,707 attempt 1/10 2017-09-28 03:33:02,707 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82c2eecf82ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 03:33:03,093 unpacking tar archive at: mozilla-central-82c2eecf82ba/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:03.344495) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:03.344837) ========= script_repo_revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:03.348312) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:03.348597) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 03:33:03.364197) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-28 03:33:03.364569) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:33:03 INFO - MultiFileLogger online at 20170928 03:33:03 in /builds/slave/test 03:33:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:33:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:33:03 INFO - {'append_to_log': False, 03:33:03 INFO - 'base_work_dir': '/builds/slave/test', 03:33:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:33:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:33:03 INFO - 'branch': 'Firefox-Non-PGO', 03:33:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:33:03 INFO - 'code_coverage': False, 03:33:03 INFO - 'config_files': ('talos/linux_config.py',), 03:33:03 INFO - 'default_actions': ('clobber', 03:33:03 INFO - 'read-buildbot-config', 03:33:03 INFO - 'download-and-extract', 03:33:03 INFO - 'populate-webroot', 03:33:03 INFO - 'create-virtualenv', 03:33:03 INFO - 'install', 03:33:03 INFO - 'setup-mitmproxy', 03:33:03 INFO - 'run-tests'), 03:33:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:33:03 INFO - 'disable_ccov_upload': False, 03:33:03 INFO - 'disable_stylo': False, 03:33:03 INFO - 'download_minidump_stackwalk': True, 03:33:03 INFO - 'download_symbols': 'ondemand', 03:33:03 INFO - 'enable_stylo': False, 03:33:03 INFO - 'enable_webrender': False, 03:33:03 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:33:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:33:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:33:03 INFO - 'gecko_profile': False, 03:33:03 INFO - 'gecko_profile_interval': 0, 03:33:03 INFO - 'installer_path': 'installer.exe', 03:33:03 INFO - 'log_level': 'info', 03:33:03 INFO - 'log_name': 'talos', 03:33:03 INFO - 'log_to_console': True, 03:33:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:33:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:33:03 INFO - 'opt_config_files': (), 03:33:03 INFO - 'pip_index': False, 03:33:03 INFO - 'suite': 'dromaeojs-e10s', 03:33:03 INFO - 'system_bits': '32', 03:33:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:33:03 INFO - 'title': 'talos-linux64-ix-080', 03:33:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:33:03 INFO - 'use_talos_json': True, 03:33:03 INFO - 'verify': 'False', 03:33:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:33:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:33:03 INFO - 'work_dir': 'build'} 03:33:03 INFO - [mozharness: 2017-09-28 10:33:03.540052Z] Running clobber step. 03:33:03 INFO - Running pre-action listener: _resource_record_pre_action 03:33:03 INFO - Running main action method: clobber 03:33:03 INFO - rmtree: /builds/slave/test/build 03:33:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:33:04 INFO - Running post-action listener: _resource_record_post_action 03:33:04 INFO - [mozharness: 2017-09-28 10:33:04.527446Z] Finished clobber step (success) 03:33:04 INFO - [mozharness: 2017-09-28 10:33:04.527544Z] Running read-buildbot-config step. 03:33:04 INFO - Running pre-action listener: _resource_record_pre_action 03:33:04 INFO - Running main action method: read_buildbot_config 03:33:04 INFO - Using buildbot properties: 03:33:04 INFO - { 03:33:04 INFO - "project": "", 03:33:04 INFO - "product": "firefox", 03:33:04 INFO - "who": "archaeopteryx@coole-files.de", 03:33:04 INFO - "installer_path": "public/build/target.tar.bz2", 03:33:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:33:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:33:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:33:04 INFO - "stage_platform": "linux64", 03:33:04 INFO - "basedir": "/builds/slave/test", 03:33:04 INFO - "buildnumber": 877, 03:33:04 INFO - "platform": "ubuntu64_hw", 03:33:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:33:04 INFO - "slavebuilddir": "test", 03:33:04 INFO - "taskId": "cmTJCBfvTQqJfpFQGB5w3Q", 03:33:04 INFO - "branch": "mozilla-central", 03:33:04 INFO - "script_repo_revision": "production", 03:33:04 INFO - "revision": "82c2eecf82ba820c4593aa4a9749662f7d54d9a7", 03:33:04 INFO - "slavename": "talos-linux64-ix-080", 03:33:04 INFO - "repo_path": "mozilla-central" 03:33:04 INFO - } 03:33:04 INFO - Finding installer, test and symbols from parent task. 03:33:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmTJCBfvTQqJfpFQGB5w3Q'}, attempt #1 03:33:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cmTJCBfvTQqJfpFQGB5w3Q'}, attempt #1 03:33:05 INFO - Task dependencies: bHRMUN3XS_OnyBl4OEvKxA 03:33:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA'}, attempt #1 03:33:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:33:06 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json 03:33:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip 03:33:06 INFO - Running post-action listener: _resource_record_post_action 03:33:06 INFO - [mozharness: 2017-09-28 10:33:06.048171Z] Finished read-buildbot-config step (success) 03:33:06 INFO - [mozharness: 2017-09-28 10:33:06.048390Z] Running download-and-extract step. 03:33:06 INFO - Running pre-action listener: _resource_record_pre_action 03:33:06 INFO - Running main action method: download_and_extract 03:33:06 INFO - mkdir: /builds/slave/test/build/tests 03:33:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:06 INFO - trying https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json 03:33:06 INFO - Downloading https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:33:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:33:06 INFO - Downloaded 989 bytes. 03:33:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:33:06 INFO - Using the following test package requirements: 03:33:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:33:06 INFO - u'common': [u'target.common.tests.zip'], 03:33:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:33:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:33:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:33:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:33:06 INFO - u'mozbase': [u'target.common.tests.zip'], 03:33:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:33:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:33:06 INFO - u'web-platform': [u'target.common.tests.zip', 03:33:06 INFO - u'target.web-platform.tests.tar.gz'], 03:33:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:33:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:33:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip 03:33:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:33:06 INFO - Fetch https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.common.tests.zip into memory 03:33:07 INFO - Content-Length response header: 55263113 03:33:07 INFO - Bytes received: 55263113 03:33:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip 03:33:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:33:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.talos.tests.zip into memory 03:33:19 INFO - Content-Length response header: 14521162 03:33:19 INFO - Bytes received: 14521162 03:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:19 INFO - trying https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:33:19 INFO - Downloading https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:33:20 INFO - Downloaded 61661872 bytes. 03:33:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:33:20 INFO - mkdir: /builds/slave/test/properties 03:33:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:33:20 INFO - Writing to file /builds/slave/test/properties/build_url 03:33:20 INFO - Contents: 03:33:20 INFO - build_url:https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 03:33:20 INFO - Running post-action listener: _resource_record_post_action 03:33:20 INFO - Running post-action listener: find_tests_for_verification 03:33:20 INFO - Running post-action listener: set_extra_try_arguments 03:33:20 INFO - [mozharness: 2017-09-28 10:33:20.986485Z] Finished download-and-extract step (success) 03:33:20 INFO - [mozharness: 2017-09-28 10:33:20.986582Z] Running populate-webroot step. 03:33:20 INFO - Running pre-action listener: _resource_record_pre_action 03:33:20 INFO - Running main action method: populate_webroot 03:33:20 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:33:20 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['tresize', 03:33:20 INFO - 'tcanvasmark']}, 03:33:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:33:20 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['dromaeo_css', 03:33:20 INFO - 'kraken']}, 03:33:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:33:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:20 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:33:20 INFO - 'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:33:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:33:20 INFO - 'tests': ['damp', 'tps']}, 03:33:20 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:33:20 INFO - 'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['damp', 'tps']}, 03:33:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:33:20 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['dromaeo_dom']}, 03:33:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:33:20 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['basic_compositor_video', 03:33:20 INFO - 'glvideo']}, 03:33:20 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:33:20 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:33:20 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:33:20 INFO - 'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['ts_paint_webext', 03:33:20 INFO - 'tp5o_webext']}, 03:33:20 INFO - 'other-e10s': {'tests': ['a11yr', 03:33:20 INFO - 'ts_paint', 03:33:20 INFO - 'tpaint', 03:33:20 INFO - 'sessionrestore', 03:33:20 INFO - 'sessionrestore_many_windows', 03:33:20 INFO - 'sessionrestore_no_auto_restore', 03:33:20 INFO - 'tabpaint', 03:33:20 INFO - 'cpstartup']}, 03:33:20 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['a11yr', 03:33:20 INFO - 'ts_paint', 03:33:20 INFO - 'tpaint', 03:33:20 INFO - 'sessionrestore', 03:33:20 INFO - 'sessionrestore_many_windows', 03:33:20 INFO - 'sessionrestore_no_auto_restore', 03:33:20 INFO - 'tabpaint', 03:33:20 INFO - 'cpstartup']}, 03:33:20 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 03:33:20 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:33:20 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['perf_reftest_singletons']}, 03:33:20 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['perf_reftest']}, 03:33:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:33:20 INFO - 'tsvgr_opacity', 03:33:20 INFO - 'tart', 03:33:20 INFO - 'tscrollx', 03:33:20 INFO - 'tsvg_static']}, 03:33:20 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['tsvgx', 03:33:20 INFO - 'tsvgr_opacity', 03:33:20 INFO - 'tart', 03:33:20 INFO - 'tscrollx', 03:33:20 INFO - 'tsvg_static']}, 03:33:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:33:20 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:33:20 INFO - 'talos_options': ['--disable-stylo'], 03:33:20 INFO - 'tests': ['tp5o']}, 03:33:20 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:20 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:33:20 INFO - 'talos_options': ['--mitmproxy', 03:33:20 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:20 INFO - '--firstNonBlankPaint'], 03:33:20 INFO - 'tests': ['tp6_google', 03:33:20 INFO - 'tp6_youtube', 03:33:20 INFO - 'tp6_amazon', 03:33:20 INFO - 'tp6_facebook']}, 03:33:20 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:20 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:33:21 INFO - 'talos_options': ['--disable-stylo', 03:33:21 INFO - '--mitmproxy', 03:33:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:21 INFO - '--firstNonBlankPaint'], 03:33:21 INFO - 'tests': ['tp6_google', 03:33:21 INFO - 'tp6_youtube', 03:33:21 INFO - 'tp6_amazon', 03:33:21 INFO - 'tp6_facebook']}, 03:33:21 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:33:21 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 03:33:21 INFO - 'talos_options': ['--stylo-threads=1', 03:33:21 INFO - '--mitmproxy', 03:33:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:33:21 INFO - '--firstNonBlankPaint'], 03:33:21 INFO - 'tests': ['tp6_google', 03:33:21 INFO - 'tp6_youtube', 03:33:21 INFO - 'tp6_amazon', 03:33:21 INFO - 'tp6_facebook']}, 03:33:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:33:21 INFO - 'talos_options': ['--xperf_path', 03:33:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:21 INFO - 'tests': ['tp5n']}, 03:33:21 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:33:21 INFO - 'talos_options': ['--disable-stylo', 03:33:21 INFO - '--xperf_path', 03:33:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:33:21 INFO - 'tests': ['tp5n']}}} 03:33:21 INFO - Running post-action listener: _resource_record_post_action 03:33:21 INFO - [mozharness: 2017-09-28 10:33:21.002174Z] Finished populate-webroot step (success) 03:33:21 INFO - [mozharness: 2017-09-28 10:33:21.002264Z] Running create-virtualenv step. 03:33:21 INFO - Running pre-action listener: _resource_record_pre_action 03:33:21 INFO - Running main action method: create_virtualenv 03:33:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:33:21 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:33:21 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:33:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:33:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:33:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:33:21 INFO - Installing distribute.............................................................................................................................................................................................done. 03:33:21 INFO - Installing pip...............done. 03:33:21 INFO - Return code: 0 03:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:33:21 INFO - Reading from file tmpfile_stdout 03:33:21 INFO - Output received: 03:33:21 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:33:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33: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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:33:22 INFO - Using env: {'DISPLAY': ':0', 03:33:22 INFO - 'HOME': '/home/cltbld', 03:33:22 INFO - 'LANG': 'en_US.UTF-8', 03:33:22 INFO - 'LANGUAGE': 'en_US:en', 03:33:22 INFO - 'LOGNAME': 'cltbld', 03:33:22 INFO - 'MAIL': '/var/mail/cltbld', 03:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:22 INFO - 'MOZ_NO_REMOTE': '1', 03:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:22 INFO - 'NO_EM_RESTART': '1', 03:33:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:22 INFO - 'PWD': '/builds/slave/test', 03:33:22 INFO - 'SHELL': '/bin/bash', 03:33:22 INFO - 'SHLVL': '1', 03:33:22 INFO - 'TERM': 'linux', 03:33:22 INFO - 'TMOUT': '86400', 03:33:22 INFO - 'USER': 'cltbld', 03:33:22 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:22 INFO - '_': '/tools/buildbot/bin/python'} 03:33:23 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:33:23 INFO - Downloading/unpacking pip>=1.5 03:33:23 INFO - Running setup.py egg_info for package pip 03:33:23 INFO - warning: no files found matching 'pip/cacert.pem' 03:33:23 INFO - warning: no files found matching '*.html' under directory 'docs' 03:33:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:33:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:33:23 INFO - Installing collected packages: pip 03:33:23 INFO - Found existing installation: pip 1.1 03:33:23 INFO - Uninstalling pip: 03:33:23 INFO - Successfully uninstalled pip 03:33:23 INFO - Running setup.py install for pip 03:33:23 INFO - warning: no files found matching 'pip/cacert.pem' 03:33:23 INFO - warning: no files found matching '*.html' under directory 'docs' 03:33:23 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:33:23 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:33:23 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:33:23 INFO - Successfully installed pip 03:33:23 INFO - Cleaning up... 03:33:23 INFO - Return code: 0 03:33:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33: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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:33:23 INFO - Using env: {'DISPLAY': ':0', 03:33:23 INFO - 'HOME': '/home/cltbld', 03:33:23 INFO - 'LANG': 'en_US.UTF-8', 03:33:23 INFO - 'LANGUAGE': 'en_US:en', 03:33:23 INFO - 'LOGNAME': 'cltbld', 03:33:23 INFO - 'MAIL': '/var/mail/cltbld', 03:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:23 INFO - 'MOZ_NO_REMOTE': '1', 03:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:23 INFO - 'NO_EM_RESTART': '1', 03:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:23 INFO - 'PWD': '/builds/slave/test', 03:33:23 INFO - 'SHELL': '/bin/bash', 03:33:23 INFO - 'SHLVL': '1', 03:33:23 INFO - 'TERM': 'linux', 03:33:23 INFO - 'TMOUT': '86400', 03:33:23 INFO - 'USER': 'cltbld', 03:33:23 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:23 INFO - '_': '/tools/buildbot/bin/python'} 03:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:23 INFO - Downloading/unpacking psutil>=3.1.1 03:33: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 03:33: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 03:33: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 03:33: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 03:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:24 INFO - Installing collected packages: psutil 03:33:24 INFO - Running setup.py install for psutil 03:33:24 INFO - building 'psutil._psutil_linux' extension 03:33:24 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 03:33:25 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 03:33:25 INFO - building 'psutil._psutil_posix' extension 03:33:25 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 03:33:25 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 03:33:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:33:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:33:26 INFO - Successfully installed psutil 03:33:26 INFO - Cleaning up... 03:33:26 INFO - Return code: 0 03:33:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33: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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:33:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:33:26 INFO - Using env: {'DISPLAY': ':0', 03:33:26 INFO - 'HOME': '/home/cltbld', 03:33:26 INFO - 'LANG': 'en_US.UTF-8', 03:33:26 INFO - 'LANGUAGE': 'en_US:en', 03:33:26 INFO - 'LOGNAME': 'cltbld', 03:33:26 INFO - 'MAIL': '/var/mail/cltbld', 03:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:26 INFO - 'MOZ_NO_REMOTE': '1', 03:33:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:26 INFO - 'NO_EM_RESTART': '1', 03:33:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:26 INFO - 'PWD': '/builds/slave/test', 03:33:26 INFO - 'SHELL': '/bin/bash', 03:33:26 INFO - 'SHLVL': '1', 03:33:26 INFO - 'TERM': 'linux', 03:33:26 INFO - 'TMOUT': '86400', 03:33:26 INFO - 'USER': 'cltbld', 03:33:26 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:26 INFO - '_': '/tools/buildbot/bin/python'} 03:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:33: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 03:33: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 03:33: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 03:33: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 03:33:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:33:27 INFO - Installing collected packages: mozsystemmonitor 03:33:27 INFO - Running setup.py install for mozsystemmonitor 03:33:27 INFO - Successfully installed mozsystemmonitor 03:33:27 INFO - Cleaning up... 03:33:27 INFO - Return code: 0 03:33:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:33:27 INFO - Using env: {'DISPLAY': ':0', 03:33:27 INFO - 'HOME': '/home/cltbld', 03:33:27 INFO - 'LANG': 'en_US.UTF-8', 03:33:27 INFO - 'LANGUAGE': 'en_US:en', 03:33:27 INFO - 'LOGNAME': 'cltbld', 03:33:27 INFO - 'MAIL': '/var/mail/cltbld', 03:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:27 INFO - 'MOZ_NO_REMOTE': '1', 03:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:27 INFO - 'NO_EM_RESTART': '1', 03:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:27 INFO - 'PWD': '/builds/slave/test', 03:33:27 INFO - 'SHELL': '/bin/bash', 03:33:27 INFO - 'SHLVL': '1', 03:33:27 INFO - 'TERM': 'linux', 03:33:27 INFO - 'TMOUT': '86400', 03:33:27 INFO - 'USER': 'cltbld', 03:33:27 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:27 INFO - '_': '/tools/buildbot/bin/python'} 03:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:33: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 03:33: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 03:33: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 03:33: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 03:33:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:33:29 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 03:33:29 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 03:33:29 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 03:33:29 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 03:33:29 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:29 INFO - warning: no files found matching '*.txt' 03:33:29 INFO - no previously-included directories found matching 'build' 03:33:29 INFO - no previously-included directories found matching 'dist' 03:33:29 INFO - no previously-included directories found matching '.git*' 03:33:29 INFO - Installing collected packages: jsonschema, functools32 03:33:29 INFO - Running setup.py install for functools32 03:33:29 INFO - warning: no files found matching '*.txt' 03:33:29 INFO - no previously-included directories found matching 'build' 03:33:29 INFO - no previously-included directories found matching 'dist' 03:33:29 INFO - no previously-included directories found matching '.git*' 03:33:29 INFO - Successfully installed jsonschema functools32 03:33:29 INFO - Cleaning up... 03:33:29 INFO - Return code: 0 03:33:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:29 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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:33:29 INFO - Using env: {'DISPLAY': ':0', 03:33:29 INFO - 'HOME': '/home/cltbld', 03:33:29 INFO - 'LANG': 'en_US.UTF-8', 03:33:29 INFO - 'LANGUAGE': 'en_US:en', 03:33:29 INFO - 'LOGNAME': 'cltbld', 03:33:29 INFO - 'MAIL': '/var/mail/cltbld', 03:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:29 INFO - 'MOZ_NO_REMOTE': '1', 03:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:29 INFO - 'NO_EM_RESTART': '1', 03:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:29 INFO - 'PWD': '/builds/slave/test', 03:33:29 INFO - 'SHELL': '/bin/bash', 03:33:29 INFO - 'SHLVL': '1', 03:33:29 INFO - 'TERM': 'linux', 03:33:29 INFO - 'TMOUT': '86400', 03:33:29 INFO - 'USER': 'cltbld', 03:33:29 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:29 INFO - '_': '/tools/buildbot/bin/python'} 03:33:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:33:29 INFO - Cleaning up... 03:33:29 INFO - Return code: 0 03:33:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:29 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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 03:33:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:33:29 INFO - Using env: {'DISPLAY': ':0', 03:33:29 INFO - 'HOME': '/home/cltbld', 03:33:29 INFO - 'LANG': 'en_US.UTF-8', 03:33:29 INFO - 'LANGUAGE': 'en_US:en', 03:33:29 INFO - 'LOGNAME': 'cltbld', 03:33:29 INFO - 'MAIL': '/var/mail/cltbld', 03:33:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:29 INFO - 'MOZ_NO_REMOTE': '1', 03:33:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:29 INFO - 'NO_EM_RESTART': '1', 03:33:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:29 INFO - 'PWD': '/builds/slave/test', 03:33:29 INFO - 'SHELL': '/bin/bash', 03:33:29 INFO - 'SHLVL': '1', 03:33:29 INFO - 'TERM': 'linux', 03:33:29 INFO - 'TMOUT': '86400', 03:33:29 INFO - 'USER': 'cltbld', 03:33:29 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:29 INFO - '_': '/tools/buildbot/bin/python'} 03:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:33:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:33:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:31 INFO - Downloading docopt-0.6.1.tar.gz 03:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:33:31 INFO - Installing collected packages: blobuploader, requests, docopt 03:33:31 INFO - Running setup.py install for blobuploader 03:33:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:33:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:33:31 INFO - Running setup.py install for requests 03:33:32 INFO - Running setup.py install for docopt 03:33:32 INFO - Successfully installed blobuploader requests docopt 03:33:32 INFO - Cleaning up... 03:33:32 INFO - Return code: 0 03:33:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:32 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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:32 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:33:32 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:32 INFO - Using env: {'DISPLAY': ':0', 03:33:32 INFO - 'HOME': '/home/cltbld', 03:33:32 INFO - 'LANG': 'en_US.UTF-8', 03:33:32 INFO - 'LANGUAGE': 'en_US:en', 03:33:32 INFO - 'LOGNAME': 'cltbld', 03:33:32 INFO - 'MAIL': '/var/mail/cltbld', 03:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:32 INFO - 'MOZ_NO_REMOTE': '1', 03:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:32 INFO - 'NO_EM_RESTART': '1', 03:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:32 INFO - 'PWD': '/builds/slave/test', 03:33:32 INFO - 'SHELL': '/bin/bash', 03:33:32 INFO - 'SHLVL': '1', 03:33:32 INFO - 'TERM': 'linux', 03:33:32 INFO - 'TMOUT': '86400', 03:33:32 INFO - 'USER': 'cltbld', 03:33:32 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:32 INFO - '_': '/tools/buildbot/bin/python'} 03:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:32 INFO - Running setup.py (path:/tmp/pip-PfyE_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:32 INFO - Running setup.py (path:/tmp/pip-8ts8bY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:32 INFO - Running setup.py (path:/tmp/pip-dpJdlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:32 INFO - Running setup.py (path:/tmp/pip-g4Vc3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:32 INFO - Running setup.py (path:/tmp/pip-cKV9QJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:32 INFO - Running setup.py (path:/tmp/pip-jFs_SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:33 INFO - Running setup.py (path:/tmp/pip-XEo1ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:33 INFO - Running setup.py (path:/tmp/pip-2yFby0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:33 INFO - Running setup.py (path:/tmp/pip-bAHlth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:33 INFO - Running setup.py (path:/tmp/pip-pJADju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:33 INFO - Running setup.py (path:/tmp/pip-1aSqAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:33 INFO - Running setup.py (path:/tmp/pip-FbwneE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:33 INFO - Running setup.py (path:/tmp/pip-GTMugP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:33 INFO - Running setup.py (path:/tmp/pip-tB2o1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:33 INFO - Running setup.py (path:/tmp/pip-4m_my0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:33 INFO - Running setup.py (path:/tmp/pip-bKqrr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:33 INFO - Running setup.py (path:/tmp/pip-NAQPiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:33:33 INFO - Running setup.py install for manifestparser 03:33:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:33:33 INFO - Running setup.py install for mozcrash 03:33:33 INFO - Running setup.py install for mozdebug 03:33:34 INFO - Running setup.py install for mozdevice 03:33:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozfile 03:33:34 INFO - Running setup.py install for mozhttpd 03:33:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozinfo 03:33:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozInstall 03:33:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozleak 03:33:34 INFO - Running setup.py install for mozlog 03:33:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for moznetwork 03:33:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:33:34 INFO - Running setup.py install for mozprocess 03:33:35 INFO - Running setup.py install for mozprofile 03:33:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:33:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:33:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:33:35 INFO - Running setup.py install for mozrunner 03:33:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:33:35 INFO - Running setup.py install for mozscreenshot 03:33:35 INFO - Running setup.py install for moztest 03:33:35 INFO - Running setup.py install for mozversion 03:33:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:33:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:33:35 INFO - Cleaning up... 03:33:35 INFO - Return code: 0 03:33:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:35 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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:35 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:33:35 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:35 INFO - Using env: {'DISPLAY': ':0', 03:33:35 INFO - 'HOME': '/home/cltbld', 03:33:35 INFO - 'LANG': 'en_US.UTF-8', 03:33:35 INFO - 'LANGUAGE': 'en_US:en', 03:33:35 INFO - 'LOGNAME': 'cltbld', 03:33:35 INFO - 'MAIL': '/var/mail/cltbld', 03:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:35 INFO - 'MOZ_NO_REMOTE': '1', 03:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:35 INFO - 'NO_EM_RESTART': '1', 03:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:35 INFO - 'PWD': '/builds/slave/test', 03:33:35 INFO - 'SHELL': '/bin/bash', 03:33:35 INFO - 'SHLVL': '1', 03:33:35 INFO - 'TERM': 'linux', 03:33:35 INFO - 'TMOUT': '86400', 03:33:35 INFO - 'USER': 'cltbld', 03:33:35 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:35 INFO - '_': '/tools/buildbot/bin/python'} 03:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:33:35 INFO - Running setup.py (path:/tmp/pip-PKvkxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:33:35 INFO - Running setup.py (path:/tmp/pip-wcZNcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:33:35 INFO - Running setup.py (path:/tmp/pip-arjBmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:33:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:33:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:33:35 INFO - Running setup.py (path:/tmp/pip-4BgkGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:33:36 INFO - Running setup.py (path:/tmp/pip-PxJ58G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:33:36 INFO - Running setup.py (path:/tmp/pip-M_g0yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:33:36 INFO - Running setup.py (path:/tmp/pip-Ak467g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:33:36 INFO - Running setup.py (path:/tmp/pip-qEn_Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:33:36 INFO - Running setup.py (path:/tmp/pip-tcmJKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:33:36 INFO - Running setup.py (path:/tmp/pip-gILCDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:33:36 INFO - Running setup.py (path:/tmp/pip-YRTQE_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:33:36 INFO - Running setup.py (path:/tmp/pip-Yq0QCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:33:36 INFO - Running setup.py (path:/tmp/pip-H16mZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:33:36 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:33:36 INFO - Running setup.py (path:/tmp/pip-QQsJfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:36 INFO - Running setup.py (path:/tmp/pip-Q557tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:33:36 INFO - Running setup.py (path:/tmp/pip-N9goE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 03:33:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:33:36 INFO - Running setup.py (path:/tmp/pip-E1BqUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:33:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:38 INFO - Downloading blessings-1.6.tar.gz 03:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:38 INFO - Installing collected packages: blessings 03:33:38 INFO - Running setup.py install for blessings 03:33:38 INFO - Successfully installed blessings 03:33:38 INFO - Cleaning up... 03:33:38 INFO - Return code: 0 03:33:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:38 INFO - Reading from file tmpfile_stdout 03:33:38 INFO - Current package versions: 03:33:38 INFO - argparse == 1.2.1 03:33:38 INFO - blessings == 1.6 03:33:38 INFO - blobuploader == 1.2.4 03:33:38 INFO - docopt == 0.6.1 03:33:38 INFO - functools32 == 3.2.3-2 03:33:38 INFO - jsonschema == 2.5.1 03:33:38 INFO - manifestparser == 1.1 03:33:38 INFO - mozInstall == 1.13 03:33:38 INFO - mozcrash == 1.0 03:33:38 INFO - mozdebug == 0.1 03:33:38 INFO - mozdevice == 0.51 03:33:38 INFO - mozfile == 1.2 03:33:38 INFO - mozhttpd == 0.7 03:33:38 INFO - mozinfo == 0.10 03:33:38 INFO - mozleak == 0.1 03:33:38 INFO - mozlog == 3.5 03:33:38 INFO - moznetwork == 0.27 03:33:38 INFO - mozprocess == 0.25 03:33:38 INFO - mozprofile == 0.28 03:33:38 INFO - mozrunner == 6.13 03:33:38 INFO - mozscreenshot == 0.1 03:33:38 INFO - mozsystemmonitor == 0.3 03:33:38 INFO - moztest == 0.8 03:33:38 INFO - mozversion == 1.4 03:33:38 INFO - psutil == 3.1.1 03:33:38 INFO - requests == 1.2.3 03:33:38 INFO - wsgiref == 0.1.2 03:33:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:33:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:33:38 INFO - Using env: {'DISPLAY': ':0', 03:33:38 INFO - 'HOME': '/home/cltbld', 03:33:38 INFO - 'LANG': 'en_US.UTF-8', 03:33:38 INFO - 'LANGUAGE': 'en_US:en', 03:33:38 INFO - 'LOGNAME': 'cltbld', 03:33:38 INFO - 'MAIL': '/var/mail/cltbld', 03:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:38 INFO - 'MOZ_NO_REMOTE': '1', 03:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:38 INFO - 'NO_EM_RESTART': '1', 03:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:38 INFO - 'PWD': '/builds/slave/test', 03:33:38 INFO - 'SHELL': '/bin/bash', 03:33:38 INFO - 'SHLVL': '1', 03:33:38 INFO - 'TERM': 'linux', 03:33:38 INFO - 'TMOUT': '86400', 03:33:38 INFO - 'USER': 'cltbld', 03:33:38 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:38 INFO - '_': '/tools/buildbot/bin/python'} 03:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:33:38 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:33:39 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)) 03:33:39 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)) 03:33:39 INFO - Installing collected packages: simplejson 03:33:39 INFO - Running setup.py install for simplejson 03:33:40 INFO - building 'simplejson._speedups' extension 03:33:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:33:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:33:40 INFO - Successfully installed simplejson 03:33:40 INFO - Cleaning up... 03:33:40 INFO - Return code: 0 03:33:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:40 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/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 0x28d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a98b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c3d9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, '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': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', '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 03:33:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:33:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:33:40 INFO - Using env: {'DISPLAY': ':0', 03:33:40 INFO - 'HOME': '/home/cltbld', 03:33:40 INFO - 'LANG': 'en_US.UTF-8', 03:33:40 INFO - 'LANGUAGE': 'en_US:en', 03:33:40 INFO - 'LOGNAME': 'cltbld', 03:33:40 INFO - 'MAIL': '/var/mail/cltbld', 03:33:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:40 INFO - 'MOZ_NO_REMOTE': '1', 03:33:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:40 INFO - 'NO_EM_RESTART': '1', 03:33:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:40 INFO - 'PWD': '/builds/slave/test', 03:33:40 INFO - 'SHELL': '/bin/bash', 03:33:40 INFO - 'SHLVL': '1', 03:33:40 INFO - 'TERM': 'linux', 03:33:40 INFO - 'TMOUT': '86400', 03:33:40 INFO - 'USER': 'cltbld', 03:33:40 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:40 INFO - '_': '/tools/buildbot/bin/python'} 03:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:33:41 INFO - Cleaning up... 03:33:41 INFO - Return code: 0 03:33:41 INFO - Running post-action listener: _resource_record_post_action 03:33:41 INFO - Running post-action listener: _start_resource_monitoring 03:33:41 INFO - Starting resource monitoring. 03:33:41 INFO - [mozharness: 2017-09-28 10:33:41.241205Z] Finished create-virtualenv step (success) 03:33:41 INFO - [mozharness: 2017-09-28 10:33:41.241717Z] Running install step. 03:33:41 INFO - Running pre-action listener: _resource_record_pre_action 03:33:41 INFO - Running main action method: install 03:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:41 INFO - Reading from file tmpfile_stdout 03:33:41 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:41 INFO - Reading from file tmpfile_stdout 03:33:41 INFO - Output received: 03:33:41 INFO - Usage: mozinstall [options] installer 03:33:41 INFO - Options: 03:33:41 INFO - -h, --help show this help message and exit 03:33:41 INFO - -d DEST, --destination=DEST 03:33:41 INFO - Directory to install application into. [default: 03:33:41 INFO - "/builds/slave/test"] 03:33:41 INFO - --app=APP Application being installed. [default: firefox] 03:33:41 INFO - mkdir: /builds/slave/test/build/application 03:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:33:59 INFO - Reading from file tmpfile_stdout 03:33:59 INFO - Output received: 03:33:59 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:59 INFO - Running post-action listener: _resource_record_post_action 03:33:59 INFO - [mozharness: 2017-09-28 10:33:59.352371Z] Finished install step (success) 03:33:59 INFO - [mozharness: 2017-09-28 10:33:59.352626Z] Running setup-mitmproxy step. 03:33:59 INFO - Running pre-action listener: _resource_record_pre_action 03:33:59 INFO - Running main action method: setup_mitmproxy 03:33:59 INFO - Skipping: mitmproxy is not required 03:33:59 INFO - Running post-action listener: _resource_record_post_action 03:33:59 INFO - [mozharness: 2017-09-28 10:33:59.353759Z] Finished setup-mitmproxy step (success) 03:33:59 INFO - [mozharness: 2017-09-28 10:33:59.353998Z] Running run-tests step. 03:33:59 INFO - Running pre-action listener: _resource_record_pre_action 03:33:59 INFO - Running pre-action listener: _set_gcov_prefix 03:33:59 INFO - Running main action method: run_tests 03:33:59 WARNING - Try message not found. 03:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:59 INFO - Python 2.7.3 03:33:59 INFO - Return code: 0 03:33:59 INFO - grabbing minidump binary from tooltool 03:33:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 03:33:59 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x2c3ad60>, '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 0x2c3ba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3bef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 03:33:59 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:33:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 03:33:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:59 INFO - Return code: 0 03:33:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:59 INFO - ENV: RUST_BACKTRACE is now full 03:33:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:33:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-080 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:33:59 INFO - Using env: {'DISPLAY': ':0', 03:33:59 INFO - 'HOME': '/home/cltbld', 03:33:59 INFO - 'LANG': 'en_US.UTF-8', 03:33:59 INFO - 'LANGUAGE': 'en_US:en', 03:33:59 INFO - 'LOGNAME': 'cltbld', 03:33:59 INFO - 'MAIL': '/var/mail/cltbld', 03:33:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:59 INFO - 'MOZ_NO_REMOTE': '1', 03:33:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:59 INFO - 'NO_EM_RESTART': '1', 03:33:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:59 INFO - 'PWD': '/builds/slave/test', 03:33:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:59 INFO - 'RUST_BACKTRACE': 'full', 03:33:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:33:59 INFO - 'SHELL': '/bin/bash', 03:33:59 INFO - 'SHLVL': '1', 03:33:59 INFO - 'TERM': 'linux', 03:33:59 INFO - 'TMOUT': '86400', 03:33:59 INFO - 'USER': 'cltbld', 03:33:59 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:59 INFO - '_': '/tools/buildbot/bin/python'} 03:33:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-080', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:33:59 INFO - mozversion application_buildid: 20170928094239 03:33:59 INFO - mozversion application_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 03:33:59 INFO - mozversion application_display_name: Nightly 03:33:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:59 INFO - mozversion application_name: Firefox 03:33:59 INFO - mozversion application_remotingname: firefox 03:33:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:33:59 INFO - mozversion application_vendor: Mozilla 03:33:59 INFO - mozversion application_version: 58.0a1 03:33:59 INFO - mozversion platform_buildid: 20170928094239 03:33:59 INFO - mozversion platform_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 03:33:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:33:59 INFO - mozversion platform_version: 58.0a1 03:33:59 INFO - using testdate: 1506594839 03:33:59 INFO - actual date: 1506594839 03:33:59 INFO - starting webserver on 'localhost:52136' 03:33:59 INFO - SUITE-START | Running 2 tests 03:33:59 INFO - TEST-START | dromaeo_css 03:33:59 INFO - Initialising browser for dromaeo_css test... 03:33:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52136/getInfo.html -profile /tmp/tmpOiZOvh/profile 03:33:59 INFO - TEST-INFO | started process 8017 (/builds/slave/test/build/application/firefox/firefox http://localhost:52136/getInfo.html) 03:34:05 INFO - TEST-INFO | 8017: exit 0 03:34:05 INFO - Browser initialized. 03:34:05 INFO - Running cycle 1/1 for dromaeo_css test... 03:34:05 INFO - Using env: {'DISPLAY': ':0', 03:34:05 INFO - 'HOME': '/home/cltbld', 03:34:05 INFO - 'JSGC_DISABLE_POISONING': '1', 03:34:05 INFO - 'LANG': 'en_US.UTF-8', 03:34:05 INFO - 'LANGUAGE': 'en_US:en', 03:34:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:34:05 INFO - 'LOGNAME': 'cltbld', 03:34:05 INFO - 'MAIL': '/var/mail/cltbld', 03:34:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:34:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:34:05 INFO - 'MOZ_CRASHREPORTER': '1', 03:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:34:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:34:05 INFO - 'MOZ_NO_REMOTE': '1', 03:34:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:34:05 INFO - 'NO_EM_RESTART': '1', 03:34:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:34:05 INFO - 'PWD': '/builds/slave/test', 03:34:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:34:05 INFO - 'RUST_BACKTRACE': 'full', 03:34:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:34:05 INFO - 'SHELL': '/bin/bash', 03:34:05 INFO - 'SHLVL': '1', 03:34:05 INFO - 'TERM': 'linux', 03:34:05 INFO - 'TMOUT': '86400', 03:34:05 INFO - 'USER': 'cltbld', 03:34:05 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:34:05 INFO - '_': '/tools/buildbot/bin/python'} 03:34:05 INFO - TEST-INFO | started process 8255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOiZOvh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:06 INFO - PID 8255 | 03:34:06 INFO - PID 8255 | (/builds/slave/test/build/application/firefox/firefox:8303): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:34:06 INFO - PID 8255 | 03:34:17 INFO - PID 8255 | RSS: Main: 151896064 03:34:17 INFO - PID 8255 | 03:37:14 INFO - PID 8255 | Cycle 1(1): loaded http://localhost:52136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52136/tests/dromaeo/cssquery-ext.html) 03:37:15 INFO - PID 8255 | RSS: Main: 149762048 03:37:15 INFO - PID 8255 | 03:40:17 INFO - PID 8255 | Cycle 1(1): loaded http://localhost:52136/tests/dromaeo/cssquery-ext.html (next: http://localhost:52136/tests/dromaeo/cssquery-jquery.html) 03:40:17 INFO - PID 8255 | RSS: Main: 150241280 03:40:17 INFO - PID 8255 | 03:43:19 INFO - PID 8255 | Cycle 1(1): loaded http://localhost:52136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52136/tests/dromaeo/cssquery-mootools.html) 03:43:20 INFO - PID 8255 | RSS: Main: 151920640 03:43:20 INFO - PID 8255 | 03:46:22 INFO - PID 8255 | Cycle 1(1): loaded http://localhost:52136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52136/tests/dromaeo/cssquery-prototype.html) 03:46:22 INFO - PID 8255 | RSS: Main: 151646208 03:46:22 INFO - PID 8255 | 03:49:25 INFO - PID 8255 | Cycle 1(1): loaded http://localhost:52136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52136/tests/dromaeo/cssquery-yui.html) 03:49:26 INFO - PID 8255 | RSS: Main: 154394624 03:49:26 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | Cycle 1(1): loaded http://localhost:52136/tests/dromaeo/cssquery-yui.html (next: http://localhost:52136/tests/dromaeo/cssquery-dojo.html) 03:52:28 INFO - PID 8255 | RSS: Main: 155881472 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | __start_tp_report 03:52:28 INFO - PID 8255 | _x_x_mozilla_page_load 03:52:28 INFO - PID 8255 | _x_x_mozilla_page_load_details 03:52:28 INFO - PID 8255 | |i|pagename|runs| 03:52:28 INFO - PID 8255 | |0;dojo.html;3205.2147223930133;3225.306559089798;3233.967660323396;3250.983745081275;3282.45839436493;6168.136460895478;6252.624842509453;6262.405071518204;6294.087357333184;6382.297947225808;6259.530535209855;6289.213848268966;6291.276503202133;6304.747810087591;6318.715657795398;5795.536357091433;5809.506191973687;5833.066709326508;5838.912416313738;5904.763809447617;5640.351359593637;5831.737571809279;5907;5908.793192238272;5922.7927022554;5704.286964129484;5739.397363276879;5805.854853628651;5816.302043754756;5825.825225243249;5766.250387449647;5767.711614419262;5825.7087145642545;5841.970790146064;5851.4148585141575;5741.397153298927;5748.137779333092;5808.012637851575;5813.09896965971;5823.883522329572;6162.599431036968;6219.906701399483;6222.97320942044;6284.842878928063;6334.208223972004;6641.900371494431;6644.60132392058;6664.866702665968;6669.633170175638;6769.627670478122;6747.505968833304;6873.518853680244;6875.518713690044;6878.759243426506;6914.723411063552;6132.080187971796;6211.937880621226;6217.844553886189;6327.46216571592;6353.872922541569;6937.479689023344;7006.159260888726;7016.298370163045;7023.33278338557;7025.578465292099;6603.306652801482;6612.371824676648;6678.732850686015;6678.899816502756;6681.997700344987;6682.398584127452;6686.765963191265;6766.594004359656;6767.2894346093935;6776.01747746574;6753.561018533779;6758.256591774901;6766.458683305324;6775.830604234933;6806.76176333826;6622.072909792633;6734.427573656294;6746.055552222692;6810.38706516406;6852.486063545254;5091.287219789232;5164.122099243138;5257.6056795739705;5358.33020872391;5364.758585863646;4514.34541991416;4635.443746750344;4642.558956899156;4645.837395691135;4688.929666055012;5695.515881150066;5792.189093526826;5807.912881306784;5809.7966571170655;5813.069908814654;6638.17022872141;6741.561798483083;6748.4938629602975;6827.829304267433;6838.452923766087;5637.548996080303;5669.744861481243;5714.771409143671;5743.282089738783;5804.88390232193;5753.367129615739;5795.797147099831;5806.274215723035;5834.445727655866;5840.853978650568;6532.6733663316645;6548.770793022221;6577.83555411109;6649.102371179829;6674.799756007327;6612.8346791330605;6718.764843230463;6741.595504269563;6793.082933803873;6814.727410903508;6446.0975463434215;6452.387023232785;6457.225132984072;6463.321351258238;6469.935300647122;6519.152510173647;6529.542931994904;6617.172853393326;6619.073329733745;6665.866682666417;6608.306127856698;6706.061151438705;6797.218319893078;6803.591784492946;6815;6432.935670643234;6468.320826313357;6477.902831457438;6524.836879078061;6574.8356291091195;6416.871662566816;6464.321246269262;6558.475321974135;6591.406773390418;6609.768658096944;6454.548181627241;6529.7388104475285;6536.542442029012;6538.248101468392;6550.377714117151;6516.478681705547;6533.705983230671;6604.14146160996;6608.1079054328975;6666.066750654815;6216.2540495139065;6345.206849143857;6345.619262844244;6431.903521447089;6443.71003304843 03:52:28 INFO - PID 8255 | |1;ext.html;872.3108744092167;889.4796544021747;914.7667344827072;923.7182659288915;924.3160061554449;41862.37206441902;42580.57419425805;42835.92910177247;42882.142357152836;42988.140237195235;38563.42154867679;38904.80547597258;42426;42800.14399712004;42949.57050429503;8052.07401148868;8163.918360816405;8200.26197642212;8211.1788821118;8231.506109633412;7975.361971042303;8101.837963240731;8107.959460202691;8109.594520273992;8109.918900810975;8118.309943654767;8151.592420378987;8152.673893044271;8165.020197576299;8177.591120443954;8093.4334596578265;8122.2689957903485;8123.512589244664;8135.430519863641;8142.267195952363;7952.20477952206;8027.638756255982;8027.799305017363;8027.839443211162;8029.95985020077;39428.40857387141;39472.21055578901;39704.20591588152;39714.20571588581;39736.20527589432;3629.256002519477;3645.981770091159;3655.1227705350525;3669.101070237782;3672.0452682302525;32240;32401.6759832401;32432.351352972808;32456;32462.837685811657;5065.696058236517;5239.266502689627;5304;5334.893302133935;5369.060414427459;193231;193671.0316448423;193930;194470;194600;48002.27996580054;48067.51932480631;48141.75929120332;48143.277850832266;48226.758866206146;50493.24260136101;52138.21792673113;52834.67913302198;54217.72891135598;54583.90832183334;15216.771748423782;15245;15325.386984520717;15329.233538323038;15337;12281.078919081105;12319.568815091428;12403.62789116328;13117.278549679859;13234.801477977839;14977.475788347356;15034.398624055135;15092.320845561977;15106.320215590325;15154.469593564172;5988.161657367972;6014.48876845473;6043.758249669964;6163.660998645118;6171.13604095427;997.3517213811081;1009.8939611340851;1014.629660174046;1020.1583693452931;1027.3989716016065;22820.31539053831;23053.423664408525;23190.28825498313;23438.296851094496;23778.16776412817;1116.1461481966303;1130.3726431830248;1136.852209212797;1142.9542818287175;1143.971400714972;12536.561220357244;12628.873711262953;12651.304178270284;12661.556845510362;12762.553310634083;213881;213904;214585;215291;215428;45204;45667.54332456699;52137;52707.209391859156;53366.199507007426;1476.6529865481602;1483.8887083468783;1486.6134804950575;1490.739120653903;1491.395984626228;27010.839132869718;27204.455910881275;27593.724062759116;27763.583546247228;27788.583171252852;37000.25999480049;37070.25859482741;37076.81461592675;37210.813945930095;37212.25575488529;192493;192838;192864;193181;193755.03122484297;33465.66534334723;34789.65210347864;35077.824610876785;35331.646683533865;35763.64236357603;43185;43359.13281734411;43706;43827;43924;31636.683633164295;31823.204419889687;31910.680893190773;32066.358672825947;32273.51589726203;31155.37689246248;31539.684603153673;31700.841495793295;31706.207344816565;31727.841360793973;35395;35693;35695.82152089223;35915;35932;30701.23246918845;31024.379512410076;31263;31867.681323186473;32322.191945201557;23015.309540713806;23123.653145202497;23192.18827341035;23475.882620586788;23650 03:52:28 INFO - PID 8255 | |2;jquery.html;587.3157771196556;590.7016956436996;594.5927039977615;613.9624035380207;615.9414855588719;22735.431614209654;23574.646380304268;23584.05663773449;23587.29238122859;23649.5270094598;20088.49778755532;21085.47286317839;24902.377440563996;24963.25110246691;25127.371815704617;6317.5893566918;6502.154719886408;6502.869942601145;6507.739690412378;6512.413882750551;6392.6484043377595;6394.200724909387;6499.252585952629;6501.642409667466;6505.4145126938565;6633.469322454216;6665.066890635315;6668.133142691443;6668.666566671672;6676.666166691671;6622.139121914121;6669.9666501667425;6670;6674.866502669944;6684.097646817715;5908.084246941731;6162.938370616326;6184.319724830265;6206.906896396557;6208.627482351073;27840.443191136063;28299.717002829915;28343.57484637732;28353.716462835313;28382.290442739097;2052.3945436096237;2060.9793902061087;2064.0092755477453;2070.2133189388087;2070.244360808309;18367.816321836744;18805.24779008838;19105.904470477697;19112.61774764511;19117.330893418664;2477.5911974524183;2509.723930367658;2537.708163561177;2543.74562543746;2558.60341647045;123387;129476;142544;150548.2472587641;150741;14806.925965370105;14850.554483365517;15102;15129.697406051817;15141.394344226328;23996.7600323998;24007.879960600436;24046.39884002914;24074.759252407253;24083.51832963331;10268.281220314655;10316.381017138845;10390.22073344487;10501.474926253657;10517.42154181512;9479.76300592477;9544.475053871965;9607.663731769355;9670.516474176264;9701;8949.865752013726;9065.41074830134;9168.358214925025;9236.907630923739;9431.292653051049;2600.269716797355;2619.4761047790516;2695.474382495434;2737.2335745991154;2761.9171424857286;943.5942544705705;966.8984756600596;974.512743628186;978.3787295067541;979.7550612346913;18448;18484.260629574666;18557.628847422977;18977.146028428753;19358.516037098903;1010.1666125446536;1017.7455636090978;1020.2959957629212;1022.4478781458079;1027.0653705128298;10339.896601034045;10340.689779306633;10654.573817047387;10666.679999600025;10837.783244335069;473986;478613;478708;483101;492761;113778;114703.42648286706;114989;115915.42042289734;116829;1156;1173.906087513014;1240.9103318194263;1248.5942068827485;1256.0830593666674;19772.50568735793;19869;19974.50063748418;20013.899930500254;20153.39539813808;58414.7079264601;60007.39992600018;61332.386676134454;61366.69316653388;61969.38030619636;76864.61567692125;76869.23130768845;76975.23024769904;77891.61054194692;78213;14250.073745206528;14631.92684036573;14639.780403293746;14698.41206351734;14740;21402.143914243257;21535.892320538296;21877.562448750617;22063.66904496402;22076;17461.214245358737;17602.647947041245;17717.46847594574;17728;17809.73285400746;15719;16101.75847362267;16252.51242462728;16394.754078689068;16422.178891055162;17357.826421735623;17928.462146135636;17954.281828727228;18139.093045347418;18196.818031820043;14434.422623094959;14517.419303228175;14615.123092614476;14623.488177913721;14716.043457175678;17852.55368615795;17923.462296131136;18088.72866907024;18212.817871821113;18221.271149154414 03:52:28 INFO - PID 8255 | |3;mootools.html;1332.4270563657626;1394.6304229379216;1410.492222799792;1416.3272445588352;1420.9147451152933;15297.388104475822;15592.68814623707;15936.521904342873;15985.600359990991;15998.680026399465;16295.103769292713;16502.25739841707;16506.75239871403;16525.66948661026;16526.338946442156;2630.3292660371626;2703.648525691657;2704.5537486314834;2705.6076868854007;2706.851123188224;2602.791776657872;2618.0836707152534;2661.241546159345;2724.0465836957105;2818.0841226601333;2651.1781347782153;2688.7714544263763;2690.3946612012337;2691.946161076777;2692.798040146987;2546.2488565873114;2565.6536367590325;2567.396661784479;2572.781313588347;2573.768360847523;2547.274026902324;2593.870306484668;2681.410089780245;2705.702372738997;2727.2227415186576;15740.60648483797;15853.60365990848;15863.127527985956;15882.205889705469;15919.283632236577;8261.17388261175;8577.142285771435;8586.184312490303;8588.742337729878;8594.4843309401;5408.756605952742;5590.804321848756;5646.943530564724;5685.4883060524335;5740.368559458456;1966;2011.155314767801;2043.1929387891848;2061.051916118587;2081.0427203486265;27263.727362726517;27470.5879411809;27472;27485.31286717828;27526;6795.558288711218;7560.848783024308;7654.655540500579;7847.332976696931;7867.960660196777;17928.193231304624;17980.1009949502;18022.90988545049;18078.548036298936;18096.819031809515;8192.098869124391;8394.202550757791;8398.79003024917;8400.117987611335;8409.621567029499;7270.236625154388;7539.736109236151;7545.660445279866;7639.618019099134;7727.072751269883;5135.794568217229;5365.248865158881;5365.54392876602;5403.594730395236;5407.405185429599;1368.931553422325;1416.6812467195005;1423.6440889777555;1430.3348942741675;1565.3894980957436;918.2057520245073;940.4122423485321;941.5715849288557;949.4872768704822;958.0898146760605;8211.794705132419;8620.956895215484;8774.956125219333;8847.11528847123;8932.732018039469;1007.9748006299754;1017.1862509991977;1020.831562792131;1023.2121266624806;1036.6630844975414;4735;4806.110869489085;4869.756512174377;5276.472352764693;5633;21494.892525537583;22491.07616009908;22725.772742272366;22938.770612293996;22942.426439338815;22399.88800055989;22661.320160395215;22711.659325110137;22888.542229155657;22961.655575166387;10028.197744180448;10290.485475726184;10391.636292729718;10433.113185379329;10490.527926243338;8257.38069644791;8287.12985136552;8327.625256863577;8382.790430239049;8453.070162282022;18577.256909724;18839.90580047091;19098.331558395945;19526;19739.506512337306;19706.605867882274;19742.30901918426;19793.30723424731;19877.503062422977;20398.69401958942;11448.198626096093;11631.53473861036;11632.53469861196;11640.301581905112;11655.18413711066;14480.275986200859;14523.491677791226;14602.12387256768;14683.045602036262;14787.408503659733;11699.473523691284;11730;11787.292762434281;12007.699807504881;12318;11378.715532111431;11681.766364672489;11745.706357341134;11892.702682433008;11975.161738678209;10283.07452329264;10378.792424151627;10421.426821524889;10422;10425.9478702606;7434.553926764412;7438.5536867788105;7464.701411943679;7498.175200728025;7646.120696120018;7756.806079848049;7785.104712958082;7798.103218129988;7821.374290056896;7926.48477848938 03:52:28 INFO - PID 8255 | |4;prototype.html;516.4835164835165;516.7726200471792;533.5864704853738;536.4876542901529;536.975836087376;6225.564210505267;6350.904736428952;6358.904616430746;6375;6386.744530218792;6290.433860952513;6320.557560970722;6342.619442833433;6347.333529979355;6365.6498892561;5204.791808327663;5209;5219.243209734586;5223.660462069973;5238.214267859814;4856.271559266103;5004.649674522785;5161.4322424533275;5169.508896654812;5211.504907033845;4974.1295273327205;4985.601151907838;4989.501049895018;4991.276264941581;5005.649604527666;4980.2280646499485;4981.2279096739885;4981.701097934136;4986.426560945483;4987.975060124712;4763.952360476385;4875.756212189376;4894.583960363373;4906.2640603909695;4913.778879950411;6034.069097888678;6104.877902441926;6175.59858609189;6231.22109736283;6262.684836184407;5939.2575928009;5953.851153721148;5976.282846058457;5982.312034116088;6019.277686677627;6651.700673469705;6653.234877989044;6663.733450661967;6676.9666151668935;6716.865662686768;5003.574696150795;5273.709945952971;5311.150215965466;5336.359636843604;5349.59878009147;6656.7670131545165;6731.461483081342;6809.761658341934;6834.521583489208;6843.8973415399305;5438.510534051954;5465.863353416117;5471.917921231185;5475.397706252309;5480.095784195642;5502.504774570308;5506.1190209566275;5512.476314750093;5534.418886016911;5563.721813909288;5866.941330586639;5933.436323549256;5957.314908785545;6004.279486461565;6023.427774361428;6592.340765923369;6653;6666.699998500079;6683.6324002180345;6741.966290168518;1895.1282410091237;1916.7445323313252;1928.3154480159342;1940.5924755801157;1949.6880499120073;1379.9448022079005;1446.2190417174609;1446.8191476065492;1455.1196526101767;1461.5176991592962;5645.943540564624;5672.716364181857;5682.289713785777;5693.345265294544;5741.311042674905;6635.2416609598495;6718.93281067183;6728.932710672929;6754.155730533684;6759;5629.211910332557;5656.462636049569;5700.315962084576;5714.685692286964;5723;3528;3529.7529172957647;3540.3627347077772;3544.1848374873925;3546.4325707886615;6429.6463694496315;6437.806865794034;6506.34936506355;6515.674216289167;6546.70539825709;6751.459883209332;6786.099892030239;6796.558223715443;6827.249002609709;6849.383555480031;6319.8104056878365;6402.743890244338;6409.519286053472;6484.1894763154605;6546;6588.538802283986;6664.566803157779;6689.531732778659;6696.732130714717;6703.363180497845;6622.470202383702;6639.634820084942;6661.134052573135;6663.833404164935;6670.9332906670315;6504.707288171949;6556.770513032021;6562.770303039561;6564.277929427663;6577.736890524326;5349.411564727955;5353.518183363516;5380.762424642276;5456.645318054314;5472.370677372153;6374.4263016326895;6440.967795160994;6526.869462610816;6612.371824676648;6693.297203793726;6457.321981192095;6462.483001359974;6482.222133344029;6576;6578.342165783383;6341.175647165839;6371.681415929278;6391.137196478416;6434.260060093149;6492.091107244895;6255.843603909939;6389.2652344980925;6423.839404014937;6437.5171862111465;6485.708143133476;6390.297067322498;6574.474042076718;6599.439047681001;6634.744186976258;6647.268800432045;6352.777652782131;6378.712957916812;6381.8085457436355;6422.582532135396;6430.582012169194 03:52:28 INFO - PID 8255 | |5;yui.html;895.3956079646246;922.958466868991;936.2790651198577;939.4598106089;952.7427594549474;19533;20377;20379.694304585406;20401.28595499156;20448;18022.459326220203;18050.90974545129;18148.092595370246;18713.064346782674;18811.717824232648;971.7230589282055;992.8609994600762;996.0238965813508;997.0278977996431;997.6458357283169;964.6527250189961;994.4480813148699;1000.5047501486774;1001.6694490818013;1003.9749006274865;1060.5386656804314;1061.3101484035362;1061.389700921969;1061.6390427254732;1067.460932229223;992.2111921022804;1055.984160237597;1058.5130839813733;1060.1306928318782;1061.787642471505;744.2185705009772;757.6249756370577;762.272030211147;762.4624639629048;762.5462849604477;20484.69272960907;20590.58818823615;20628.5874282515;20704.792952070587;20725.79274207269;21386.679199812017;21757.67363489549;22033.33899983003;22106;22228.88885555578;17312.307507699803;17484.475465735923;17528.912355438268;17544;17699.29202831885;3688.5389326334207;3721.1813401051727;3737.719671024684;3742.0644838790304;3746.569144548357;132320;132939;135527.32236338855;135637;139633;16453.341866325212;16909.32362705478;16928.746068808978;16989.915050424668;17071.743923841153;31006.37987240288;31084.844575776977;31763.364732705217;32176.839115804272;32514.512282315784;8362.707305244287;8405.327573794204;8415.410921235578;8418.158184181655;8433.578321083922;4193.475815523059;4277.315629499328;4313.956860431418;4327.870163895088;4328.826846926151;5341.919871201935;5497.862553436196;5534.667919924817;5546.667199968015;5561.805336813192;947.3699989507038;973.8490533967247;982.4252812104855;994.9452780097164;997.8004399120205;690.8411065454873;710.2861624067779;712.2307907459931;721.7798571435762;725.2529894208973;12116.21244619097;12144.757104857854;12213.45039473226;12467.625971220878;12708.301043442514;685.6468918506973;690.378659206718;696.989545156823;703.9190493093257;705.7529864547367;5743.310802703702;5768.019436695772;5779.624324418984;5789.913151302734;5865.560082993792;117972;119547;121806.39096804637;122224;123048.38475807743;103621;103690;105518;106623.93376066296;107315.46342268238;93261;94043;94204.52897735605;98074.50962744998;98513;10675.6345456269;10772.946135269274;10784.352938823695;10947.412625169147;11167.776644467227;42898.35652465153;43095.56904430916;43741.56258437375;44366;45209.77395113003;55440;57390;58049.70975145097;58940.70529647496;59736;16105.114218718083;16271.837281627033;16298.918505407397;16329.265183066553;16439;17216.311347545958;17265.39571115005;17266.136693165543;17383.82616173822;17394;15820.76268855945;15989;15995.840041599435;16115.355385784906;16210.27053782559;15584.610384740472;15619;15718.292676829342;15856.76214856755;15867.761983570486;15391.538253851955;15470.767938480707;15552.066875987477;15618.609534761268;15623.843761562239;12237.816432753338;12331.69170770738;12396.256224626552;12474.43865026058;12632.178908370926;11810.527578897092;11921.463534141158;11923.821142682693;11986;12110.697232569257 03:52:28 INFO - PID 8255 | __end_tp_report 03:52:28 INFO - PID 8255 | __start_cc_report 03:52:28 INFO - PID 8255 | _x_x_mozilla_cycle_collect,287 03:52:28 INFO - PID 8255 | __end_cc_report 03:52:28 INFO - PID 8255 | __startTimestamp1506595948407__endTimestamp 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | ------- Summary: start ------- 03:52:28 INFO - PID 8255 | Number of tests: 6 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | [#0] dojo.html Cycles:165 Average:6192.50 Median:6446.10 stddev:736.24 (11.4%) stddev-sans-first:700.21 03:52:28 INFO - PID 8255 | Values: 3205.2 3225.3 3234.0 3251.0 3282.5 6168.1 6252.6 6262.4 6294.1 6382.3 6259.5 6289.2 6291.3 6304.7 6318.7 5795.5 5809.5 5833.1 5838.9 5904.8 5640.4 5831.7 5907.0 5908.8 5922.8 5704.3 5739.4 5805.9 5816.3 5825.8 5766.3 5767.7 5825.7 5842.0 5851.4 5741.4 5748.1 5808.0 5813.1 5823.9 6162.6 6219.9 6223.0 6284.8 6334.2 6641.9 6644.6 6664.9 6669.6 6769.6 6747.5 6873.5 6875.5 6878.8 6914.7 6132.1 6211.9 6217.8 6327.5 6353.9 6937.5 7006.2 7016.3 7023.3 7025.6 6603.3 6612.4 6678.7 6678.9 6682.0 6682.4 6686.8 6766.6 6767.3 6776.0 6753.6 6758.3 6766.5 6775.8 6806.8 6622.1 6734.4 6746.1 6810.4 6852.5 5091.3 5164.1 5257.6 5358.3 5364.8 4514.3 4635.4 4642.6 4645.8 4688.9 5695.5 5792.2 5807.9 5809.8 5813.1 6638.2 6741.6 6748.5 6827.8 6838.5 5637.5 5669.7 5714.8 5743.3 5804.9 5753.4 5795.8 5806.3 5834.4 5840.9 6532.7 6548.8 6577.8 6649.1 6674.8 6612.8 6718.8 6741.6 6793.1 6814.7 6446.1 6452.4 6457.2 6463.3 6469.9 6519.2 6529.5 6617.2 6619.1 6665.9 6608.3 6706.1 6797.2 6803.6 6815.0 6432.9 6468.3 6477.9 6524.8 6574.8 6416.9 6464.3 6558.5 6591.4 6609.8 6454.5 6529.7 6536.5 6538.2 6550.4 6516.5 6533.7 6604.1 6608.1 6666.1 6216.3 6345.2 6345.6 6431.9 6443.7 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | [#1] ext.html Cycles:180 Average:37339.61 Median:35729.73 stddev:51865.61 (145.2%) stddev-sans-first:51938.82 03:52:28 INFO - PID 8255 | Values: 872.3 889.5 914.8 923.7 924.3 41862.4 42580.6 42835.9 42882.1 42988.1 38563.4 38904.8 42426.0 42800.1 42949.6 8052.1 8163.9 8200.3 8211.2 8231.5 7975.4 8101.8 8108.0 8109.6 8109.9 8118.3 8151.6 8152.7 8165.0 8177.6 8093.4 8122.3 8123.5 8135.4 8142.3 7952.2 8027.6 8027.8 8027.8 8030.0 39428.4 39472.2 39704.2 39714.2 39736.2 3629.3 3646.0 3655.1 3669.1 3672.0 32240.0 32401.7 32432.4 32456.0 32462.8 5065.7 5239.3 5304.0 5334.9 5369.1 193231.0 193671.0 193930.0 194470.0 194600.0 48002.3 48067.5 48141.8 48143.3 48226.8 50493.2 52138.2 52834.7 54217.7 54583.9 15216.8 15245.0 15325.4 15329.2 15337.0 12281.1 12319.6 12403.6 13117.3 13234.8 14977.5 15034.4 15092.3 15106.3 15154.5 5988.2 6014.5 6043.8 6163.7 6171.1 997.4 1009.9 1014.6 1020.2 1027.4 22820.3 23053.4 23190.3 23438.3 23778.2 1116.1 1130.4 1136.9 1143.0 1144.0 12536.6 12628.9 12651.3 12661.6 12762.6 213881.0 213904.0 214585.0 215291.0 215428.0 45204.0 45667.5 52137.0 52707.2 53366.2 1476.7 1483.9 1486.6 1490.7 1491.4 27010.8 27204.5 27593.7 27763.6 27788.6 37000.3 37070.3 37076.8 37210.8 37212.3 192493.0 192838.0 192864.0 193181.0 193755.0 33465.7 34789.7 35077.8 35331.6 35763.6 43185.0 43359.1 43706.0 43827.0 43924.0 31636.7 31823.2 31910.7 32066.4 32273.5 31155.4 31539.7 31700.8 31706.2 31727.8 35395.0 35693.0 35695.8 35915.0 35932.0 30701.2 31024.4 31263.0 31867.7 32322.2 23015.3 23123.7 23192.2 23475.9 23650.0 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | [#2] jquery.html Cycles:180 Average:34709.85 Median:22069.83 stddev:81446.64 (369.0%) stddev-sans-first:81634.82 03:52:28 INFO - PID 8255 | Values: 587.3 590.7 594.6 614.0 615.9 22735.4 23574.6 23584.1 23587.3 23649.5 20088.5 21085.5 24902.4 24963.3 25127.4 6317.6 6502.2 6502.9 6507.7 6512.4 6392.6 6394.2 6499.3 6501.6 6505.4 6633.5 6665.1 6668.1 6668.7 6676.7 6622.1 6670.0 6670.0 6674.9 6684.1 5908.1 6162.9 6184.3 6206.9 6208.6 27840.4 28299.7 28343.6 28353.7 28382.3 2052.4 2061.0 2064.0 2070.2 2070.2 18367.8 18805.2 19105.9 19112.6 19117.3 2477.6 2509.7 2537.7 2543.7 2558.6 123387.0 129476.0 142544.0 150548.2 150741.0 14806.9 14850.6 15102.0 15129.7 15141.4 23996.8 24007.9 24046.4 24074.8 24083.5 10268.3 10316.4 10390.2 10501.5 10517.4 9479.8 9544.5 9607.7 9670.5 9701.0 8949.9 9065.4 9168.4 9236.9 9431.3 2600.3 2619.5 2695.5 2737.2 2761.9 943.6 966.9 974.5 978.4 979.8 18448.0 18484.3 18557.6 18977.1 19358.5 1010.2 1017.7 1020.3 1022.4 1027.1 10339.9 10340.7 10654.6 10666.7 10837.8 473986.0 478613.0 478708.0 483101.0 492761.0 113778.0 114703.4 114989.0 115915.4 116829.0 1156.0 1173.9 1240.9 1248.6 1256.1 19772.5 19869.0 19974.5 20013.9 20153.4 58414.7 60007.4 61332.4 61366.7 61969.4 76864.6 76869.2 76975.2 77891.6 78213.0 14250.1 14631.9 14639.8 14698.4 14740.0 21402.1 21535.9 21877.6 22063.7 22076.0 17461.2 17602.6 17717.5 17728.0 17809.7 15719.0 16101.8 16252.5 16394.8 16422.2 17357.8 17928.5 17954.3 18139.1 18196.8 14434.4 14517.4 14615.1 14623.5 14716.0 17852.6 17923.5 18088.7 18212.8 18221.3 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | [#3] mootools.html Cycles:180 Average:9690.25 Median:2546.76 stddev:6987.84 (274.4%) stddev-sans-first:6979.23 03:52:28 INFO - PID 8255 | Values: 1332.4 1394.6 1410.5 1416.3 1420.9 15297.4 15592.7 15936.5 15985.6 15998.7 16295.1 16502.3 16506.8 16525.7 16526.3 2630.3 2703.6 2704.6 2705.6 2706.9 2602.8 2618.1 2661.2 2724.0 2818.1 2651.2 2688.8 2690.4 2691.9 2692.8 2546.2 2565.7 2567.4 2572.8 2573.8 2547.3 2593.9 2681.4 2705.7 2727.2 15740.6 15853.6 15863.1 15882.2 15919.3 8261.2 8577.1 8586.2 8588.7 8594.5 5408.8 5590.8 5646.9 5685.5 5740.4 1966.0 2011.2 2043.2 2061.1 2081.0 27263.7 27470.6 27472.0 27485.3 27526.0 6795.6 7560.8 7654.7 7847.3 7868.0 17928.2 17980.1 18022.9 18078.5 18096.8 8192.1 8394.2 8398.8 8400.1 8409.6 7270.2 7539.7 7545.7 7639.6 7727.1 5135.8 5365.2 5365.5 5403.6 5407.4 1368.9 1416.7 1423.6 1430.3 1565.4 918.2 940.4 941.6 949.5 958.1 8211.8 8621.0 8775.0 8847.1 8932.7 1008.0 1017.2 1020.8 1023.2 1036.7 4735.0 4806.1 4869.8 5276.5 5633.0 21494.9 22491.1 22725.8 22938.8 22942.4 22399.9 22661.3 22711.7 22888.5 22961.7 10028.2 10290.5 10391.6 10433.1 10490.5 8257.4 8287.1 8327.6 8382.8 8453.1 18577.3 18839.9 19098.3 19526.0 19739.5 19706.6 19742.3 19793.3 19877.5 20398.7 11448.2 11631.5 11632.5 11640.3 11655.2 14480.3 14523.5 14602.1 14683.0 14787.4 11699.5 11730.0 11787.3 12007.7 12318.0 11378.7 11681.8 11745.7 11892.7 11975.2 10283.1 10378.8 10421.4 10422.0 10425.9 7434.6 7438.6 7464.7 7498.2 7646.1 7756.8 7785.1 7798.1 7821.4 7926.5 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | [#4] prototype.html Cycles:180 Average:5599.89 Median:6259.26 stddev:1495.18 (23.9%) stddev-sans-first:1449.87 03:52:28 INFO - PID 8255 | Values: 516.5 516.8 533.6 536.5 537.0 6225.6 6350.9 6358.9 6375.0 6386.7 6290.4 6320.6 6342.6 6347.3 6365.6 5204.8 5209.0 5219.2 5223.7 5238.2 4856.3 5004.6 5161.4 5169.5 5211.5 4974.1 4985.6 4989.5 4991.3 5005.6 4980.2 4981.2 4981.7 4986.4 4988.0 4764.0 4875.8 4894.6 4906.3 4913.8 6034.1 6104.9 6175.6 6231.2 6262.7 5939.3 5953.9 5976.3 5982.3 6019.3 6651.7 6653.2 6663.7 6677.0 6716.9 5003.6 5273.7 5311.2 5336.4 5349.6 6656.8 6731.5 6809.8 6834.5 6843.9 5438.5 5465.9 5471.9 5475.4 5480.1 5502.5 5506.1 5512.5 5534.4 5563.7 5866.9 5933.4 5957.3 6004.3 6023.4 6592.3 6653.0 6666.7 6683.6 6742.0 1895.1 1916.7 1928.3 1940.6 1949.7 1379.9 1446.2 1446.8 1455.1 1461.5 5645.9 5672.7 5682.3 5693.3 5741.3 6635.2 6718.9 6728.9 6754.2 6759.0 5629.2 5656.5 5700.3 5714.7 5723.0 3528.0 3529.8 3540.4 3544.2 3546.4 6429.6 6437.8 6506.3 6515.7 6546.7 6751.5 6786.1 6796.6 6827.2 6849.4 6319.8 6402.7 6409.5 6484.2 6546.0 6588.5 6664.6 6689.5 6696.7 6703.4 6622.5 6639.6 6661.1 6663.8 6670.9 6504.7 6556.8 6562.8 6564.3 6577.7 5349.4 5353.5 5380.8 5456.6 5472.4 6374.4 6441.0 6526.9 6612.4 6693.3 6457.3 6462.5 6482.2 6576.0 6578.3 6341.2 6371.7 6391.1 6434.3 6492.1 6255.8 6389.3 6423.8 6437.5 6485.7 6390.3 6574.5 6599.4 6634.7 6647.3 6352.8 6378.7 6381.8 6422.6 6430.6 03:52:28 INFO - PID 8255 | 03:52:28 INFO - PID 8255 | [#5] yui.html Cycles:180 Average:24177.74 Median:20424.64 stddev:34536.05 (169.1%) stddev-sans-first:34588.69 03:52:28 INFO - PID 8255 | Values: 895.4 923.0 936.3 939.5 952.7 19533.0 20377.0 20379.7 20401.3 20448.0 18022.5 18050.9 18148.1 18713.1 18811.7 971.7 992.9 996.0 997.0 997.6 964.7 994.4 1000.5 1001.7 1004.0 1060.5 1061.3 1061.4 1061.6 1067.5 992.2 1056.0 1058.5 1060.1 1061.8 744.2 757.6 762.3 762.5 762.5 20484.7 20590.6 20628.6 20704.8 20725.8 21386.7 21757.7 22033.3 22106.0 22228.9 17312.3 17484.5 17528.9 17544.0 17699.3 3688.5 3721.2 3737.7 3742.1 3746.6 132320.0 132939.0 135527.3 135637.0 139633.0 16453.3 16909.3 16928.7 16989.9 17071.7 31006.4 31084.8 31763.4 32176.8 32514.5 8362.7 8405.3 8415.4 8418.2 8433.6 4193.5 4277.3 4314.0 4327.9 4328.8 5341.9 5497.9 5534.7 5546.7 5561.8 947.4 973.8 982.4 994.9 997.8 690.8 710.3 712.2 721.8 725.3 12116.2 12144.8 12213.5 12467.6 12708.3 685.6 690.4 697.0 703.9 705.8 5743.3 5768.0 5779.6 5789.9 5865.6 117972.0 119547.0 121806.4 122224.0 123048.4 103621.0 103690.0 105518.0 106623.9 107315.5 93261.0 94043.0 94204.5 98074.5 98513.0 10675.6 10772.9 10784.4 10947.4 11167.8 42898.4 43095.6 43741.6 44366.0 45209.8 55440.0 57390.0 58049.7 58940.7 59736.0 16105.1 16271.8 16298.9 16329.3 16439.0 17216.3 17265.4 17266.1 17383.8 17394.0 15820.8 15989.0 15995.8 16115.4 16210.3 15584.6 15619.0 15718.3 15856.8 15867.8 15391.5 15470.8 15552.1 15618.6 15623.8 12237.8 12331.7 12396.3 12474.4 12632.2 11810.5 11921.5 11923.8 11986.0 12110.7 03:52:28 INFO - PID 8255 | -------- Summary: end -------- 03:52:28 INFO - PID 8255 | 03:52:28 INFO - TEST-INFO | 8255: exit 0 03:52:28 INFO - TEST-OK | dromaeo_css | took 1109209ms 03:52:28 INFO - TEST-START | kraken 03:52:28 INFO - Initialising browser for kraken test... 03:52:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52136/getInfo.html -profile /tmp/tmpzmCi6x/profile 03:52:28 INFO - TEST-INFO | started process 8623 (/builds/slave/test/build/application/firefox/firefox http://localhost:52136/getInfo.html) 03:52:34 INFO - TEST-INFO | 8623: exit 0 03:52:34 INFO - Browser initialized. 03:52:34 INFO - Running cycle 1/1 for kraken test... 03:52:34 INFO - Using env: {'DISPLAY': ':0', 03:52:34 INFO - 'HOME': '/home/cltbld', 03:52:34 INFO - 'JSGC_DISABLE_POISONING': '1', 03:52:34 INFO - 'LANG': 'en_US.UTF-8', 03:52:34 INFO - 'LANGUAGE': 'en_US:en', 03:52:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:52:34 INFO - 'LOGNAME': 'cltbld', 03:52:34 INFO - 'MAIL': '/var/mail/cltbld', 03:52:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:52:34 INFO - 'MOZ_CRASHREPORTER': '1', 03:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:52:34 INFO - 'MOZ_NO_REMOTE': '1', 03:52:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:34 INFO - 'NO_EM_RESTART': '1', 03:52:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:34 INFO - 'PWD': '/builds/slave/test', 03:52:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:34 INFO - 'RUST_BACKTRACE': 'full', 03:52:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:52:34 INFO - 'SHELL': '/bin/bash', 03:52:34 INFO - 'SHLVL': '1', 03:52:34 INFO - 'TERM': 'linux', 03:52:34 INFO - 'TMOUT': '86400', 03:52:34 INFO - 'USER': 'cltbld', 03:52:34 INFO - 'XDG_SESSION_COOKIE': '781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893', 03:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:34 INFO - '_': '/tools/buildbot/bin/python'} 03:52:34 INFO - TEST-INFO | started process 8860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzmCi6x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:35 INFO - PID 8860 | 03:52:35 INFO - PID 8860 | (/builds/slave/test/build/application/firefox/firefox:8909): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:52:35 INFO - PID 8860 | 03:52:45 INFO - PID 8860 | RSS: Main: 151429120 03:52:45 INFO - PID 8860 | 03:52:48 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52136/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:49 INFO - PID 8860 | RSS: Main: 156934144 03:52:49 INFO - PID 8860 | 03:52:52 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52136/tests/kraken/driver.html?testName=audio-dft) 03:52:52 INFO - PID 8860 | RSS: Main: 157356032 03:52:52 INFO - PID 8860 | 03:52:55 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52136/tests/kraken/driver.html?testName=audio-fft) 03:52:56 INFO - PID 8860 | RSS: Main: 154423296 03:52:56 INFO - PID 8860 | 03:52:58 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52136/tests/kraken/driver.html?testName=audio-oscillator) 03:52:58 INFO - PID 8860 | RSS: Main: 155009024 03:52:58 INFO - PID 8860 | 03:53:01 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:53:01 INFO - PID 8860 | RSS: Main: 155295744 03:53:01 INFO - PID 8860 | 03:53:04 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52136/tests/kraken/driver.html?testName=imaging-darkroom) 03:53:05 INFO - PID 8860 | RSS: Main: 157188096 03:53:05 INFO - PID 8860 | 03:53:09 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52136/tests/kraken/driver.html?testName=imaging-desaturate) 03:53:09 INFO - PID 8860 | RSS: Main: 157655040 03:53:09 INFO - PID 8860 | 03:53:12 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52136/tests/kraken/driver.html?testName=json-parse-financial) 03:53:13 INFO - PID 8860 | RSS: Main: 157761536 03:53:13 INFO - PID 8860 | 03:53:15 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:53:15 INFO - PID 8860 | RSS: Main: 158216192 03:53:15 INFO - PID 8860 | 03:53:17 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:53:17 INFO - PID 8860 | RSS: Main: 157495296 03:53:17 INFO - PID 8860 | 03:53:19 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:53:20 INFO - PID 8860 | RSS: Main: 154505216 03:53:20 INFO - PID 8860 | 03:53:23 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:53:23 INFO - PID 8860 | RSS: Main: 155004928 03:53:23 INFO - PID 8860 | 03:53:26 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:53:27 INFO - PID 8860 | RSS: Main: 155361280 03:53:27 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | Cycle 1(1): loaded http://localhost:52136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52136/tests/kraken/driver.html?testName=ai-astar) 03:53:29 INFO - PID 8860 | RSS: Main: 156626944 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | __start_tp_report 03:53:29 INFO - PID 8860 | _x_x_mozilla_page_load 03:53:29 INFO - PID 8860 | _x_x_mozilla_page_load_details 03:53:29 INFO - PID 8860 | |i|pagename|runs| 03:53:29 INFO - PID 8860 | |0;ai-astar;107;107;105;109;107;97;107;107;107;106 03:53:29 INFO - PID 8860 | |1;audio-beat-detection;118;119;116;117;116;116;142;120;119;127 03:53:29 INFO - PID 8860 | |2;audio-dft;163;166;163;162;162;162;162;168;164;164 03:53:29 INFO - PID 8860 | |3;audio-fft;76;74;73;73;74;75;74;74;71;74 03:53:29 INFO - PID 8860 | |4;audio-oscillator;82;80;80;79;78;78;79;79;80;126 03:53:29 INFO - PID 8860 | |5;imaging-gaussian-blur;115;114;115;114;114;114;114;114;115;114 03:53:29 INFO - PID 8860 | |6;imaging-darkroom;148;149;149;148;149;148;149;148;149;150 03:53:29 INFO - PID 8860 | |7;imaging-desaturate;94;94;93;94;94;94;94;95;94;94 03:53:29 INFO - PID 8860 | |8;json-parse-financial;52;52;52;53;53;60;53;53;52;51 03:53:29 INFO - PID 8860 | |9;json-stringify-tinderbox;36;37;37;38;37;37;37;37;37;37 03:53:29 INFO - PID 8860 | |10;stanford-crypto-aes;72;73;82;78;73;72;80;73;72;73 03:53:29 INFO - PID 8860 | |11;stanford-crypto-ccm;113;111;118;112;113;114;113;124;118;118 03:53:29 INFO - PID 8860 | |12;stanford-crypto-pbkdf2;173;169;167;164;168;173;172;177;165;171 03:53:29 INFO - PID 8860 | |13;stanford-crypto-sha256-iterative;67;64;67;65;66;64;64;68;65;68 03:53:29 INFO - PID 8860 | __end_tp_report 03:53:29 INFO - PID 8860 | __start_cc_report 03:53:29 INFO - PID 8860 | _x_x_mozilla_cycle_collect,737 03:53:29 INFO - PID 8860 | __end_cc_report 03:53:29 INFO - PID 8860 | __startTimestamp1506596009433__endTimestamp 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | ------- Summary: start ------- 03:53:29 INFO - PID 8860 | Number of tests: 14 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#0] ai-astar Cycles:10 Average:105.90 Median:107.00 stddev:3.28 (3.1%) stddev-sans-first:3.46 03:53:29 INFO - PID 8860 | Values: 107.0 107.0 105.0 109.0 107.0 97.0 107.0 107.0 107.0 106.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#1] audio-beat-detection Cycles:10 Average:121.00 Median:119.00 stddev:8.07 (6.8%) stddev-sans-first:8.49 03:53:29 INFO - PID 8860 | Values: 118.0 119.0 116.0 117.0 116.0 116.0 142.0 120.0 119.0 127.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.01 (1.2%) stddev-sans-first:2.12 03:53:29 INFO - PID 8860 | Values: 163.0 166.0 163.0 162.0 162.0 162.0 162.0 168.0 164.0 164.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#3] audio-fft Cycles:10 Average:73.80 Median:74.00 stddev:1.32 (1.8%) stddev-sans-first:1.13 03:53:29 INFO - PID 8860 | Values: 76.0 74.0 73.0 73.0 74.0 75.0 74.0 74.0 71.0 74.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#4] audio-oscillator Cycles:10 Average:84.10 Median:79.50 stddev:14.77 (18.6%) stddev-sans-first:15.64 03:53:29 INFO - PID 8860 | Values: 82.0 80.0 80.0 79.0 78.0 78.0 79.0 79.0 80.0 126.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:53:29 INFO - PID 8860 | Values: 115.0 114.0 115.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 03:53:29 INFO - PID 8860 | Values: 148.0 149.0 149.0 148.0 149.0 148.0 149.0 148.0 149.0 150.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:53:29 INFO - PID 8860 | Values: 94.0 94.0 93.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:2.51 (4.7%) stddev-sans-first:2.64 03:53:29 INFO - PID 8860 | Values: 52.0 52.0 52.0 53.0 53.0 60.0 53.0 53.0 52.0 51.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#9] json-stringify-tinderbox Cycles:10 Average:37.00 Median:37.00 stddev:0.47 (1.3%) stddev-sans-first:0.33 03:53:29 INFO - PID 8860 | Values: 36.0 37.0 37.0 38.0 37.0 37.0 37.0 37.0 37.0 37.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:73.00 stddev:3.74 (5.1%) stddev-sans-first:3.82 03:53:29 INFO - PID 8860 | Values: 72.0 73.0 82.0 78.0 73.0 72.0 80.0 73.0 72.0 73.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:116.00 stddev:4.01 (3.5%) stddev-sans-first:4.15 03:53:29 INFO - PID 8860 | Values: 113.0 111.0 118.0 112.0 113.0 114.0 113.0 124.0 118.0 118.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:171.50 stddev:4.04 (2.4%) stddev-sans-first:4.13 03:53:29 INFO - PID 8860 | Values: 173.0 169.0 167.0 164.0 168.0 173.0 172.0 177.0 165.0 171.0 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.50 stddev:1.62 (2.4%) stddev-sans-first:1.66 03:53:29 INFO - PID 8860 | Values: 67.0 64.0 67.0 65.0 66.0 64.0 64.0 68.0 65.0 68.0 03:53:29 INFO - PID 8860 | -------- Summary: end -------- 03:53:29 INFO - PID 8860 | 03:53:29 INFO - PID 8860 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:53:30 INFO - TEST-INFO | 8860: exit 0 03:53:30 INFO - TEST-OK | kraken | took 61162ms 03:53:30 INFO - SUITE-END | took 1170s 03:53:30 INFO - Completed test suite (00:19:30) 03:53:30 INFO - javascript benchmark 03:53:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8623.632037396852, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.2147223930133, 3225.306559089798, 3233.967660323396, 3250.983745081275, 3282.45839436493, 6168.136460895478, 6252.624842509453, 6262.405071518204, 6294.087357333184, 6382.297947225808, 6259.530535209855, 6289.213848268966, 6291.276503202133, 6304.747810087591, 6318.715657795398, 5795.536357091433, 5809.506191973687, 5833.066709326508, 5838.912416313738, 5904.763809447617, 5640.351359593637, 5831.737571809279, 5907.0, 5908.793192238272, 5922.7927022554, 5704.286964129484, 5739.397363276879, 5805.854853628651, 5816.302043754756, 5825.825225243249, 5766.250387449647, 5767.711614419262, 5825.7087145642545, 5841.970790146064, 5851.4148585141575, 5741.397153298927, 5748.137779333092, 5808.012637851575, 5813.09896965971, 5823.883522329572, 6162.599431036968, 6219.906701399483, 6222.97320942044, 6284.842878928063, 6334.208223972004, 6641.900371494431, 6644.60132392058, 6664.866702665968, 6669.633170175638, 6769.627670478122, 6747.505968833304, 6873.518853680244, 6875.518713690044, 6878.759243426506, 6914.723411063552, 6132.080187971796, 6211.937880621226, 6217.844553886189, 6327.46216571592, 6353.872922541569, 6937.479689023344, 7006.159260888726, 7016.298370163045, 7023.33278338557, 7025.578465292099, 6603.306652801482, 6612.371824676648, 6678.732850686015, 6678.899816502756, 6681.997700344987, 6682.398584127452, 6686.765963191265, 6766.594004359656, 6767.2894346093935, 6776.01747746574, 6753.561018533779, 6758.256591774901, 6766.458683305324, 6775.830604234933, 6806.76176333826, 6622.072909792633, 6734.427573656294, 6746.055552222692, 6810.38706516406, 6852.486063545254, 5091.287219789232, 5164.122099243138, 5257.6056795739705, 5358.33020872391, 5364.758585863646, 4514.34541991416, 4635.443746750344, 4642.558956899156, 4645.837395691135, 4688.929666055012, 5695.515881150066, 5792.189093526826, 5807.912881306784, 5809.7966571170655, 5813.069908814654, 6638.17022872141, 6741.561798483083, 6748.4938629602975, 6827.829304267433, 6838.452923766087, 5637.548996080303, 5669.744861481243, 5714.771409143671, 5743.282089738783, 5804.88390232193, 5753.367129615739, 5795.797147099831, 5806.274215723035, 5834.445727655866, 5840.853978650568, 6532.6733663316645, 6548.770793022221, 6577.83555411109, 6649.102371179829, 6674.799756007327, 6612.8346791330605, 6718.764843230463, 6741.595504269563, 6793.082933803873, 6814.727410903508, 6446.0975463434215, 6452.387023232785, 6457.225132984072, 6463.321351258238, 6469.935300647122, 6519.152510173647, 6529.542931994904, 6617.172853393326, 6619.073329733745, 6665.866682666417, 6608.306127856698, 6706.061151438705, 6797.218319893078, 6803.591784492946, 6815.0, 6432.935670643234, 6468.320826313357, 6477.902831457438, 6524.836879078061, 6574.8356291091195, 6416.871662566816, 6464.321246269262, 6558.475321974135, 6591.406773390418, 6609.768658096944, 6454.548181627241, 6529.7388104475285, 6536.542442029012, 6538.248101468392, 6550.377714117151, 6516.478681705547, 6533.705983230671, 6604.14146160996, 6608.1079054328975, 6666.066750654815, 6216.2540495139065, 6345.206849143857, 6345.619262844244, 6431.903521447089, 6443.71003304843], "value": 6137.705539264488, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.3108744092167, 889.4796544021747, 914.7667344827072, 923.7182659288915, 924.3160061554449, 41862.37206441902, 42580.57419425805, 42835.92910177247, 42882.142357152836, 42988.140237195235, 38563.42154867679, 38904.80547597258, 42426.0, 42800.14399712004, 42949.57050429503, 8052.07401148868, 8163.918360816405, 8200.26197642212, 8211.1788821118, 8231.506109633412, 7975.361971042303, 8101.837963240731, 8107.959460202691, 8109.594520273992, 8109.918900810975, 8118.309943654767, 8151.592420378987, 8152.673893044271, 8165.020197576299, 8177.591120443954, 8093.4334596578265, 8122.2689957903485, 8123.512589244664, 8135.430519863641, 8142.267195952363, 7952.20477952206, 8027.638756255982, 8027.799305017363, 8027.839443211162, 8029.95985020077, 39428.40857387141, 39472.21055578901, 39704.20591588152, 39714.20571588581, 39736.20527589432, 3629.256002519477, 3645.981770091159, 3655.1227705350525, 3669.101070237782, 3672.0452682302525, 32240.0, 32401.6759832401, 32432.351352972808, 32456.0, 32462.837685811657, 5065.696058236517, 5239.266502689627, 5304.0, 5334.893302133935, 5369.060414427459, 193231.0, 193671.0316448423, 193930.0, 194470.0, 194600.0, 48002.27996580054, 48067.51932480631, 48141.75929120332, 48143.277850832266, 48226.758866206146, 50493.24260136101, 52138.21792673113, 52834.67913302198, 54217.72891135598, 54583.90832183334, 15216.771748423782, 15245.0, 15325.386984520717, 15329.233538323038, 15337.0, 12281.078919081105, 12319.568815091428, 12403.62789116328, 13117.278549679859, 13234.801477977839, 14977.475788347356, 15034.398624055135, 15092.320845561977, 15106.320215590325, 15154.469593564172, 5988.161657367972, 6014.48876845473, 6043.758249669964, 6163.660998645118, 6171.13604095427, 997.3517213811081, 1009.8939611340851, 1014.629660174046, 1020.1583693452931, 1027.3989716016065, 22820.31539053831, 23053.423664408525, 23190.28825498313, 23438.296851094496, 23778.16776412817, 1116.1461481966303, 1130.3726431830248, 1136.852209212797, 1142.9542818287175, 1143.971400714972, 12536.561220357244, 12628.873711262953, 12651.304178270284, 12661.556845510362, 12762.553310634083, 213881.0, 213904.0, 214585.0, 215291.0, 215428.0, 45204.0, 45667.54332456699, 52137.0, 52707.209391859156, 53366.199507007426, 1476.6529865481602, 1483.8887083468783, 1486.6134804950575, 1490.739120653903, 1491.395984626228, 27010.839132869718, 27204.455910881275, 27593.724062759116, 27763.583546247228, 27788.583171252852, 37000.25999480049, 37070.25859482741, 37076.81461592675, 37210.813945930095, 37212.25575488529, 192493.0, 192838.0, 192864.0, 193181.0, 193755.03122484297, 33465.66534334723, 34789.65210347864, 35077.824610876785, 35331.646683533865, 35763.64236357603, 43185.0, 43359.13281734411, 43706.0, 43827.0, 43924.0, 31636.683633164295, 31823.204419889687, 31910.680893190773, 32066.358672825947, 32273.51589726203, 31155.37689246248, 31539.684603153673, 31700.841495793295, 31706.207344816565, 31727.841360793973, 35395.0, 35693.0, 35695.82152089223, 35915.0, 35932.0, 30701.23246918845, 31024.379512410076, 31263.0, 31867.681323186473, 32322.191945201557, 23015.309540713806, 23123.653145202497, 23192.18827341035, 23475.882620586788, 23650.0], "value": 17454.654281589083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.3157771196556, 590.7016956436996, 594.5927039977615, 613.9624035380207, 615.9414855588719, 22735.431614209654, 23574.646380304268, 23584.05663773449, 23587.29238122859, 23649.5270094598, 20088.49778755532, 21085.47286317839, 24902.377440563996, 24963.25110246691, 25127.371815704617, 6317.5893566918, 6502.154719886408, 6502.869942601145, 6507.739690412378, 6512.413882750551, 6392.6484043377595, 6394.200724909387, 6499.252585952629, 6501.642409667466, 6505.4145126938565, 6633.469322454216, 6665.066890635315, 6668.133142691443, 6668.666566671672, 6676.666166691671, 6622.139121914121, 6669.9666501667425, 6670.0, 6674.866502669944, 6684.097646817715, 5908.084246941731, 6162.938370616326, 6184.319724830265, 6206.906896396557, 6208.627482351073, 27840.443191136063, 28299.717002829915, 28343.57484637732, 28353.716462835313, 28382.290442739097, 2052.3945436096237, 2060.9793902061087, 2064.0092755477453, 2070.2133189388087, 2070.244360808309, 18367.816321836744, 18805.24779008838, 19105.904470477697, 19112.61774764511, 19117.330893418664, 2477.5911974524183, 2509.723930367658, 2537.708163561177, 2543.74562543746, 2558.60341647045, 123387.0, 129476.0, 142544.0, 150548.2472587641, 150741.0, 14806.925965370105, 14850.554483365517, 15102.0, 15129.697406051817, 15141.394344226328, 23996.7600323998, 24007.879960600436, 24046.39884002914, 24074.759252407253, 24083.51832963331, 10268.281220314655, 10316.381017138845, 10390.22073344487, 10501.474926253657, 10517.42154181512, 9479.76300592477, 9544.475053871965, 9607.663731769355, 9670.516474176264, 9701.0, 8949.865752013726, 9065.41074830134, 9168.358214925025, 9236.907630923739, 9431.292653051049, 2600.269716797355, 2619.4761047790516, 2695.474382495434, 2737.2335745991154, 2761.9171424857286, 943.5942544705705, 966.8984756600596, 974.512743628186, 978.3787295067541, 979.7550612346913, 18448.0, 18484.260629574666, 18557.628847422977, 18977.146028428753, 19358.516037098903, 1010.1666125446536, 1017.7455636090978, 1020.2959957629212, 1022.4478781458079, 1027.0653705128298, 10339.896601034045, 10340.689779306633, 10654.573817047387, 10666.679999600025, 10837.783244335069, 473986.0, 478613.0, 478708.0, 483101.0, 492761.0, 113778.0, 114703.42648286706, 114989.0, 115915.42042289734, 116829.0, 1156.0, 1173.906087513014, 1240.9103318194263, 1248.5942068827485, 1256.0830593666674, 19772.50568735793, 19869.0, 19974.50063748418, 20013.899930500254, 20153.39539813808, 58414.7079264601, 60007.39992600018, 61332.386676134454, 61366.69316653388, 61969.38030619636, 76864.61567692125, 76869.23130768845, 76975.23024769904, 77891.61054194692, 78213.0, 14250.073745206528, 14631.92684036573, 14639.780403293746, 14698.41206351734, 14740.0, 21402.143914243257, 21535.892320538296, 21877.562448750617, 22063.66904496402, 22076.0, 17461.214245358737, 17602.647947041245, 17717.46847594574, 17728.0, 17809.73285400746, 15719.0, 16101.75847362267, 16252.51242462728, 16394.754078689068, 16422.178891055162, 17357.826421735623, 17928.462146135636, 17954.281828727228, 18139.093045347418, 18196.818031820043, 14434.422623094959, 14517.419303228175, 14615.123092614476, 14623.488177913721, 14716.043457175678, 17852.55368615795, 17923.462296131136, 18088.72866907024, 18212.817871821113, 18221.271149154414], "value": 11986.158567344222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.4270563657626, 1394.6304229379216, 1410.492222799792, 1416.3272445588352, 1420.9147451152933, 15297.388104475822, 15592.68814623707, 15936.521904342873, 15985.600359990991, 15998.680026399465, 16295.103769292713, 16502.25739841707, 16506.75239871403, 16525.66948661026, 16526.338946442156, 2630.3292660371626, 2703.648525691657, 2704.5537486314834, 2705.6076868854007, 2706.851123188224, 2602.791776657872, 2618.0836707152534, 2661.241546159345, 2724.0465836957105, 2818.0841226601333, 2651.1781347782153, 2688.7714544263763, 2690.3946612012337, 2691.946161076777, 2692.798040146987, 2546.2488565873114, 2565.6536367590325, 2567.396661784479, 2572.781313588347, 2573.768360847523, 2547.274026902324, 2593.870306484668, 2681.410089780245, 2705.702372738997, 2727.2227415186576, 15740.60648483797, 15853.60365990848, 15863.127527985956, 15882.205889705469, 15919.283632236577, 8261.17388261175, 8577.142285771435, 8586.184312490303, 8588.742337729878, 8594.4843309401, 5408.756605952742, 5590.804321848756, 5646.943530564724, 5685.4883060524335, 5740.368559458456, 1966.0, 2011.155314767801, 2043.1929387891848, 2061.051916118587, 2081.0427203486265, 27263.727362726517, 27470.5879411809, 27472.0, 27485.31286717828, 27526.0, 6795.558288711218, 7560.848783024308, 7654.655540500579, 7847.332976696931, 7867.960660196777, 17928.193231304624, 17980.1009949502, 18022.90988545049, 18078.548036298936, 18096.819031809515, 8192.098869124391, 8394.202550757791, 8398.79003024917, 8400.117987611335, 8409.621567029499, 7270.236625154388, 7539.736109236151, 7545.660445279866, 7639.618019099134, 7727.072751269883, 5135.794568217229, 5365.248865158881, 5365.54392876602, 5403.594730395236, 5407.405185429599, 1368.931553422325, 1416.6812467195005, 1423.6440889777555, 1430.3348942741675, 1565.3894980957436, 918.2057520245073, 940.4122423485321, 941.5715849288557, 949.4872768704822, 958.0898146760605, 8211.794705132419, 8620.956895215484, 8774.956125219333, 8847.11528847123, 8932.732018039469, 1007.9748006299754, 1017.1862509991977, 1020.831562792131, 1023.2121266624806, 1036.6630844975414, 4735.0, 4806.110869489085, 4869.756512174377, 5276.472352764693, 5633.0, 21494.892525537583, 22491.07616009908, 22725.772742272366, 22938.770612293996, 22942.426439338815, 22399.88800055989, 22661.320160395215, 22711.659325110137, 22888.542229155657, 22961.655575166387, 10028.197744180448, 10290.485475726184, 10391.636292729718, 10433.113185379329, 10490.527926243338, 8257.38069644791, 8287.12985136552, 8327.625256863577, 8382.790430239049, 8453.070162282022, 18577.256909724, 18839.90580047091, 19098.331558395945, 19526.0, 19739.506512337306, 19706.605867882274, 19742.30901918426, 19793.30723424731, 19877.503062422977, 20398.69401958942, 11448.198626096093, 11631.53473861036, 11632.53469861196, 11640.301581905112, 11655.18413711066, 14480.275986200859, 14523.491677791226, 14602.12387256768, 14683.045602036262, 14787.408503659733, 11699.473523691284, 11730.0, 11787.292762434281, 12007.699807504881, 12318.0, 11378.715532111431, 11681.766364672489, 11745.706357341134, 11892.702682433008, 11975.161738678209, 10283.07452329264, 10378.792424151627, 10421.426821524889, 10422.0, 10425.9478702606, 7434.553926764412, 7438.5536867788105, 7464.701411943679, 7498.175200728025, 7646.120696120018, 7756.806079848049, 7785.104712958082, 7798.103218129988, 7821.374290056896, 7926.48477848938], "value": 6872.426743544011, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.4835164835165, 516.7726200471792, 533.5864704853738, 536.4876542901529, 536.975836087376, 6225.564210505267, 6350.904736428952, 6358.904616430746, 6375.0, 6386.744530218792, 6290.433860952513, 6320.557560970722, 6342.619442833433, 6347.333529979355, 6365.6498892561, 5204.791808327663, 5209.0, 5219.243209734586, 5223.660462069973, 5238.214267859814, 4856.271559266103, 5004.649674522785, 5161.4322424533275, 5169.508896654812, 5211.504907033845, 4974.1295273327205, 4985.601151907838, 4989.501049895018, 4991.276264941581, 5005.649604527666, 4980.2280646499485, 4981.2279096739885, 4981.701097934136, 4986.426560945483, 4987.975060124712, 4763.952360476385, 4875.756212189376, 4894.583960363373, 4906.2640603909695, 4913.778879950411, 6034.069097888678, 6104.877902441926, 6175.59858609189, 6231.22109736283, 6262.684836184407, 5939.2575928009, 5953.851153721148, 5976.282846058457, 5982.312034116088, 6019.277686677627, 6651.700673469705, 6653.234877989044, 6663.733450661967, 6676.9666151668935, 6716.865662686768, 5003.574696150795, 5273.709945952971, 5311.150215965466, 5336.359636843604, 5349.59878009147, 6656.7670131545165, 6731.461483081342, 6809.761658341934, 6834.521583489208, 6843.8973415399305, 5438.510534051954, 5465.863353416117, 5471.917921231185, 5475.397706252309, 5480.095784195642, 5502.504774570308, 5506.1190209566275, 5512.476314750093, 5534.418886016911, 5563.721813909288, 5866.941330586639, 5933.436323549256, 5957.314908785545, 6004.279486461565, 6023.427774361428, 6592.340765923369, 6653.0, 6666.699998500079, 6683.6324002180345, 6741.966290168518, 1895.1282410091237, 1916.7445323313252, 1928.3154480159342, 1940.5924755801157, 1949.6880499120073, 1379.9448022079005, 1446.2190417174609, 1446.8191476065492, 1455.1196526101767, 1461.5176991592962, 5645.943540564624, 5672.716364181857, 5682.289713785777, 5693.345265294544, 5741.311042674905, 6635.2416609598495, 6718.93281067183, 6728.932710672929, 6754.155730533684, 6759.0, 5629.211910332557, 5656.462636049569, 5700.315962084576, 5714.685692286964, 5723.0, 3528.0, 3529.7529172957647, 3540.3627347077772, 3544.1848374873925, 3546.4325707886615, 6429.6463694496315, 6437.806865794034, 6506.34936506355, 6515.674216289167, 6546.70539825709, 6751.459883209332, 6786.099892030239, 6796.558223715443, 6827.249002609709, 6849.383555480031, 6319.8104056878365, 6402.743890244338, 6409.519286053472, 6484.1894763154605, 6546.0, 6588.538802283986, 6664.566803157779, 6689.531732778659, 6696.732130714717, 6703.363180497845, 6622.470202383702, 6639.634820084942, 6661.134052573135, 6663.833404164935, 6670.9332906670315, 6504.707288171949, 6556.770513032021, 6562.770303039561, 6564.277929427663, 6577.736890524326, 5349.411564727955, 5353.518183363516, 5380.762424642276, 5456.645318054314, 5472.370677372153, 6374.4263016326895, 6440.967795160994, 6526.869462610816, 6612.371824676648, 6693.297203793726, 6457.321981192095, 6462.483001359974, 6482.222133344029, 6576.0, 6578.342165783383, 6341.175647165839, 6371.681415929278, 6391.137196478416, 6434.260060093149, 6492.091107244895, 6255.843603909939, 6389.2652344980925, 6423.839404014937, 6437.5171862111465, 6485.708143133476, 6390.297067322498, 6574.474042076718, 6599.439047681001, 6634.744186976258, 6647.268800432045, 6352.777652782131, 6378.712957916812, 6381.8085457436355, 6422.582532135396, 6430.582012169194], "value": 5173.461968471216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.3956079646246, 922.958466868991, 936.2790651198577, 939.4598106089, 952.7427594549474, 19533.0, 20377.0, 20379.694304585406, 20401.28595499156, 20448.0, 18022.459326220203, 18050.90974545129, 18148.092595370246, 18713.064346782674, 18811.717824232648, 971.7230589282055, 992.8609994600762, 996.0238965813508, 997.0278977996431, 997.6458357283169, 964.6527250189961, 994.4480813148699, 1000.5047501486774, 1001.6694490818013, 1003.9749006274865, 1060.5386656804314, 1061.3101484035362, 1061.389700921969, 1061.6390427254732, 1067.460932229223, 992.2111921022804, 1055.984160237597, 1058.5130839813733, 1060.1306928318782, 1061.787642471505, 744.2185705009772, 757.6249756370577, 762.272030211147, 762.4624639629048, 762.5462849604477, 20484.69272960907, 20590.58818823615, 20628.5874282515, 20704.792952070587, 20725.79274207269, 21386.679199812017, 21757.67363489549, 22033.33899983003, 22106.0, 22228.88885555578, 17312.307507699803, 17484.475465735923, 17528.912355438268, 17544.0, 17699.29202831885, 3688.5389326334207, 3721.1813401051727, 3737.719671024684, 3742.0644838790304, 3746.569144548357, 132320.0, 132939.0, 135527.32236338855, 135637.0, 139633.0, 16453.341866325212, 16909.32362705478, 16928.746068808978, 16989.915050424668, 17071.743923841153, 31006.37987240288, 31084.844575776977, 31763.364732705217, 32176.839115804272, 32514.512282315784, 8362.707305244287, 8405.327573794204, 8415.410921235578, 8418.158184181655, 8433.578321083922, 4193.475815523059, 4277.315629499328, 4313.956860431418, 4327.870163895088, 4328.826846926151, 5341.919871201935, 5497.862553436196, 5534.667919924817, 5546.667199968015, 5561.805336813192, 947.3699989507038, 973.8490533967247, 982.4252812104855, 994.9452780097164, 997.8004399120205, 690.8411065454873, 710.2861624067779, 712.2307907459931, 721.7798571435762, 725.2529894208973, 12116.21244619097, 12144.757104857854, 12213.45039473226, 12467.625971220878, 12708.301043442514, 685.6468918506973, 690.378659206718, 696.989545156823, 703.9190493093257, 705.7529864547367, 5743.310802703702, 5768.019436695772, 5779.624324418984, 5789.913151302734, 5865.560082993792, 117972.0, 119547.0, 121806.39096804637, 122224.0, 123048.38475807743, 103621.0, 103690.0, 105518.0, 106623.93376066296, 107315.46342268238, 93261.0, 94043.0, 94204.52897735605, 98074.50962744998, 98513.0, 10675.6345456269, 10772.946135269274, 10784.352938823695, 10947.412625169147, 11167.776644467227, 42898.35652465153, 43095.56904430916, 43741.56258437375, 44366.0, 45209.77395113003, 55440.0, 57390.0, 58049.70975145097, 58940.70529647496, 59736.0, 16105.114218718083, 16271.837281627033, 16298.918505407397, 16329.265183066553, 16439.0, 17216.311347545958, 17265.39571115005, 17266.136693165543, 17383.82616173822, 17394.0, 15820.76268855945, 15989.0, 15995.840041599435, 16115.355385784906, 16210.27053782559, 15584.610384740472, 15619.0, 15718.292676829342, 15856.76214856755, 15867.761983570486, 15391.538253851955, 15470.767938480707, 15552.066875987477, 15618.609534761268, 15623.843761562239, 12237.816432753338, 12331.69170770738, 12396.256224626552, 12474.43865026058, 12632.178908370926, 11810.527578897092, 11921.463534141158, 11923.821142682693, 11986.0, 12110.697232569257], "value": 9007.982857178618, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 105.0, 109.0, 107.0, 97.0, 107.0, 107.0, 107.0, 106.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 116.0, 117.0, 116.0, 116.0, 142.0, 120.0, 119.0, 127.0], "value": 121.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 163.0, 162.0, 162.0, 162.0, 162.0, 168.0, 164.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 73.0, 73.0, 74.0, 75.0, 74.0, 74.0, 71.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 79.0, 78.0, 78.0, 79.0, 79.0, 80.0, 126.0], "value": 84.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 148.0, 149.0, 148.0, 149.0, 148.0, 149.0, 150.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 53.0, 53.0, 60.0, 53.0, 53.0, 52.0, 51.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 38.0, 37.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 37.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 82.0, 78.0, 73.0, 72.0, 80.0, 73.0, 72.0, 73.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 118.0, 112.0, 113.0, 114.0, 113.0, 124.0, 118.0, 118.0], "value": 115.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 169.0, 167.0, 164.0, 168.0, 173.0, 172.0, 177.0, 165.0, 171.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 67.0, 65.0, 66.0, 64.0, 64.0, 68.0, 65.0, 68.0], "value": 65.8, "unit": "score"}]}]} 03:53:30 INFO - Return code: 0 03:53:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:53:30 INFO - # TBPL SUCCESS # 03:53:30 INFO - Running post-action listener: _package_coverage_data 03:53:30 INFO - Running post-action listener: _resource_record_post_action 03:53:30 INFO - [mozharness: 2017-09-28 10:53:30.720565Z] Finished run-tests step (success) 03:53:30 INFO - Running post-run listener: _resource_record_post_run 03:53:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 425984; Write bytes: 445542400; Read time: 64; Write time: 361896 03:53:30 INFO - TinderboxPrint: CPU usage
13.1% 03:53:30 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 64 03:53:30 INFO - TinderboxPrint: I/O write bytes / time
445,542,400 / 361,896 03:53:30 INFO - TinderboxPrint: CPU idle
8,234.8 (86.9%) 03:53:30 INFO - TinderboxPrint: CPU user
1,194.1 (12.6%) 03:53:30 INFO - TinderboxPrint: Swap in / out
0 / 0 03:53:30 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 113233920; Read time: 0; Write time: 121356 03:53:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:53:30 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 421888; Write bytes: 331657216; Read time: 60; Write time: 240536 03:53:31 INFO - Running post-run listener: _upload_blobber_files 03:53:31 INFO - Blob upload gear active. 03:53:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:31 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 03:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:53:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:32 INFO - (blobuploader) - INFO - Done attempting. 03:53:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:34 INFO - (blobuploader) - INFO - Done attempting. 03:53:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:53:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:53:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:36 INFO - (blobuploader) - INFO - Done attempting. 03:53:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:53:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:53:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:42 INFO - (blobuploader) - INFO - Done attempting. 03:53:42 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:42 INFO - Return code: 0 03:53:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/718157aa147ff32728c5ce90f48c64b6f350f60b8b5e2a74e758e8100000c4e8778236b3238c687ccf5a2a1fa46466f5bac1b1a3f56e24f515c16290e692724c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5939e0f52a47637299b65d989eb9494ae355a97688432f7f16f5fbe4409bafc1889f8635ac01492fd3931d7a5fa6275bcad1dce6ac6cd3c07b4f65f78da5c76c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f3b0fd889c512200166cd803c5f34ab56ea0a1ea55471fe3cd2c15b43f770831cf1e91e60c1407d9f4ebf35cebb8cd0ae68d950b49e4fee6550e084d1783e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d38d65d1452aaaa755491794458b8d722965d76f4b92da367c9513428f2331a7341e2f99afd8ce8cad657e8bc3a1c9e2c07288e5400770bf8e3718e8f4572880"} 03:53:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:42 INFO - Contents: 03:53:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/718157aa147ff32728c5ce90f48c64b6f350f60b8b5e2a74e758e8100000c4e8778236b3238c687ccf5a2a1fa46466f5bac1b1a3f56e24f515c16290e692724c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5939e0f52a47637299b65d989eb9494ae355a97688432f7f16f5fbe4409bafc1889f8635ac01492fd3931d7a5fa6275bcad1dce6ac6cd3c07b4f65f78da5c76c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f3b0fd889c512200166cd803c5f34ab56ea0a1ea55471fe3cd2c15b43f770831cf1e91e60c1407d9f4ebf35cebb8cd0ae68d950b49e4fee6550e084d1783e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d38d65d1452aaaa755491794458b8d722965d76f4b92da367c9513428f2331a7341e2f99afd8ce8cad657e8bc3a1c9e2c07288e5400770bf8e3718e8f4572880"} 03:53:42 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:42 INFO - Copying logs to upload dir... 03:53:42 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.207146 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-09-28 03:53:42.634557) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 03:53:42.639326) ========= 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=781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/718157aa147ff32728c5ce90f48c64b6f350f60b8b5e2a74e758e8100000c4e8778236b3238c687ccf5a2a1fa46466f5bac1b1a3f56e24f515c16290e692724c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5939e0f52a47637299b65d989eb9494ae355a97688432f7f16f5fbe4409bafc1889f8635ac01492fd3931d7a5fa6275bcad1dce6ac6cd3c07b4f65f78da5c76c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f3b0fd889c512200166cd803c5f34ab56ea0a1ea55471fe3cd2c15b43f770831cf1e91e60c1407d9f4ebf35cebb8cd0ae68d950b49e4fee6550e084d1783e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d38d65d1452aaaa755491794458b8d722965d76f4b92da367c9513428f2331a7341e2f99afd8ce8cad657e8bc3a1c9e2c07288e5400770bf8e3718e8f4572880"} build_url:https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/bHRMUN3XS_OnyBl4OEvKxA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/718157aa147ff32728c5ce90f48c64b6f350f60b8b5e2a74e758e8100000c4e8778236b3238c687ccf5a2a1fa46466f5bac1b1a3f56e24f515c16290e692724c", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5939e0f52a47637299b65d989eb9494ae355a97688432f7f16f5fbe4409bafc1889f8635ac01492fd3931d7a5fa6275bcad1dce6ac6cd3c07b4f65f78da5c76c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/85f3b0fd889c512200166cd803c5f34ab56ea0a1ea55471fe3cd2c15b43f770831cf1e91e60c1407d9f4ebf35cebb8cd0ae68d950b49e4fee6550e084d1783e4", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d38d65d1452aaaa755491794458b8d722965d76f4b92da367c9513428f2331a7341e2f99afd8ce8cad657e8bc3a1c9e2c07288e5400770bf8e3718e8f4572880"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 03:53:42.666931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:53:42.670254) ========= 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=781b77c4c33858b1f599d705000001c1-1506594780.511212-1739050893 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 03:53:42.750849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 03:53:42.752048) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 03:53:42.752374) ========= ========= Total master_lag: 0.23 =========