builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-037 starttime: 1506120953.84 results: success (0) revision: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:53.843596) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:53.843956) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:53.844227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:53.926605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:53.926871) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-22 15:55:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.4M=0s 2017-09-22 15:55:53 (99.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128129 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.084039) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.084339) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015098 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.165858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.166382) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 --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 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 --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=56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-22 15:55:54,139 truncating revision to first 12 chars 2017-09-22 15:55:54,139 Setting DEBUG logging. 2017-09-22 15:55:54,139 attempt 1/10 2017-09-22 15:55:54,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3d72fdb0e561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-22 15:55:54,429 unpacking tar archive at: mozilla-central-3d72fdb0e561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.575403 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.777541) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.777857) ========= script_repo_revision: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.778241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.778516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-22 15:55:54.796374) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-22 15:55:54.796658) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:55:54 INFO - MultiFileLogger online at 20170922 15:55:54 in /builds/slave/test 15:55:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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 15:55:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:54 INFO - {'append_to_log': False, 15:55:54 INFO - 'base_work_dir': '/builds/slave/test', 15:55:54 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:55:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:54 INFO - 'branch': 'Firefox-Non-PGO', 15:55:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:54 INFO - 'code_coverage': False, 15:55:54 INFO - 'config_files': ('talos/linux_config.py',), 15:55:54 INFO - 'default_actions': ('clobber', 15:55:54 INFO - 'read-buildbot-config', 15:55:54 INFO - 'download-and-extract', 15:55:54 INFO - 'populate-webroot', 15:55:54 INFO - 'create-virtualenv', 15:55:54 INFO - 'install', 15:55:54 INFO - 'setup-mitmproxy', 15:55:54 INFO - 'run-tests'), 15:55:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:54 INFO - 'disable_ccov_upload': False, 15:55:54 INFO - 'disable_stylo': False, 15:55:54 INFO - 'download_minidump_stackwalk': True, 15:55:54 INFO - 'download_symbols': 'ondemand', 15:55:54 INFO - 'enable_stylo': False, 15:55:54 INFO - 'enable_webrender': False, 15:55:54 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:55:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:54 INFO - 'gecko_profile': False, 15:55:54 INFO - 'gecko_profile_interval': 0, 15:55:54 INFO - 'installer_path': 'installer.exe', 15:55:54 INFO - 'log_level': 'info', 15:55:54 INFO - 'log_name': 'talos', 15:55:54 INFO - 'log_to_console': True, 15:55:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:55:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:55:54 INFO - 'opt_config_files': (), 15:55:54 INFO - 'pip_index': False, 15:55:54 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:55:54 INFO - 'system_bits': '32', 15:55:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:54 INFO - 'title': 'talos-linux64-ix-037', 15:55:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:54 INFO - 'use_talos_json': True, 15:55:54 INFO - 'verify': 'False', 15:55:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:54 INFO - 'work_dir': 'build'} 15:55:54 INFO - [mozharness: 2017-09-22 22:55:54.899694Z] Running clobber step. 15:55:54 INFO - Running pre-action listener: _resource_record_pre_action 15:55:54 INFO - Running main action method: clobber 15:55:54 INFO - rmtree: /builds/slave/test/build 15:55:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:55:55 INFO - Running post-action listener: _resource_record_post_action 15:55:55 INFO - [mozharness: 2017-09-22 22:55:55.900848Z] Finished clobber step (success) 15:55:55 INFO - [mozharness: 2017-09-22 22:55:55.900945Z] Running read-buildbot-config step. 15:55:55 INFO - Running pre-action listener: _resource_record_pre_action 15:55:55 INFO - Running main action method: read_buildbot_config 15:55:55 INFO - Using buildbot properties: 15:55:55 INFO - { 15:55:55 INFO - "project": "", 15:55:55 INFO - "product": "firefox", 15:55:55 INFO - "who": "kwierso@gmail.com", 15:55:55 INFO - "installer_path": "public/build/target.tar.bz2", 15:55:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:55:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:55:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:55:55 INFO - "stage_platform": "linux64", 15:55:55 INFO - "basedir": "/builds/slave/test", 15:55:55 INFO - "buildnumber": 60, 15:55:55 INFO - "platform": "ubuntu64_hw", 15:55:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:55:55 INFO - "slavebuilddir": "test", 15:55:55 INFO - "taskId": "ZYAfnAOqTH-wmelJQXJL9g", 15:55:55 INFO - "branch": "mozilla-central", 15:55:55 INFO - "script_repo_revision": "production", 15:55:55 INFO - "revision": "3d72fdb0e561ea59d9e5850c3e71367dbb8a7148", 15:55:55 INFO - "slavename": "talos-linux64-ix-037", 15:55:55 INFO - "repo_path": "mozilla-central" 15:55:55 INFO - } 15:55:55 INFO - Finding installer, test and symbols from parent task. 15:55:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYAfnAOqTH-wmelJQXJL9g'}, attempt #1 15:55:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYAfnAOqTH-wmelJQXJL9g'}, attempt #1 15:55:56 INFO - Task dependencies: Rya6KjrkSJOt9EaGINvG8Q 15:55:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q'}, attempt #1 15:55:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2 15:55:57 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.test_packages.json 15:55:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.crashreporter-symbols.zip 15:55:57 INFO - Running post-action listener: _resource_record_post_action 15:55:57 INFO - [mozharness: 2017-09-22 22:55:57.237036Z] Finished read-buildbot-config step (success) 15:55:57 INFO - [mozharness: 2017-09-22 22:55:57.237298Z] Running download-and-extract step. 15:55:57 INFO - Running pre-action listener: _resource_record_pre_action 15:55:57 INFO - Running main action method: download_and_extract 15:55:57 INFO - mkdir: /builds/slave/test/build/tests 15:55:57 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')]} 15:55:57 INFO - trying https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.test_packages.json 15:55:57 INFO - Downloading https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:55:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:56:00 INFO - Downloaded 989 bytes. 15:56:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:56:00 INFO - Using the following test package requirements: 15:56:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:56:00 INFO - u'common': [u'target.common.tests.zip'], 15:56:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:56:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:56:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:56:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:56:00 INFO - u'mozbase': [u'target.common.tests.zip'], 15:56:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:56:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:56:00 INFO - u'web-platform': [u'target.common.tests.zip', 15:56:00 INFO - u'target.web-platform.tests.tar.gz'], 15:56:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:56:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:56:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.common.tests.zip 15:56:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:56:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.common.tests.zip into memory 15:56:01 INFO - Content-Length response header: 54892793 15:56:01 INFO - Bytes received: 54892793 15:56:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.talos.tests.zip 15:56:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:56:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.talos.tests.zip into memory 15:56:13 INFO - Content-Length response header: 14513823 15:56:13 INFO - Bytes received: 14513823 15:56:13 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')]} 15:56:13 INFO - trying https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2 15:56:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:56:16 INFO - Downloaded 61652185 bytes. 15:56:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2 15:56:16 INFO - mkdir: /builds/slave/test/properties 15:56:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:16 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:16 INFO - Contents: 15:56:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2 15:56:16 INFO - Running post-action listener: _resource_record_post_action 15:56:16 INFO - Running post-action listener: find_tests_for_verification 15:56:16 INFO - Running post-action listener: set_extra_try_arguments 15:56:16 INFO - [mozharness: 2017-09-22 22:56:16.134653Z] Finished download-and-extract step (success) 15:56:16 INFO - [mozharness: 2017-09-22 22:56:16.134750Z] Running populate-webroot step. 15:56:16 INFO - Running pre-action listener: _resource_record_pre_action 15:56:16 INFO - Running main action method: populate_webroot 15:56:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:56:16 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tresize', 15:56:16 INFO - 'tcanvasmark']}, 15:56:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:56:16 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['dromaeo_css', 15:56:16 INFO - 'kraken']}, 15:56:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:16 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'tests': ['damp', 'tps']}, 15:56:16 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['damp', 'tps']}, 15:56:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:16 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['dromaeo_dom']}, 15:56:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:56:16 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['basic_compositor_video', 15:56:16 INFO - 'glvideo']}, 15:56:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:56:16 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['ts_paint_webext', 15:56:16 INFO - 'tp5o_webext']}, 15:56:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_many_windows', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_many_windows', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:56:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:56:16 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['perf_reftest_singletons']}, 15:56:16 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['perf_reftest']}, 15:56:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:56:16 INFO - 'tsvgr_opacity', 15:56:16 INFO - 'tart', 15:56:16 INFO - 'tscrollx', 15:56:16 INFO - 'tsvg_static']}, 15:56:16 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tsvgx', 15:56:16 INFO - 'tsvgr_opacity', 15:56:16 INFO - 'tart', 15:56:16 INFO - 'tscrollx', 15:56:16 INFO - 'tsvg_static']}, 15:56:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:56:16 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo'], 15:56:16 INFO - 'tests': ['tp5o']}, 15:56:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:56:16 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:56:16 INFO - 'talos_options': ['--mitmproxy', 15:56:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:56:16 INFO - '--firstNonBlankPaint'], 15:56:16 INFO - 'tests': ['tp6_google', 15:56:16 INFO - 'tp6_youtube', 15:56:16 INFO - 'tp6_amazon', 15:56:16 INFO - 'tp6_facebook']}, 15:56:16 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:56:16 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:56:16 INFO - 'talos_options': ['--disable-stylo', 15:56:16 INFO - '--mitmproxy', 15:56:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:56:16 INFO - '--firstNonBlankPaint'], 15:56:16 INFO - 'tests': ['tp6_google', 15:56:16 INFO - 'tp6_youtube', 15:56:16 INFO - 'tp6_amazon', 15:56:16 INFO - 'tp6_facebook']}, 15:56:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:56:16 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:56:16 INFO - 'talos_options': ['--stylo-threads=1', 15:56:16 INFO - '--mitmproxy', 15:56:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:56:16 INFO - '--firstNonBlankPaint'], 15:56:16 INFO - 'tests': ['tp6_google', 15:56:16 INFO - 'tp6_youtube', 15:56:16 INFO - 'tp6_amazon', 15:56:16 INFO - 'tp6_facebook']}, 15:56:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--xperf_path', 15:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:16 INFO - 'tests': ['tp5n']}, 15:56:16 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-stylo', 15:56:16 INFO - '--xperf_path', 15:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:16 INFO - 'tests': ['tp5n']}}} 15:56:16 INFO - Running post-action listener: _resource_record_post_action 15:56:16 INFO - [mozharness: 2017-09-22 22:56:16.151085Z] Finished populate-webroot step (success) 15:56:16 INFO - [mozharness: 2017-09-22 22:56:16.151174Z] Running create-virtualenv step. 15:56:16 INFO - Running pre-action listener: _resource_record_pre_action 15:56:16 INFO - Running main action method: create_virtualenv 15:56:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:16 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:56:16 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:56:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:56:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:17 INFO - Installing pip...............done. 15:56:17 INFO - Return code: 0 15:56:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:56:17 INFO - Reading from file tmpfile_stdout 15:56:17 INFO - Output received: 15:56:17 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:56:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56:17 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')]} 15:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:17 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')]} 15:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:17 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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:17 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 15:56:17 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 15:56:17 INFO - Using env: {'DISPLAY': ':0', 15:56:17 INFO - 'HOME': '/home/cltbld', 15:56:17 INFO - 'LANG': 'en_US.UTF-8', 15:56:17 INFO - 'LANGUAGE': 'en_US:en', 15:56:17 INFO - 'LOGNAME': 'cltbld', 15:56:17 INFO - 'MAIL': '/var/mail/cltbld', 15:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:17 INFO - 'MOZ_NO_REMOTE': '1', 15:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:17 INFO - 'NO_EM_RESTART': '1', 15:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:17 INFO - 'PWD': '/builds/slave/test', 15:56:17 INFO - 'SHELL': '/bin/bash', 15:56:17 INFO - 'SHLVL': '1', 15:56:17 INFO - 'TERM': 'linux', 15:56:17 INFO - 'TMOUT': '86400', 15:56:17 INFO - 'USER': 'cltbld', 15:56:17 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:17 INFO - '_': '/tools/buildbot/bin/python'} 15:56:18 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:56:18 INFO - Downloading/unpacking pip>=1.5 15:56:18 INFO - Running setup.py egg_info for package pip 15:56:18 INFO - warning: no files found matching 'pip/cacert.pem' 15:56:18 INFO - warning: no files found matching '*.html' under directory 'docs' 15:56:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:56:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:56:18 INFO - Installing collected packages: pip 15:56:18 INFO - Found existing installation: pip 1.1 15:56:18 INFO - Uninstalling pip: 15:56:18 INFO - Successfully uninstalled pip 15:56:18 INFO - Running setup.py install for pip 15:56:18 INFO - warning: no files found matching 'pip/cacert.pem' 15:56:18 INFO - warning: no files found matching '*.html' under directory 'docs' 15:56:18 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:56:18 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:56:18 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:56:18 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:56:18 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:56:18 INFO - Successfully installed pip 15:56:18 INFO - Cleaning up... 15:56:18 INFO - Return code: 0 15:56:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:56:18 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')]} 15:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:18 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')]} 15:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:18 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 15:56:18 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 15:56:18 INFO - Using env: {'DISPLAY': ':0', 15:56:18 INFO - 'HOME': '/home/cltbld', 15:56:18 INFO - 'LANG': 'en_US.UTF-8', 15:56:18 INFO - 'LANGUAGE': 'en_US:en', 15:56:18 INFO - 'LOGNAME': 'cltbld', 15:56:18 INFO - 'MAIL': '/var/mail/cltbld', 15:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:18 INFO - 'MOZ_NO_REMOTE': '1', 15:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:18 INFO - 'NO_EM_RESTART': '1', 15:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:18 INFO - 'PWD': '/builds/slave/test', 15:56:18 INFO - 'SHELL': '/bin/bash', 15:56:18 INFO - 'SHLVL': '1', 15:56:18 INFO - 'TERM': 'linux', 15:56:18 INFO - 'TMOUT': '86400', 15:56:18 INFO - 'USER': 'cltbld', 15:56:18 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:18 INFO - '_': '/tools/buildbot/bin/python'} 15:56:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:18 INFO - Downloading/unpacking psutil>=3.1.1 15:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:19 INFO - Installing collected packages: psutil 15:56:19 INFO - Running setup.py install for psutil 15:56:19 INFO - building 'psutil._psutil_linux' extension 15:56:19 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 15:56:19 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 15:56:20 INFO - building 'psutil._psutil_posix' extension 15:56:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:56:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:56:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:20 INFO - Successfully installed psutil 15:56:20 INFO - Cleaning up... 15:56:20 INFO - Return code: 0 15:56:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:56:20 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')]} 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:20 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')]} 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:20 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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:20 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 15:56:20 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 15:56:20 INFO - Using env: {'DISPLAY': ':0', 15:56:20 INFO - 'HOME': '/home/cltbld', 15:56:20 INFO - 'LANG': 'en_US.UTF-8', 15:56:20 INFO - 'LANGUAGE': 'en_US:en', 15:56:20 INFO - 'LOGNAME': 'cltbld', 15:56:20 INFO - 'MAIL': '/var/mail/cltbld', 15:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:20 INFO - 'MOZ_NO_REMOTE': '1', 15:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:20 INFO - 'NO_EM_RESTART': '1', 15:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:20 INFO - 'PWD': '/builds/slave/test', 15:56:20 INFO - 'SHELL': '/bin/bash', 15:56:20 INFO - 'SHLVL': '1', 15:56:20 INFO - 'TERM': 'linux', 15:56:20 INFO - 'TMOUT': '86400', 15:56:20 INFO - 'USER': 'cltbld', 15:56:20 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:20 INFO - '_': '/tools/buildbot/bin/python'} 15:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:56:21 INFO - Installing collected packages: mozsystemmonitor 15:56:21 INFO - Running setup.py install for mozsystemmonitor 15:56:21 INFO - Successfully installed mozsystemmonitor 15:56:21 INFO - Cleaning up... 15:56:22 INFO - Return code: 0 15:56:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:56:22 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')]} 15:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:22 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')]} 15:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:22 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 15:56:22 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 15:56:22 INFO - Using env: {'DISPLAY': ':0', 15:56:22 INFO - 'HOME': '/home/cltbld', 15:56:22 INFO - 'LANG': 'en_US.UTF-8', 15:56:22 INFO - 'LANGUAGE': 'en_US:en', 15:56:22 INFO - 'LOGNAME': 'cltbld', 15:56:22 INFO - 'MAIL': '/var/mail/cltbld', 15:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:22 INFO - 'MOZ_NO_REMOTE': '1', 15:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:22 INFO - 'NO_EM_RESTART': '1', 15:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:22 INFO - 'PWD': '/builds/slave/test', 15:56:22 INFO - 'SHELL': '/bin/bash', 15:56:22 INFO - 'SHLVL': '1', 15:56:22 INFO - 'TERM': 'linux', 15:56:22 INFO - 'TMOUT': '86400', 15:56:22 INFO - 'USER': 'cltbld', 15:56:22 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:22 INFO - '_': '/tools/buildbot/bin/python'} 15:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:22 INFO - Downloading/unpacking jsonschema==2.5.1 15:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:56:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:56:24 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 15:56:24 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 15:56:24 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 15:56:24 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 15:56:24 INFO - Downloading functools32-3.2.3-2.tar.gz 15:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:56:24 INFO - warning: no files found matching '*.txt' 15:56:24 INFO - no previously-included directories found matching 'build' 15:56:24 INFO - no previously-included directories found matching 'dist' 15:56:24 INFO - no previously-included directories found matching '.git*' 15:56:24 INFO - Installing collected packages: jsonschema, functools32 15:56:24 INFO - Running setup.py install for functools32 15:56:24 INFO - warning: no files found matching '*.txt' 15:56:24 INFO - no previously-included directories found matching 'build' 15:56:24 INFO - no previously-included directories found matching 'dist' 15:56:24 INFO - no previously-included directories found matching '.git*' 15:56:25 INFO - Successfully installed jsonschema functools32 15:56:25 INFO - Cleaning up... 15:56:25 INFO - Return code: 0 15:56:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:56:25 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')]} 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:25 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')]} 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:25 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 15:56:25 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 15:56:25 INFO - Using env: {'DISPLAY': ':0', 15:56:25 INFO - 'HOME': '/home/cltbld', 15:56:25 INFO - 'LANG': 'en_US.UTF-8', 15:56:25 INFO - 'LANGUAGE': 'en_US:en', 15:56:25 INFO - 'LOGNAME': 'cltbld', 15:56:25 INFO - 'MAIL': '/var/mail/cltbld', 15:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:25 INFO - 'MOZ_NO_REMOTE': '1', 15:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:25 INFO - 'NO_EM_RESTART': '1', 15:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:25 INFO - 'PWD': '/builds/slave/test', 15:56:25 INFO - 'SHELL': '/bin/bash', 15:56:25 INFO - 'SHLVL': '1', 15:56:25 INFO - 'TERM': 'linux', 15:56:25 INFO - 'TMOUT': '86400', 15:56:25 INFO - 'USER': 'cltbld', 15:56:25 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:25 INFO - '_': '/tools/buildbot/bin/python'} 15:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:56:25 INFO - Cleaning up... 15:56:25 INFO - Return code: 0 15:56:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:56:25 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')]} 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:25 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')]} 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:25 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 15:56:25 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 15:56:25 INFO - Using env: {'DISPLAY': ':0', 15:56:25 INFO - 'HOME': '/home/cltbld', 15:56:25 INFO - 'LANG': 'en_US.UTF-8', 15:56:25 INFO - 'LANGUAGE': 'en_US:en', 15:56:25 INFO - 'LOGNAME': 'cltbld', 15:56:25 INFO - 'MAIL': '/var/mail/cltbld', 15:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:25 INFO - 'MOZ_NO_REMOTE': '1', 15:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:25 INFO - 'NO_EM_RESTART': '1', 15:56:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:25 INFO - 'PWD': '/builds/slave/test', 15:56:25 INFO - 'SHELL': '/bin/bash', 15:56:25 INFO - 'SHLVL': '1', 15:56:25 INFO - 'TERM': 'linux', 15:56:25 INFO - 'TMOUT': '86400', 15:56:25 INFO - 'USER': 'cltbld', 15:56:25 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:25 INFO - '_': '/tools/buildbot/bin/python'} 15:56:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:25 INFO - Downloading/unpacking blobuploader==1.2.4 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:26 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56: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 15:56: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 15:56: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 15:56: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 15:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:56:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56: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 15:56: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 15:56: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 15:56: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 15:56:27 INFO - Downloading docopt-0.6.1.tar.gz 15:56:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:27 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:27 INFO - Running setup.py install for blobuploader 15:56:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:56:27 INFO - Running setup.py install for requests 15:56:27 INFO - Running setup.py install for docopt 15:56:27 INFO - Successfully installed blobuploader requests docopt 15:56:27 INFO - Cleaning up... 15:56:27 INFO - Return code: 0 15:56:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56: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')]} 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:27 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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:27 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 15:56:27 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 15:56:27 INFO - Using env: {'DISPLAY': ':0', 15:56:27 INFO - 'HOME': '/home/cltbld', 15:56:27 INFO - 'LANG': 'en_US.UTF-8', 15:56:27 INFO - 'LANGUAGE': 'en_US:en', 15:56:27 INFO - 'LOGNAME': 'cltbld', 15:56:27 INFO - 'MAIL': '/var/mail/cltbld', 15:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:27 INFO - 'MOZ_NO_REMOTE': '1', 15:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:27 INFO - 'NO_EM_RESTART': '1', 15:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:27 INFO - 'PWD': '/builds/slave/test', 15:56:27 INFO - 'SHELL': '/bin/bash', 15:56:27 INFO - 'SHLVL': '1', 15:56:27 INFO - 'TERM': 'linux', 15:56:27 INFO - 'TMOUT': '86400', 15:56:27 INFO - 'USER': 'cltbld', 15:56:27 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:27 INFO - '_': '/tools/buildbot/bin/python'} 15:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:27 INFO - Running setup.py (path:/tmp/pip-9iuuVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:28 INFO - Running setup.py (path:/tmp/pip-N1MIky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:28 INFO - Running setup.py (path:/tmp/pip-XsYCCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:28 INFO - Running setup.py (path:/tmp/pip-rslHYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:28 INFO - Running setup.py (path:/tmp/pip-ilJEAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:28 INFO - Running setup.py (path:/tmp/pip-Vk07xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:28 INFO - Running setup.py (path:/tmp/pip-YNZefi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:28 INFO - Running setup.py (path:/tmp/pip-Cd0KuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:28 INFO - Running setup.py (path:/tmp/pip-sP537p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:28 INFO - Running setup.py (path:/tmp/pip-03wAId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:28 INFO - Running setup.py (path:/tmp/pip-oEjLD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:28 INFO - Running setup.py (path:/tmp/pip-3Fr9Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:28 INFO - Running setup.py (path:/tmp/pip-0DaWQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:28 INFO - Running setup.py (path:/tmp/pip-COmCro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:28 INFO - Running setup.py (path:/tmp/pip-DwP4Pt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:29 INFO - Running setup.py (path:/tmp/pip-XFgcBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:29 INFO - Running setup.py (path:/tmp/pip-YuiEtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:29 INFO - Running setup.py install for manifestparser 15:56:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozcrash 15:56:29 INFO - Running setup.py install for mozdebug 15:56:29 INFO - Running setup.py install for mozdevice 15:56:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozfile 15:56:29 INFO - Running setup.py install for mozhttpd 15:56:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozinfo 15:56:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozInstall 15:56:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:56:29 INFO - Running setup.py install for mozleak 15:56:30 INFO - Running setup.py install for mozlog 15:56:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for moznetwork 15:56:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for mozprocess 15:56:30 INFO - Running setup.py install for mozprofile 15:56:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for mozrunner 15:56:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Running setup.py install for mozscreenshot 15:56:30 INFO - Running setup.py install for moztest 15:56:30 INFO - Running setup.py install for mozversion 15:56:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:56:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:30 INFO - Cleaning up... 15:56:30 INFO - Return code: 0 15:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:30 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')]} 15:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:30 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')]} 15:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:30 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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:30 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 15:56:30 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 15:56:30 INFO - Using env: {'DISPLAY': ':0', 15:56:30 INFO - 'HOME': '/home/cltbld', 15:56:30 INFO - 'LANG': 'en_US.UTF-8', 15:56:30 INFO - 'LANGUAGE': 'en_US:en', 15:56:30 INFO - 'LOGNAME': 'cltbld', 15:56:30 INFO - 'MAIL': '/var/mail/cltbld', 15:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:30 INFO - 'MOZ_NO_REMOTE': '1', 15:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:30 INFO - 'NO_EM_RESTART': '1', 15:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:30 INFO - 'PWD': '/builds/slave/test', 15:56:30 INFO - 'SHELL': '/bin/bash', 15:56:30 INFO - 'SHLVL': '1', 15:56:30 INFO - 'TERM': 'linux', 15:56:30 INFO - 'TMOUT': '86400', 15:56:30 INFO - 'USER': 'cltbld', 15:56:30 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:30 INFO - '_': '/tools/buildbot/bin/python'} 15:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:31 INFO - Running setup.py (path:/tmp/pip-Shyxlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:31 INFO - Running setup.py (path:/tmp/pip-llHjPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:31 INFO - Running setup.py (path:/tmp/pip-_nf05Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:31 INFO - Running setup.py (path:/tmp/pip-74opgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:31 INFO - Running setup.py (path:/tmp/pip-2MT8FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:31 INFO - Running setup.py (path:/tmp/pip-bJ31XH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:31 INFO - Running setup.py (path:/tmp/pip-kjZkCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:31 INFO - Running setup.py (path:/tmp/pip-TTSOFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:31 INFO - Running setup.py (path:/tmp/pip-2sEtGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:31 INFO - Running setup.py (path:/tmp/pip-NnX_R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 INFO - Running setup.py (path:/tmp/pip-TgewT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 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)) 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:31 INFO - Running setup.py (path:/tmp/pip-p0y1Ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:32 INFO - Running setup.py (path:/tmp/pip-F3mQ6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:32 INFO - Running setup.py (path:/tmp/pip-06h1ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:32 INFO - Running setup.py (path:/tmp/pip-WZyM_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:32 INFO - Running setup.py (path:/tmp/pip-A_3gAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:32 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)) 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:32 INFO - Running setup.py (path:/tmp/pip-GZlb47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 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)) 15:56:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:33 INFO - Downloading blessings-1.6.tar.gz 15:56:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:33 INFO - Installing collected packages: blessings 15:56:33 INFO - Running setup.py install for blessings 15:56:33 INFO - Successfully installed blessings 15:56:33 INFO - Cleaning up... 15:56:33 INFO - Return code: 0 15:56:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:56:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:33 INFO - Reading from file tmpfile_stdout 15:56:33 INFO - Current package versions: 15:56:33 INFO - argparse == 1.2.1 15:56:33 INFO - blessings == 1.6 15:56:33 INFO - blobuploader == 1.2.4 15:56:33 INFO - docopt == 0.6.1 15:56:33 INFO - functools32 == 3.2.3-2 15:56:33 INFO - jsonschema == 2.5.1 15:56:33 INFO - manifestparser == 1.1 15:56:33 INFO - mozInstall == 1.13 15:56:33 INFO - mozcrash == 1.0 15:56:33 INFO - mozdebug == 0.1 15:56:33 INFO - mozdevice == 0.51 15:56:33 INFO - mozfile == 1.2 15:56:33 INFO - mozhttpd == 0.7 15:56:33 INFO - mozinfo == 0.10 15:56:33 INFO - mozleak == 0.1 15:56:33 INFO - mozlog == 3.5 15:56:33 INFO - moznetwork == 0.27 15:56:33 INFO - mozprocess == 0.25 15:56:33 INFO - mozprofile == 0.28 15:56:33 INFO - mozrunner == 6.13 15:56:33 INFO - mozscreenshot == 0.1 15:56:33 INFO - mozsystemmonitor == 0.3 15:56:33 INFO - moztest == 0.8 15:56:33 INFO - mozversion == 1.4 15:56:33 INFO - psutil == 3.1.1 15:56:33 INFO - requests == 1.2.3 15:56:33 INFO - wsgiref == 0.1.2 15:56:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:33 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')]} 15:56:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:33 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')]} 15:56:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:33 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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:33 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 15:56:33 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 15:56:33 INFO - Using env: {'DISPLAY': ':0', 15:56:33 INFO - 'HOME': '/home/cltbld', 15:56:33 INFO - 'LANG': 'en_US.UTF-8', 15:56:33 INFO - 'LANGUAGE': 'en_US:en', 15:56:33 INFO - 'LOGNAME': 'cltbld', 15:56:33 INFO - 'MAIL': '/var/mail/cltbld', 15:56:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:33 INFO - 'MOZ_NO_REMOTE': '1', 15:56:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:33 INFO - 'NO_EM_RESTART': '1', 15:56:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:33 INFO - 'PWD': '/builds/slave/test', 15:56:33 INFO - 'SHELL': '/bin/bash', 15:56:33 INFO - 'SHLVL': '1', 15:56:33 INFO - 'TERM': 'linux', 15:56:33 INFO - 'TMOUT': '86400', 15:56:33 INFO - 'USER': 'cltbld', 15:56:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:33 INFO - '_': '/tools/buildbot/bin/python'} 15:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 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)) 15:56:34 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:56:35 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)) 15:56:35 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)) 15:56:35 INFO - Installing collected packages: simplejson 15:56:35 INFO - Running setup.py install for simplejson 15:56:35 INFO - building 'simplejson._speedups' extension 15:56:35 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 15:56:36 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 15:56:36 INFO - Successfully installed simplejson 15:56:36 INFO - Cleaning up... 15:56:36 INFO - Return code: 0 15:56:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:56:36 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')]} 15:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:36 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')]} 15:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:36 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 0x24421f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27af9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', '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 15:56:36 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 15:56:36 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 15:56:36 INFO - Using env: {'DISPLAY': ':0', 15:56:36 INFO - 'HOME': '/home/cltbld', 15:56:36 INFO - 'LANG': 'en_US.UTF-8', 15:56:36 INFO - 'LANGUAGE': 'en_US:en', 15:56:36 INFO - 'LOGNAME': 'cltbld', 15:56:36 INFO - 'MAIL': '/var/mail/cltbld', 15:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:36 INFO - 'MOZ_NO_REMOTE': '1', 15:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:36 INFO - 'NO_EM_RESTART': '1', 15:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:36 INFO - 'PWD': '/builds/slave/test', 15:56:36 INFO - 'SHELL': '/bin/bash', 15:56:36 INFO - 'SHLVL': '1', 15:56:36 INFO - 'TERM': 'linux', 15:56:36 INFO - 'TMOUT': '86400', 15:56:36 INFO - 'USER': 'cltbld', 15:56:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:36 INFO - '_': '/tools/buildbot/bin/python'} 15:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:56:36 INFO - Cleaning up... 15:56:36 INFO - Return code: 0 15:56:36 INFO - Running post-action listener: _resource_record_post_action 15:56:36 INFO - Running post-action listener: _start_resource_monitoring 15:56:36 INFO - Starting resource monitoring. 15:56:36 INFO - [mozharness: 2017-09-22 22:56:36.658263Z] Finished create-virtualenv step (success) 15:56:36 INFO - [mozharness: 2017-09-22 22:56:36.658786Z] Running install step. 15:56:36 INFO - Running pre-action listener: _resource_record_pre_action 15:56:36 INFO - Running main action method: install 15:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:36 INFO - Reading from file tmpfile_stdout 15:56:36 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:37 INFO - Reading from file tmpfile_stdout 15:56:37 INFO - Output received: 15:56:37 INFO - Usage: mozinstall [options] installer 15:56:37 INFO - Options: 15:56:37 INFO - -h, --help show this help message and exit 15:56:37 INFO - -d DEST, --destination=DEST 15:56:37 INFO - Directory to install application into. [default: 15:56:37 INFO - "/builds/slave/test"] 15:56:37 INFO - --app=APP Application being installed. [default: firefox] 15:56:37 INFO - mkdir: /builds/slave/test/build/application 15:56:37 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'] 15:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:56:54 INFO - Reading from file tmpfile_stdout 15:56:54 INFO - Output received: 15:56:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:56:54 INFO - Running post-action listener: _resource_record_post_action 15:56:54 INFO - [mozharness: 2017-09-22 22:56:54.792104Z] Finished install step (success) 15:56:54 INFO - [mozharness: 2017-09-22 22:56:54.792357Z] Running setup-mitmproxy step. 15:56:54 INFO - Running pre-action listener: _resource_record_pre_action 15:56:54 INFO - Running main action method: setup_mitmproxy 15:56:54 INFO - Skipping: mitmproxy is not required 15:56:54 INFO - Running post-action listener: _resource_record_post_action 15:56:54 INFO - [mozharness: 2017-09-22 22:56:54.793552Z] Finished setup-mitmproxy step (success) 15:56:54 INFO - [mozharness: 2017-09-22 22:56:54.793787Z] Running run-tests step. 15:56:54 INFO - Running pre-action listener: _resource_record_pre_action 15:56:54 INFO - Running pre-action listener: _set_gcov_prefix 15:56:54 INFO - Running main action method: run_tests 15:56:54 WARNING - Try message not found. 15:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:56:54 INFO - Python 2.7.3 15:56:54 INFO - Return code: 0 15:56:54 INFO - grabbing minidump binary from tooltool 15:56:54 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')]} 15:56:54 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 0x27acd60>, '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 0x27ada60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27adef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:56:54 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 15:56:54 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 15:56:54 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 15:56:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:54 INFO - Return code: 0 15:56:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:56:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:56:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:56:54 INFO - ENV: RUST_BACKTRACE is now full 15:56:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:56:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:56:54 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 15:56:54 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-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 15:56:54 INFO - Using env: {'DISPLAY': ':0', 15:56:54 INFO - 'HOME': '/home/cltbld', 15:56:54 INFO - 'LANG': 'en_US.UTF-8', 15:56:54 INFO - 'LANGUAGE': 'en_US:en', 15:56:54 INFO - 'LOGNAME': 'cltbld', 15:56:54 INFO - 'MAIL': '/var/mail/cltbld', 15:56:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:54 INFO - 'MOZ_NO_REMOTE': '1', 15:56:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:54 INFO - 'NO_EM_RESTART': '1', 15:56:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:54 INFO - 'PWD': '/builds/slave/test', 15:56:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:54 INFO - 'RUST_BACKTRACE': 'full', 15:56:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:56:54 INFO - 'SHELL': '/bin/bash', 15:56:54 INFO - 'SHLVL': '1', 15:56:54 INFO - 'TERM': 'linux', 15:56:54 INFO - 'TMOUT': '86400', 15:56:54 INFO - 'USER': 'cltbld', 15:56:54 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:54 INFO - '_': '/tools/buildbot/bin/python'} 15:56:54 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-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 15:56:55 INFO - mozversion application_buildid: 20170922215617 15:56:55 INFO - mozversion application_changeset: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 15:56:55 INFO - mozversion application_display_name: Nightly 15:56:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:56:55 INFO - mozversion application_name: Firefox 15:56:55 INFO - mozversion application_remotingname: firefox 15:56:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:56:55 INFO - mozversion application_vendor: Mozilla 15:56:55 INFO - mozversion application_version: 58.0a1 15:56:55 INFO - mozversion platform_buildid: 20170922215617 15:56:55 INFO - mozversion platform_changeset: 3d72fdb0e561ea59d9e5850c3e71367dbb8a7148 15:56:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:56:55 INFO - mozversion platform_version: 58.0a1 15:56:55 INFO - using testdate: 1506121015 15:56:55 INFO - actual date: 1506121015 15:56:55 INFO - starting webserver on 'localhost:38047' 15:56:55 INFO - SUITE-START | Running 2 tests 15:56:55 INFO - TEST-START | dromaeo_css 15:56:55 INFO - Initialising browser for dromaeo_css test... 15:56:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38047/getInfo.html -profile /tmp/tmp_7M60K/profile 15:56:55 INFO - TEST-INFO | started process 18991 (/builds/slave/test/build/application/firefox/firefox http://localhost:38047/getInfo.html) 15:57:00 INFO - TEST-INFO | 18991: exit 0 15:57:00 INFO - Browser initialized. 15:57:00 INFO - Running cycle 1/1 for dromaeo_css test... 15:57:00 INFO - Using env: {'DISPLAY': ':0', 15:57:00 INFO - 'HOME': '/home/cltbld', 15:57:00 INFO - 'JSGC_DISABLE_POISONING': '1', 15:57:00 INFO - 'LANG': 'en_US.UTF-8', 15:57:00 INFO - 'LANGUAGE': 'en_US:en', 15:57:00 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:57:00 INFO - 'LOGNAME': 'cltbld', 15:57:00 INFO - 'MAIL': '/var/mail/cltbld', 15:57:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:57:00 INFO - 'MOZ_CRASHREPORTER': '1', 15:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:00 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:57:00 INFO - 'MOZ_NO_REMOTE': '1', 15:57:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:57:00 INFO - 'NO_EM_RESTART': '1', 15:57:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:00 INFO - 'PWD': '/builds/slave/test', 15:57:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:00 INFO - 'RUST_BACKTRACE': 'full', 15:57:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:57:00 INFO - 'SHELL': '/bin/bash', 15:57:00 INFO - 'SHLVL': '1', 15:57:00 INFO - 'STYLO_FORCE_DISABLED': '1', 15:57:01 INFO - 'TERM': 'linux', 15:57:01 INFO - 'TMOUT': '86400', 15:57:01 INFO - 'USER': 'cltbld', 15:57:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 15:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:01 INFO - '_': '/tools/buildbot/bin/python'} 15:57:01 INFO - TEST-INFO | started process 19224 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_7M60K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:01 INFO - PID 19224 | 15:57:01 INFO - PID 19224 | (/builds/slave/test/build/application/firefox/firefox:19273): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:57:01 INFO - PID 19224 | 15:57:12 INFO - PID 19224 | RSS: Main: 150712320 15:57:12 INFO - PID 19224 | 16:00:07 INFO - PID 19224 | Cycle 1(1): loaded http://localhost:38047/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38047/tests/dromaeo/cssquery-ext.html) 16:00:09 INFO - PID 19224 | RSS: Main: 152596480 16:00:09 INFO - PID 19224 | 16:03:11 INFO - PID 19224 | Cycle 1(1): loaded http://localhost:38047/tests/dromaeo/cssquery-ext.html (next: http://localhost:38047/tests/dromaeo/cssquery-jquery.html) 16:03:11 INFO - PID 19224 | RSS: Main: 152637440 16:03:11 INFO - PID 19224 | 16:06:13 INFO - PID 19224 | Cycle 1(1): loaded http://localhost:38047/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38047/tests/dromaeo/cssquery-mootools.html) 16:06:14 INFO - PID 19224 | RSS: Main: 154308608 16:06:14 INFO - PID 19224 | 16:09:15 INFO - PID 19224 | Cycle 1(1): loaded http://localhost:38047/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38047/tests/dromaeo/cssquery-prototype.html) 16:09:16 INFO - PID 19224 | RSS: Main: 152592384 16:09:16 INFO - PID 19224 | 16:12:19 INFO - PID 19224 | Cycle 1(1): loaded http://localhost:38047/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38047/tests/dromaeo/cssquery-yui.html) 16:12:20 INFO - PID 19224 | RSS: Main: 154165248 16:12:20 INFO - PID 19224 | 16:15:21 INFO - PID 19224 | Cycle 1(1): loaded http://localhost:38047/tests/dromaeo/cssquery-yui.html (next: http://localhost:38047/tests/dromaeo/cssquery-dojo.html) 16:15:22 INFO - PID 19224 | RSS: Main: 154771456 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | __start_tp_report 16:15:22 INFO - PID 19224 | _x_x_mozilla_page_load 16:15:22 INFO - PID 19224 | _x_x_mozilla_page_load_details 16:15:22 INFO - PID 19224 | |i|pagename|runs| 16:15:22 INFO - PID 19224 | |0;dojo.html;2975.6280464941897;3011.608490896183;3015.6079709637743;3147.8898238561646;3183.060997005883;6215.09881067245;6294.874102517947;6310.905336419957;6344.777932772354;6414.550981431295;6274.780382686607;6296;6300.936990630093;6313.936860631392;6359.523035772312;5822.1266809978415;5857.711303513242;5882.088276317167;5884.323302820188;5919.378465261128;12.42243740644352;5835.912461313083;5877.911831322513;5908.261467316585;5909.940900591004;5355.410904800468;5725.656460612356;5741.454561816641;5852.590318677694;5856.912146317809;5785.652860828363;5787.797427090031;5827.79602713903;5854.975379308604;5867.970660146672;5742.310922689304;5752.453516915886;5814.825555233349;5817.069268916953;5834.474897259224;6191.226096737908;6305.621662700252;6320.810375688737;6396.360363963567;6402.199725034371;6585.176852893388;6755.425788807957;6780.932190678129;6814.557053791487;6839.760608378732;6677.532572719863;6694.799156025327;6697.8995315070315;6700.430463410616;6704.5306828522025;6163.96918015407;6244.500439964792;6268.905966410507;6381.872362552723;6389.297177310492;6991.19601245853;7051.576905385693;7065.57606543609;7070.681819318143;7072.434205263567;6677.565958212701;6679.532432729759;6749.190097188369;6753.324667533306;6759.493038022168;6572.277049524549;6701.430378417792;6703.927371620517;6738.393544581011;6786.626735529593;6506.642134682544;6671.132752742113;6676.532642714963;6681.665916704145;6689.799306020827;6443.097966284724;6682.966585167043;6694.464442844561;6699.43054840344;6831.180258369028;5209.7916083356995;5264.868378290574;5265.578753699695;5281.392639846466;5283.630145889828;4502.774861256924;4511.233090374644;4540.455145382575;4541.3869127668;4550;5701.4298570142655;5803.245578074823;5806.21616081832;5821.010428227211;5892.6759028253855;6756.763513277012;6768.932310676831;6770.119884414995;6855.348741869514;6865.27914568973;5829.7376618052285;5876.6180198286975;5892.145638882338;5900.940990590039;5905.43898329658;5787.102999035156;5800.970995144998;5852.824415267549;5857.912131318034;5879.000569903127;6444.194475690539;6551.410373066352;6566.179227596551;6661.500387470959;6666.799996000128;6678.1318428603;6722.462203023746;6740.662966851638;6794.966025169842;6795.354441328066;6555.4427873631275;6607.372299631527;6608.471322294109;6630.734770609314;6646.136002319668;6618.602883826986;6648.767293144717;6729.226138994079;6744.527883048139;6745.831354216184;6763.695633696397;6775.322467753185;6780.118584583973;6874.690638921161;6876.793696189123;6404.7438102477245;6488.286288508355;6494.220693516808;6499.1551098358805;6505.479561634963;6511.2512061113575;6520.250171230369;6587.209534855656;6598.472122230306;6623.238327592196;6495.610263384212;6544.640044797582;6568.310327415744;6574.112494813139;6578.506612004215;6590.1103351046995;6620.735170593315;6641.933580664131;6706.865862682622;6708.899366509604;6355.713992870239;6372.58578192416;6422.967885160544;6455.806325810233;6466.159399278252 16:15:22 INFO - PID 19224 | |1;ext.html;856.4133568505574;884.8363052835226;912.9224015958652;915.6657819895736;916.0152835701623;37982;40676.59323406765;41008.99999999996;41039.38440923385;41046;37428;37746.43380349297;37823.43264851023;37828.810855945754;37947.24105517888;7223.097112860893;7373.11522617284;7379.815504612401;7384.372328352097;7385.113786345646;7252.637368131599;7343.669534870917;7353.301436363537;7353.77938661841;7357.705691772323;7846.215378462165;8134.227248411392;8142.307903828152;8150;8160.9591952040155;8011.879821802678;8024.43828931975;8054.677812887507;8057.556834374107;8071.152528984431;7788.922110778876;7935.960320198362;7976.880346794803;8003.319717823933;8013.759587212393;38089;38096.42855357172;38129.809350953066;38158;38221;3519.894403167909;3558.768680035815;3560;3561.6794488495902;3570.0539357070397;31818;31879.203019924687;31899.362012759848;31970.520442193385;31995.680043199736;5171.120909445403;5234.16253399458;5239.449857764918;5268;5269.578433725293;195656;197956;198587;198625.00687496614;198999;48304.7584762074;48360.516394836304;48390.5160948393;48639.756801215764;48664.27003594949;51213.48786512087;51252.74373628108;51260.74369628128;51362.74318628383;51424.74287628538;16091.195440227943;16424.260908259155;16425;16451.67096658084;16452.83547164537;13467.259300738553;13468.595942121752;13488.123271987486;13516.256605886574;13527.188368697713;14232.430702771773;14528.273586320642;14551.126932384092;14587.927060364631;14655.267236638125;5841.481214884161;5894.67579283135;5926.377730338252;5946.970265148733;5955.642661440241;1004.091297375876;1008.8184126857236;1013.9797204056025;1020.3520764314713;1030.6392762533053;22306.553868922856;22492.662610060863;22728.886355568116;22745.317640470814;23038.078476860737;1112.1103117506125;1116.2298014370058;1117.8323251512174;1121.2823792772633;1123.3540714089431;12109.576164834189;12176.81734773979;12179;12186.51253949832;12270.38648067593;219975;221934;222107;222584;223412;51424.48575514197;51912;56173.15740263899;56184;56184.438155618736;1437.0300047468127;1453.1571688420902;1459.9708005840037;1463.7877507761316;1469.1111877314286;26363;26546.734532654427;26563.33591660224;26712.19863404101;27366.452670946866;37191.25617487689;37274.25451491009;37314.440283395226;37327.81336093302;37346.813265933495;194721;197468;198412;198700;198807;32587;32777.34445311033;32850.67149328476;33045.339093218485;33148.83425582953;39473.40789888096;41267.38098928578;41718;41825.372619410125;41916;30202;30660.540091899085;31057.378852423277;31287;31978;29789.553156702234;30391.088267352014;30421.84789076129;30509.54235686422;30542.694573053985;35402.29195416129;35412.64587354093;35623.82188089043;35649.82175089108;35791;30303.848480757457;30314.393712126075;30485.23786905345;30652;31034;22314.553708925407;22474.32577022692;22670.659940101243;22908.656370154793;22950.42623934415 16:15:22 INFO - PID 19224 | |2;jquery.html;575.2952633024546;587.5622661117466;590.1727298469427;604.2718524178365;605.0923614578132;21747.782522174773;22411.887940560275;22476;22527.32418027462;22608.321750347473;23183.18858839941;24037;24412.75587244127;24612.38469038275;24733.134340298093;6594.703238354262;6803;6803.047573339736;6807.489438292123;6807.931920680804;6031.1254868044325;6298.370162983688;6695.832604184886;6781.491388145884;6793.286704895964;6316.557840951135;6320.241571011485;6322.304546499881;6328.398802113815;6328.525360597951;6250.437460628543;6309.905351419732;6388.488920886318;6624.900626490607;6657.068010478537;6194.225721784777;6199.907001394983;6200.689965501752;6201.100840378165;6215.782447614311;27421.451570968668;27806.860965695243;27993;28004.43991120166;28026.299342516395;2066.95866082679;2074.1288658763356;2095.1619352259067;2105.8631188972668;2106.368089573122;18564.3502477414;19005;19440.416787496397;19524.70712939307;19539.316123935594;2473.9010439582394;2485.478049609584;2529.8861551230057;2530.607755797854;2533.949321013588;123933;126264.99999999908;129712.35143824315;131859.99999999904;132647.33676331557;14685.454454604593;14836.406543738129;14872.776908346383;14915.403383864741;15575.766363504557;23584.292471225548;23664;23664.408389790395;23728.881355593112;23770.286891393287;9476.147146756686;9516.143547080796;9549;9601.711948641552;9608.615655373847;8492.447990880573;8576;8620.87928569282;8660.826783464296;8676.95661521701;9173.266138708887;9231.723048308562;9263.397879137834;9268.675596354095;9418.95290523543;2707.458508298348;2768.6262354581872;2789.6512935883015;2901.347196880685;2905.8111222770453;949.6011675096476;955.8852937647526;957.0471666236001;980.3578655980344;991.7421470417744;18388.908055459637;18726.90636546836;18883.90558047201;18970.905145474186;18981;1030.9639162629421;1035.0994634667886;1044.9582016719398;1045.6862941117633;1053.478528128566;10284.331518451278;10443.321184123008;10624.946875265574;10687.572497100184;10750;449696;457812;459476;472418;508027;112250.43874780738;113841;113878.43060784643;114454;117601.4119929395;1043.9373637581768;1082.2370228988543;1089.0525243038448;1135.1486385211092;1175.6766889105393;19448.22207111756;19555.217791288756;19641.70537441911;19738.40784776459;20158.992050397716;56310;57011.71494142503;58289.708551458665;58319.70840145772;60199.39800601938;71838;72114;72388;72467.63766181347;72592.63703681447;14100.858991409954;14423.855761442252;14452.638684032983;14544.054636448596;14575.198364090076;21967.670484943057;22098;22285.108595656642;22606;22638.547229055657;17645.911770441067;18104.818951810314;18189.45431637053;18207.45377638673;18240;15831.525054248392;15926;16372.590685232964;16604.086775226995;16669.83330166683;16894.49316520506;17146;17199.22603482821;17692.469225923243;18492.260309587466;14227.786583201054;14327.498537551135;14379.496717614833;14385.28073596337;14445.566633001026;16597.585060373105;17760.111994400486;17773.644527109125;17881.105944702973;17973.550661233574 16:15:22 INFO - PID 19224 | |3;mootools.html;1313.4352228541727;1374.3952660829227;1396.280915328606;1396.588006538071;1399.461207435137;15416.845831541681;16044.358225670989;16057.83942160578;16058.839411605895;16099.83900160998;15645.061296322228;15869.047857128551;15873.84126158738;15878.84121158788;15902.602434939132;2757.8345299282005;2798.5102607043736;2834.674012488559;2835.31952331441;2837.645294338208;2724.1282789507363;2734.220747087081;2740.9588856167074;2741.821781584191;2750.4499100179946;2725.3731641722316;2725.523033469145;2846.7437930586243;2848.6296781418387;2849.230707708917;2831.5469524876025;2838.3329917469378;2855.842928638924;2864.7135286471394;2866.5986761853355;2719.5376785946437;2736.8768405421606;2842.729940655655;2845.2744550139787;2845.900393486239;15377.692446151013;15416.075035497794;15418.922905385514;15510.30203640839;15591.688166236612;7984.680612775482;8270.421070525066;8294.751157465285;8308.462934357163;8345.499270043816;5364.177601374357;5576.302962129734;5674.404187560288;5681.23303354046;5703.372629010805;1931.2950772967906;1939.9903000484908;1974.19058186143;1991.4324417540931;2008.4777957730948;27815.635670967993;27991;28134.577981330298;28136.71863281382;28137.85931070352;6992.3357281058215;7015.088038554955;7035.366816986496;7193.4604904631315;7230.385417239489;17990.550236243937;17997.550061248574;18011.369602063864;18019.369322073664;18046.5488362792;8148.918510814816;8332.916670833214;8334.083250842403;8336.62485188168;8339.874901876477;7093.219745827955;7195.856082878313;7485.513441626277;7516.849663006818;7635.694572217049;5216.478352164753;5490.149026900836;5503.559715222773;5517.144842549411;5538.169274608841;1581.5018269245152;1584.8018997625297;1586.912719800399;1601.0633779239042;1604.4143887480986;846.399056669759;855.4097672605882;868.6438560190292;870.0820634230947;885.3979294080087;7251.057362542836;7268.636568171676;7352.558846469229;7378.741744038933;7385.889211661829;692.2904023376079;697.4594689115976;726.0452504955966;736.6869080640706;740.1525253584615;4429.734215947054;4972.527609877128;5000.024995125988;5016.924746128811;5094.974525127424;21529.246476373253;23265.418364541023;23396.766032339798;23398.532029359318;23400.06399744025;20607.58784824295;22704.545909082055;22756.20353287627;22756.317310480714;23207.651885221734;10518.789624207626;10752.516136773864;10760.677179684622;10769.78460430787;11482.425878706199;7600.885986710093;8208.712695055645;8274.131216222451;8403.83192336162;8419.789505262172;18461.723074154168;18540.907295463436;19105.617887642446;19270.421887343404;19382.12780424856;19126.7130993038;19572.510687232934;19729.40811775649;19975.700364494252;20192.697109543074;11388.601398950997;11392.487338069972;11553.24903881245;11563.5952741657;11571.942140289244;14309.21299328547;14345;14395.064320819114;14450.132992020512;14472.855271447152;11689.766204676029;11740.882591173979;11787.11596630239;11977.520899163936;12008.63974080779;11133.443327833738;11140.442977850913;11142.442877856236;11176.944115279372;11442.48508817122;10056.748581285234;10288.588456461657;10323.63867264642;10366.844497332395;10368.377897326185;7381.298776616213;7506.662200201114;7554.017977662868;7624.504407213513;7657.961710191414;7273.236310187566;7402.222766609644;7458.216887226763;7482.214367491335;7517.962410187914 16:15:22 INFO - PID 19224 | |4;prototype.html;509.2641133562004;518.7250757098737;533.1078896983863;536.3510152715214;542.054115568333;6243.594166379182;6249.218847644044;6268.968655156724;6312.558120931537;6346.5874718143405;6209.410106039931;6215.595986260902;6277.372262773721;6306.558540902139;6311.684415779216;5157.149070403379;5192.8701782455455;5193.610479214074;5222.895542089156;5229.189475631283;4830.2030165022725;5080.923786143211;5233.921491177635;5249.212618107276;5258.368995720519;4966;4966.751662416883;5002.474740152286;5007.2489126630935;5010.148274793294;4930.383702037263;4941.629377796679;4992.528698294349;5006.499350064964;5015.548600625962;4407.669424793121;4494.910101797946;4503.594676479132;4513.932291015637;4519.909601807945;5985.7306421210715;5989.9101513477335;6056.545759068087;6080.692651079995;6083.726232319556;5665.688387138705;5685.459881311269;5721.7711291548285;5732.5127364174095;5764.5676574257095;6449.677516124175;6483.578567393151;6545.214574251073;6550.737970481175;6550.868982620368;4717.622590192776;4883.096627123993;4902.7058376497525;4914.557689807934;4934.703917764946;6524.184476940382;6648.900266496006;6694.196696396415;6865.794026179223;6880.621565813878;4963.875903102451;4987.725675087905;5024.598032157419;5029.974850125799;5032.6980381177245;5077.847664570068;5118.232265160182;5120.539151476385;5124.615653825978;5169.586433085344;5744.971275143681;5745.913811292834;5756.1653560233535;5764.942350576441;5788.797392091256;6533.823911695846;6565.848392771496;6571.178602674666;6594.845901967136;6639.236487803964;1739.7651317072286;1746.8340507651753;1757.6484703059439;1774.9556261093576;1776.6979613465483;1177.8645455772526;1211.963641090751;1219.9817002744967;1223.7063104854772;1246.9127161098636;5669.518090962232;5694.686792226467;5699.772009119672;5701.344345400332;5752.28096487939;6522.478201743849;6576.76981305652;6623;6635.175326785173;6694.230163531159;5470.234167216593;5602.971985140048;5696.8860622787315;5700.657960522382;5718.714064296769;3464.5496085509226;3521.7710848794745;3522.9918946200933;3537.1510837399355;3552.928941421157;6280.371962803683;6363.5863668861375;6426.807195784134;6442.742290308429;6534.150560427114;6715;6715.1941766988275;6791.295311937995;6806.76176333826;6814.795556133324;6284.654344011124;6435.613863168225;6448.806970710433;6465.288818230085;6470.5147113965695;6614.900776488453;6644.800655980328;6658.7336506539195;6662.56693314933;6677.599344039373;6603.735850565923;6609.768658096944;6641.203055633162;6720.1599800025;6733.057371968026;6397.808065758035;6486.475678215521;6488.870222595616;6529.118568993125;6579.605223686594;5015.774290157025;5021.497850215095;5041.344625198701;5051.141305978066;5066.885285237242;6469.223693156851;6671.66641667905;6724.764633238009;6754.628495432798;6820.31796820314;6323.241211054703;6506.967465162644;6513.250976137805;6582.670866456754;6598.406143447113;6362.854686156536;6434.420902118832;6468.935310647022;6495.285518593046;6506.349365063646;6300.84247893788;6376.52176086786;6393.1688880445245;6420.807375778734;6444.645544494911;6364.122583837687;6462.579932304385;6492.701459708172;6509.446697030616;6569.24453687832;6249.187605611241;6291.276503202191;6306.4639505642535;6356.459700925473;6376.649284289409 16:15:22 INFO - PID 19224 | |5;yui.html;897.9416337938029;912.2884150362718;933.7665583604099;936.2135805923019;947.7488465556627;19545;20289.797102028977;20435.080421381055;20438.08028638711;20442.386728398134;16865.578360540963;17158.22787974541;17210;19757;19872.403827885188;985.1330828870601;987.7036888933327;991.6083147156869;992.2954702161474;992.4839083676484;962.6149540183948;982.5283863745407;991.3754334769121;1001;1008.2690049713935;1067.64767626683;1067.695706723584;1067.7117178361837;1067.941263230522;1067.9893201067969;1031.6234574380371;1060.6870973062926;1060.978780424395;1060.9893901061007;1064.0157853985072;751.6655088485626;752.0298814529251;752.5071078443628;752.6500177417527;760.9581473018982;20568.38294851142;20742.79257207424;20749.896250518803;20768.169273229054;20790;21200.257990970244;21809.890950545305;22128.778712212992;22245.332640020824;22274.109035638554;17433.564160895952;17489.475315740547;17677.646447070987;17809.554761130945;17811.910940445345;3800.3349413852466;3810.1998580298173;3831.731778775487;3833.961660383416;3835.9808200959096;136524;138533;138915;139258;140463.29768351195;16935.745963810554;17479.825201748074;17489.7376539352;17517.7372339415;17526.21132049061;32117;32254.19364515906;32631;33040.50439243413;33100.83449582737;9043.909560904438;9155.13026262504;9177.174054335143;9201.539923003824;9218.492982885871;3890;4129.256733787947;4157.397177409259;4180.080382315886;4198.097409057067;5720.713964301768;5758.769649213985;5811.389804070512;5825.097109947965;5835.620684655484;1005.7586179316911;1026.2405819693374;1032.9896701033044;1042.5517027678172;1042.6559235452435;670.4401824476616;684.0320945861649;686.9244383117853;695.3116414749362;701.8350687588413;11558.94220528892;12090.214136081127;12167.391630418444;13299.734005319839;13352;682.7303215229956;696.6481926627122;702.771599230242;707.6532499075519;717.4224749077043;5782.392848750821;5889.087191485327;5935.080062590306;5936.22829032223;5975.671338076448;124673;128333;129149;130005;130182;108008;111502;112704.43647781709;114414;115352;97004;97574.51212743891;98256.50871745596;99193;99874.5006274964;10803.760176314638;10893.618723344645;10904.509297081491;10966.890331096587;11187;43811.56188438203;44618;44904.550954491344;45637.315440269085;47632;57721.711391442775;57876;57897;58430;60139;15320.846791531942;16037.518874433787;16054.277557509706;16129.354825806837;16173.59566010859;17610.82389176092;17749.29002839872;17866.821331787036;17991.820081799015;18032.90983545074;15018.249087545797;15119.092854428769;15254;15272.312745926682;15340.30968606393;16005.439809606607;16189.190540472693;16247.756283655519;16257.430989915296;16292.266847991632;15763.842361576237;15942.963707358984;16002.599935001717;16164.434244801376;16251.43119990842;11183.384913829817;11281.266717663326;11397.943010284895;11660.825087623862;11670.124740644655;10844.67465976022;11077.279976801483;11101.444927753742;11148;11285.943570282425 16:15:22 INFO - PID 19224 | __end_tp_report 16:15:22 INFO - PID 19224 | __start_cc_report 16:15:22 INFO - PID 19224 | _x_x_mozilla_cycle_collect,281 16:15:22 INFO - PID 19224 | __end_cc_report 16:15:22 INFO - PID 19224 | __startTimestamp1506122122079__endTimestamp 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | ------- Summary: start ------- 16:15:22 INFO - PID 19224 | Number of tests: 6 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | [#0] dojo.html Cycles:165 Average:6172.06 Median:6466.16 stddev:904.56 (14.0%) stddev-sans-first:871.89 16:15:22 INFO - PID 19224 | Values: 2975.6 3011.6 3015.6 3147.9 3183.1 6215.1 6294.9 6310.9 6344.8 6414.6 6274.8 6296.0 6300.9 6313.9 6359.5 5822.1 5857.7 5882.1 5884.3 5919.4 12.4 5835.9 5877.9 5908.3 5909.9 5355.4 5725.7 5741.5 5852.6 5856.9 5785.7 5787.8 5827.8 5855.0 5868.0 5742.3 5752.5 5814.8 5817.1 5834.5 6191.2 6305.6 6320.8 6396.4 6402.2 6585.2 6755.4 6780.9 6814.6 6839.8 6677.5 6694.8 6697.9 6700.4 6704.5 6164.0 6244.5 6268.9 6381.9 6389.3 6991.2 7051.6 7065.6 7070.7 7072.4 6677.6 6679.5 6749.2 6753.3 6759.5 6572.3 6701.4 6703.9 6738.4 6786.6 6506.6 6671.1 6676.5 6681.7 6689.8 6443.1 6683.0 6694.5 6699.4 6831.2 5209.8 5264.9 5265.6 5281.4 5283.6 4502.8 4511.2 4540.5 4541.4 4550.0 5701.4 5803.2 5806.2 5821.0 5892.7 6756.8 6768.9 6770.1 6855.3 6865.3 5829.7 5876.6 5892.1 5900.9 5905.4 5787.1 5801.0 5852.8 5857.9 5879.0 6444.2 6551.4 6566.2 6661.5 6666.8 6678.1 6722.5 6740.7 6795.0 6795.4 6555.4 6607.4 6608.5 6630.7 6646.1 6618.6 6648.8 6729.2 6744.5 6745.8 6763.7 6775.3 6780.1 6874.7 6876.8 6404.7 6488.3 6494.2 6499.2 6505.5 6511.3 6520.3 6587.2 6598.5 6623.2 6495.6 6544.6 6568.3 6574.1 6578.5 6590.1 6620.7 6641.9 6706.9 6708.9 6355.7 6372.6 6423.0 6455.8 6466.2 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | [#1] ext.html Cycles:180 Average:37370.88 Median:19461.09 stddev:53355.70 (274.2%) stddev-sans-first:53434.93 16:15:22 INFO - PID 19224 | Values: 856.4 884.8 912.9 915.7 916.0 37982.0 40676.6 41009.0 41039.4 41046.0 37428.0 37746.4 37823.4 37828.8 37947.2 7223.1 7373.1 7379.8 7384.4 7385.1 7252.6 7343.7 7353.3 7353.8 7357.7 7846.2 8134.2 8142.3 8150.0 8161.0 8011.9 8024.4 8054.7 8057.6 8071.2 7788.9 7936.0 7976.9 8003.3 8013.8 38089.0 38096.4 38129.8 38158.0 38221.0 3519.9 3558.8 3560.0 3561.7 3570.1 31818.0 31879.2 31899.4 31970.5 31995.7 5171.1 5234.2 5239.4 5268.0 5269.6 195656.0 197956.0 198587.0 198625.0 198999.0 48304.8 48360.5 48390.5 48639.8 48664.3 51213.5 51252.7 51260.7 51362.7 51424.7 16091.2 16424.3 16425.0 16451.7 16452.8 13467.3 13468.6 13488.1 13516.3 13527.2 14232.4 14528.3 14551.1 14587.9 14655.3 5841.5 5894.7 5926.4 5947.0 5955.6 1004.1 1008.8 1014.0 1020.4 1030.6 22306.6 22492.7 22728.9 22745.3 23038.1 1112.1 1116.2 1117.8 1121.3 1123.4 12109.6 12176.8 12179.0 12186.5 12270.4 219975.0 221934.0 222107.0 222584.0 223412.0 51424.5 51912.0 56173.2 56184.0 56184.4 1437.0 1453.2 1460.0 1463.8 1469.1 26363.0 26546.7 26563.3 26712.2 27366.5 37191.3 37274.3 37314.4 37327.8 37346.8 194721.0 197468.0 198412.0 198700.0 198807.0 32587.0 32777.3 32850.7 33045.3 33148.8 39473.4 41267.4 41718.0 41825.4 41916.0 30202.0 30660.5 31057.4 31287.0 31978.0 29789.6 30391.1 30421.8 30509.5 30542.7 35402.3 35412.6 35623.8 35649.8 35791.0 30303.8 30314.4 30485.2 30652.0 31034.0 22314.6 22474.3 22670.7 22908.7 22950.4 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | [#2] jquery.html Cycles:180 Average:33770.77 Median:23383.74 stddev:79200.34 (338.7%) stddev-sans-first:79383.30 16:15:22 INFO - PID 19224 | Values: 575.3 587.6 590.2 604.3 605.1 21747.8 22411.9 22476.0 22527.3 22608.3 23183.2 24037.0 24412.8 24612.4 24733.1 6594.7 6803.0 6803.0 6807.5 6807.9 6031.1 6298.4 6695.8 6781.5 6793.3 6316.6 6320.2 6322.3 6328.4 6328.5 6250.4 6309.9 6388.5 6624.9 6657.1 6194.2 6199.9 6200.7 6201.1 6215.8 27421.5 27806.9 27993.0 28004.4 28026.3 2067.0 2074.1 2095.2 2105.9 2106.4 18564.4 19005.0 19440.4 19524.7 19539.3 2473.9 2485.5 2529.9 2530.6 2533.9 123933.0 126265.0 129712.4 131860.0 132647.3 14685.5 14836.4 14872.8 14915.4 15575.8 23584.3 23664.0 23664.4 23728.9 23770.3 9476.1 9516.1 9549.0 9601.7 9608.6 8492.4 8576.0 8620.9 8660.8 8677.0 9173.3 9231.7 9263.4 9268.7 9419.0 2707.5 2768.6 2789.7 2901.3 2905.8 949.6 955.9 957.0 980.4 991.7 18388.9 18726.9 18883.9 18970.9 18981.0 1031.0 1035.1 1045.0 1045.7 1053.5 10284.3 10443.3 10624.9 10687.6 10750.0 449696.0 457812.0 459476.0 472418.0 508027.0 112250.4 113841.0 113878.4 114454.0 117601.4 1043.9 1082.2 1089.1 1135.1 1175.7 19448.2 19555.2 19641.7 19738.4 20159.0 56310.0 57011.7 58289.7 58319.7 60199.4 71838.0 72114.0 72388.0 72467.6 72592.6 14100.9 14423.9 14452.6 14544.1 14575.2 21967.7 22098.0 22285.1 22606.0 22638.5 17645.9 18104.8 18189.5 18207.5 18240.0 15831.5 15926.0 16372.6 16604.1 16669.8 16894.5 17146.0 17199.2 17692.5 18492.3 14227.8 14327.5 14379.5 14385.3 14445.6 16597.6 17760.1 17773.6 17881.1 17973.6 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | [#3] mootools.html Cycles:180 Average:9594.81 Median:2738.92 stddev:7008.78 (255.9%) stddev-sans-first:7000.83 16:15:22 INFO - PID 19224 | Values: 1313.4 1374.4 1396.3 1396.6 1399.5 15416.8 16044.4 16057.8 16058.8 16099.8 15645.1 15869.0 15873.8 15878.8 15902.6 2757.8 2798.5 2834.7 2835.3 2837.6 2724.1 2734.2 2741.0 2741.8 2750.4 2725.4 2725.5 2846.7 2848.6 2849.2 2831.5 2838.3 2855.8 2864.7 2866.6 2719.5 2736.9 2842.7 2845.3 2845.9 15377.7 15416.1 15418.9 15510.3 15591.7 7984.7 8270.4 8294.8 8308.5 8345.5 5364.2 5576.3 5674.4 5681.2 5703.4 1931.3 1940.0 1974.2 1991.4 2008.5 27815.6 27991.0 28134.6 28136.7 28137.9 6992.3 7015.1 7035.4 7193.5 7230.4 17990.6 17997.6 18011.4 18019.4 18046.5 8148.9 8332.9 8334.1 8336.6 8339.9 7093.2 7195.9 7485.5 7516.8 7635.7 5216.5 5490.1 5503.6 5517.1 5538.2 1581.5 1584.8 1586.9 1601.1 1604.4 846.4 855.4 868.6 870.1 885.4 7251.1 7268.6 7352.6 7378.7 7385.9 692.3 697.5 726.0 736.7 740.2 4429.7 4972.5 5000.0 5016.9 5095.0 21529.2 23265.4 23396.8 23398.5 23400.1 20607.6 22704.5 22756.2 22756.3 23207.7 10518.8 10752.5 10760.7 10769.8 11482.4 7600.9 8208.7 8274.1 8403.8 8419.8 18461.7 18540.9 19105.6 19270.4 19382.1 19126.7 19572.5 19729.4 19975.7 20192.7 11388.6 11392.5 11553.2 11563.6 11571.9 14309.2 14345.0 14395.1 14450.1 14472.9 11689.8 11740.9 11787.1 11977.5 12008.6 11133.4 11140.4 11142.4 11176.9 11442.5 10056.7 10288.6 10323.6 10366.8 10368.4 7381.3 7506.7 7554.0 7624.5 7658.0 7273.2 7402.2 7458.2 7482.2 7518.0 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | [#4] prototype.html Cycles:180 Average:5497.77 Median:6212.50 stddev:1524.40 (24.5%) stddev-sans-first:1481.98 16:15:22 INFO - PID 19224 | Values: 509.3 518.7 533.1 536.4 542.1 6243.6 6249.2 6269.0 6312.6 6346.6 6209.4 6215.6 6277.4 6306.6 6311.7 5157.1 5192.9 5193.6 5222.9 5229.2 4830.2 5080.9 5233.9 5249.2 5258.4 4966.0 4966.8 5002.5 5007.2 5010.1 4930.4 4941.6 4992.5 5006.5 5015.5 4407.7 4494.9 4503.6 4513.9 4519.9 5985.7 5989.9 6056.5 6080.7 6083.7 5665.7 5685.5 5721.8 5732.5 5764.6 6449.7 6483.6 6545.2 6550.7 6550.9 4717.6 4883.1 4902.7 4914.6 4934.7 6524.2 6648.9 6694.2 6865.8 6880.6 4963.9 4987.7 5024.6 5030.0 5032.7 5077.8 5118.2 5120.5 5124.6 5169.6 5745.0 5745.9 5756.2 5764.9 5788.8 6533.8 6565.8 6571.2 6594.8 6639.2 1739.8 1746.8 1757.6 1775.0 1776.7 1177.9 1212.0 1220.0 1223.7 1246.9 5669.5 5694.7 5699.8 5701.3 5752.3 6522.5 6576.8 6623.0 6635.2 6694.2 5470.2 5603.0 5696.9 5700.7 5718.7 3464.5 3521.8 3523.0 3537.2 3552.9 6280.4 6363.6 6426.8 6442.7 6534.2 6715.0 6715.2 6791.3 6806.8 6814.8 6284.7 6435.6 6448.8 6465.3 6470.5 6614.9 6644.8 6658.7 6662.6 6677.6 6603.7 6609.8 6641.2 6720.2 6733.1 6397.8 6486.5 6488.9 6529.1 6579.6 5015.8 5021.5 5041.3 5051.1 5066.9 6469.2 6671.7 6724.8 6754.6 6820.3 6323.2 6507.0 6513.3 6582.7 6598.4 6362.9 6434.4 6468.9 6495.3 6506.3 6300.8 6376.5 6393.2 6420.8 6444.6 6364.1 6462.6 6492.7 6509.4 6569.2 6249.2 6291.3 6306.5 6356.5 6376.6 16:15:22 INFO - PID 19224 | 16:15:22 INFO - PID 19224 | [#5] yui.html Cycles:180 Average:24850.52 Median:19651.00 stddev:36113.62 (183.8%) stddev-sans-first:36170.14 16:15:22 INFO - PID 19224 | Values: 897.9 912.3 933.8 936.2 947.7 19545.0 20289.8 20435.1 20438.1 20442.4 16865.6 17158.2 17210.0 19757.0 19872.4 985.1 987.7 991.6 992.3 992.5 962.6 982.5 991.4 1001.0 1008.3 1067.6 1067.7 1067.7 1067.9 1068.0 1031.6 1060.7 1061.0 1061.0 1064.0 751.7 752.0 752.5 752.7 761.0 20568.4 20742.8 20749.9 20768.2 20790.0 21200.3 21809.9 22128.8 22245.3 22274.1 17433.6 17489.5 17677.6 17809.6 17811.9 3800.3 3810.2 3831.7 3834.0 3836.0 136524.0 138533.0 138915.0 139258.0 140463.3 16935.7 17479.8 17489.7 17517.7 17526.2 32117.0 32254.2 32631.0 33040.5 33100.8 9043.9 9155.1 9177.2 9201.5 9218.5 3890.0 4129.3 4157.4 4180.1 4198.1 5720.7 5758.8 5811.4 5825.1 5835.6 1005.8 1026.2 1033.0 1042.6 1042.7 670.4 684.0 686.9 695.3 701.8 11558.9 12090.2 12167.4 13299.7 13352.0 682.7 696.6 702.8 707.7 717.4 5782.4 5889.1 5935.1 5936.2 5975.7 124673.0 128333.0 129149.0 130005.0 130182.0 108008.0 111502.0 112704.4 114414.0 115352.0 97004.0 97574.5 98256.5 99193.0 99874.5 10803.8 10893.6 10904.5 10966.9 11187.0 43811.6 44618.0 44904.6 45637.3 47632.0 57721.7 57876.0 57897.0 58430.0 60139.0 15320.8 16037.5 16054.3 16129.4 16173.6 17610.8 17749.3 17866.8 17991.8 18032.9 15018.2 15119.1 15254.0 15272.3 15340.3 16005.4 16189.2 16247.8 16257.4 16292.3 15763.8 15943.0 16002.6 16164.4 16251.4 11183.4 11281.3 11397.9 11660.8 11670.1 10844.7 11077.3 11101.4 11148.0 11285.9 16:15:22 INFO - PID 19224 | -------- Summary: end -------- 16:15:22 INFO - PID 19224 | 16:15:22 INFO - TEST-INFO | 19224: exit 0 16:15:22 INFO - TEST-OK | dromaeo_css | took 1107726ms 16:15:22 INFO - TEST-START | kraken 16:15:22 INFO - Initialising browser for kraken test... 16:15:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38047/getInfo.html -profile /tmp/tmpm_dLul/profile 16:15:22 INFO - TEST-INFO | started process 19587 (/builds/slave/test/build/application/firefox/firefox http://localhost:38047/getInfo.html) 16:15:27 INFO - TEST-INFO | 19587: exit 0 16:15:28 INFO - Browser initialized. 16:15:28 INFO - Running cycle 1/1 for kraken test... 16:15:28 INFO - Using env: {'DISPLAY': ':0', 16:15:28 INFO - 'HOME': '/home/cltbld', 16:15:28 INFO - 'JSGC_DISABLE_POISONING': '1', 16:15:28 INFO - 'LANG': 'en_US.UTF-8', 16:15:28 INFO - 'LANGUAGE': 'en_US:en', 16:15:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:15:28 INFO - 'LOGNAME': 'cltbld', 16:15:28 INFO - 'MAIL': '/var/mail/cltbld', 16:15:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:15:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:15:28 INFO - 'MOZ_CRASHREPORTER': '1', 16:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:15:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:15:28 INFO - 'MOZ_NO_REMOTE': '1', 16:15:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:15:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:15:28 INFO - 'NO_EM_RESTART': '1', 16:15:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:15:28 INFO - 'PWD': '/builds/slave/test', 16:15:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:15:28 INFO - 'RUST_BACKTRACE': 'full', 16:15:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:15:28 INFO - 'SHELL': '/bin/bash', 16:15:28 INFO - 'SHLVL': '1', 16:15:28 INFO - 'STYLO_FORCE_DISABLED': '1', 16:15:28 INFO - 'TERM': 'linux', 16:15:28 INFO - 'TMOUT': '86400', 16:15:28 INFO - 'USER': 'cltbld', 16:15:28 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802', 16:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:15:28 INFO - '_': '/tools/buildbot/bin/python'} 16:15:28 INFO - TEST-INFO | started process 19820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_dLul/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:28 INFO - PID 19820 | 16:15:28 INFO - PID 19820 | (/builds/slave/test/build/application/firefox/firefox:19869): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:15:28 INFO - PID 19820 | 16:15:39 INFO - PID 19820 | RSS: Main: 153399296 16:15:39 INFO - PID 19820 | 16:15:41 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38047/tests/kraken/driver.html?testName=audio-beat-detection) 16:15:42 INFO - PID 19820 | RSS: Main: 160550912 16:15:42 INFO - PID 19820 | 16:15:45 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38047/tests/kraken/driver.html?testName=audio-dft) 16:15:46 INFO - PID 19820 | RSS: Main: 160669696 16:15:46 INFO - PID 19820 | 16:15:49 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38047/tests/kraken/driver.html?testName=audio-fft) 16:15:49 INFO - PID 19820 | RSS: Main: 156303360 16:15:49 INFO - PID 19820 | 16:15:51 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38047/tests/kraken/driver.html?testName=audio-oscillator) 16:15:52 INFO - PID 19820 | RSS: Main: 156971008 16:15:52 INFO - PID 19820 | 16:15:54 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38047/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:15:54 INFO - PID 19820 | RSS: Main: 156717056 16:15:54 INFO - PID 19820 | 16:15:58 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38047/tests/kraken/driver.html?testName=imaging-darkroom) 16:15:58 INFO - PID 19820 | RSS: Main: 159047680 16:15:58 INFO - PID 19820 | 16:16:02 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38047/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:03 INFO - PID 19820 | RSS: Main: 159604736 16:16:03 INFO - PID 19820 | 16:16:06 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38047/tests/kraken/driver.html?testName=json-parse-financial) 16:16:06 INFO - PID 19820 | RSS: Main: 159113216 16:16:06 INFO - PID 19820 | 16:16:08 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38047/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:09 INFO - PID 19820 | RSS: Main: 158674944 16:16:09 INFO - PID 19820 | 16:16:10 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:11 INFO - PID 19820 | RSS: Main: 159031296 16:16:11 INFO - PID 19820 | 16:16:13 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:16:14 INFO - PID 19820 | RSS: Main: 156291072 16:16:14 INFO - PID 19820 | 16:16:16 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:16:17 INFO - PID 19820 | RSS: Main: 156934144 16:16:17 INFO - PID 19820 | 16:16:20 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:16:20 INFO - PID 19820 | RSS: Main: 157302784 16:16:20 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | Cycle 1(1): loaded http://localhost:38047/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38047/tests/kraken/driver.html?testName=ai-astar) 16:16:22 INFO - PID 19820 | RSS: Main: 158527488 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | __start_tp_report 16:16:22 INFO - PID 19820 | _x_x_mozilla_page_load 16:16:22 INFO - PID 19820 | _x_x_mozilla_page_load_details 16:16:22 INFO - PID 19820 | |i|pagename|runs| 16:16:22 INFO - PID 19820 | |0;ai-astar;108;106;108;108;106;109;106;109;107;106 16:16:22 INFO - PID 19820 | |1;audio-beat-detection;125;117;118;116;116;118;116;146;122;122 16:16:22 INFO - PID 19820 | |2;audio-dft;166;165;163;164;166;164;166;164;171;165 16:16:22 INFO - PID 19820 | |3;audio-fft;81;77;76;78;76;75;76;74;76;75 16:16:22 INFO - PID 19820 | |4;audio-oscillator;79;79;79;78;80;79;79;79;79;79 16:16:22 INFO - PID 19820 | |5;imaging-gaussian-blur;114;114;117;114;113;114;113;111;114;114 16:16:22 INFO - PID 19820 | |6;imaging-darkroom;158;149;146;147;147;148;147;149;148;150 16:16:22 INFO - PID 19820 | |7;imaging-desaturate;94;96;94;94;95;94;95;95;94;95 16:16:22 INFO - PID 19820 | |8;json-parse-financial;52;53;53;54;60;51;51;50;51;50 16:16:22 INFO - PID 19820 | |9;json-stringify-tinderbox;37;37;37;38;38;39;38;39;38;38 16:16:22 INFO - PID 19820 | |10;stanford-crypto-aes;75;73;73;72;74;73;77;76;78;77 16:16:22 INFO - PID 19820 | |11;stanford-crypto-ccm;119;108;117;114;122;113;112;120;108;112 16:16:22 INFO - PID 19820 | |12;stanford-crypto-pbkdf2;169;169;166;168;173;169;170;171;168;167 16:16:22 INFO - PID 19820 | |13;stanford-crypto-sha256-iterative;67;69;65;65;66;64;66;66;63;64 16:16:22 INFO - PID 19820 | __end_tp_report 16:16:22 INFO - PID 19820 | __start_cc_report 16:16:22 INFO - PID 19820 | _x_x_mozilla_cycle_collect,747 16:16:22 INFO - PID 19820 | __end_cc_report 16:16:22 INFO - PID 19820 | __startTimestamp1506122182697__endTimestamp 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | ------- Summary: start ------- 16:16:22 INFO - PID 19820 | Number of tests: 14 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#0] ai-astar Cycles:10 Average:107.30 Median:108.00 stddev:1.25 (1.2%) stddev-sans-first:1.30 16:16:22 INFO - PID 19820 | Values: 108.0 106.0 108.0 108.0 106.0 109.0 106.0 109.0 107.0 106.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:120.00 stddev:9.12 (7.6%) stddev-sans-first:9.59 16:16:22 INFO - PID 19820 | Values: 125.0 117.0 118.0 116.0 116.0 118.0 116.0 146.0 122.0 122.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:2.22 (1.3%) stddev-sans-first:2.35 16:16:22 INFO - PID 19820 | Values: 166.0 165.0 163.0 164.0 166.0 164.0 166.0 164.0 171.0 165.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#3] audio-fft Cycles:10 Average:76.40 Median:76.00 stddev:1.96 (2.6%) stddev-sans-first:1.17 16:16:22 INFO - PID 19820 | Values: 81.0 77.0 76.0 78.0 76.0 75.0 76.0 74.0 76.0 75.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 16:16:22 INFO - PID 19820 | Values: 79.0 79.0 79.0 78.0 80.0 79.0 79.0 79.0 79.0 79.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 16:16:22 INFO - PID 19820 | Values: 114.0 114.0 117.0 114.0 113.0 114.0 113.0 111.0 114.0 114.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.50 stddev:3.41 (2.3%) stddev-sans-first:1.27 16:16:22 INFO - PID 19820 | Values: 158.0 149.0 146.0 147.0 147.0 148.0 147.0 149.0 148.0 150.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 16:16:22 INFO - PID 19820 | Values: 94.0 96.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:2.95 (5.6%) stddev-sans-first:3.13 16:16:22 INFO - PID 19820 | Values: 52.0 53.0 53.0 54.0 60.0 51.0 51.0 50.0 51.0 50.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.74 (1.9%) stddev-sans-first:0.71 16:16:22 INFO - PID 19820 | Values: 37.0 37.0 37.0 38.0 38.0 39.0 38.0 39.0 38.0 38.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#10] stanford-crypto-aes Cycles:10 Average:74.80 Median:75.50 stddev:2.10 (2.8%) stddev-sans-first:2.22 16:16:22 INFO - PID 19820 | Values: 75.0 73.0 73.0 72.0 74.0 73.0 77.0 76.0 78.0 77.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#11] stanford-crypto-ccm Cycles:10 Average:114.50 Median:115.50 stddev:4.86 (4.2%) stddev-sans-first:4.87 16:16:22 INFO - PID 19820 | Values: 119.0 108.0 117.0 114.0 122.0 113.0 112.0 120.0 108.0 112.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:2.00 (1.2%) stddev-sans-first:2.12 16:16:22 INFO - PID 19820 | Values: 169.0 169.0 166.0 168.0 173.0 169.0 170.0 171.0 168.0 167.0 16:16:22 INFO - PID 19820 | 16:16:22 INFO - PID 19820 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:1.72 (2.6%) stddev-sans-first:1.73 16:16:22 INFO - PID 19820 | Values: 67.0 69.0 65.0 65.0 66.0 64.0 66.0 66.0 63.0 64.0 16:16:22 INFO - PID 19820 | -------- Summary: end -------- 16:16:22 INFO - PID 19820 | 16:16:23 INFO - PID 19820 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:16:23 INFO - TEST-INFO | 19820: exit 0 16:16:23 INFO - TEST-OK | kraken | took 60502ms 16:16:23 INFO - SUITE-END | took 1168s 16:16:23 INFO - Completed test suite (00:19:28) 16:16:23 INFO - javascript benchmark 16:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8527.388628509148, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.6280464941897, 3011.608490896183, 3015.6079709637743, 3147.8898238561646, 3183.060997005883, 6215.09881067245, 6294.874102517947, 6310.905336419957, 6344.777932772354, 6414.550981431295, 6274.780382686607, 6296.0, 6300.936990630093, 6313.936860631392, 6359.523035772312, 5822.1266809978415, 5857.711303513242, 5882.088276317167, 5884.323302820188, 5919.378465261128, 12.42243740644352, 5835.912461313083, 5877.911831322513, 5908.261467316585, 5909.940900591004, 5355.410904800468, 5725.656460612356, 5741.454561816641, 5852.590318677694, 5856.912146317809, 5785.652860828363, 5787.797427090031, 5827.79602713903, 5854.975379308604, 5867.970660146672, 5742.310922689304, 5752.453516915886, 5814.825555233349, 5817.069268916953, 5834.474897259224, 6191.226096737908, 6305.621662700252, 6320.810375688737, 6396.360363963567, 6402.199725034371, 6585.176852893388, 6755.425788807957, 6780.932190678129, 6814.557053791487, 6839.760608378732, 6677.532572719863, 6694.799156025327, 6697.8995315070315, 6700.430463410616, 6704.5306828522025, 6163.96918015407, 6244.500439964792, 6268.905966410507, 6381.872362552723, 6389.297177310492, 6991.19601245853, 7051.576905385693, 7065.57606543609, 7070.681819318143, 7072.434205263567, 6677.565958212701, 6679.532432729759, 6749.190097188369, 6753.324667533306, 6759.493038022168, 6572.277049524549, 6701.430378417792, 6703.927371620517, 6738.393544581011, 6786.626735529593, 6506.642134682544, 6671.132752742113, 6676.532642714963, 6681.665916704145, 6689.799306020827, 6443.097966284724, 6682.966585167043, 6694.464442844561, 6699.43054840344, 6831.180258369028, 5209.7916083356995, 5264.868378290574, 5265.578753699695, 5281.392639846466, 5283.630145889828, 4502.774861256924, 4511.233090374644, 4540.455145382575, 4541.3869127668, 4550.0, 5701.4298570142655, 5803.245578074823, 5806.21616081832, 5821.010428227211, 5892.6759028253855, 6756.763513277012, 6768.932310676831, 6770.119884414995, 6855.348741869514, 6865.27914568973, 5829.7376618052285, 5876.6180198286975, 5892.145638882338, 5900.940990590039, 5905.43898329658, 5787.102999035156, 5800.970995144998, 5852.824415267549, 5857.912131318034, 5879.000569903127, 6444.194475690539, 6551.410373066352, 6566.179227596551, 6661.500387470959, 6666.799996000128, 6678.1318428603, 6722.462203023746, 6740.662966851638, 6794.966025169842, 6795.354441328066, 6555.4427873631275, 6607.372299631527, 6608.471322294109, 6630.734770609314, 6646.136002319668, 6618.602883826986, 6648.767293144717, 6729.226138994079, 6744.527883048139, 6745.831354216184, 6763.695633696397, 6775.322467753185, 6780.118584583973, 6874.690638921161, 6876.793696189123, 6404.7438102477245, 6488.286288508355, 6494.220693516808, 6499.1551098358805, 6505.479561634963, 6511.2512061113575, 6520.250171230369, 6587.209534855656, 6598.472122230306, 6623.238327592196, 6495.610263384212, 6544.640044797582, 6568.310327415744, 6574.112494813139, 6578.506612004215, 6590.1103351046995, 6620.735170593315, 6641.933580664131, 6706.865862682622, 6708.899366509604, 6355.713992870239, 6372.58578192416, 6422.967885160544, 6455.806325810233, 6466.159399278252], "value": 6105.27123850086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.4133568505574, 884.8363052835226, 912.9224015958652, 915.6657819895736, 916.0152835701623, 37982.0, 40676.59323406765, 41008.99999999996, 41039.38440923385, 41046.0, 37428.0, 37746.43380349297, 37823.43264851023, 37828.810855945754, 37947.24105517888, 7223.097112860893, 7373.11522617284, 7379.815504612401, 7384.372328352097, 7385.113786345646, 7252.637368131599, 7343.669534870917, 7353.301436363537, 7353.77938661841, 7357.705691772323, 7846.215378462165, 8134.227248411392, 8142.307903828152, 8150.0, 8160.9591952040155, 8011.879821802678, 8024.43828931975, 8054.677812887507, 8057.556834374107, 8071.152528984431, 7788.922110778876, 7935.960320198362, 7976.880346794803, 8003.319717823933, 8013.759587212393, 38089.0, 38096.42855357172, 38129.809350953066, 38158.0, 38221.0, 3519.894403167909, 3558.768680035815, 3560.0, 3561.6794488495902, 3570.0539357070397, 31818.0, 31879.203019924687, 31899.362012759848, 31970.520442193385, 31995.680043199736, 5171.120909445403, 5234.16253399458, 5239.449857764918, 5268.0, 5269.578433725293, 195656.0, 197956.0, 198587.0, 198625.00687496614, 198999.0, 48304.7584762074, 48360.516394836304, 48390.5160948393, 48639.756801215764, 48664.27003594949, 51213.48786512087, 51252.74373628108, 51260.74369628128, 51362.74318628383, 51424.74287628538, 16091.195440227943, 16424.260908259155, 16425.0, 16451.67096658084, 16452.83547164537, 13467.259300738553, 13468.595942121752, 13488.123271987486, 13516.256605886574, 13527.188368697713, 14232.430702771773, 14528.273586320642, 14551.126932384092, 14587.927060364631, 14655.267236638125, 5841.481214884161, 5894.67579283135, 5926.377730338252, 5946.970265148733, 5955.642661440241, 1004.091297375876, 1008.8184126857236, 1013.9797204056025, 1020.3520764314713, 1030.6392762533053, 22306.553868922856, 22492.662610060863, 22728.886355568116, 22745.317640470814, 23038.078476860737, 1112.1103117506125, 1116.2298014370058, 1117.8323251512174, 1121.2823792772633, 1123.3540714089431, 12109.576164834189, 12176.81734773979, 12179.0, 12186.51253949832, 12270.38648067593, 219975.0, 221934.0, 222107.0, 222584.0, 223412.0, 51424.48575514197, 51912.0, 56173.15740263899, 56184.0, 56184.438155618736, 1437.0300047468127, 1453.1571688420902, 1459.9708005840037, 1463.7877507761316, 1469.1111877314286, 26363.0, 26546.734532654427, 26563.33591660224, 26712.19863404101, 27366.452670946866, 37191.25617487689, 37274.25451491009, 37314.440283395226, 37327.81336093302, 37346.813265933495, 194721.0, 197468.0, 198412.0, 198700.0, 198807.0, 32587.0, 32777.34445311033, 32850.67149328476, 33045.339093218485, 33148.83425582953, 39473.40789888096, 41267.38098928578, 41718.0, 41825.372619410125, 41916.0, 30202.0, 30660.540091899085, 31057.378852423277, 31287.0, 31978.0, 29789.553156702234, 30391.088267352014, 30421.84789076129, 30509.54235686422, 30542.694573053985, 35402.29195416129, 35412.64587354093, 35623.82188089043, 35649.82175089108, 35791.0, 30303.848480757457, 30314.393712126075, 30485.23786905345, 30652.0, 31034.0, 22314.553708925407, 22474.32577022692, 22670.659940101243, 22908.656370154793, 22950.42623934415], "value": 17157.33981724595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.2952633024546, 587.5622661117466, 590.1727298469427, 604.2718524178365, 605.0923614578132, 21747.782522174773, 22411.887940560275, 22476.0, 22527.32418027462, 22608.321750347473, 23183.18858839941, 24037.0, 24412.75587244127, 24612.38469038275, 24733.134340298093, 6594.703238354262, 6803.0, 6803.047573339736, 6807.489438292123, 6807.931920680804, 6031.1254868044325, 6298.370162983688, 6695.832604184886, 6781.491388145884, 6793.286704895964, 6316.557840951135, 6320.241571011485, 6322.304546499881, 6328.398802113815, 6328.525360597951, 6250.437460628543, 6309.905351419732, 6388.488920886318, 6624.900626490607, 6657.068010478537, 6194.225721784777, 6199.907001394983, 6200.689965501752, 6201.100840378165, 6215.782447614311, 27421.451570968668, 27806.860965695243, 27993.0, 28004.43991120166, 28026.299342516395, 2066.95866082679, 2074.1288658763356, 2095.1619352259067, 2105.8631188972668, 2106.368089573122, 18564.3502477414, 19005.0, 19440.416787496397, 19524.70712939307, 19539.316123935594, 2473.9010439582394, 2485.478049609584, 2529.8861551230057, 2530.607755797854, 2533.949321013588, 123933.0, 126264.99999999908, 129712.35143824315, 131859.99999999904, 132647.33676331557, 14685.454454604593, 14836.406543738129, 14872.776908346383, 14915.403383864741, 15575.766363504557, 23584.292471225548, 23664.0, 23664.408389790395, 23728.881355593112, 23770.286891393287, 9476.147146756686, 9516.143547080796, 9549.0, 9601.711948641552, 9608.615655373847, 8492.447990880573, 8576.0, 8620.87928569282, 8660.826783464296, 8676.95661521701, 9173.266138708887, 9231.723048308562, 9263.397879137834, 9268.675596354095, 9418.95290523543, 2707.458508298348, 2768.6262354581872, 2789.6512935883015, 2901.347196880685, 2905.8111222770453, 949.6011675096476, 955.8852937647526, 957.0471666236001, 980.3578655980344, 991.7421470417744, 18388.908055459637, 18726.90636546836, 18883.90558047201, 18970.905145474186, 18981.0, 1030.9639162629421, 1035.0994634667886, 1044.9582016719398, 1045.6862941117633, 1053.478528128566, 10284.331518451278, 10443.321184123008, 10624.946875265574, 10687.572497100184, 10750.0, 449696.0, 457812.0, 459476.0, 472418.0, 508027.0, 112250.43874780738, 113841.0, 113878.43060784643, 114454.0, 117601.4119929395, 1043.9373637581768, 1082.2370228988543, 1089.0525243038448, 1135.1486385211092, 1175.6766889105393, 19448.22207111756, 19555.217791288756, 19641.70537441911, 19738.40784776459, 20158.992050397716, 56310.0, 57011.71494142503, 58289.708551458665, 58319.70840145772, 60199.39800601938, 71838.0, 72114.0, 72388.0, 72467.63766181347, 72592.63703681447, 14100.858991409954, 14423.855761442252, 14452.638684032983, 14544.054636448596, 14575.198364090076, 21967.670484943057, 22098.0, 22285.108595656642, 22606.0, 22638.547229055657, 17645.911770441067, 18104.818951810314, 18189.45431637053, 18207.45377638673, 18240.0, 15831.525054248392, 15926.0, 16372.590685232964, 16604.086775226995, 16669.83330166683, 16894.49316520506, 17146.0, 17199.22603482821, 17692.469225923243, 18492.260309587466, 14227.786583201054, 14327.498537551135, 14379.496717614833, 14385.28073596337, 14445.566633001026, 16597.585060373105, 17760.111994400486, 17773.644527109125, 17881.105944702973, 17973.550661233574], "value": 11815.216478711554, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.4352228541727, 1374.3952660829227, 1396.280915328606, 1396.588006538071, 1399.461207435137, 15416.845831541681, 16044.358225670989, 16057.83942160578, 16058.839411605895, 16099.83900160998, 15645.061296322228, 15869.047857128551, 15873.84126158738, 15878.84121158788, 15902.602434939132, 2757.8345299282005, 2798.5102607043736, 2834.674012488559, 2835.31952331441, 2837.645294338208, 2724.1282789507363, 2734.220747087081, 2740.9588856167074, 2741.821781584191, 2750.4499100179946, 2725.3731641722316, 2725.523033469145, 2846.7437930586243, 2848.6296781418387, 2849.230707708917, 2831.5469524876025, 2838.3329917469378, 2855.842928638924, 2864.7135286471394, 2866.5986761853355, 2719.5376785946437, 2736.8768405421606, 2842.729940655655, 2845.2744550139787, 2845.900393486239, 15377.692446151013, 15416.075035497794, 15418.922905385514, 15510.30203640839, 15591.688166236612, 7984.680612775482, 8270.421070525066, 8294.751157465285, 8308.462934357163, 8345.499270043816, 5364.177601374357, 5576.302962129734, 5674.404187560288, 5681.23303354046, 5703.372629010805, 1931.2950772967906, 1939.9903000484908, 1974.19058186143, 1991.4324417540931, 2008.4777957730948, 27815.635670967993, 27991.0, 28134.577981330298, 28136.71863281382, 28137.85931070352, 6992.3357281058215, 7015.088038554955, 7035.366816986496, 7193.4604904631315, 7230.385417239489, 17990.550236243937, 17997.550061248574, 18011.369602063864, 18019.369322073664, 18046.5488362792, 8148.918510814816, 8332.916670833214, 8334.083250842403, 8336.62485188168, 8339.874901876477, 7093.219745827955, 7195.856082878313, 7485.513441626277, 7516.849663006818, 7635.694572217049, 5216.478352164753, 5490.149026900836, 5503.559715222773, 5517.144842549411, 5538.169274608841, 1581.5018269245152, 1584.8018997625297, 1586.912719800399, 1601.0633779239042, 1604.4143887480986, 846.399056669759, 855.4097672605882, 868.6438560190292, 870.0820634230947, 885.3979294080087, 7251.057362542836, 7268.636568171676, 7352.558846469229, 7378.741744038933, 7385.889211661829, 692.2904023376079, 697.4594689115976, 726.0452504955966, 736.6869080640706, 740.1525253584615, 4429.734215947054, 4972.527609877128, 5000.024995125988, 5016.924746128811, 5094.974525127424, 21529.246476373253, 23265.418364541023, 23396.766032339798, 23398.532029359318, 23400.06399744025, 20607.58784824295, 22704.545909082055, 22756.20353287627, 22756.317310480714, 23207.651885221734, 10518.789624207626, 10752.516136773864, 10760.677179684622, 10769.78460430787, 11482.425878706199, 7600.885986710093, 8208.712695055645, 8274.131216222451, 8403.83192336162, 8419.789505262172, 18461.723074154168, 18540.907295463436, 19105.617887642446, 19270.421887343404, 19382.12780424856, 19126.7130993038, 19572.510687232934, 19729.40811775649, 19975.700364494252, 20192.697109543074, 11388.601398950997, 11392.487338069972, 11553.24903881245, 11563.5952741657, 11571.942140289244, 14309.21299328547, 14345.0, 14395.064320819114, 14450.132992020512, 14472.855271447152, 11689.766204676029, 11740.882591173979, 11787.11596630239, 11977.520899163936, 12008.63974080779, 11133.443327833738, 11140.442977850913, 11142.442877856236, 11176.944115279372, 11442.48508817122, 10056.748581285234, 10288.588456461657, 10323.63867264642, 10366.844497332395, 10368.377897326185, 7381.298776616213, 7506.662200201114, 7554.017977662868, 7624.504407213513, 7657.961710191414, 7273.236310187566, 7402.222766609644, 7458.216887226763, 7482.214367491335, 7517.962410187914], "value": 6764.994537789636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.2641133562004, 518.7250757098737, 533.1078896983863, 536.3510152715214, 542.054115568333, 6243.594166379182, 6249.218847644044, 6268.968655156724, 6312.558120931537, 6346.5874718143405, 6209.410106039931, 6215.595986260902, 6277.372262773721, 6306.558540902139, 6311.684415779216, 5157.149070403379, 5192.8701782455455, 5193.610479214074, 5222.895542089156, 5229.189475631283, 4830.2030165022725, 5080.923786143211, 5233.921491177635, 5249.212618107276, 5258.368995720519, 4966.0, 4966.751662416883, 5002.474740152286, 5007.2489126630935, 5010.148274793294, 4930.383702037263, 4941.629377796679, 4992.528698294349, 5006.499350064964, 5015.548600625962, 4407.669424793121, 4494.910101797946, 4503.594676479132, 4513.932291015637, 4519.909601807945, 5985.7306421210715, 5989.9101513477335, 6056.545759068087, 6080.692651079995, 6083.726232319556, 5665.688387138705, 5685.459881311269, 5721.7711291548285, 5732.5127364174095, 5764.5676574257095, 6449.677516124175, 6483.578567393151, 6545.214574251073, 6550.737970481175, 6550.868982620368, 4717.622590192776, 4883.096627123993, 4902.7058376497525, 4914.557689807934, 4934.703917764946, 6524.184476940382, 6648.900266496006, 6694.196696396415, 6865.794026179223, 6880.621565813878, 4963.875903102451, 4987.725675087905, 5024.598032157419, 5029.974850125799, 5032.6980381177245, 5077.847664570068, 5118.232265160182, 5120.539151476385, 5124.615653825978, 5169.586433085344, 5744.971275143681, 5745.913811292834, 5756.1653560233535, 5764.942350576441, 5788.797392091256, 6533.823911695846, 6565.848392771496, 6571.178602674666, 6594.845901967136, 6639.236487803964, 1739.7651317072286, 1746.8340507651753, 1757.6484703059439, 1774.9556261093576, 1776.6979613465483, 1177.8645455772526, 1211.963641090751, 1219.9817002744967, 1223.7063104854772, 1246.9127161098636, 5669.518090962232, 5694.686792226467, 5699.772009119672, 5701.344345400332, 5752.28096487939, 6522.478201743849, 6576.76981305652, 6623.0, 6635.175326785173, 6694.230163531159, 5470.234167216593, 5602.971985140048, 5696.8860622787315, 5700.657960522382, 5718.714064296769, 3464.5496085509226, 3521.7710848794745, 3522.9918946200933, 3537.1510837399355, 3552.928941421157, 6280.371962803683, 6363.5863668861375, 6426.807195784134, 6442.742290308429, 6534.150560427114, 6715.0, 6715.1941766988275, 6791.295311937995, 6806.76176333826, 6814.795556133324, 6284.654344011124, 6435.613863168225, 6448.806970710433, 6465.288818230085, 6470.5147113965695, 6614.900776488453, 6644.800655980328, 6658.7336506539195, 6662.56693314933, 6677.599344039373, 6603.735850565923, 6609.768658096944, 6641.203055633162, 6720.1599800025, 6733.057371968026, 6397.808065758035, 6486.475678215521, 6488.870222595616, 6529.118568993125, 6579.605223686594, 5015.774290157025, 5021.497850215095, 5041.344625198701, 5051.141305978066, 5066.885285237242, 6469.223693156851, 6671.66641667905, 6724.764633238009, 6754.628495432798, 6820.31796820314, 6323.241211054703, 6506.967465162644, 6513.250976137805, 6582.670866456754, 6598.406143447113, 6362.854686156536, 6434.420902118832, 6468.935310647022, 6495.285518593046, 6506.349365063646, 6300.84247893788, 6376.52176086786, 6393.1688880445245, 6420.807375778734, 6444.645544494911, 6364.122583837687, 6462.579932304385, 6492.701459708172, 6509.446697030616, 6569.24453687832, 6249.187605611241, 6291.276503202191, 6306.4639505642535, 6356.459700925473, 6376.649284289409], "value": 5051.469915589224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.9416337938029, 912.2884150362718, 933.7665583604099, 936.2135805923019, 947.7488465556627, 19545.0, 20289.797102028977, 20435.080421381055, 20438.08028638711, 20442.386728398134, 16865.578360540963, 17158.22787974541, 17210.0, 19757.0, 19872.403827885188, 985.1330828870601, 987.7036888933327, 991.6083147156869, 992.2954702161474, 992.4839083676484, 962.6149540183948, 982.5283863745407, 991.3754334769121, 1001.0, 1008.2690049713935, 1067.64767626683, 1067.695706723584, 1067.7117178361837, 1067.941263230522, 1067.9893201067969, 1031.6234574380371, 1060.6870973062926, 1060.978780424395, 1060.9893901061007, 1064.0157853985072, 751.6655088485626, 752.0298814529251, 752.5071078443628, 752.6500177417527, 760.9581473018982, 20568.38294851142, 20742.79257207424, 20749.896250518803, 20768.169273229054, 20790.0, 21200.257990970244, 21809.890950545305, 22128.778712212992, 22245.332640020824, 22274.109035638554, 17433.564160895952, 17489.475315740547, 17677.646447070987, 17809.554761130945, 17811.910940445345, 3800.3349413852466, 3810.1998580298173, 3831.731778775487, 3833.961660383416, 3835.9808200959096, 136524.0, 138533.0, 138915.0, 139258.0, 140463.29768351195, 16935.745963810554, 17479.825201748074, 17489.7376539352, 17517.7372339415, 17526.21132049061, 32117.0, 32254.19364515906, 32631.0, 33040.50439243413, 33100.83449582737, 9043.909560904438, 9155.13026262504, 9177.174054335143, 9201.539923003824, 9218.492982885871, 3890.0, 4129.256733787947, 4157.397177409259, 4180.080382315886, 4198.097409057067, 5720.713964301768, 5758.769649213985, 5811.389804070512, 5825.097109947965, 5835.620684655484, 1005.7586179316911, 1026.2405819693374, 1032.9896701033044, 1042.5517027678172, 1042.6559235452435, 670.4401824476616, 684.0320945861649, 686.9244383117853, 695.3116414749362, 701.8350687588413, 11558.94220528892, 12090.214136081127, 12167.391630418444, 13299.734005319839, 13352.0, 682.7303215229956, 696.6481926627122, 702.771599230242, 707.6532499075519, 717.4224749077043, 5782.392848750821, 5889.087191485327, 5935.080062590306, 5936.22829032223, 5975.671338076448, 124673.0, 128333.0, 129149.0, 130005.0, 130182.0, 108008.0, 111502.0, 112704.43647781709, 114414.0, 115352.0, 97004.0, 97574.51212743891, 98256.50871745596, 99193.0, 99874.5006274964, 10803.760176314638, 10893.618723344645, 10904.509297081491, 10966.890331096587, 11187.0, 43811.56188438203, 44618.0, 44904.550954491344, 45637.315440269085, 47632.0, 57721.711391442775, 57876.0, 57897.0, 58430.0, 60139.0, 15320.846791531942, 16037.518874433787, 16054.277557509706, 16129.354825806837, 16173.59566010859, 17610.82389176092, 17749.29002839872, 17866.821331787036, 17991.820081799015, 18032.90983545074, 15018.249087545797, 15119.092854428769, 15254.0, 15272.312745926682, 15340.30968606393, 16005.439809606607, 16189.190540472693, 16247.756283655519, 16257.430989915296, 16292.266847991632, 15763.842361576237, 15942.963707358984, 16002.599935001717, 16164.434244801376, 16251.43119990842, 11183.384913829817, 11281.266717663326, 11397.943010284895, 11660.825087623862, 11670.124740644655, 10844.67465976022, 11077.279976801483, 11101.444927753742, 11148.0, 11285.943570282425], "value": 9090.524643513152, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1421.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 108.0, 108.0, 106.0, 109.0, 106.0, 109.0, 107.0, 106.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 117.0, 118.0, 116.0, 116.0, 118.0, 116.0, 146.0, 122.0, 122.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 163.0, 164.0, 166.0, 164.0, 166.0, 164.0, 171.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 76.0, 78.0, 76.0, 75.0, 76.0, 74.0, 76.0, 75.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 78.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 114.0, 113.0, 114.0, 113.0, 111.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 149.0, 146.0, 147.0, 147.0, 148.0, 147.0, 149.0, 148.0, 150.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 54.0, 60.0, 51.0, 51.0, 50.0, 51.0, 50.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 38.0, 38.0, 39.0, 38.0, 39.0, 38.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 72.0, 74.0, 73.0, 77.0, 76.0, 78.0, 77.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 108.0, 117.0, 114.0, 122.0, 113.0, 112.0, 120.0, 108.0, 112.0], "value": 114.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 166.0, 168.0, 173.0, 169.0, 170.0, 171.0, 168.0, 167.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 65.0, 65.0, 66.0, 64.0, 66.0, 66.0, 63.0, 64.0], "value": 65.5, "unit": "score"}]}]} 16:16:23 INFO - Return code: 0 16:16:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:16:23 INFO - # TBPL SUCCESS # 16:16:23 INFO - Running post-action listener: _package_coverage_data 16:16:23 INFO - Running post-action listener: _resource_record_post_action 16:16:23 INFO - [mozharness: 2017-09-22 23:16:23.978134Z] Finished run-tests step (success) 16:16:23 INFO - Running post-run listener: _resource_record_post_run 16:16:24 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 342814720; Read time: 16; Write time: 325936 16:16:24 INFO - TinderboxPrint: CPU usage
13.1% 16:16:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:16:24 INFO - TinderboxPrint: I/O write bytes / time
342,814,720 / 325,936 16:16:24 INFO - TinderboxPrint: CPU idle
8,221.2 (86.9%) 16:16:24 INFO - TinderboxPrint: CPU user
1,191.5 (12.6%) 16:16:24 INFO - TinderboxPrint: Swap in / out
0 / 0 16:16:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10043392; Read time: 0; Write time: 800 16:16:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:16:24 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 332771328; Read time: 0; Write time: 325136 16:16:24 INFO - Running post-run listener: _upload_blobber_files 16:16:24 INFO - Blob upload gear active. 16:16:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:16:24 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 16:16:24 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'] 16:16:24 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 16:16:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:16:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:31 INFO - (blobuploader) - INFO - Done attempting. 16:16:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:16:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:16:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:32 INFO - (blobuploader) - INFO - Done attempting. 16:16:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:16:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:33 INFO - (blobuploader) - INFO - Done attempting. 16:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:34 INFO - (blobuploader) - INFO - Done attempting. 16:16:34 INFO - (blobuploader) - INFO - Iteration through files over. 16:16:34 INFO - Return code: 0 16:16:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:16:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:16:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58571bdc094b72770a87a8918818be6e3295f06d7a5c0b73028fc40b36a59e33c27619d20626751f11d851bd775450efd0a26f7f5dbfcc94e78a86ed2a4a91f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89ce2b523fc64c3119eeb10301ba9ec3cf4fdb102c2b4eac55adf3b785fc100293042fb14c8534c64816d1c85f627495b2cb88191fd9efe7c6595f306aeb1da6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccf0c046c038a92d200dd0e0a103dc2bfdcc3067e8356017238481b843bb914303757e892e5555839fe6bb872be102e9da141fa4fb31f4961456865ce03e6a08", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86e90214ac727dc1472ba47d2b6ce0d2e7b07393e7f0a540905228f94f53db6b48afad7b11d31ff8e1952bf06198ed1c643f53d7c8e38d136a43de539a4d5fb"} 16:16:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:16:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:16:34 INFO - Contents: 16:16:34 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58571bdc094b72770a87a8918818be6e3295f06d7a5c0b73028fc40b36a59e33c27619d20626751f11d851bd775450efd0a26f7f5dbfcc94e78a86ed2a4a91f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89ce2b523fc64c3119eeb10301ba9ec3cf4fdb102c2b4eac55adf3b785fc100293042fb14c8534c64816d1c85f627495b2cb88191fd9efe7c6595f306aeb1da6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccf0c046c038a92d200dd0e0a103dc2bfdcc3067e8356017238481b843bb914303757e892e5555839fe6bb872be102e9da141fa4fb31f4961456865ce03e6a08", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86e90214ac727dc1472ba47d2b6ce0d2e7b07393e7f0a540905228f94f53db6b48afad7b11d31ff8e1952bf06198ed1c643f53d7c8e38d136a43de539a4d5fb"} 16:16:34 INFO - Running post-run listener: copy_logs_to_upload_dir 16:16:34 INFO - Copying logs to upload dir... 16:16:34 INFO - mkdir: /builds/slave/test/build/upload/logs 16:16:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.102979 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-09-22 16:16:34.936797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 16:16:34.941970) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58571bdc094b72770a87a8918818be6e3295f06d7a5c0b73028fc40b36a59e33c27619d20626751f11d851bd775450efd0a26f7f5dbfcc94e78a86ed2a4a91f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89ce2b523fc64c3119eeb10301ba9ec3cf4fdb102c2b4eac55adf3b785fc100293042fb14c8534c64816d1c85f627495b2cb88191fd9efe7c6595f306aeb1da6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccf0c046c038a92d200dd0e0a103dc2bfdcc3067e8356017238481b843bb914303757e892e5555839fe6bb872be102e9da141fa4fb31f4961456865ce03e6a08", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86e90214ac727dc1472ba47d2b6ce0d2e7b07393e7f0a540905228f94f53db6b48afad7b11d31ff8e1952bf06198ed1c643f53d7c8e38d136a43de539a4d5fb"} build_url:https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/Rya6KjrkSJOt9EaGINvG8Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58571bdc094b72770a87a8918818be6e3295f06d7a5c0b73028fc40b36a59e33c27619d20626751f11d851bd775450efd0a26f7f5dbfcc94e78a86ed2a4a91f6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/89ce2b523fc64c3119eeb10301ba9ec3cf4fdb102c2b4eac55adf3b785fc100293042fb14c8534c64816d1c85f627495b2cb88191fd9efe7c6595f306aeb1da6", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ccf0c046c038a92d200dd0e0a103dc2bfdcc3067e8356017238481b843bb914303757e892e5555839fe6bb872be102e9da141fa4fb31f4961456865ce03e6a08", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d86e90214ac727dc1472ba47d2b6ce0d2e7b07393e7f0a540905228f94f53db6b48afad7b11d31ff8e1952bf06198ed1c643f53d7c8e38d136a43de539a4d5fb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-22 16:16:34.973441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:16:34.973782) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1506120181.809726-1263941802 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004577 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-22 16:16:35.053429) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 16:16:35.056817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-22 16:16:35.057096) ========= ========= Total master_lag: 0.26 =========