builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-025 starttime: 1506596596.4 results: success (0) revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.395353) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.395795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.396080) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.409593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.409947) ========= 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=232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-28 04:03:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.7M=0s 2017-09-28 04:03:16 (41.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156601 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.584226) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.584570) ========= 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=232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014950 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:16.634023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 04:03:16.634365) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-28 04:03:16,653 truncating revision to first 12 chars 2017-09-28 04:03:16,653 Setting DEBUG logging. 2017-09-28 04:03:16,653 attempt 1/10 2017-09-28 04:03:16,653 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82c2eecf82ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-28 04:03:17,314 unpacking tar archive at: mozilla-central-82c2eecf82ba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.002879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-28 04:03:17.660054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:17.660391) ========= script_repo_revision: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:17.660769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:17.661043) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-28 04:03:17.677334) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-28 04:03:17.677772) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:03:17 INFO - MultiFileLogger online at 20170928 04:03:17 in /builds/slave/test 04:03:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:03:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:03:17 INFO - {'append_to_log': False, 04:03:17 INFO - 'base_work_dir': '/builds/slave/test', 04:03:17 INFO - 'blob_upload_branch': 'Firefox', 04:03:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:03:17 INFO - 'branch': 'Firefox', 04:03:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:03:17 INFO - 'code_coverage': False, 04:03:17 INFO - 'config_files': ('talos/linux_config.py',), 04:03:17 INFO - 'default_actions': ('clobber', 04:03:17 INFO - 'read-buildbot-config', 04:03:17 INFO - 'download-and-extract', 04:03:17 INFO - 'populate-webroot', 04:03:17 INFO - 'create-virtualenv', 04:03:17 INFO - 'install', 04:03:17 INFO - 'setup-mitmproxy', 04:03:17 INFO - 'run-tests'), 04:03:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:03:17 INFO - 'disable_ccov_upload': False, 04:03:17 INFO - 'disable_stylo': False, 04:03:17 INFO - 'download_minidump_stackwalk': True, 04:03:17 INFO - 'download_symbols': 'ondemand', 04:03:17 INFO - 'enable_stylo': False, 04:03:17 INFO - 'enable_webrender': False, 04:03:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 04:03:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:03:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:03:17 INFO - 'gecko_profile': False, 04:03:17 INFO - 'gecko_profile_interval': 0, 04:03:17 INFO - 'installer_path': 'installer.exe', 04:03:17 INFO - 'log_level': 'info', 04:03:17 INFO - 'log_name': 'talos', 04:03:17 INFO - 'log_to_console': True, 04:03:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:03:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:03:17 INFO - 'opt_config_files': (), 04:03:17 INFO - 'pip_index': False, 04:03:17 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 04:03:17 INFO - 'system_bits': '32', 04:03:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:03:17 INFO - 'title': 'talos-linux64-ix-025', 04:03:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:03:17 INFO - 'use_talos_json': True, 04:03:17 INFO - 'verify': 'False', 04:03:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:03:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:03:17 INFO - 'work_dir': 'build'} 04:03:17 INFO - [mozharness: 2017-09-28 11:03:17.836030Z] Running clobber step. 04:03:17 INFO - Running pre-action listener: _resource_record_pre_action 04:03:17 INFO - Running main action method: clobber 04:03:17 INFO - rmtree: /builds/slave/test/build 04:03:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:03:18 INFO - Running post-action listener: _resource_record_post_action 04:03:18 INFO - [mozharness: 2017-09-28 11:03:18.829745Z] Finished clobber step (success) 04:03:18 INFO - [mozharness: 2017-09-28 11:03:18.829842Z] Running read-buildbot-config step. 04:03:18 INFO - Running pre-action listener: _resource_record_pre_action 04:03:18 INFO - Running main action method: read_buildbot_config 04:03:18 INFO - Using buildbot properties: 04:03:18 INFO - { 04:03:18 INFO - "project": "", 04:03:18 INFO - "product": "firefox", 04:03:18 INFO - "who": "archaeopteryx@coole-files.de", 04:03:18 INFO - "installer_path": "public/build/target.tar.bz2", 04:03:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 04:03:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 04:03:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 04:03:18 INFO - "stage_platform": "linux64-pgo", 04:03:18 INFO - "basedir": "/builds/slave/test", 04:03:18 INFO - "buildnumber": 69, 04:03:18 INFO - "platform": "ubuntu64_hw", 04:03:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:03:18 INFO - "slavebuilddir": "test", 04:03:18 INFO - "taskId": "SrfFqqUwTMyUfNIM_TVDHg", 04:03:18 INFO - "branch": "mozilla-central", 04:03:18 INFO - "script_repo_revision": "production", 04:03:18 INFO - "revision": "82c2eecf82ba820c4593aa4a9749662f7d54d9a7", 04:03:18 INFO - "slavename": "talos-linux64-ix-025", 04:03:18 INFO - "repo_path": "mozilla-central" 04:03:18 INFO - } 04:03:18 INFO - Finding installer, test and symbols from parent task. 04:03:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SrfFqqUwTMyUfNIM_TVDHg'}, attempt #1 04:03:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SrfFqqUwTMyUfNIM_TVDHg'}, attempt #1 04:03:19 INFO - Task dependencies: Z4ZwPVwgTtW5UJmF2XNdLA 04:03:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA'}, attempt #1 04:03:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2 04:03:20 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.test_packages.json 04:03:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.crashreporter-symbols.zip 04:03:20 INFO - Running post-action listener: _resource_record_post_action 04:03:20 INFO - [mozharness: 2017-09-28 11:03:20.207795Z] Finished read-buildbot-config step (success) 04:03:20 INFO - [mozharness: 2017-09-28 11:03:20.208013Z] Running download-and-extract step. 04:03:20 INFO - Running pre-action listener: _resource_record_pre_action 04:03:20 INFO - Running main action method: download_and_extract 04:03:20 INFO - mkdir: /builds/slave/test/build/tests 04:03: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')]} 04:03:20 INFO - trying https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.test_packages.json 04:03:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:03:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:03:20 INFO - Downloaded 989 bytes. 04:03:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:03:20 INFO - Using the following test package requirements: 04:03:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:03:20 INFO - u'common': [u'target.common.tests.zip'], 04:03:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:03:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:03:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:03:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:03:20 INFO - u'mozbase': [u'target.common.tests.zip'], 04:03:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:03:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:03:20 INFO - u'web-platform': [u'target.common.tests.zip', 04:03:20 INFO - u'target.web-platform.tests.tar.gz'], 04:03:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:03:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 04:03:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.common.tests.zip 04:03:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:03:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.common.tests.zip into memory 04:03:21 INFO - Content-Length response header: 55814911 04:03:21 INFO - Bytes received: 55814911 04:03:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.talos.tests.zip 04:03:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:03:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.talos.tests.zip into memory 04:03:33 INFO - Content-Length response header: 14521162 04:03:33 INFO - Bytes received: 14521162 04:03: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')]} 04:03:33 INFO - trying https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2 04:03:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:03:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:03:35 INFO - Downloaded 62409407 bytes. 04:03:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2 04:03:35 INFO - mkdir: /builds/slave/test/properties 04:03:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:03:35 INFO - Writing to file /builds/slave/test/properties/build_url 04:03:35 INFO - Contents: 04:03:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2 04:03:35 INFO - Running post-action listener: _resource_record_post_action 04:03:35 INFO - Running post-action listener: find_tests_for_verification 04:03:35 INFO - Running post-action listener: set_extra_try_arguments 04:03:35 INFO - [mozharness: 2017-09-28 11:03:35.087555Z] Finished download-and-extract step (success) 04:03:35 INFO - [mozharness: 2017-09-28 11:03:35.087686Z] Running populate-webroot step. 04:03:35 INFO - Running pre-action listener: _resource_record_pre_action 04:03:35 INFO - Running main action method: populate_webroot 04:03:35 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:03:35 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['tresize', 04:03:35 INFO - 'tcanvasmark']}, 04:03:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:03:35 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['dromaeo_css', 04:03:35 INFO - 'kraken']}, 04:03:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:35 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:03:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'tests': ['damp', 'tps']}, 04:03:35 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['damp', 'tps']}, 04:03:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:03:35 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['dromaeo_dom']}, 04:03:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:03:35 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['basic_compositor_video', 04:03:35 INFO - 'glvideo']}, 04:03:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:03:35 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['ts_paint_webext', 04:03:35 INFO - 'tp5o_webext']}, 04:03:35 INFO - 'other-e10s': {'tests': ['a11yr', 04:03:35 INFO - 'ts_paint', 04:03:35 INFO - 'tpaint', 04:03:35 INFO - 'sessionrestore', 04:03:35 INFO - 'sessionrestore_many_windows', 04:03:35 INFO - 'sessionrestore_no_auto_restore', 04:03:35 INFO - 'tabpaint', 04:03:35 INFO - 'cpstartup']}, 04:03:35 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['a11yr', 04:03:35 INFO - 'ts_paint', 04:03:35 INFO - 'tpaint', 04:03:35 INFO - 'sessionrestore', 04:03:35 INFO - 'sessionrestore_many_windows', 04:03:35 INFO - 'sessionrestore_no_auto_restore', 04:03:35 INFO - 'tabpaint', 04:03:35 INFO - 'cpstartup']}, 04:03:35 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 04:03:35 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 04:03:35 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['perf_reftest_singletons']}, 04:03:35 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['perf_reftest']}, 04:03:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:03:35 INFO - 'tsvgr_opacity', 04:03:35 INFO - 'tart', 04:03:35 INFO - 'tscrollx', 04:03:35 INFO - 'tsvg_static']}, 04:03:35 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['tsvgx', 04:03:35 INFO - 'tsvgr_opacity', 04:03:35 INFO - 'tart', 04:03:35 INFO - 'tscrollx', 04:03:35 INFO - 'tsvg_static']}, 04:03:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:03:35 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'talos_options': ['--disable-stylo'], 04:03:35 INFO - 'tests': ['tp5o']}, 04:03:35 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:03:35 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:03:35 INFO - 'talos_options': ['--mitmproxy', 04:03:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:03:35 INFO - '--firstNonBlankPaint'], 04:03:35 INFO - 'tests': ['tp6_google', 04:03:35 INFO - 'tp6_youtube', 04:03:35 INFO - 'tp6_amazon', 04:03:35 INFO - 'tp6_facebook']}, 04:03:35 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:03:35 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:03:35 INFO - 'talos_options': ['--disable-stylo', 04:03:35 INFO - '--mitmproxy', 04:03:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:03:35 INFO - '--firstNonBlankPaint'], 04:03:35 INFO - 'tests': ['tp6_google', 04:03:35 INFO - 'tp6_youtube', 04:03:35 INFO - 'tp6_amazon', 04:03:35 INFO - 'tp6_facebook']}, 04:03:35 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:03:35 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 04:03:35 INFO - 'talos_options': ['--stylo-threads=1', 04:03:35 INFO - '--mitmproxy', 04:03:35 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:03:35 INFO - '--firstNonBlankPaint'], 04:03:35 INFO - 'tests': ['tp6_google', 04:03:35 INFO - 'tp6_youtube', 04:03:35 INFO - 'tp6_amazon', 04:03:35 INFO - 'tp6_facebook']}, 04:03:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'talos_options': ['--xperf_path', 04:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:35 INFO - 'tests': ['tp5n']}, 04:03:35 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 04:03:35 INFO - 'talos_options': ['--disable-stylo', 04:03:35 INFO - '--xperf_path', 04:03:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:03:35 INFO - 'tests': ['tp5n']}}} 04:03:35 INFO - Running post-action listener: _resource_record_post_action 04:03:35 INFO - [mozharness: 2017-09-28 11:03:35.109661Z] Finished populate-webroot step (success) 04:03:35 INFO - [mozharness: 2017-09-28 11:03:35.109790Z] Running create-virtualenv step. 04:03:35 INFO - Running pre-action listener: _resource_record_pre_action 04:03:35 INFO - Running main action method: create_virtualenv 04:03:35 INFO - Creating virtualenv /builds/slave/test/build/venv 04:03:35 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:03:35 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 04:03:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:03:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:03:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:03:36 INFO - Installing distribute.............................................................................................................................................................................................done. 04:03:36 INFO - Installing pip...............done. 04:03:36 INFO - Return code: 0 04:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:03:36 INFO - Reading from file tmpfile_stdout 04:03:36 INFO - Output received: 04:03:36 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 04:03:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:03: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')]} 04:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03: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')]} 04:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03: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', 'pip>=1.5'] in /builds/slave/test/build 04:03: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 pip>=1.5 04:03:36 INFO - Using env: {'DISPLAY': ':0', 04:03:36 INFO - 'HOME': '/home/cltbld', 04:03:36 INFO - 'LANG': 'en_US.UTF-8', 04:03:36 INFO - 'LANGUAGE': 'en_US:en', 04:03:36 INFO - 'LOGNAME': 'cltbld', 04:03:36 INFO - 'MAIL': '/var/mail/cltbld', 04:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:36 INFO - 'MOZ_NO_REMOTE': '1', 04:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:36 INFO - 'NO_EM_RESTART': '1', 04:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:36 INFO - 'PWD': '/builds/slave/test', 04:03:36 INFO - 'SHELL': '/bin/bash', 04:03:36 INFO - 'SHLVL': '1', 04:03:36 INFO - 'TERM': 'linux', 04:03:36 INFO - 'TMOUT': '86400', 04:03:36 INFO - 'USER': 'cltbld', 04:03:36 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:36 INFO - '_': '/tools/buildbot/bin/python'} 04:03:38 INFO - Ignoring indexes: http://pypi.python.org/simple/ 04:03:38 INFO - Downloading/unpacking pip>=1.5 04:03:38 INFO - Running setup.py egg_info for package pip 04:03:38 INFO - warning: no files found matching 'pip/cacert.pem' 04:03:38 INFO - warning: no files found matching '*.html' under directory 'docs' 04:03:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:03:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:03:38 INFO - Installing collected packages: pip 04:03:38 INFO - Found existing installation: pip 1.1 04:03:38 INFO - Uninstalling pip: 04:03:38 INFO - Successfully uninstalled pip 04:03:38 INFO - Running setup.py install for pip 04:03:38 INFO - warning: no files found matching 'pip/cacert.pem' 04:03:38 INFO - warning: no files found matching '*.html' under directory 'docs' 04:03:38 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 04:03:38 INFO - no previously-included directories found matching 'docs/_build/_sources' 04:03:38 INFO - Installing pip script to /builds/slave/test/build/venv/bin 04:03:38 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 04:03:38 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 04:03:38 INFO - Successfully installed pip 04:03:38 INFO - Cleaning up... 04:03:38 INFO - Return code: 0 04:03:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:38 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 04:03:38 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 04:03:38 INFO - Using env: {'DISPLAY': ':0', 04:03:38 INFO - 'HOME': '/home/cltbld', 04:03:38 INFO - 'LANG': 'en_US.UTF-8', 04:03:38 INFO - 'LANGUAGE': 'en_US:en', 04:03:38 INFO - 'LOGNAME': 'cltbld', 04:03:38 INFO - 'MAIL': '/var/mail/cltbld', 04:03:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:38 INFO - 'MOZ_NO_REMOTE': '1', 04:03:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:38 INFO - 'NO_EM_RESTART': '1', 04:03:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:38 INFO - 'PWD': '/builds/slave/test', 04:03:38 INFO - 'SHELL': '/bin/bash', 04:03:38 INFO - 'SHLVL': '1', 04:03:38 INFO - 'TERM': 'linux', 04:03:38 INFO - 'TMOUT': '86400', 04:03:38 INFO - 'USER': 'cltbld', 04:03:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:38 INFO - '_': '/tools/buildbot/bin/python'} 04:03:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:38 INFO - Downloading/unpacking psutil>=3.1.1 04:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:03:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:03:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:39 INFO - Installing collected packages: psutil 04:03:39 INFO - Running setup.py install for psutil 04:03:39 INFO - building 'psutil._psutil_linux' extension 04:03:39 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 04:03:39 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 04:03:39 INFO - building 'psutil._psutil_posix' extension 04:03:39 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 04:03:40 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 04:03:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:03:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:03:40 INFO - Successfully installed psutil 04:03:40 INFO - Cleaning up... 04:03:40 INFO - Return code: 0 04:03:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:03:40 INFO - Using env: {'DISPLAY': ':0', 04:03:40 INFO - 'HOME': '/home/cltbld', 04:03:40 INFO - 'LANG': 'en_US.UTF-8', 04:03:40 INFO - 'LANGUAGE': 'en_US:en', 04:03:40 INFO - 'LOGNAME': 'cltbld', 04:03:40 INFO - 'MAIL': '/var/mail/cltbld', 04:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:40 INFO - 'MOZ_NO_REMOTE': '1', 04:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:40 INFO - 'NO_EM_RESTART': '1', 04:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:40 INFO - 'PWD': '/builds/slave/test', 04:03:40 INFO - 'SHELL': '/bin/bash', 04:03:40 INFO - 'SHLVL': '1', 04:03:40 INFO - 'TERM': 'linux', 04:03:40 INFO - 'TMOUT': '86400', 04:03:40 INFO - 'USER': 'cltbld', 04:03:40 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:40 INFO - '_': '/tools/buildbot/bin/python'} 04:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:03:40 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 04:03:40 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 04:03:40 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 04:03:40 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 04:03:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:03:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:03:41 INFO - Installing collected packages: mozsystemmonitor 04:03:41 INFO - Running setup.py install for mozsystemmonitor 04:03:41 INFO - Successfully installed mozsystemmonitor 04:03:41 INFO - Cleaning up... 04:03:42 INFO - Return code: 0 04:03:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:03:42 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')]} 04:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:42 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')]} 04:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:42 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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:42 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 04:03:42 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 04:03:42 INFO - Using env: {'DISPLAY': ':0', 04:03:42 INFO - 'HOME': '/home/cltbld', 04:03:42 INFO - 'LANG': 'en_US.UTF-8', 04:03:42 INFO - 'LANGUAGE': 'en_US:en', 04:03:42 INFO - 'LOGNAME': 'cltbld', 04:03:42 INFO - 'MAIL': '/var/mail/cltbld', 04:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:42 INFO - 'MOZ_NO_REMOTE': '1', 04:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:42 INFO - 'NO_EM_RESTART': '1', 04:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:42 INFO - 'PWD': '/builds/slave/test', 04:03:42 INFO - 'SHELL': '/bin/bash', 04:03:42 INFO - 'SHLVL': '1', 04:03:42 INFO - 'TERM': 'linux', 04:03:42 INFO - 'TMOUT': '86400', 04:03:42 INFO - 'USER': 'cltbld', 04:03:42 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:42 INFO - '_': '/tools/buildbot/bin/python'} 04:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:42 INFO - Downloading/unpacking jsonschema==2.5.1 04:03:42 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 04:03:42 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 04:03:42 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 04:03:42 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 04:03:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:03:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:03:44 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 04:03:44 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 04:03:44 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 04:03:44 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 04:03:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:03:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:03:44 INFO - warning: no files found matching '*.txt' 04:03:44 INFO - no previously-included directories found matching 'build' 04:03:44 INFO - no previously-included directories found matching 'dist' 04:03:44 INFO - no previously-included directories found matching '.git*' 04:03:44 INFO - Installing collected packages: jsonschema, functools32 04:03:44 INFO - Running setup.py install for functools32 04:03:44 INFO - warning: no files found matching '*.txt' 04:03:44 INFO - no previously-included directories found matching 'build' 04:03:44 INFO - no previously-included directories found matching 'dist' 04:03:44 INFO - no previously-included directories found matching '.git*' 04:03:44 INFO - Successfully installed jsonschema functools32 04:03:44 INFO - Cleaning up... 04:03:44 INFO - Return code: 0 04:03:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:03:44 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')]} 04:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:44 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')]} 04:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:44 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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:44 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 04:03:44 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 04:03:44 INFO - Using env: {'DISPLAY': ':0', 04:03:44 INFO - 'HOME': '/home/cltbld', 04:03:44 INFO - 'LANG': 'en_US.UTF-8', 04:03:44 INFO - 'LANGUAGE': 'en_US:en', 04:03:44 INFO - 'LOGNAME': 'cltbld', 04:03:44 INFO - 'MAIL': '/var/mail/cltbld', 04:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:44 INFO - 'MOZ_NO_REMOTE': '1', 04:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:44 INFO - 'NO_EM_RESTART': '1', 04:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:44 INFO - 'PWD': '/builds/slave/test', 04:03:44 INFO - 'SHELL': '/bin/bash', 04:03:44 INFO - 'SHLVL': '1', 04:03:44 INFO - 'TERM': 'linux', 04:03:44 INFO - 'TMOUT': '86400', 04:03:44 INFO - 'USER': 'cltbld', 04:03:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:44 INFO - '_': '/tools/buildbot/bin/python'} 04:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:03:44 INFO - Cleaning up... 04:03:44 INFO - Return code: 0 04:03:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:03:44 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')]} 04:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:44 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')]} 04:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:44 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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:44 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 04:03:44 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 04:03:44 INFO - Using env: {'DISPLAY': ':0', 04:03:44 INFO - 'HOME': '/home/cltbld', 04:03:44 INFO - 'LANG': 'en_US.UTF-8', 04:03:44 INFO - 'LANGUAGE': 'en_US:en', 04:03:44 INFO - 'LOGNAME': 'cltbld', 04:03:44 INFO - 'MAIL': '/var/mail/cltbld', 04:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:44 INFO - 'MOZ_NO_REMOTE': '1', 04:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:44 INFO - 'NO_EM_RESTART': '1', 04:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:44 INFO - 'PWD': '/builds/slave/test', 04:03:44 INFO - 'SHELL': '/bin/bash', 04:03:44 INFO - 'SHLVL': '1', 04:03:44 INFO - 'TERM': 'linux', 04:03:44 INFO - 'TMOUT': '86400', 04:03:44 INFO - 'USER': 'cltbld', 04:03:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:44 INFO - '_': '/tools/buildbot/bin/python'} 04:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:03:45 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 04:03:45 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 04:03:45 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 04:03:45 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 04:03:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:03:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:03:46 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 04:03:46 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 04:03:46 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 04:03:46 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 04:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:03:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:03:46 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 04:03:46 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 04:03:46 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 04:03:46 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 04:03:46 INFO - Downloading docopt-0.6.1.tar.gz 04:03:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:03:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:03:46 INFO - Running setup.py install for blobuploader 04:03:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:03:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:03:46 INFO - Running setup.py install for requests 04:03:47 INFO - Running setup.py install for docopt 04:03:47 INFO - Successfully installed blobuploader requests docopt 04:03:47 INFO - Cleaning up... 04:03:47 INFO - Return code: 0 04:03:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:47 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')]} 04:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:47 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')]} 04:03:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:47 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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:47 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 04:03:47 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 04:03:47 INFO - Using env: {'DISPLAY': ':0', 04:03:47 INFO - 'HOME': '/home/cltbld', 04:03:47 INFO - 'LANG': 'en_US.UTF-8', 04:03:47 INFO - 'LANGUAGE': 'en_US:en', 04:03:47 INFO - 'LOGNAME': 'cltbld', 04:03:47 INFO - 'MAIL': '/var/mail/cltbld', 04:03:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:47 INFO - 'MOZ_NO_REMOTE': '1', 04:03:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:47 INFO - 'NO_EM_RESTART': '1', 04:03:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:47 INFO - 'PWD': '/builds/slave/test', 04:03:47 INFO - 'SHELL': '/bin/bash', 04:03:47 INFO - 'SHLVL': '1', 04:03:47 INFO - 'TERM': 'linux', 04:03:47 INFO - 'TMOUT': '86400', 04:03:47 INFO - 'USER': 'cltbld', 04:03:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:47 INFO - '_': '/tools/buildbot/bin/python'} 04:03:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:47 INFO - Running setup.py (path:/tmp/pip-1mZ7tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:47 INFO - Running setup.py (path:/tmp/pip-YlUBgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:47 INFO - Running setup.py (path:/tmp/pip-DsvQ7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:47 INFO - Running setup.py (path:/tmp/pip-GqAX_z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:47 INFO - Running setup.py (path:/tmp/pip-r40PlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:47 INFO - Running setup.py (path:/tmp/pip-AuyX_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:48 INFO - Running setup.py (path:/tmp/pip-IQcszW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:48 INFO - Running setup.py (path:/tmp/pip-cqixr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:48 INFO - Running setup.py (path:/tmp/pip-tn3EFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:48 INFO - Running setup.py (path:/tmp/pip-ephIMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:48 INFO - Running setup.py (path:/tmp/pip-ahikXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:48 INFO - Running setup.py (path:/tmp/pip-ExjzPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:48 INFO - Running setup.py (path:/tmp/pip-woeyJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:48 INFO - Running setup.py (path:/tmp/pip-d9je5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:48 INFO - Running setup.py (path:/tmp/pip-OibeHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:48 INFO - Running setup.py (path:/tmp/pip-lpVSWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:48 INFO - Running setup.py (path:/tmp/pip-nXe4sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:03:48 INFO - Running setup.py install for manifestparser 04:03:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:03:48 INFO - Running setup.py install for mozcrash 04:03:48 INFO - Running setup.py install for mozdebug 04:03:49 INFO - Running setup.py install for mozdevice 04:03:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Running setup.py install for mozfile 04:03:49 INFO - Running setup.py install for mozhttpd 04:03:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Running setup.py install for mozinfo 04:03:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Running setup.py install for mozInstall 04:03:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Running setup.py install for mozleak 04:03:49 INFO - Running setup.py install for mozlog 04:03:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Running setup.py install for moznetwork 04:03:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:03:49 INFO - Running setup.py install for mozprocess 04:03:49 INFO - Running setup.py install for mozprofile 04:03:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:03:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:03:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:03:50 INFO - Running setup.py install for mozrunner 04:03:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:03:50 INFO - Running setup.py install for mozscreenshot 04:03:50 INFO - Running setup.py install for moztest 04:03:50 INFO - Running setup.py install for mozversion 04:03:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:03:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:03:50 INFO - Cleaning up... 04:03:50 INFO - Return code: 0 04:03:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:50 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')]} 04:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:50 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')]} 04:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:50 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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:50 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 04:03:50 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 04:03:50 INFO - Using env: {'DISPLAY': ':0', 04:03:50 INFO - 'HOME': '/home/cltbld', 04:03:50 INFO - 'LANG': 'en_US.UTF-8', 04:03:50 INFO - 'LANGUAGE': 'en_US:en', 04:03:50 INFO - 'LOGNAME': 'cltbld', 04:03:50 INFO - 'MAIL': '/var/mail/cltbld', 04:03:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:50 INFO - 'MOZ_NO_REMOTE': '1', 04:03:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:50 INFO - 'NO_EM_RESTART': '1', 04:03:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:50 INFO - 'PWD': '/builds/slave/test', 04:03:50 INFO - 'SHELL': '/bin/bash', 04:03:50 INFO - 'SHLVL': '1', 04:03:50 INFO - 'TERM': 'linux', 04:03:50 INFO - 'TMOUT': '86400', 04:03:50 INFO - 'USER': 'cltbld', 04:03:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:50 INFO - '_': '/tools/buildbot/bin/python'} 04:03:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:03:50 INFO - Running setup.py (path:/tmp/pip-287OGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:03:50 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)) 04:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:03:50 INFO - Running setup.py (path:/tmp/pip-Kw_f9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:03:50 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)) 04:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:03:50 INFO - Running setup.py (path:/tmp/pip-kVJg2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:03:50 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)) 04:03:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:03:50 INFO - Running setup.py (path:/tmp/pip-Gy7ObN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:03:51 INFO - Running setup.py (path:/tmp/pip-b2fyXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:03:51 INFO - Running setup.py (path:/tmp/pip-fur18d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:03:51 INFO - Running setup.py (path:/tmp/pip-OaoqdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:03:51 INFO - Running setup.py (path:/tmp/pip-DKgKHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:03:51 INFO - Running setup.py (path:/tmp/pip-kW20Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:03:51 INFO - Running setup.py (path:/tmp/pip-0iBhSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:03:51 INFO - Running setup.py (path:/tmp/pip-YSiP_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:03:51 INFO - Running setup.py (path:/tmp/pip-zPjgno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:03:51 INFO - Running setup.py (path:/tmp/pip-ZCAujI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:03:51 INFO - Running setup.py (path:/tmp/pip-EyleeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:51 INFO - Running setup.py (path:/tmp/pip-DPQKQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:03:51 INFO - Running setup.py (path:/tmp/pip-fsn2XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:03:51 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)) 04:03:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:03:51 INFO - Running setup.py (path:/tmp/pip-x7uk_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:03:51 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)) 04:03:51 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)) 04:03:51 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)) 04:03:51 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)) 04:03:51 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)) 04:03:51 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)) 04:03:51 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)) 04:03:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:03:51 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 04:03:51 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 04:03:51 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 04:03:51 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 04:03:53 INFO - Downloading blessings-1.6.tar.gz 04:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:03:53 INFO - Installing collected packages: blessings 04:03:53 INFO - Running setup.py install for blessings 04:03:53 INFO - Successfully installed blessings 04:03:53 INFO - Cleaning up... 04:03:53 INFO - Return code: 0 04:03:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:03:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:53 INFO - Reading from file tmpfile_stdout 04:03:53 INFO - Current package versions: 04:03:53 INFO - argparse == 1.2.1 04:03:53 INFO - blessings == 1.6 04:03:53 INFO - blobuploader == 1.2.4 04:03:53 INFO - docopt == 0.6.1 04:03:53 INFO - functools32 == 3.2.3-2 04:03:53 INFO - jsonschema == 2.5.1 04:03:53 INFO - manifestparser == 1.1 04:03:53 INFO - mozInstall == 1.13 04:03:53 INFO - mozcrash == 1.0 04:03:53 INFO - mozdebug == 0.1 04:03:53 INFO - mozdevice == 0.51 04:03:53 INFO - mozfile == 1.2 04:03:53 INFO - mozhttpd == 0.7 04:03:53 INFO - mozinfo == 0.10 04:03:53 INFO - mozleak == 0.1 04:03:53 INFO - mozlog == 3.5 04:03:53 INFO - moznetwork == 0.27 04:03:53 INFO - mozprocess == 0.25 04:03:53 INFO - mozprofile == 0.28 04:03:53 INFO - mozrunner == 6.13 04:03:53 INFO - mozscreenshot == 0.1 04:03:53 INFO - mozsystemmonitor == 0.3 04:03:53 INFO - moztest == 0.8 04:03:53 INFO - mozversion == 1.4 04:03:53 INFO - psutil == 3.1.1 04:03:53 INFO - requests == 1.2.3 04:03:53 INFO - wsgiref == 0.1.2 04:03:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:03:53 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')]} 04:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:53 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')]} 04:03:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:53 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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:53 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 04:03:53 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 04:03:53 INFO - Using env: {'DISPLAY': ':0', 04:03:53 INFO - 'HOME': '/home/cltbld', 04:03:53 INFO - 'LANG': 'en_US.UTF-8', 04:03:53 INFO - 'LANGUAGE': 'en_US:en', 04:03:53 INFO - 'LOGNAME': 'cltbld', 04:03:53 INFO - 'MAIL': '/var/mail/cltbld', 04:03:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:53 INFO - 'MOZ_NO_REMOTE': '1', 04:03:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:53 INFO - 'NO_EM_RESTART': '1', 04:03:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:53 INFO - 'PWD': '/builds/slave/test', 04:03:53 INFO - 'SHELL': '/bin/bash', 04:03:53 INFO - 'SHLVL': '1', 04:03:53 INFO - 'TERM': 'linux', 04:03:53 INFO - 'TMOUT': '86400', 04:03:53 INFO - 'USER': 'cltbld', 04:03:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:53 INFO - '_': '/tools/buildbot/bin/python'} 04:03:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:53 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)) 04:03:53 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)) 04:03:53 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)) 04:03:53 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)) 04:03:53 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)) 04:03:53 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)) 04:03:53 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)) 04:03:53 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)) 04:03:53 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)) 04:03:53 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:03:53 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 04:03:53 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 04:03:53 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 04:03:53 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 04:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:03:54 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)) 04:03:54 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)) 04:03:54 INFO - Installing collected packages: simplejson 04:03:54 INFO - Running setup.py install for simplejson 04:03:55 INFO - building 'simplejson._speedups' extension 04:03:55 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 04:03:55 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 04:03:55 INFO - Successfully installed simplejson 04:03:55 INFO - Cleaning up... 04:03:55 INFO - Return code: 0 04:03:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:03:55 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')]} 04:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:03:55 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')]} 04:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:03:55 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 0x19971f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b5fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d049c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, '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': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', '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 04:03:55 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 04:03:55 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 04:03:55 INFO - Using env: {'DISPLAY': ':0', 04:03:55 INFO - 'HOME': '/home/cltbld', 04:03:55 INFO - 'LANG': 'en_US.UTF-8', 04:03:55 INFO - 'LANGUAGE': 'en_US:en', 04:03:55 INFO - 'LOGNAME': 'cltbld', 04:03:55 INFO - 'MAIL': '/var/mail/cltbld', 04:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:03:55 INFO - 'MOZ_NO_REMOTE': '1', 04:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:03:55 INFO - 'NO_EM_RESTART': '1', 04:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:03:55 INFO - 'PWD': '/builds/slave/test', 04:03:55 INFO - 'SHELL': '/bin/bash', 04:03:55 INFO - 'SHLVL': '1', 04:03:56 INFO - 'TERM': 'linux', 04:03:56 INFO - 'TMOUT': '86400', 04:03:56 INFO - 'USER': 'cltbld', 04:03:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:03:56 INFO - '_': '/tools/buildbot/bin/python'} 04:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:03:56 INFO - Cleaning up... 04:03:56 INFO - Return code: 0 04:03:56 INFO - Running post-action listener: _resource_record_post_action 04:03:56 INFO - Running post-action listener: _start_resource_monitoring 04:03:56 INFO - Starting resource monitoring. 04:03:56 INFO - [mozharness: 2017-09-28 11:03:56.267507Z] Finished create-virtualenv step (success) 04:03:56 INFO - [mozharness: 2017-09-28 11:03:56.268019Z] Running install step. 04:03:56 INFO - Running pre-action listener: _resource_record_pre_action 04:03:56 INFO - Running main action method: install 04:03:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:03:56 INFO - Reading from file tmpfile_stdout 04:03:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:03:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:03:56 INFO - Reading from file tmpfile_stdout 04:03:56 INFO - Output received: 04:03:56 INFO - Usage: mozinstall [options] installer 04:03:56 INFO - Options: 04:03:56 INFO - -h, --help show this help message and exit 04:03:56 INFO - -d DEST, --destination=DEST 04:03:56 INFO - Directory to install application into. [default: 04:03:56 INFO - "/builds/slave/test"] 04:03:56 INFO - --app=APP Application being installed. [default: firefox] 04:03:56 INFO - mkdir: /builds/slave/test/build/application 04:03:56 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'] 04:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:04:14 INFO - Reading from file tmpfile_stdout 04:04:14 INFO - Output received: 04:04:14 INFO - /builds/slave/test/build/application/firefox/firefox 04:04:14 INFO - Running post-action listener: _resource_record_post_action 04:04:14 INFO - [mozharness: 2017-09-28 11:04:14.237146Z] Finished install step (success) 04:04:14 INFO - [mozharness: 2017-09-28 11:04:14.237401Z] Running setup-mitmproxy step. 04:04:14 INFO - Running pre-action listener: _resource_record_pre_action 04:04:14 INFO - Running main action method: setup_mitmproxy 04:04:14 INFO - Skipping: mitmproxy is not required 04:04:14 INFO - Running post-action listener: _resource_record_post_action 04:04:14 INFO - [mozharness: 2017-09-28 11:04:14.238620Z] Finished setup-mitmproxy step (success) 04:04:14 INFO - [mozharness: 2017-09-28 11:04:14.238840Z] Running run-tests step. 04:04:14 INFO - Running pre-action listener: _resource_record_pre_action 04:04:14 INFO - Running pre-action listener: _set_gcov_prefix 04:04:14 INFO - Running main action method: run_tests 04:04:14 WARNING - Try message not found. 04:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:04:14 INFO - Python 2.7.3 04:04:14 INFO - Return code: 0 04:04:14 INFO - grabbing minidump binary from tooltool 04:04:14 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')]} 04:04:14 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 0x1d01d60>, '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 0x1d02a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d02ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:04:14 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 04:04:14 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 04:04:14 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 04:04:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:04:14 INFO - Return code: 0 04:04:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:04:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:04:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:04:14 INFO - ENV: RUST_BACKTRACE is now full 04:04:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:04:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 04:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 04:04:14 INFO - Using env: {'DISPLAY': ':0', 04:04:14 INFO - 'HOME': '/home/cltbld', 04:04:14 INFO - 'LANG': 'en_US.UTF-8', 04:04:14 INFO - 'LANGUAGE': 'en_US:en', 04:04:14 INFO - 'LOGNAME': 'cltbld', 04:04:14 INFO - 'MAIL': '/var/mail/cltbld', 04:04:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:04:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:14 INFO - 'MOZ_NO_REMOTE': '1', 04:04:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:04:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:14 INFO - 'NO_EM_RESTART': '1', 04:04:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:14 INFO - 'PWD': '/builds/slave/test', 04:04:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:04:14 INFO - 'RUST_BACKTRACE': 'full', 04:04:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:04:14 INFO - 'SHELL': '/bin/bash', 04:04:14 INFO - 'SHLVL': '1', 04:04:14 INFO - 'TERM': 'linux', 04:04:14 INFO - 'TMOUT': '86400', 04:04:14 INFO - 'USER': 'cltbld', 04:04:14 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:14 INFO - '_': '/tools/buildbot/bin/python'} 04:04:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 04:04:14 INFO - mozversion application_buildid: 20170928094239 04:04:14 INFO - mozversion application_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 04:04:14 INFO - mozversion application_display_name: Nightly 04:04:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:04:14 INFO - mozversion application_name: Firefox 04:04:14 INFO - mozversion application_remotingname: firefox 04:04:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:04:14 INFO - mozversion application_vendor: Mozilla 04:04:14 INFO - mozversion application_version: 58.0a1 04:04:14 INFO - mozversion platform_buildid: 20170928094239 04:04:14 INFO - mozversion platform_changeset: 82c2eecf82ba820c4593aa4a9749662f7d54d9a7 04:04:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:04:14 INFO - mozversion platform_version: 58.0a1 04:04:14 INFO - using testdate: 1506596654 04:04:14 INFO - actual date: 1506596654 04:04:14 INFO - starting webserver on 'localhost:54932' 04:04:14 INFO - SUITE-START | Running 2 tests 04:04:14 INFO - TEST-START | dromaeo_css 04:04:14 INFO - Initialising browser for dromaeo_css test... 04:04:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54932/getInfo.html -profile /tmp/tmpemIcck/profile 04:04:14 INFO - TEST-INFO | started process 11021 (/builds/slave/test/build/application/firefox/firefox http://localhost:54932/getInfo.html) 04:04:20 INFO - TEST-INFO | 11021: exit 0 04:04:20 INFO - Browser initialized. 04:04:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:04:20 INFO - Using env: {'DISPLAY': ':0', 04:04:20 INFO - 'HOME': '/home/cltbld', 04:04:20 INFO - 'JSGC_DISABLE_POISONING': '1', 04:04:20 INFO - 'LANG': 'en_US.UTF-8', 04:04:20 INFO - 'LANGUAGE': 'en_US:en', 04:04:20 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:04:20 INFO - 'LOGNAME': 'cltbld', 04:04:20 INFO - 'MAIL': '/var/mail/cltbld', 04:04:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:04:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:04:20 INFO - 'MOZ_CRASHREPORTER': '1', 04:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:04:20 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:04:20 INFO - 'MOZ_NO_REMOTE': '1', 04:04:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:04:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:04:20 INFO - 'NO_EM_RESTART': '1', 04:04:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:04:20 INFO - 'PWD': '/builds/slave/test', 04:04:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:04:20 INFO - 'RUST_BACKTRACE': 'full', 04:04:20 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:04:20 INFO - 'SHELL': '/bin/bash', 04:04:20 INFO - 'SHLVL': '1', 04:04:20 INFO - 'STYLO_FORCE_DISABLED': '1', 04:04:20 INFO - 'TERM': 'linux', 04:04:20 INFO - 'TMOUT': '86400', 04:04:20 INFO - 'USER': 'cltbld', 04:04:20 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:04:20 INFO - '_': '/tools/buildbot/bin/python'} 04:04:20 INFO - TEST-INFO | started process 11259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpemIcck/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:20 INFO - PID 11259 | 04:04:20 INFO - PID 11259 | (/builds/slave/test/build/application/firefox/firefox:11308): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:04:20 INFO - PID 11259 | 04:04:31 INFO - PID 11259 | RSS: Main: 144273408 04:04:31 INFO - PID 11259 | 04:07:28 INFO - PID 11259 | Cycle 1(1): loaded http://localhost:54932/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54932/tests/dromaeo/cssquery-ext.html) 04:07:29 INFO - PID 11259 | RSS: Main: 142606336 04:07:29 INFO - PID 11259 | 04:10:31 INFO - PID 11259 | Cycle 1(1): loaded http://localhost:54932/tests/dromaeo/cssquery-ext.html (next: http://localhost:54932/tests/dromaeo/cssquery-jquery.html) 04:10:31 INFO - PID 11259 | RSS: Main: 142696448 04:10:31 INFO - PID 11259 | 04:13:33 INFO - PID 11259 | Cycle 1(1): loaded http://localhost:54932/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54932/tests/dromaeo/cssquery-mootools.html) 04:13:33 INFO - PID 11259 | RSS: Main: 144056320 04:13:33 INFO - PID 11259 | 04:16:35 INFO - PID 11259 | Cycle 1(1): loaded http://localhost:54932/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54932/tests/dromaeo/cssquery-prototype.html) 04:16:35 INFO - PID 11259 | RSS: Main: 144535552 04:16:35 INFO - PID 11259 | 04:19:39 INFO - PID 11259 | Cycle 1(1): loaded http://localhost:54932/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54932/tests/dromaeo/cssquery-yui.html) 04:19:39 INFO - PID 11259 | RSS: Main: 147083264 04:19:39 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | Cycle 1(1): loaded http://localhost:54932/tests/dromaeo/cssquery-yui.html (next: http://localhost:54932/tests/dromaeo/cssquery-dojo.html) 04:22:41 INFO - PID 11259 | RSS: Main: 148369408 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | __start_tp_report 04:22:41 INFO - PID 11259 | _x_x_mozilla_page_load 04:22:41 INFO - PID 11259 | _x_x_mozilla_page_load_details 04:22:41 INFO - PID 11259 | |i|pagename|runs| 04:22:41 INFO - PID 11259 | |0;dojo.html;3870.3033453978283;3876.069743261618;3876.767393956363;3911.960880391195;3914.4911161548994;6156;6236.407541283582;6260.655663938482;6286.182796236489;6318.652474113927;6260.655663938482;6317.620942743439;6353.047042943549;6379.649119298437;6420.58266212697;5557.972210138963;5667.801626943058;5673.290838645169;5693.03218452864;5706.9727449059155;712.597932851686;5639.351474580435;5687.516561092312;5724.4561766632105;5783.479486846183;5619.157126431007;5648.943510564883;5664.858378540528;5707.5148612368;5733.082706766918;5631.943680563183;5643.209950606918;5718.1136923776885;5719.28508936383;5719.48524632785;5620;5636.605437619368;5704.914426283609;5708.286464191976;5715.714214289269;6199.163112979735;6232;6327.14583531222;6375.649339286338;6380.904286435707;6662.600243985376;6805.28544502825;6807.727690892359;6826.795196144124;6910.930890691079;6912.963055541659;6942.895856562105;6943.305669433067;6955.234924158339;6978.685959131852;6281.87436251277;6314.210723659543;6358.268799088071;6367.808965731036;6415.358464153547;7055.329743674342;7124.50128491011;7145.285471452813;7154.4634152438775;7156.284371562802;6750.5274630775375;6750.628715420699;6817.829554261084;6841.62371069586;6842;6777.356151165632;6852.554583952027;6859.211190713032;6865.347791959756;6940.895886561706;6839.1451068616425;6847.589144651337;6848.7260509580055;6863.073485079451;6888.586684798928;6683.398494135454;6755.1556055493065;6834.453243740489;6839.0425340452375;6849.280825513349;4868.829590964299;4928.753562321869;4977.477364876709;4995.650304478651;5007.3240112584335;4472.932906006413;4485.753283569435;4554.749488778149;4555.316702494586;4575.153596584642;6288.151099601587;6351.110844481776;6352.14246076783;6370;6377.139086223393;6715.731370745213;6806.387425131762;6826.351496607815;6912.412444942136;6928.272531384233;6241.531885108635;6292.150559674477;6300.621962682254;6332.050192471166;6378.712957916812;5541.9168712469345;5569.637973531708;5591.30108736408;5603.131514615241;5622.971885140548;7132.215456299803;7146.892796608055;7222.3860971817985;7222.96388518054;7223.2415596361625;6844.2129155147795;6845.760398386232;6859.965700171567;6938.06336144614;6941.652917354213;7029.718811247493;7076.893846592202;7158.606276654834;7168.569885806868;7196.388306993755;6731.764388246584;6794.660266986532;6824.7952561423235;6831.077804496329;6837.111175547346;6766.594004359754;6778.661066946732;6861.245263021164;6886.758963436256;6945.895811562729;6620.63586502747;6628.5028622852515;6633.402993730588;6633.502487313374;6636.303188165173;6526.641034743135;6620.735170593122;6645.966770166118;6698.363655452724;6709.93290067093;6447.645379503984;6593.538452308292;6610.9669451652435;6621.768238111643;6631.6684165792485;6644.534882558174;6661.800145995628;6675.899861502178;6779.457643388616;6785.1518560179975;6327.050942358499;6391;6406.711697973509;6418.293987661447;6441.227052753699 04:22:41 INFO - PID 11259 | |1;ext.html;943.6744323208491;950.9286803489736;980.0591432225063;1016.0246163682864;1020.6784862768233;44767;45981.54018459815;46386.3042054369;46993.53006469934;47227.763861180734;47826;48046.27930581044;48052.2792158117;48175.759121204435;48324.51675483244;8547;8723.869141962876;8727.345449091343;8730.126987301282;8735.344849136309;8421.073681894986;8573.228409443149;8578;8583.828323433527;8601;8658.696945606906;8666.350023748213;8675.132486751307;8677.566121693922;8702.651893924236;8560.357973152008;8566.914330856705;8599.4840309581;8603.784905377353;8610.44032137909;8525.062243153248;8534.829303413897;8561.400701950866;8572.442791218613;8596.140385961417;42207.36688949668;42244.788776055924;42531.36202956958;42546.57453425488;42781.57218427807;3710.8330125144435;3757.3424650686293;3772.1512659651635;3773.056735816046;3779.3952967525065;33925;33940.49089263663;34055;34066.31867362639;34074;5350.384705758848;5371.167469042305;5399.514043736082;5412.296401467824;5433.429489903582;223092;225242;225757;226024;226162;54644.72677636586;54669.1799623006;54712;54995.175072373946;58828.41171588315;59573;60261.39738602558;60267.69866150641;60463.69768151131;60849.39150608437;17277.13614319279;17608.9119554404;17616;17639.559011024827;17642.5589360267;14008.089474184146;14171.220582868042;14173.645658858612;14178.71642567143;14179.22014289224;16332.673346533003;16351.591210219602;16382.262798174112;16439.342426302814;16446;6132.264128304632;6158.149757730174;6190.50475961931;6265.686715664198;6312.558120931582;1080.2276372393776;1086.842407850873;1088.3198001249218;1106.441247170174;1111.6387174168428;26852.59721104185;27115.864420678165;27195.184144475697;27345;27614.861925690242;1208.583038851595;1213.508529045738;1216.3614102596032;1230.9630711078682;1234.0991076514194;14348.928255358656;14372.85627143736;14488.565343039725;14544.927275363556;14619.415223390944;283688;287708;288164;311200;315232;67906.66046669734;68234.65882670555;68339.31660683428;68414;68545;1513.2585033333587;1517.332373755544;1520.7642815363636;1537.8539038791298;1545.1115608525142;31554;31618.841905790323;31795.36409271848;31829.72681092823;31913.521297181025;44584.33123503215;44713.10573788571;44941;44957.55042449664;44989.32516012197;239272;241356;241936;242235;242708;40301;40587;40730.1853962925;40736;40847.93640476916;50454.747726261136;50773.49226507688;50831.74584127056;51341.48658513367;51431.22853157131;36025.63974360328;36811.44782828313;37057.444138338484;37088;37296.62703372932;36658.816705917365;37448.812755937135;37475.25049499049;37480.81259593685;37525.62474375221;42380.57619423766;43119.35320970251;43271;43273;43632.34551481667;35490.29019419649;35809.64190358063;35854.64145358618;36047;36476;26063.869680651474;26264;26357.60463593086;26683.733162668126;26809.463810723286 04:22:41 INFO - PID 11259 | |2;jquery.html;633.3856159525259;643.9356064393561;646.176125440064;646.6249575246358;649.8342922554745;22834.08663653454;23307.883460582674;23467.295981120573;23682.171124010685;24877.626835597435;26443.735562644415;27411.45177096457;27442.725572744268;27455.313617159532;27459;6490.058941453498;6557;6632.867342653144;6661.067450556926;6700.865982680343;6721.831954201135;6795.456363490909;6797.184337879461;6799.796006119825;6800.081988931505;6756.8310792230095;6761.661916904135;6773.4242589379965;6774.085498457719;6774.187097548301;6742.662866856662;6765.830854228634;6766.627835469048;6767.593944363305;6772.830679233034;6328.6835658216905;6349.396807303298;6352.555321127523;6353.523485738542;6361.236651601791;30438.391232175454;31209.687903121132;31501;31791.682083179105;31808.840955795305;2280.224723593986;2281.0761641535205;2304.5506126305377;2309.9307020789233;2310.06442390832;20778.064987075617;20888.686669699968;21498.785012149834;21505.354839354844;21551.56896862054;2565.4356041670803;2570.611869590419;2592.6629538160105;2610.8955641774305;2612.6995395529566;135885;142507;145630;153802;153980;16381.672366552602;16541;16887.324507019828;17227.3970411035;17403.91298043527;26884.05905793288;26914;26940.59589106165;26940.73059269382;26943.191704248904;10855.240133190759;10917.39954302505;11083.612073577386;11167.720806979729;11168.329900206014;9914.206863450907;10037.949810250902;10053.949730251448;10210.4384258865;10229.181665466893;9928.80142397148;9964.451955142391;9969.40183588987;10039.648612298535;10274.33216840903;2907.756510293342;3072.308730535656;3079.16862447138;3081.7980987414926;3092.1187461573345;1048.6906362623045;1064.9307794993456;1073.5276478349501;1088.1240601316017;1098.7308109513222;21932.561348772935;21971.231006915;22058.669119963215;22253.66619500709;22300.66549001766;1145.3013661666378;1146.3924120216132;1148.8391625172483;1152.124385467051;1162.5756598841363;11808.291502509705;12192.939035304944;12312.322822244683;12395.75208495843;12397.62807115788;614560;614595;616776;640219;643541;117509.4124529389;118186.40906795411;118895;119508.4024579889;121595;1124.6850881753123;1154.7748189103213;1235.993820030894;1278.1691900264716;1280.0975312404732;22054.66917996199;22448.887755561118;22750.65874011924;22750.772492274864;22828;60680;60973.69513152406;61784;62031;63030.36969630245;76472.23527764651;77675.61162194153;77888.61055694685;78499.21500785147;78540.60729696315;16255.349786008428;16272.61682756979;16527;16542.338306467605;16574;24506;24675.259742207763;24787.380315492257;25016.249512514652;25619.35951601225;20114.295999639944;20208.79791202069;20356.592868142852;20381.49046273796;20565.97170141517;17188.742168867728;17715.822841771416;18245.270189192815;18251.178696958934;18525.90737046306;20967.895160524098;21167.364979050653;21280.148794048066;21439.892800536523;21471.248506302203;15930;16107.758383624021;16164.838351616803;16322;16400.17999100064;20200.49498762543;20321.59356812885;20382;20509.38471845847;20537.075831587914 04:22:41 INFO - PID 11259 | |3;mootools.html;1457.9927100364496;1481.7406953783086;1495.259846376044;1495.8130233720785;1505.3226048278277;16405.34378624855;16971.490855274347;16995.915020424894;16998.150092495387;17009.999999999967;16605;16759.16204189792;16818.15909204538;16838.747418788727;16877.156142192904;2458.4714286428457;2479.876006199692;2489.4772097859473;2491.0533997081084;2496.2636022373445;2385.677933478984;2478.083109249571;2479.690038745157;2481.081999660128;2483.5405449991717;2428.781409673129;2455.8649274289905;2460.495598402323;2478.08310924958;2485.751424857518;2192.5614877024577;2232.843700940935;2250.8086812620863;2251.5609456156058;2253.729552453708;2319.3389883883183;2337.9064837406654;2356.352003199117;2407.6027455470003;2500.1874390822873;16494.75257871133;16530.83469165317;16603;16631;16639.916800415922;8163.795905102361;8361.790955226168;8363.623636936352;8392.4544904581;8425.789355266106;5224.138017227153;5472.452754724535;5499.780008799643;5502.174673798922;5573.916391254134;2116.5872654832315;2125.90433430496;2130.680397940321;2148.1085349579907;2198.274569392097;29406.11781646554;30005.69994300051;30214.244643884078;30317.545236821465;30344.393112137855;7493.3630641395;7566.810829729301;7740.225977402215;7859.467403856193;8197;23623.527529449657;23660.290191294287;23697;23698.763012369654;23730.762692373202;8651.610677519528;8771.517566533901;8808.11918808127;8833.911660883308;8855.247303979106;7662.770116896502;7812.84374312522;7850.136484986761;7854.921450785419;7855.921440785519;6136.9079463808075;6161.691915404212;6177.320494745574;6202.472789812826;6293.181886354744;1795.64087182564;1854.378783107674;1876.934307299238;1884.2463014793918;1900.4773687235845;964.0333719212867;966.1739212972948;979.8285300072458;988.1896844587513;996.2279233594022;8140.185981401813;8196.098429172785;8231.629576669064;8238;8290.212429819157;789.4789438970253;792.8889955406248;794.8012996750813;796.3947399976059;810.8662070758377;5360.2227676987395;5780.335261444903;5846.035404158351;5944.375840536768;5951.791687290924;23919.16282930089;24467.265982020566;24761.133360332304;24770.25689229326;24839.751602483742;23333;23675;23883.28350149498;24023.51952960931;24088.87955560211;12322.199057061442;12662.873371266354;12919.901808346396;12925;12959.870401296055;10041.849372259276;10128.797424051625;10214.233932455245;10269.178465722574;10526.210534210119;20590.897045514677;20644.690329645367;20833.687494687896;20977.685334720296;21104.894475527522;21892.23377181791;22195.445113872283;22199.44501387478;22220.333389998326;22727.431814204116;15865.762013570036;15868.127253001196;15882.761758573399;15991.840081599035;16217.432389866299;15421.537353879401;15667.764983525029;15676.92161539185;15690.921545392657;15694.21528923572;12812.423440945366;12949.158304710163;13037.217766934014;13129.540466083641;13146.27695476758;11824.58613948542;11930.880691192977;12140.878591213976;12358.567450139202;12370.13409061393;10762.3542587445;10841.783164336826;10931.344119352865;10937.726556836144;10943.398113103856;8130.918690813016;8138.796530086795;8303.418760686694;8324.583770811314;8333.208345207195;8412.62143203545;8416.569183238742;8471.703490377808;8491.660333586588;8622.568871556523 04:22:41 INFO - PID 11259 | |4;prototype.html;552.4999875113024;569.3196630027118;575.7104086845462;583.533173461231;594.4887396838718;6091.360407157245;6155.599886007406;6204.348543402945;6265.185525881635;6335.683215839213;6119.204503414561;6149.2313460817395;6182.938170618292;6189.164462797532;6237.469815065713;4930.112579735646;5037.4710655381205;5096.133657278262;5118.692878427288;5126.5642420394315;5042.420121685998;5056.115179843531;5063.569596584295;5070.6957582545165;5091.312672789181;4891.192953162724;4933.432655244639;5001.224810154432;5020;5031.27046578246;4959.752012399365;4970.552650261476;4991.575716064139;5009.5491405773655;5021.623378246646;4622.399088118523;4642.76786160694;4648.302754586839;4653.348531205634;4673.415823022122;6115.755369785204;6167.229096362955;6205.81382558524;6246.312905580428;6298.212723409574;5849.795257165979;5859.384764599741;5875.324337701177;5885.911711324334;5904.169707390723;6668.599884006975;6675.833104172386;6682.398584127452;6714.597124172566;6715.7985260442265;4861.857463496076;5080.542751152377;5132.435432102466;5133.30700355451;5134.845954621367;6742.258351581371;6777.49168812341;6848.623325717083;6984.0571522844275;7020.946857971294;5264.447233040552;5281.735913204401;5294.658380128258;5296.496832800878;5320.813771517978;5275.287836142148;5287.920681189786;5353.81261655848;5376.542993845567;5377.946220537745;5855.238818953594;5883.61756485827;5911;5913.940860591339;5952.196453478811;6686.297938716365;6730;6772.5936443813525;6787.2534021257625;6798.76204332846;1813.5738101546126;1814.8094450082551;1840.7054871220541;1867.7105048717472;1878.614883948787;1267.5310135250018;1306.490468717201;1314.1786383510307;1346.3335648853683;1356.525216174331;6107.938920610826;6120.387961203933;6149.907751383644;6166.599171053867;6264.310925798159;6644.302348253461;6656.633885136267;6717.899231511531;6735.42748866342;6760.985852122221;6143.692815359214;6192.102145188923;6201.069839524108;6208.317085120633;6210.813675589739;3504.649535046526;3547.219611685425;3573.4997100405963;3579.355715971098;3599.1002249437643;6997.425579244629;7089.751858684921;7090.574565525982;7102.786916392516;7108;6729.932700673028;6765;6817.625030623363;6893.172819261721;6950.818360878663;6942.271061538567;6989.4408447324095;7020.578765273997;7043.92956070443;7093.1488221413765;6745.763898263734;6795.762148324785;6814.93185068143;6832.214295356098;6836.248012718497;6651.33486651331;6682.766103186365;6694.966525167343;6725.529212955046;6750;6885.724571017103;6949.722011119498;6977.2673869243;6994.2306346302885;7000.404965577779;5226.817061402832;5237.738113094254;5259.921101183561;5298.470152984671;5302.39022512416;6617.205935287604;6748.8650226994205;6825.726970921108;6855.143107111611;6855.245922948372;6415.262244841903;6602.141721576164;6624.8343791405605;6629.436497897733;6639.136912201576;6547.434680521518;6565.704543295467;6588.868222635425;6603.471722262111;6656.966715166393;6322.557420980487;6445.903311450238;6449;6454.677266136769;6548.476121910331;6557.000114964982;6583.736650534117;6584.539082264387;6609.405153536205;6688.83277918056;6436.452901503425;6446.129772480843;6451.935480645321;6460.353964603502;6471.320511346429 04:22:41 INFO - PID 11259 | |5;yui.html;960.4717405427014;988.5996171550522;998.5157198758606;998.6354980432144;1009.3101883480525;20469.385918422435;20864.269750558713;20867.060982255796;20899.791002089976;20914.163433462643;16787.0767107809;16996.575085622866;18656.813431865678;19864.90067549664;20044.098015589298;969.8496733006396;1047.141344097838;1051.978960420791;1053.3153450257316;1053.3416614615865;1036.678629624815;1045.2160879340495;1068.086785798143;1070.785842831433;1074.8710154781438;1134.7390100276941;1134.982975255372;1135.3755434511027;1136.7044568412189;1137.6075254037385;1119.8264269038311;1122.5622007417114;1123.3203911633425;1124.0670243697712;1129.8926601972798;797.7686470923484;814.0231721933703;819;819.3117781063876;841.9242268195892;21432.249871254586;21483.785162148335;21637.45906352338;21661.35015949524;21687.56624867494;23043.423914402105;23515.882420587957;23577.646335304984;23847.403814904592;23849;18807.24771009158;18834.811651883443;18863.905680471646;19304.32434864773;19317.227310907547;3927.725059245854;3952.3873799561115;3952.4071389291835;3987.4018897165365;3993.341098718708;164110;165761.17119414447;166429;167379;170764.14617926956;15592.050993625797;15712.607184820243;15852.841471585367;16016.439424620083;16019.038857668576;34646.48030279548;35519.28961420757;35519.934401967985;35860.282794344486;36068.45897311543;8904.777380565538;9033.322500812465;9034.503102329303;9038.502882341534;9041.321900857462;4432.29083346663;4499.572540608637;4594.954050459452;4604.401427814362;4624.098300831306;6220.34686357935;6336.334684858116;6341.429271365507;6370.904436433457;6378.362163783585;1101.1576144249655;1141.5947338694643;1146.2033886448837;1157.890000449956;1160.4139909345895;741.4402126394538;752.7704050264722;755.2824816424419;756.481809960179;779.3920741821388;13729.519466818614;14352.712945741026;14361.353739081558;14795.926020369829;14905.180215088274;741.1513816679872;749.1796482851269;750.8836130399797;752.7327798631517;773.9922600774033;5926.970365148233;5992.520598352121;6022.638641681513;6127.816165515042;6142.938570614326;144988.27505862404;146796;147389;147484;150242;133943;134775;137595;139336;144663.2766836159;111324.4433777842;111427;111675.88324116818;112061;114506.42746786213;11114.777704446027;11160.609378671708;11182.72043198894;11538.94230528842;11546.076313895037;57324;57862.71068644798;57921;59172.40827591841;59884.401155987885;72267.63866180636;72274;72448;73703.63148184225;75889.62055189689;17204.881682690586;17340.65318693594;17482.388116415863;17488.562785930455;17772.111394430485;18939.526511837314;19312.61374772525;19325.226990920204;19401;19481.318153864548;18365.724514132566;18430.539236518656;18446.90776546109;18508.537286567942;18642.720359194893;17093;17220.225089871237;17473.56316092108;17484.562885927953;17528.211230494915;17475.21361538759;17531.649367012335;17746.5563360917;17832.821671783637;17847.910760446113;11865;11893.583724569598;11997.880021199677;12154.209976351509;12259.264444133023;13726.65683357924;13835.723285534434;13915.58253252404;13916.721665566429;14023.158610483404 04:22:41 INFO - PID 11259 | __end_tp_report 04:22:41 INFO - PID 11259 | __start_cc_report 04:22:41 INFO - PID 11259 | _x_x_mozilla_cycle_collect,267 04:22:41 INFO - PID 11259 | __end_cc_report 04:22:41 INFO - PID 11259 | __startTimestamp1506597761356__endTimestamp 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | ------- Summary: start ------- 04:22:41 INFO - PID 11259 | Number of tests: 6 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | [#0] dojo.html Cycles:165 Average:6275.99 Median:6610.97 stddev:873.69 (13.2%) stddev-sans-first:855.74 04:22:41 INFO - PID 11259 | Values: 3870.3 3876.1 3876.8 3912.0 3914.5 6156.0 6236.4 6260.7 6286.2 6318.7 6260.7 6317.6 6353.0 6379.6 6420.6 5558.0 5667.8 5673.3 5693.0 5707.0 712.6 5639.4 5687.5 5724.5 5783.5 5619.2 5648.9 5664.9 5707.5 5733.1 5631.9 5643.2 5718.1 5719.3 5719.5 5620.0 5636.6 5704.9 5708.3 5715.7 6199.2 6232.0 6327.1 6375.6 6380.9 6662.6 6805.3 6807.7 6826.8 6910.9 6913.0 6942.9 6943.3 6955.2 6978.7 6281.9 6314.2 6358.3 6367.8 6415.4 7055.3 7124.5 7145.3 7154.5 7156.3 6750.5 6750.6 6817.8 6841.6 6842.0 6777.4 6852.6 6859.2 6865.3 6940.9 6839.1 6847.6 6848.7 6863.1 6888.6 6683.4 6755.2 6834.5 6839.0 6849.3 4868.8 4928.8 4977.5 4995.7 5007.3 4472.9 4485.8 4554.7 4555.3 4575.2 6288.2 6351.1 6352.1 6370.0 6377.1 6715.7 6806.4 6826.4 6912.4 6928.3 6241.5 6292.2 6300.6 6332.1 6378.7 5541.9 5569.6 5591.3 5603.1 5623.0 7132.2 7146.9 7222.4 7223.0 7223.2 6844.2 6845.8 6860.0 6938.1 6941.7 7029.7 7076.9 7158.6 7168.6 7196.4 6731.8 6794.7 6824.8 6831.1 6837.1 6766.6 6778.7 6861.2 6886.8 6945.9 6620.6 6628.5 6633.4 6633.5 6636.3 6526.6 6620.7 6646.0 6698.4 6709.9 6447.6 6593.5 6611.0 6621.8 6631.7 6644.5 6661.8 6675.9 6779.5 6785.2 6327.1 6391.0 6406.7 6418.3 6441.2 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | [#1] ext.html Cycles:180 Average:44995.47 Median:3776.23 stddev:66756.60 (1767.8%) stddev-sans-first:66861.93 04:22:41 INFO - PID 11259 | Values: 943.7 950.9 980.1 1016.0 1020.7 44767.0 45981.5 46386.3 46993.5 47227.8 47826.0 48046.3 48052.3 48175.8 48324.5 8547.0 8723.9 8727.3 8730.1 8735.3 8421.1 8573.2 8578.0 8583.8 8601.0 8658.7 8666.4 8675.1 8677.6 8702.7 8560.4 8566.9 8599.5 8603.8 8610.4 8525.1 8534.8 8561.4 8572.4 8596.1 42207.4 42244.8 42531.4 42546.6 42781.6 3710.8 3757.3 3772.2 3773.1 3779.4 33925.0 33940.5 34055.0 34066.3 34074.0 5350.4 5371.2 5399.5 5412.3 5433.4 223092.0 225242.0 225757.0 226024.0 226162.0 54644.7 54669.2 54712.0 54995.2 58828.4 59573.0 60261.4 60267.7 60463.7 60849.4 17277.1 17608.9 17616.0 17639.6 17642.6 14008.1 14171.2 14173.6 14178.7 14179.2 16332.7 16351.6 16382.3 16439.3 16446.0 6132.3 6158.1 6190.5 6265.7 6312.6 1080.2 1086.8 1088.3 1106.4 1111.6 26852.6 27115.9 27195.2 27345.0 27614.9 1208.6 1213.5 1216.4 1231.0 1234.1 14348.9 14372.9 14488.6 14544.9 14619.4 283688.0 287708.0 288164.0 311200.0 315232.0 67906.7 68234.7 68339.3 68414.0 68545.0 1513.3 1517.3 1520.8 1537.9 1545.1 31554.0 31618.8 31795.4 31829.7 31913.5 44584.3 44713.1 44941.0 44957.6 44989.3 239272.0 241356.0 241936.0 242235.0 242708.0 40301.0 40587.0 40730.2 40736.0 40847.9 50454.7 50773.5 50831.7 51341.5 51431.2 36025.6 36811.4 37057.4 37088.0 37296.6 36658.8 37448.8 37475.3 37480.8 37525.6 42380.6 43119.4 43271.0 43273.0 43632.3 35490.3 35809.6 35854.6 36047.0 36476.0 26063.9 26264.0 26357.6 26683.7 26809.5 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | [#2] jquery.html Cycles:180 Average:40252.42 Median:2280.65 stddev:104024.10 (4561.2%) stddev-sans-first:104273.38 04:22:41 INFO - PID 11259 | Values: 633.4 643.9 646.2 646.6 649.8 22834.1 23307.9 23467.3 23682.2 24877.6 26443.7 27411.5 27442.7 27455.3 27459.0 6490.1 6557.0 6632.9 6661.1 6700.9 6721.8 6795.5 6797.2 6799.8 6800.1 6756.8 6761.7 6773.4 6774.1 6774.2 6742.7 6765.8 6766.6 6767.6 6772.8 6328.7 6349.4 6352.6 6353.5 6361.2 30438.4 31209.7 31501.0 31791.7 31808.8 2280.2 2281.1 2304.6 2309.9 2310.1 20778.1 20888.7 21498.8 21505.4 21551.6 2565.4 2570.6 2592.7 2610.9 2612.7 135885.0 142507.0 145630.0 153802.0 153980.0 16381.7 16541.0 16887.3 17227.4 17403.9 26884.1 26914.0 26940.6 26940.7 26943.2 10855.2 10917.4 11083.6 11167.7 11168.3 9914.2 10037.9 10053.9 10210.4 10229.2 9928.8 9964.5 9969.4 10039.6 10274.3 2907.8 3072.3 3079.2 3081.8 3092.1 1048.7 1064.9 1073.5 1088.1 1098.7 21932.6 21971.2 22058.7 22253.7 22300.7 1145.3 1146.4 1148.8 1152.1 1162.6 11808.3 12192.9 12312.3 12395.8 12397.6 614560.0 614595.0 616776.0 640219.0 643541.0 117509.4 118186.4 118895.0 119508.4 121595.0 1124.7 1154.8 1236.0 1278.2 1280.1 22054.7 22448.9 22750.7 22750.8 22828.0 60680.0 60973.7 61784.0 62031.0 63030.4 76472.2 77675.6 77888.6 78499.2 78540.6 16255.3 16272.6 16527.0 16542.3 16574.0 24506.0 24675.3 24787.4 25016.2 25619.4 20114.3 20208.8 20356.6 20381.5 20566.0 17188.7 17715.8 18245.3 18251.2 18525.9 20967.9 21167.4 21280.1 21439.9 21471.2 15930.0 16107.8 16164.8 16322.0 16400.2 20200.5 20321.6 20382.0 20509.4 20537.1 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | [#3] mootools.html Cycles:180 Average:10566.45 Median:13134.48 stddev:7847.38 (59.7%) stddev-sans-first:7839.56 04:22:41 INFO - PID 11259 | Values: 1458.0 1481.7 1495.3 1495.8 1505.3 16405.3 16971.5 16995.9 16998.2 17010.0 16605.0 16759.2 16818.2 16838.7 16877.2 2458.5 2479.9 2489.5 2491.1 2496.3 2385.7 2478.1 2479.7 2481.1 2483.5 2428.8 2455.9 2460.5 2478.1 2485.8 2192.6 2232.8 2250.8 2251.6 2253.7 2319.3 2337.9 2356.4 2407.6 2500.2 16494.8 16530.8 16603.0 16631.0 16639.9 8163.8 8361.8 8363.6 8392.5 8425.8 5224.1 5472.5 5499.8 5502.2 5573.9 2116.6 2125.9 2130.7 2148.1 2198.3 29406.1 30005.7 30214.2 30317.5 30344.4 7493.4 7566.8 7740.2 7859.5 8197.0 23623.5 23660.3 23697.0 23698.8 23730.8 8651.6 8771.5 8808.1 8833.9 8855.2 7662.8 7812.8 7850.1 7854.9 7855.9 6136.9 6161.7 6177.3 6202.5 6293.2 1795.6 1854.4 1876.9 1884.2 1900.5 964.0 966.2 979.8 988.2 996.2 8140.2 8196.1 8231.6 8238.0 8290.2 789.5 792.9 794.8 796.4 810.9 5360.2 5780.3 5846.0 5944.4 5951.8 23919.2 24467.3 24761.1 24770.3 24839.8 23333.0 23675.0 23883.3 24023.5 24088.9 12322.2 12662.9 12919.9 12925.0 12959.9 10041.8 10128.8 10214.2 10269.2 10526.2 20590.9 20644.7 20833.7 20977.7 21104.9 21892.2 22195.4 22199.4 22220.3 22727.4 15865.8 15868.1 15882.8 15991.8 16217.4 15421.5 15667.8 15676.9 15690.9 15694.2 12812.4 12949.2 13037.2 13129.5 13146.3 11824.6 11930.9 12140.9 12358.6 12370.1 10762.4 10841.8 10931.3 10937.7 10943.4 8130.9 8138.8 8303.4 8324.6 8333.2 8412.6 8416.6 8471.7 8491.7 8622.6 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | [#4] prototype.html Cycles:180 Average:5655.47 Median:6205.08 stddev:1567.31 (25.3%) stddev-sans-first:1524.19 04:22:41 INFO - PID 11259 | Values: 552.5 569.3 575.7 583.5 594.5 6091.4 6155.6 6204.3 6265.2 6335.7 6119.2 6149.2 6182.9 6189.2 6237.5 4930.1 5037.5 5096.1 5118.7 5126.6 5042.4 5056.1 5063.6 5070.7 5091.3 4891.2 4933.4 5001.2 5020.0 5031.3 4959.8 4970.6 4991.6 5009.5 5021.6 4622.4 4642.8 4648.3 4653.3 4673.4 6115.8 6167.2 6205.8 6246.3 6298.2 5849.8 5859.4 5875.3 5885.9 5904.2 6668.6 6675.8 6682.4 6714.6 6715.8 4861.9 5080.5 5132.4 5133.3 5134.8 6742.3 6777.5 6848.6 6984.1 7020.9 5264.4 5281.7 5294.7 5296.5 5320.8 5275.3 5287.9 5353.8 5376.5 5377.9 5855.2 5883.6 5911.0 5913.9 5952.2 6686.3 6730.0 6772.6 6787.3 6798.8 1813.6 1814.8 1840.7 1867.7 1878.6 1267.5 1306.5 1314.2 1346.3 1356.5 6107.9 6120.4 6149.9 6166.6 6264.3 6644.3 6656.6 6717.9 6735.4 6761.0 6143.7 6192.1 6201.1 6208.3 6210.8 3504.6 3547.2 3573.5 3579.4 3599.1 6997.4 7089.8 7090.6 7102.8 7108.0 6729.9 6765.0 6817.6 6893.2 6950.8 6942.3 6989.4 7020.6 7043.9 7093.1 6745.8 6795.8 6814.9 6832.2 6836.2 6651.3 6682.8 6695.0 6725.5 6750.0 6885.7 6949.7 6977.3 6994.2 7000.4 5226.8 5237.7 5259.9 5298.5 5302.4 6617.2 6748.9 6825.7 6855.1 6855.2 6415.3 6602.1 6624.8 6629.4 6639.1 6547.4 6565.7 6588.9 6603.5 6657.0 6322.6 6445.9 6449.0 6454.7 6548.5 6557.0 6583.7 6584.5 6609.4 6688.8 6436.5 6446.1 6451.9 6460.4 6471.3 04:22:41 INFO - PID 11259 | 04:22:41 INFO - PID 11259 | [#5] yui.html Cycles:180 Average:28659.13 Median:18575.63 stddev:43148.47 (232.3%) stddev-sans-first:43219.39 04:22:41 INFO - PID 11259 | Values: 960.5 988.6 998.5 998.6 1009.3 20469.4 20864.3 20867.1 20899.8 20914.2 16787.1 16996.6 18656.8 19864.9 20044.1 969.8 1047.1 1052.0 1053.3 1053.3 1036.7 1045.2 1068.1 1070.8 1074.9 1134.7 1135.0 1135.4 1136.7 1137.6 1119.8 1122.6 1123.3 1124.1 1129.9 797.8 814.0 819.0 819.3 841.9 21432.2 21483.8 21637.5 21661.4 21687.6 23043.4 23515.9 23577.6 23847.4 23849.0 18807.2 18834.8 18863.9 19304.3 19317.2 3927.7 3952.4 3952.4 3987.4 3993.3 164110.0 165761.2 166429.0 167379.0 170764.1 15592.1 15712.6 15852.8 16016.4 16019.0 34646.5 35519.3 35519.9 35860.3 36068.5 8904.8 9033.3 9034.5 9038.5 9041.3 4432.3 4499.6 4595.0 4604.4 4624.1 6220.3 6336.3 6341.4 6370.9 6378.4 1101.2 1141.6 1146.2 1157.9 1160.4 741.4 752.8 755.3 756.5 779.4 13729.5 14352.7 14361.4 14795.9 14905.2 741.2 749.2 750.9 752.7 774.0 5927.0 5992.5 6022.6 6127.8 6142.9 144988.3 146796.0 147389.0 147484.0 150242.0 133943.0 134775.0 137595.0 139336.0 144663.3 111324.4 111427.0 111675.9 112061.0 114506.4 11114.8 11160.6 11182.7 11538.9 11546.1 57324.0 57862.7 57921.0 59172.4 59884.4 72267.6 72274.0 72448.0 73703.6 75889.6 17204.9 17340.7 17482.4 17488.6 17772.1 18939.5 19312.6 19325.2 19401.0 19481.3 18365.7 18430.5 18446.9 18508.5 18642.7 17093.0 17220.2 17473.6 17484.6 17528.2 17475.2 17531.6 17746.6 17832.8 17847.9 11865.0 11893.6 11997.9 12154.2 12259.3 13726.7 13835.7 13915.6 13916.7 14023.2 04:22:41 INFO - PID 11259 | -------- Summary: end -------- 04:22:41 INFO - PID 11259 | 04:22:42 INFO - TEST-INFO | 11259: exit 0 04:22:42 INFO - TEST-OK | dromaeo_css | took 1107451ms 04:22:42 INFO - TEST-START | kraken 04:22:42 INFO - Initialising browser for kraken test... 04:22:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54932/getInfo.html -profile /tmp/tmpgqHwyj/profile 04:22:42 INFO - TEST-INFO | started process 11622 (/builds/slave/test/build/application/firefox/firefox http://localhost:54932/getInfo.html) 04:22:47 INFO - TEST-INFO | 11622: exit 0 04:22:47 INFO - Browser initialized. 04:22:47 INFO - Running cycle 1/1 for kraken test... 04:22:47 INFO - Using env: {'DISPLAY': ':0', 04:22:47 INFO - 'HOME': '/home/cltbld', 04:22:47 INFO - 'JSGC_DISABLE_POISONING': '1', 04:22:47 INFO - 'LANG': 'en_US.UTF-8', 04:22:47 INFO - 'LANGUAGE': 'en_US:en', 04:22:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 04:22:47 INFO - 'LOGNAME': 'cltbld', 04:22:47 INFO - 'MAIL': '/var/mail/cltbld', 04:22:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:22:47 INFO - 'MOZ_CRASHREPORTER': '1', 04:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 04:22:47 INFO - 'MOZ_NO_REMOTE': '1', 04:22:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:47 INFO - 'NO_EM_RESTART': '1', 04:22:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:47 INFO - 'PWD': '/builds/slave/test', 04:22:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:47 INFO - 'RUST_BACKTRACE': 'full', 04:22:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:22:47 INFO - 'SHELL': '/bin/bash', 04:22:47 INFO - 'SHLVL': '1', 04:22:47 INFO - 'STYLO_FORCE_DISABLED': '1', 04:22:47 INFO - 'TERM': 'linux', 04:22:47 INFO - 'TMOUT': '86400', 04:22:47 INFO - 'USER': 'cltbld', 04:22:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474', 04:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:47 INFO - '_': '/tools/buildbot/bin/python'} 04:22:47 INFO - TEST-INFO | started process 11858 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgqHwyj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:48 INFO - PID 11858 | 04:22:48 INFO - PID 11858 | (/builds/slave/test/build/application/firefox/firefox:11908): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:22:48 INFO - PID 11858 | 04:22:58 INFO - PID 11858 | RSS: Main: 145113088 04:22:58 INFO - PID 11858 | 04:23:01 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54932/tests/kraken/driver.html?testName=audio-beat-detection) 04:23:01 INFO - PID 11858 | RSS: Main: 150446080 04:23:01 INFO - PID 11858 | 04:23:04 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54932/tests/kraken/driver.html?testName=audio-dft) 04:23:05 INFO - PID 11858 | RSS: Main: 150999040 04:23:05 INFO - PID 11858 | 04:23:07 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54932/tests/kraken/driver.html?testName=audio-fft) 04:23:08 INFO - PID 11858 | RSS: Main: 147775488 04:23:08 INFO - PID 11858 | 04:23:10 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54932/tests/kraken/driver.html?testName=audio-oscillator) 04:23:11 INFO - PID 11858 | RSS: Main: 148725760 04:23:11 INFO - PID 11858 | 04:23:13 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54932/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:23:13 INFO - PID 11858 | RSS: Main: 148410368 04:23:13 INFO - PID 11858 | 04:23:16 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54932/tests/kraken/driver.html?testName=imaging-darkroom) 04:23:17 INFO - PID 11858 | RSS: Main: 148701184 04:23:17 INFO - PID 11858 | 04:23:21 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54932/tests/kraken/driver.html?testName=imaging-desaturate) 04:23:21 INFO - PID 11858 | RSS: Main: 149897216 04:23:21 INFO - PID 11858 | 04:23:24 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54932/tests/kraken/driver.html?testName=json-parse-financial) 04:23:25 INFO - PID 11858 | RSS: Main: 151764992 04:23:25 INFO - PID 11858 | 04:23:26 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54932/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:23:27 INFO - PID 11858 | RSS: Main: 151670784 04:23:27 INFO - PID 11858 | 04:23:28 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:23:29 INFO - PID 11858 | RSS: Main: 150941696 04:23:29 INFO - PID 11858 | 04:23:31 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:23:32 INFO - PID 11858 | RSS: Main: 148348928 04:23:32 INFO - PID 11858 | 04:23:34 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:23:35 INFO - PID 11858 | RSS: Main: 148357120 04:23:35 INFO - PID 11858 | 04:23:37 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:23:38 INFO - PID 11858 | RSS: Main: 148824064 04:23:38 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | Cycle 1(1): loaded http://localhost:54932/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54932/tests/kraken/driver.html?testName=ai-astar) 04:23:40 INFO - PID 11858 | RSS: Main: 150257664 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | __start_tp_report 04:23:40 INFO - PID 11858 | _x_x_mozilla_page_load 04:23:40 INFO - PID 11858 | _x_x_mozilla_page_load_details 04:23:40 INFO - PID 11858 | |i|pagename|runs| 04:23:40 INFO - PID 11858 | |0;ai-astar;105;104;104;106;106;106;107;107;105;104 04:23:40 INFO - PID 11858 | |1;audio-beat-detection;114;112;113;114;115;112;112;116;112;112 04:23:40 INFO - PID 11858 | |2;audio-dft;160;162;162;163;162;163;163;162;163;165 04:23:40 INFO - PID 11858 | |3;audio-fft;72;74;73;76;74;73;75;81;83;75 04:23:40 INFO - PID 11858 | |4;audio-oscillator;79;79;78;78;79;78;77;78;78;78 04:23:40 INFO - PID 11858 | |5;imaging-gaussian-blur;113;114;114;114;114;115;114;114;113;114 04:23:40 INFO - PID 11858 | |6;imaging-darkroom;150;150;150;152;150;151;151;151;150;149 04:23:40 INFO - PID 11858 | |7;imaging-desaturate;94;95;96;94;94;95;100;95;94;95 04:23:40 INFO - PID 11858 | |8;json-parse-financial;44;45;45;45;57;46;45;43;44;45 04:23:40 INFO - PID 11858 | |9;json-stringify-tinderbox;37;37;41;38;38;38;37;38;39;37 04:23:40 INFO - PID 11858 | |10;stanford-crypto-aes;73;70;70;69;69;73;69;71;70;71 04:23:40 INFO - PID 11858 | |11;stanford-crypto-ccm;107;110;102;104;105;105;102;109;103;110 04:23:40 INFO - PID 11858 | |12;stanford-crypto-pbkdf2;149;150;146;144;147;148;149;147;147;148 04:23:40 INFO - PID 11858 | |13;stanford-crypto-sha256-iterative;60;61;59;58;60;61;59;59;62;62 04:23:40 INFO - PID 11858 | __end_tp_report 04:23:40 INFO - PID 11858 | __start_cc_report 04:23:40 INFO - PID 11858 | _x_x_mozilla_cycle_collect,716 04:23:40 INFO - PID 11858 | __end_cc_report 04:23:40 INFO - PID 11858 | __startTimestamp1506597820398__endTimestamp 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | ------- Summary: start ------- 04:23:40 INFO - PID 11858 | Number of tests: 14 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#0] ai-astar Cycles:10 Average:105.40 Median:106.00 stddev:1.17 (1.1%) stddev-sans-first:1.24 04:23:40 INFO - PID 11858 | Values: 105.0 104.0 104.0 106.0 106.0 106.0 107.0 107.0 105.0 104.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#1] audio-beat-detection Cycles:10 Average:113.20 Median:113.50 stddev:1.48 (1.3%) stddev-sans-first:1.54 04:23:40 INFO - PID 11858 | Values: 114.0 112.0 113.0 114.0 115.0 112.0 112.0 116.0 112.0 112.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.27 (0.8%) stddev-sans-first:0.97 04:23:40 INFO - PID 11858 | Values: 160.0 162.0 162.0 163.0 162.0 163.0 163.0 162.0 163.0 165.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#3] audio-fft Cycles:10 Average:75.60 Median:75.00 stddev:3.60 (4.8%) stddev-sans-first:3.57 04:23:40 INFO - PID 11858 | Values: 72.0 74.0 73.0 76.0 74.0 73.0 75.0 81.0 83.0 75.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#4] audio-oscillator Cycles:10 Average:78.20 Median:78.00 stddev:0.63 (0.8%) stddev-sans-first:0.60 04:23:40 INFO - PID 11858 | Values: 79.0 79.0 78.0 78.0 79.0 78.0 77.0 78.0 78.0 78.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 04:23:40 INFO - PID 11858 | Values: 113.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 113.0 114.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 04:23:40 INFO - PID 11858 | Values: 150.0 150.0 150.0 152.0 150.0 151.0 151.0 151.0 150.0 149.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:1.81 (1.9%) stddev-sans-first:1.87 04:23:40 INFO - PID 11858 | Values: 94.0 95.0 96.0 94.0 94.0 95.0 100.0 95.0 94.0 95.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#8] json-parse-financial Cycles:10 Average:45.90 Median:45.00 stddev:3.98 (8.9%) stddev-sans-first:4.17 04:23:40 INFO - PID 11858 | Values: 44.0 45.0 45.0 45.0 57.0 46.0 45.0 43.0 44.0 45.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:1.25 (3.3%) stddev-sans-first:1.27 04:23:40 INFO - PID 11858 | Values: 37.0 37.0 41.0 38.0 38.0 38.0 37.0 38.0 39.0 37.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#10] stanford-crypto-aes Cycles:10 Average:70.50 Median:70.50 stddev:1.51 (2.1%) stddev-sans-first:1.30 04:23:40 INFO - PID 11858 | Values: 73.0 70.0 70.0 69.0 69.0 73.0 69.0 71.0 70.0 71.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#11] stanford-crypto-ccm Cycles:10 Average:105.70 Median:106.00 stddev:3.13 (3.0%) stddev-sans-first:3.28 04:23:40 INFO - PID 11858 | Values: 107.0 110.0 102.0 104.0 105.0 105.0 102.0 109.0 103.0 110.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:148.00 stddev:1.72 (1.2%) stddev-sans-first:1.73 04:23:40 INFO - PID 11858 | Values: 149.0 150.0 146.0 144.0 147.0 148.0 149.0 147.0 147.0 148.0 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.50 stddev:1.37 (2.3%) stddev-sans-first:1.45 04:23:40 INFO - PID 11858 | Values: 60.0 61.0 59.0 58.0 60.0 61.0 59.0 59.0 62.0 62.0 04:23:40 INFO - PID 11858 | -------- Summary: end -------- 04:23:40 INFO - PID 11858 | 04:23:40 INFO - PID 11858 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:23:40 INFO - TEST-INFO | 11858: exit 0 04:23:40 INFO - TEST-OK | kraken | took 58917ms 04:23:40 INFO - SUITE-END | took 1166s 04:23:41 INFO - Completed test suite (00:19:26) 04:23:41 INFO - javascript benchmark 04:23:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9189.29395129104, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3870.3033453978283, 3876.069743261618, 3876.767393956363, 3911.960880391195, 3914.4911161548994, 6156.0, 6236.407541283582, 6260.655663938482, 6286.182796236489, 6318.652474113927, 6260.655663938482, 6317.620942743439, 6353.047042943549, 6379.649119298437, 6420.58266212697, 5557.972210138963, 5667.801626943058, 5673.290838645169, 5693.03218452864, 5706.9727449059155, 712.597932851686, 5639.351474580435, 5687.516561092312, 5724.4561766632105, 5783.479486846183, 5619.157126431007, 5648.943510564883, 5664.858378540528, 5707.5148612368, 5733.082706766918, 5631.943680563183, 5643.209950606918, 5718.1136923776885, 5719.28508936383, 5719.48524632785, 5620.0, 5636.605437619368, 5704.914426283609, 5708.286464191976, 5715.714214289269, 6199.163112979735, 6232.0, 6327.14583531222, 6375.649339286338, 6380.904286435707, 6662.600243985376, 6805.28544502825, 6807.727690892359, 6826.795196144124, 6910.930890691079, 6912.963055541659, 6942.895856562105, 6943.305669433067, 6955.234924158339, 6978.685959131852, 6281.87436251277, 6314.210723659543, 6358.268799088071, 6367.808965731036, 6415.358464153547, 7055.329743674342, 7124.50128491011, 7145.285471452813, 7154.4634152438775, 7156.284371562802, 6750.5274630775375, 6750.628715420699, 6817.829554261084, 6841.62371069586, 6842.0, 6777.356151165632, 6852.554583952027, 6859.211190713032, 6865.347791959756, 6940.895886561706, 6839.1451068616425, 6847.589144651337, 6848.7260509580055, 6863.073485079451, 6888.586684798928, 6683.398494135454, 6755.1556055493065, 6834.453243740489, 6839.0425340452375, 6849.280825513349, 4868.829590964299, 4928.753562321869, 4977.477364876709, 4995.650304478651, 5007.3240112584335, 4472.932906006413, 4485.753283569435, 4554.749488778149, 4555.316702494586, 4575.153596584642, 6288.151099601587, 6351.110844481776, 6352.14246076783, 6370.0, 6377.139086223393, 6715.731370745213, 6806.387425131762, 6826.351496607815, 6912.412444942136, 6928.272531384233, 6241.531885108635, 6292.150559674477, 6300.621962682254, 6332.050192471166, 6378.712957916812, 5541.9168712469345, 5569.637973531708, 5591.30108736408, 5603.131514615241, 5622.971885140548, 7132.215456299803, 7146.892796608055, 7222.3860971817985, 7222.96388518054, 7223.2415596361625, 6844.2129155147795, 6845.760398386232, 6859.965700171567, 6938.06336144614, 6941.652917354213, 7029.718811247493, 7076.893846592202, 7158.606276654834, 7168.569885806868, 7196.388306993755, 6731.764388246584, 6794.660266986532, 6824.7952561423235, 6831.077804496329, 6837.111175547346, 6766.594004359754, 6778.661066946732, 6861.245263021164, 6886.758963436256, 6945.895811562729, 6620.63586502747, 6628.5028622852515, 6633.402993730588, 6633.502487313374, 6636.303188165173, 6526.641034743135, 6620.735170593122, 6645.966770166118, 6698.363655452724, 6709.93290067093, 6447.645379503984, 6593.538452308292, 6610.9669451652435, 6621.768238111643, 6631.6684165792485, 6644.534882558174, 6661.800145995628, 6675.899861502178, 6779.457643388616, 6785.1518560179975, 6327.050942358499, 6391.0, 6406.711697973509, 6418.293987661447, 6441.227052753699], "value": 6217.718723612819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [943.6744323208491, 950.9286803489736, 980.0591432225063, 1016.0246163682864, 1020.6784862768233, 44767.0, 45981.54018459815, 46386.3042054369, 46993.53006469934, 47227.763861180734, 47826.0, 48046.27930581044, 48052.2792158117, 48175.759121204435, 48324.51675483244, 8547.0, 8723.869141962876, 8727.345449091343, 8730.126987301282, 8735.344849136309, 8421.073681894986, 8573.228409443149, 8578.0, 8583.828323433527, 8601.0, 8658.696945606906, 8666.350023748213, 8675.132486751307, 8677.566121693922, 8702.651893924236, 8560.357973152008, 8566.914330856705, 8599.4840309581, 8603.784905377353, 8610.44032137909, 8525.062243153248, 8534.829303413897, 8561.400701950866, 8572.442791218613, 8596.140385961417, 42207.36688949668, 42244.788776055924, 42531.36202956958, 42546.57453425488, 42781.57218427807, 3710.8330125144435, 3757.3424650686293, 3772.1512659651635, 3773.056735816046, 3779.3952967525065, 33925.0, 33940.49089263663, 34055.0, 34066.31867362639, 34074.0, 5350.384705758848, 5371.167469042305, 5399.514043736082, 5412.296401467824, 5433.429489903582, 223092.0, 225242.0, 225757.0, 226024.0, 226162.0, 54644.72677636586, 54669.1799623006, 54712.0, 54995.175072373946, 58828.41171588315, 59573.0, 60261.39738602558, 60267.69866150641, 60463.69768151131, 60849.39150608437, 17277.13614319279, 17608.9119554404, 17616.0, 17639.559011024827, 17642.5589360267, 14008.089474184146, 14171.220582868042, 14173.645658858612, 14178.71642567143, 14179.22014289224, 16332.673346533003, 16351.591210219602, 16382.262798174112, 16439.342426302814, 16446.0, 6132.264128304632, 6158.149757730174, 6190.50475961931, 6265.686715664198, 6312.558120931582, 1080.2276372393776, 1086.842407850873, 1088.3198001249218, 1106.441247170174, 1111.6387174168428, 26852.59721104185, 27115.864420678165, 27195.184144475697, 27345.0, 27614.861925690242, 1208.583038851595, 1213.508529045738, 1216.3614102596032, 1230.9630711078682, 1234.0991076514194, 14348.928255358656, 14372.85627143736, 14488.565343039725, 14544.927275363556, 14619.415223390944, 283688.0, 287708.0, 288164.0, 311200.0, 315232.0, 67906.66046669734, 68234.65882670555, 68339.31660683428, 68414.0, 68545.0, 1513.2585033333587, 1517.332373755544, 1520.7642815363636, 1537.8539038791298, 1545.1115608525142, 31554.0, 31618.841905790323, 31795.36409271848, 31829.72681092823, 31913.521297181025, 44584.33123503215, 44713.10573788571, 44941.0, 44957.55042449664, 44989.32516012197, 239272.0, 241356.0, 241936.0, 242235.0, 242708.0, 40301.0, 40587.0, 40730.1853962925, 40736.0, 40847.93640476916, 50454.747726261136, 50773.49226507688, 50831.74584127056, 51341.48658513367, 51431.22853157131, 36025.63974360328, 36811.44782828313, 37057.444138338484, 37088.0, 37296.62703372932, 36658.816705917365, 37448.812755937135, 37475.25049499049, 37480.81259593685, 37525.62474375221, 42380.57619423766, 43119.35320970251, 43271.0, 43273.0, 43632.34551481667, 35490.29019419649, 35809.64190358063, 35854.64145358618, 36047.0, 36476.0, 26063.869680651474, 26264.0, 26357.60463593086, 26683.733162668126, 26809.463810723286], "value": 19673.738646038535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [633.3856159525259, 643.9356064393561, 646.176125440064, 646.6249575246358, 649.8342922554745, 22834.08663653454, 23307.883460582674, 23467.295981120573, 23682.171124010685, 24877.626835597435, 26443.735562644415, 27411.45177096457, 27442.725572744268, 27455.313617159532, 27459.0, 6490.058941453498, 6557.0, 6632.867342653144, 6661.067450556926, 6700.865982680343, 6721.831954201135, 6795.456363490909, 6797.184337879461, 6799.796006119825, 6800.081988931505, 6756.8310792230095, 6761.661916904135, 6773.4242589379965, 6774.085498457719, 6774.187097548301, 6742.662866856662, 6765.830854228634, 6766.627835469048, 6767.593944363305, 6772.830679233034, 6328.6835658216905, 6349.396807303298, 6352.555321127523, 6353.523485738542, 6361.236651601791, 30438.391232175454, 31209.687903121132, 31501.0, 31791.682083179105, 31808.840955795305, 2280.224723593986, 2281.0761641535205, 2304.5506126305377, 2309.9307020789233, 2310.06442390832, 20778.064987075617, 20888.686669699968, 21498.785012149834, 21505.354839354844, 21551.56896862054, 2565.4356041670803, 2570.611869590419, 2592.6629538160105, 2610.8955641774305, 2612.6995395529566, 135885.0, 142507.0, 145630.0, 153802.0, 153980.0, 16381.672366552602, 16541.0, 16887.324507019828, 17227.3970411035, 17403.91298043527, 26884.05905793288, 26914.0, 26940.59589106165, 26940.73059269382, 26943.191704248904, 10855.240133190759, 10917.39954302505, 11083.612073577386, 11167.720806979729, 11168.329900206014, 9914.206863450907, 10037.949810250902, 10053.949730251448, 10210.4384258865, 10229.181665466893, 9928.80142397148, 9964.451955142391, 9969.40183588987, 10039.648612298535, 10274.33216840903, 2907.756510293342, 3072.308730535656, 3079.16862447138, 3081.7980987414926, 3092.1187461573345, 1048.6906362623045, 1064.9307794993456, 1073.5276478349501, 1088.1240601316017, 1098.7308109513222, 21932.561348772935, 21971.231006915, 22058.669119963215, 22253.66619500709, 22300.66549001766, 1145.3013661666378, 1146.3924120216132, 1148.8391625172483, 1152.124385467051, 1162.5756598841363, 11808.291502509705, 12192.939035304944, 12312.322822244683, 12395.75208495843, 12397.62807115788, 614560.0, 614595.0, 616776.0, 640219.0, 643541.0, 117509.4124529389, 118186.40906795411, 118895.0, 119508.4024579889, 121595.0, 1124.6850881753123, 1154.7748189103213, 1235.993820030894, 1278.1691900264716, 1280.0975312404732, 22054.66917996199, 22448.887755561118, 22750.65874011924, 22750.772492274864, 22828.0, 60680.0, 60973.69513152406, 61784.0, 62031.0, 63030.36969630245, 76472.23527764651, 77675.61162194153, 77888.61055694685, 78499.21500785147, 78540.60729696315, 16255.349786008428, 16272.61682756979, 16527.0, 16542.338306467605, 16574.0, 24506.0, 24675.259742207763, 24787.380315492257, 25016.249512514652, 25619.35951601225, 20114.295999639944, 20208.79791202069, 20356.592868142852, 20381.49046273796, 20565.97170141517, 17188.742168867728, 17715.822841771416, 18245.270189192815, 18251.178696958934, 18525.90737046306, 20967.895160524098, 21167.364979050653, 21280.148794048066, 21439.892800536523, 21471.248506302203, 15930.0, 16107.758383624021, 16164.838351616803, 16322.0, 16400.17999100064, 20200.49498762543, 20321.59356812885, 20382.0, 20509.38471845847, 20537.075831587914], "value": 13102.79729987961, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.9927100364496, 1481.7406953783086, 1495.259846376044, 1495.8130233720785, 1505.3226048278277, 16405.34378624855, 16971.490855274347, 16995.915020424894, 16998.150092495387, 17009.999999999967, 16605.0, 16759.16204189792, 16818.15909204538, 16838.747418788727, 16877.156142192904, 2458.4714286428457, 2479.876006199692, 2489.4772097859473, 2491.0533997081084, 2496.2636022373445, 2385.677933478984, 2478.083109249571, 2479.690038745157, 2481.081999660128, 2483.5405449991717, 2428.781409673129, 2455.8649274289905, 2460.495598402323, 2478.08310924958, 2485.751424857518, 2192.5614877024577, 2232.843700940935, 2250.8086812620863, 2251.5609456156058, 2253.729552453708, 2319.3389883883183, 2337.9064837406654, 2356.352003199117, 2407.6027455470003, 2500.1874390822873, 16494.75257871133, 16530.83469165317, 16603.0, 16631.0, 16639.916800415922, 8163.795905102361, 8361.790955226168, 8363.623636936352, 8392.4544904581, 8425.789355266106, 5224.138017227153, 5472.452754724535, 5499.780008799643, 5502.174673798922, 5573.916391254134, 2116.5872654832315, 2125.90433430496, 2130.680397940321, 2148.1085349579907, 2198.274569392097, 29406.11781646554, 30005.69994300051, 30214.244643884078, 30317.545236821465, 30344.393112137855, 7493.3630641395, 7566.810829729301, 7740.225977402215, 7859.467403856193, 8197.0, 23623.527529449657, 23660.290191294287, 23697.0, 23698.763012369654, 23730.762692373202, 8651.610677519528, 8771.517566533901, 8808.11918808127, 8833.911660883308, 8855.247303979106, 7662.770116896502, 7812.84374312522, 7850.136484986761, 7854.921450785419, 7855.921440785519, 6136.9079463808075, 6161.691915404212, 6177.320494745574, 6202.472789812826, 6293.181886354744, 1795.64087182564, 1854.378783107674, 1876.934307299238, 1884.2463014793918, 1900.4773687235845, 964.0333719212867, 966.1739212972948, 979.8285300072458, 988.1896844587513, 996.2279233594022, 8140.185981401813, 8196.098429172785, 8231.629576669064, 8238.0, 8290.212429819157, 789.4789438970253, 792.8889955406248, 794.8012996750813, 796.3947399976059, 810.8662070758377, 5360.2227676987395, 5780.335261444903, 5846.035404158351, 5944.375840536768, 5951.791687290924, 23919.16282930089, 24467.265982020566, 24761.133360332304, 24770.25689229326, 24839.751602483742, 23333.0, 23675.0, 23883.28350149498, 24023.51952960931, 24088.87955560211, 12322.199057061442, 12662.873371266354, 12919.901808346396, 12925.0, 12959.870401296055, 10041.849372259276, 10128.797424051625, 10214.233932455245, 10269.178465722574, 10526.210534210119, 20590.897045514677, 20644.690329645367, 20833.687494687896, 20977.685334720296, 21104.894475527522, 21892.23377181791, 22195.445113872283, 22199.44501387478, 22220.333389998326, 22727.431814204116, 15865.762013570036, 15868.127253001196, 15882.761758573399, 15991.840081599035, 16217.432389866299, 15421.537353879401, 15667.764983525029, 15676.92161539185, 15690.921545392657, 15694.21528923572, 12812.423440945366, 12949.158304710163, 13037.217766934014, 13129.540466083641, 13146.27695476758, 11824.58613948542, 11930.880691192977, 12140.878591213976, 12358.567450139202, 12370.13409061393, 10762.3542587445, 10841.783164336826, 10931.344119352865, 10937.726556836144, 10943.398113103856, 8130.918690813016, 8138.796530086795, 8303.418760686694, 8324.583770811314, 8333.208345207195, 8412.62143203545, 8416.569183238742, 8471.703490377808, 8491.660333586588, 8622.568871556523], "value": 7250.932120979128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4999875113024, 569.3196630027118, 575.7104086845462, 583.533173461231, 594.4887396838718, 6091.360407157245, 6155.599886007406, 6204.348543402945, 6265.185525881635, 6335.683215839213, 6119.204503414561, 6149.2313460817395, 6182.938170618292, 6189.164462797532, 6237.469815065713, 4930.112579735646, 5037.4710655381205, 5096.133657278262, 5118.692878427288, 5126.5642420394315, 5042.420121685998, 5056.115179843531, 5063.569596584295, 5070.6957582545165, 5091.312672789181, 4891.192953162724, 4933.432655244639, 5001.224810154432, 5020.0, 5031.27046578246, 4959.752012399365, 4970.552650261476, 4991.575716064139, 5009.5491405773655, 5021.623378246646, 4622.399088118523, 4642.76786160694, 4648.302754586839, 4653.348531205634, 4673.415823022122, 6115.755369785204, 6167.229096362955, 6205.81382558524, 6246.312905580428, 6298.212723409574, 5849.795257165979, 5859.384764599741, 5875.324337701177, 5885.911711324334, 5904.169707390723, 6668.599884006975, 6675.833104172386, 6682.398584127452, 6714.597124172566, 6715.7985260442265, 4861.857463496076, 5080.542751152377, 5132.435432102466, 5133.30700355451, 5134.845954621367, 6742.258351581371, 6777.49168812341, 6848.623325717083, 6984.0571522844275, 7020.946857971294, 5264.447233040552, 5281.735913204401, 5294.658380128258, 5296.496832800878, 5320.813771517978, 5275.287836142148, 5287.920681189786, 5353.81261655848, 5376.542993845567, 5377.946220537745, 5855.238818953594, 5883.61756485827, 5911.0, 5913.940860591339, 5952.196453478811, 6686.297938716365, 6730.0, 6772.5936443813525, 6787.2534021257625, 6798.76204332846, 1813.5738101546126, 1814.8094450082551, 1840.7054871220541, 1867.7105048717472, 1878.614883948787, 1267.5310135250018, 1306.490468717201, 1314.1786383510307, 1346.3335648853683, 1356.525216174331, 6107.938920610826, 6120.387961203933, 6149.907751383644, 6166.599171053867, 6264.310925798159, 6644.302348253461, 6656.633885136267, 6717.899231511531, 6735.42748866342, 6760.985852122221, 6143.692815359214, 6192.102145188923, 6201.069839524108, 6208.317085120633, 6210.813675589739, 3504.649535046526, 3547.219611685425, 3573.4997100405963, 3579.355715971098, 3599.1002249437643, 6997.425579244629, 7089.751858684921, 7090.574565525982, 7102.786916392516, 7108.0, 6729.932700673028, 6765.0, 6817.625030623363, 6893.172819261721, 6950.818360878663, 6942.271061538567, 6989.4408447324095, 7020.578765273997, 7043.92956070443, 7093.1488221413765, 6745.763898263734, 6795.762148324785, 6814.93185068143, 6832.214295356098, 6836.248012718497, 6651.33486651331, 6682.766103186365, 6694.966525167343, 6725.529212955046, 6750.0, 6885.724571017103, 6949.722011119498, 6977.2673869243, 6994.2306346302885, 7000.404965577779, 5226.817061402832, 5237.738113094254, 5259.921101183561, 5298.470152984671, 5302.39022512416, 6617.205935287604, 6748.8650226994205, 6825.726970921108, 6855.143107111611, 6855.245922948372, 6415.262244841903, 6602.141721576164, 6624.8343791405605, 6629.436497897733, 6639.136912201576, 6547.434680521518, 6565.704543295467, 6588.868222635425, 6603.471722262111, 6656.966715166393, 6322.557420980487, 6445.903311450238, 6449.0, 6454.677266136769, 6548.476121910331, 6557.000114964982, 6583.736650534117, 6584.539082264387, 6609.405153536205, 6688.83277918056, 6436.452901503425, 6446.129772480843, 6451.935480645321, 6460.353964603502, 6471.320511346429], "value": 5208.709206644457, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [960.4717405427014, 988.5996171550522, 998.5157198758606, 998.6354980432144, 1009.3101883480525, 20469.385918422435, 20864.269750558713, 20867.060982255796, 20899.791002089976, 20914.163433462643, 16787.0767107809, 16996.575085622866, 18656.813431865678, 19864.90067549664, 20044.098015589298, 969.8496733006396, 1047.141344097838, 1051.978960420791, 1053.3153450257316, 1053.3416614615865, 1036.678629624815, 1045.2160879340495, 1068.086785798143, 1070.785842831433, 1074.8710154781438, 1134.7390100276941, 1134.982975255372, 1135.3755434511027, 1136.7044568412189, 1137.6075254037385, 1119.8264269038311, 1122.5622007417114, 1123.3203911633425, 1124.0670243697712, 1129.8926601972798, 797.7686470923484, 814.0231721933703, 819.0, 819.3117781063876, 841.9242268195892, 21432.249871254586, 21483.785162148335, 21637.45906352338, 21661.35015949524, 21687.56624867494, 23043.423914402105, 23515.882420587957, 23577.646335304984, 23847.403814904592, 23849.0, 18807.24771009158, 18834.811651883443, 18863.905680471646, 19304.32434864773, 19317.227310907547, 3927.725059245854, 3952.3873799561115, 3952.4071389291835, 3987.4018897165365, 3993.341098718708, 164110.0, 165761.17119414447, 166429.0, 167379.0, 170764.14617926956, 15592.050993625797, 15712.607184820243, 15852.841471585367, 16016.439424620083, 16019.038857668576, 34646.48030279548, 35519.28961420757, 35519.934401967985, 35860.282794344486, 36068.45897311543, 8904.777380565538, 9033.322500812465, 9034.503102329303, 9038.502882341534, 9041.321900857462, 4432.29083346663, 4499.572540608637, 4594.954050459452, 4604.401427814362, 4624.098300831306, 6220.34686357935, 6336.334684858116, 6341.429271365507, 6370.904436433457, 6378.362163783585, 1101.1576144249655, 1141.5947338694643, 1146.2033886448837, 1157.890000449956, 1160.4139909345895, 741.4402126394538, 752.7704050264722, 755.2824816424419, 756.481809960179, 779.3920741821388, 13729.519466818614, 14352.712945741026, 14361.353739081558, 14795.926020369829, 14905.180215088274, 741.1513816679872, 749.1796482851269, 750.8836130399797, 752.7327798631517, 773.9922600774033, 5926.970365148233, 5992.520598352121, 6022.638641681513, 6127.816165515042, 6142.938570614326, 144988.27505862404, 146796.0, 147389.0, 147484.0, 150242.0, 133943.0, 134775.0, 137595.0, 139336.0, 144663.2766836159, 111324.4433777842, 111427.0, 111675.88324116818, 112061.0, 114506.42746786213, 11114.777704446027, 11160.609378671708, 11182.72043198894, 11538.94230528842, 11546.076313895037, 57324.0, 57862.71068644798, 57921.0, 59172.40827591841, 59884.401155987885, 72267.63866180636, 72274.0, 72448.0, 73703.63148184225, 75889.62055189689, 17204.881682690586, 17340.65318693594, 17482.388116415863, 17488.562785930455, 17772.111394430485, 18939.526511837314, 19312.61374772525, 19325.226990920204, 19401.0, 19481.318153864548, 18365.724514132566, 18430.539236518656, 18446.90776546109, 18508.537286567942, 18642.720359194893, 17093.0, 17220.225089871237, 17473.56316092108, 17484.562885927953, 17528.211230494915, 17475.21361538759, 17531.649367012335, 17746.5563360917, 17832.821671783637, 17847.910760446113, 11865.0, 11893.583724569598, 11997.880021199677, 12154.209976351509, 12259.264444133023, 13726.65683357924, 13835.723285534434, 13915.58253252404, 13916.721665566429, 14023.158610483404], "value": 9946.229765993929, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1362.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 104.0, 104.0, 106.0, 106.0, 106.0, 107.0, 107.0, 105.0, 104.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 112.0, 113.0, 114.0, 115.0, 112.0, 112.0, 116.0, 112.0, 112.0], "value": 113.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 162.0, 163.0, 165.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 73.0, 76.0, 74.0, 73.0, 75.0, 81.0, 83.0, 75.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 78.0, 78.0, 79.0, 78.0, 77.0, 78.0, 78.0, 78.0], "value": 78.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 152.0, 150.0, 151.0, 151.0, 151.0, 150.0, 149.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 94.0, 95.0, 100.0, 95.0, 94.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 45.0, 45.0, 45.0, 57.0, 46.0, 45.0, 43.0, 44.0, 45.0], "value": 45.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 41.0, 38.0, 38.0, 38.0, 37.0, 38.0, 39.0, 37.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 70.0, 69.0, 69.0, 73.0, 69.0, 71.0, 70.0, 71.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 110.0, 102.0, 104.0, 105.0, 105.0, 102.0, 109.0, 103.0, 110.0], "value": 105.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 146.0, 144.0, 147.0, 148.0, 149.0, 147.0, 147.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 59.0, 58.0, 60.0, 61.0, 59.0, 59.0, 62.0, 62.0], "value": 60.1, "unit": "score"}]}]} 04:23:41 INFO - Return code: 0 04:23:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:23:41 INFO - # TBPL SUCCESS # 04:23:41 INFO - Running post-action listener: _package_coverage_data 04:23:41 INFO - Running post-action listener: _resource_record_post_action 04:23:41 INFO - [mozharness: 2017-09-28 11:23:41.177269Z] Finished run-tests step (success) 04:23:41 INFO - Running post-run listener: _resource_record_post_run 04:23:41 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 454656; Write bytes: 321994752; Read time: 60; Write time: 193696 04:23:41 INFO - TinderboxPrint: CPU usage
13.1% 04:23:41 INFO - TinderboxPrint: I/O read bytes / time
454,656 / 60 04:23:41 INFO - TinderboxPrint: I/O write bytes / time
321,994,752 / 193,696 04:23:41 INFO - TinderboxPrint: CPU idle
8,205.8 (86.9%) 04:23:41 INFO - TinderboxPrint: CPU user
1,185.0 (12.6%) 04:23:41 INFO - TinderboxPrint: Swap in / out
0 / 0 04:23:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12828672; Read time: 0; Write time: 2340 04:23:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:23:41 INFO - run-tests - Wall time: 1167s; CPU: 13.0%; Read bytes: 454656; Write bytes: 308551680; Read time: 60; Write time: 191356 04:23:41 INFO - Running post-run listener: _upload_blobber_files 04:23:41 INFO - Blob upload gear active. 04:23:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:23:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:23:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:23:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:23:42 INFO - (blobuploader) - INFO - Open directory for files ... 04:23:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 04:23:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 04:23:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:43 INFO - (blobuploader) - INFO - Done attempting. 04:23:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 04:23:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 04:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:44 INFO - (blobuploader) - INFO - Done attempting. 04:23:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:23:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:23:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:51 INFO - (blobuploader) - INFO - Done attempting. 04:23:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:23:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:23:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:23:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:23:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:23:52 INFO - (blobuploader) - INFO - Done attempting. 04:23:52 INFO - (blobuploader) - INFO - Iteration through files over. 04:23:52 INFO - Return code: 0 04:23:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:23:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:23:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e74f1bd9fb864885f24994ee330470e367f5434136b84140e7ce76b7011622f41677dc30154e933004d963647db03e6df218b5da6161bd62a60c9c3eef8d4a78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013c53ece4c1303e4f9ac97cc295016a91333683e1d8ee8e5e17a1bbc83ace9aa0236bf8379b7a907e20df86e52f8f8d0ba79d2ad76e32d1f11a1d4d662897df", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb540873bcc0b1bfbfd8c45c75827c6d039ec180d13cd5f48fbf6f93ad4e1c08c37bf48d2c3f03b1b4f3c7edc165cf7bc4e50c5b6d01322b4d7360ad532c7ab8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44916b33d2691adf2ebf22cd0339d79cab6e64391adad561df75ffdd53b4632af9cc4ed21494f417251b7811664eb327eebb33d69ed59f0c1d1abc79ecf3ad15"} 04:23:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:23:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:23:52 INFO - Contents: 04:23:52 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e74f1bd9fb864885f24994ee330470e367f5434136b84140e7ce76b7011622f41677dc30154e933004d963647db03e6df218b5da6161bd62a60c9c3eef8d4a78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013c53ece4c1303e4f9ac97cc295016a91333683e1d8ee8e5e17a1bbc83ace9aa0236bf8379b7a907e20df86e52f8f8d0ba79d2ad76e32d1f11a1d4d662897df", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb540873bcc0b1bfbfd8c45c75827c6d039ec180d13cd5f48fbf6f93ad4e1c08c37bf48d2c3f03b1b4f3c7edc165cf7bc4e50c5b6d01322b4d7360ad532c7ab8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44916b33d2691adf2ebf22cd0339d79cab6e64391adad561df75ffdd53b4632af9cc4ed21494f417251b7811664eb327eebb33d69ed59f0c1d1abc79ecf3ad15"} 04:23:52 INFO - Running post-run listener: copy_logs_to_upload_dir 04:23:52 INFO - Copying logs to upload dir... 04:23:52 INFO - mkdir: /builds/slave/test/build/upload/logs 04:23:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.503236 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-28 04:23:52.233651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 04:23:52.238360) ========= 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=232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474 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/sha512/e74f1bd9fb864885f24994ee330470e367f5434136b84140e7ce76b7011622f41677dc30154e933004d963647db03e6df218b5da6161bd62a60c9c3eef8d4a78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013c53ece4c1303e4f9ac97cc295016a91333683e1d8ee8e5e17a1bbc83ace9aa0236bf8379b7a907e20df86e52f8f8d0ba79d2ad76e32d1f11a1d4d662897df", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb540873bcc0b1bfbfd8c45c75827c6d039ec180d13cd5f48fbf6f93ad4e1c08c37bf48d2c3f03b1b4f3c7edc165cf7bc4e50c5b6d01322b4d7360ad532c7ab8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44916b33d2691adf2ebf22cd0339d79cab6e64391adad561df75ffdd53b4632af9cc4ed21494f417251b7811664eb327eebb33d69ed59f0c1d1abc79ecf3ad15"} build_url:https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/Z4ZwPVwgTtW5UJmF2XNdLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e74f1bd9fb864885f24994ee330470e367f5434136b84140e7ce76b7011622f41677dc30154e933004d963647db03e6df218b5da6161bd62a60c9c3eef8d4a78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/013c53ece4c1303e4f9ac97cc295016a91333683e1d8ee8e5e17a1bbc83ace9aa0236bf8379b7a907e20df86e52f8f8d0ba79d2ad76e32d1f11a1d4d662897df", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb540873bcc0b1bfbfd8c45c75827c6d039ec180d13cd5f48fbf6f93ad4e1c08c37bf48d2c3f03b1b4f3c7edc165cf7bc4e50c5b6d01322b4d7360ad532c7ab8", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44916b33d2691adf2ebf22cd0339d79cab6e64391adad561df75ffdd53b4632af9cc4ed21494f417251b7811664eb327eebb33d69ed59f0c1d1abc79ecf3ad15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-28 04:23:52.268102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 04:23:52.268432) ========= 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=232498196343f89f466a4a9a000001c8-1506596595.215609-1421829474 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-28 04:23:52.351897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 04:23:52.354781) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-28 04:23:52.355119) ========= ========= Total master_lag: 0.22 =========