builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-081 starttime: 1505816611.54 results: success (0) revision: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.540192) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.540640) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.540948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.615178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.615447) ========= 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=483e410453545d07cca6935c000001ab-1505816471.235603-1652916788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-19 03:23:31-- 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% 226M=0s 2017-09-19 03:23:31 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121395 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.763461) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.763793) ========= 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=483e410453545d07cca6935c000001ab-1505816471.235603-1652916788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.814024) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:31.814402) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7c12af6fd620adc74e9dfb622d17966bdebdf2ac --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 7c12af6fd620adc74e9dfb622d17966bdebdf2ac --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=483e410453545d07cca6935c000001ab-1505816471.235603-1652916788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-19 03:23:31,864 truncating revision to first 12 chars 2017-09-19 03:23:31,864 Setting DEBUG logging. 2017-09-19 03:23:31,864 attempt 1/10 2017-09-19 03:23:31,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7c12af6fd620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-19 03:23:32,211 unpacking tar archive at: mozilla-central-7c12af6fd620/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641680 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:32.471982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:32.472285) ========= script_repo_revision: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:32.472659) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:32.472919) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-19 03:23:32.486358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-19 03:23:32.486755) ========= /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=483e410453545d07cca6935c000001ab-1505816471.235603-1652916788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:23:32 INFO - MultiFileLogger online at 20170919 03:23:32 in /builds/slave/test 03:23:32 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 03:23:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:23:32 INFO - {'append_to_log': False, 03:23:32 INFO - 'base_work_dir': '/builds/slave/test', 03:23:32 INFO - 'blob_upload_branch': 'Firefox', 03:23:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:23:32 INFO - 'branch': 'Firefox', 03:23:32 INFO - 'buildbot_json_path': 'buildprops.json', 03:23:32 INFO - 'code_coverage': False, 03:23:32 INFO - 'config_files': ('talos/linux_config.py',), 03:23:32 INFO - 'default_actions': ('clobber', 03:23:32 INFO - 'read-buildbot-config', 03:23:32 INFO - 'download-and-extract', 03:23:32 INFO - 'populate-webroot', 03:23:32 INFO - 'create-virtualenv', 03:23:32 INFO - 'install', 03:23:32 INFO - 'setup-mitmproxy', 03:23:32 INFO - 'run-tests'), 03:23:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:23:32 INFO - 'disable_ccov_upload': False, 03:23:32 INFO - 'disable_stylo': False, 03:23:32 INFO - 'download_minidump_stackwalk': True, 03:23:32 INFO - 'download_symbols': 'ondemand', 03:23:32 INFO - 'enable_stylo': False, 03:23:32 INFO - 'enable_webrender': False, 03:23:32 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:23:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:23:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:23:32 INFO - 'gecko_profile': False, 03:23:32 INFO - 'gecko_profile_interval': 0, 03:23:32 INFO - 'installer_path': 'installer.exe', 03:23:32 INFO - 'log_level': 'info', 03:23:32 INFO - 'log_name': 'talos', 03:23:32 INFO - 'log_to_console': True, 03:23:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:23:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:23:32 INFO - 'opt_config_files': (), 03:23:32 INFO - 'pip_index': False, 03:23:32 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 03:23:32 INFO - 'system_bits': '32', 03:23:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:23:32 INFO - 'title': 'talos-linux64-ix-081', 03:23:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:23:32 INFO - 'use_talos_json': True, 03:23:32 INFO - 'verify': 'False', 03:23:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:23:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:23:32 INFO - 'work_dir': 'build'} 03:23:32 INFO - [mozharness: 2017-09-19 10:23:32.676172Z] Running clobber step. 03:23:32 INFO - Running pre-action listener: _resource_record_pre_action 03:23:32 INFO - Running main action method: clobber 03:23:32 INFO - rmtree: /builds/slave/test/build 03:23:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:23:33 INFO - Running post-action listener: _resource_record_post_action 03:23:33 INFO - [mozharness: 2017-09-19 10:23:33.669842Z] Finished clobber step (success) 03:23:33 INFO - [mozharness: 2017-09-19 10:23:33.669938Z] Running read-buildbot-config step. 03:23:33 INFO - Running pre-action listener: _resource_record_pre_action 03:23:33 INFO - Running main action method: read_buildbot_config 03:23:33 INFO - Using buildbot properties: 03:23:33 INFO - { 03:23:33 INFO - "project": "", 03:23:33 INFO - "product": "firefox", 03:23:33 INFO - "who": "archaeopteryx@coole-files.de", 03:23:33 INFO - "installer_path": "public/build/target.tar.bz2", 03:23:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 03:23:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:23:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 03:23:33 INFO - "stage_platform": "linux64-pgo", 03:23:33 INFO - "basedir": "/builds/slave/test", 03:23:33 INFO - "buildnumber": 29, 03:23:33 INFO - "platform": "ubuntu64_hw", 03:23:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:23:33 INFO - "slavebuilddir": "test", 03:23:33 INFO - "taskId": "Zv61L9bbT7Gtz1k7HN3jUg", 03:23:33 INFO - "branch": "mozilla-central", 03:23:33 INFO - "script_repo_revision": "production", 03:23:33 INFO - "revision": "7c12af6fd620adc74e9dfb622d17966bdebdf2ac", 03:23:33 INFO - "slavename": "talos-linux64-ix-081", 03:23:33 INFO - "repo_path": "mozilla-central" 03:23:33 INFO - } 03:23:33 INFO - Finding installer, test and symbols from parent task. 03:23:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv61L9bbT7Gtz1k7HN3jUg'}, attempt #1 03:23:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zv61L9bbT7Gtz1k7HN3jUg'}, attempt #1 03:23:34 INFO - Task dependencies: XOvwxOU7QG2Ewekbfzv2aw 03:23:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw'}, attempt #1 03:23:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2 03:23:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.test_packages.json 03:23:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.crashreporter-symbols.zip 03:23:34 INFO - Running post-action listener: _resource_record_post_action 03:23:34 INFO - [mozharness: 2017-09-19 10:23:34.987310Z] Finished read-buildbot-config step (success) 03:23:34 INFO - [mozharness: 2017-09-19 10:23:34.987524Z] Running download-and-extract step. 03:23:34 INFO - Running pre-action listener: _resource_record_pre_action 03:23:34 INFO - Running main action method: download_and_extract 03:23:34 INFO - mkdir: /builds/slave/test/build/tests 03:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:34 INFO - trying https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.test_packages.json 03:23:34 INFO - Downloading https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:23:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:23:35 INFO - Downloaded 989 bytes. 03:23:35 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:23:35 INFO - Using the following test package requirements: 03:23:35 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:23:35 INFO - u'common': [u'target.common.tests.zip'], 03:23:35 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:23:35 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:23:35 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:23:35 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:23:35 INFO - u'mozbase': [u'target.common.tests.zip'], 03:23:35 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:23:35 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:23:35 INFO - u'web-platform': [u'target.common.tests.zip', 03:23:35 INFO - u'target.web-platform.tests.tar.gz'], 03:23:35 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:23:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 03:23:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.common.tests.zip 03:23:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:23:35 INFO - Fetch https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.common.tests.zip into memory 03:23:36 INFO - Content-Length response header: 55320083 03:23:36 INFO - Bytes received: 55320083 03:23:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.talos.tests.zip 03:23:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:23:47 INFO - Fetch https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.talos.tests.zip into memory 03:23:48 INFO - Content-Length response header: 14508787 03:23:48 INFO - Bytes received: 14508787 03:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:49 INFO - trying https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2 03:23:49 INFO - Downloading https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:23:51 INFO - Downloaded 62371838 bytes. 03:23:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2 03:23:51 INFO - mkdir: /builds/slave/test/properties 03:23:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:51 INFO - Contents: 03:23:51 INFO - build_url:https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2 03:23:51 INFO - Running post-action listener: _resource_record_post_action 03:23:51 INFO - Running post-action listener: find_tests_for_verification 03:23:51 INFO - Running post-action listener: set_extra_try_arguments 03:23:51 INFO - [mozharness: 2017-09-19 10:23:51.686340Z] Finished download-and-extract step (success) 03:23:51 INFO - [mozharness: 2017-09-19 10:23:51.686435Z] Running populate-webroot step. 03:23:51 INFO - Running pre-action listener: _resource_record_pre_action 03:23:51 INFO - Running main action method: populate_webroot 03:23:51 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:51 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['tresize', 03:23:51 INFO - 'tcanvasmark']}, 03:23:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:51 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['dromaeo_css', 03:23:51 INFO - 'kraken']}, 03:23:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:51 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'tests': ['damp', 'tps']}, 03:23:51 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['damp', 'tps']}, 03:23:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:51 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['dromaeo_dom']}, 03:23:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:23:51 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['basic_compositor_video', 03:23:51 INFO - 'glvideo']}, 03:23:51 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:23:51 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['ts_paint_webext', 03:23:51 INFO - 'tp5o_webext']}, 03:23:51 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:51 INFO - 'ts_paint', 03:23:51 INFO - 'tpaint', 03:23:51 INFO - 'sessionrestore', 03:23:51 INFO - 'sessionrestore_many_windows', 03:23:51 INFO - 'sessionrestore_no_auto_restore', 03:23:51 INFO - 'tabpaint']}, 03:23:51 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['a11yr', 03:23:51 INFO - 'ts_paint', 03:23:51 INFO - 'tpaint', 03:23:51 INFO - 'sessionrestore', 03:23:51 INFO - 'sessionrestore_many_windows', 03:23:51 INFO - 'sessionrestore_no_auto_restore', 03:23:51 INFO - 'tabpaint']}, 03:23:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:23:51 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 03:23:51 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['perf_reftest_singletons']}, 03:23:51 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['bloom_basic']}, 03:23:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:51 INFO - 'tsvgr_opacity', 03:23:51 INFO - 'tart', 03:23:51 INFO - 'tscrollx', 03:23:51 INFO - 'tsvg_static']}, 03:23:51 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['tsvgx', 03:23:51 INFO - 'tsvgr_opacity', 03:23:51 INFO - 'tart', 03:23:51 INFO - 'tscrollx', 03:23:51 INFO - 'tsvg_static']}, 03:23:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:23:51 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'talos_options': ['--disable-stylo'], 03:23:51 INFO - 'tests': ['tp5o']}, 03:23:51 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:51 INFO - 'talos_options': ['--mitmproxy', 03:23:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:51 INFO - '--firstNonBlankPaint'], 03:23:51 INFO - 'tests': ['tp6_google', 03:23:51 INFO - 'tp6_youtube', 03:23:51 INFO - 'tp6_amazon', 03:23:51 INFO - 'tp6_facebook']}, 03:23:51 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:51 INFO - 'talos_options': ['--disable-stylo', 03:23:51 INFO - '--mitmproxy', 03:23:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:51 INFO - '--firstNonBlankPaint'], 03:23:51 INFO - 'tests': ['tp6_google', 03:23:51 INFO - 'tp6_youtube', 03:23:51 INFO - 'tp6_amazon', 03:23:51 INFO - 'tp6_facebook']}, 03:23:51 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:23:51 INFO - 'talos_options': ['--stylo-threads=1', 03:23:51 INFO - '--mitmproxy', 03:23:51 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:23:51 INFO - '--firstNonBlankPaint'], 03:23:51 INFO - 'tests': ['tp6_google', 03:23:51 INFO - 'tp6_youtube', 03:23:51 INFO - 'tp6_amazon', 03:23:51 INFO - 'tp6_facebook']}, 03:23:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'talos_options': ['--xperf_path', 03:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:51 INFO - 'tests': ['tp5n']}, 03:23:51 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:23:51 INFO - 'talos_options': ['--disable-stylo', 03:23:51 INFO - '--xperf_path', 03:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:51 INFO - 'tests': ['tp5n']}}} 03:23:51 INFO - Running post-action listener: _resource_record_post_action 03:23:51 INFO - [mozharness: 2017-09-19 10:23:51.705795Z] Finished populate-webroot step (success) 03:23:51 INFO - [mozharness: 2017-09-19 10:23:51.705884Z] Running create-virtualenv step. 03:23:51 INFO - Running pre-action listener: _resource_record_pre_action 03:23:51 INFO - Running main action method: create_virtualenv 03:23:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:51 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:23:51 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:23:51 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:23:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:52 INFO - Installing pip...............done. 03:23:52 INFO - Return code: 0 03:23:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:23:52 INFO - Reading from file tmpfile_stdout 03:23:52 INFO - Output received: 03:23:52 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:23:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:52 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:23:52 INFO - Using env: {'DISPLAY': ':0', 03:23:52 INFO - 'HOME': '/home/cltbld', 03:23:52 INFO - 'LANG': 'en_US.UTF-8', 03:23:52 INFO - 'LANGUAGE': 'en_US:en', 03:23:52 INFO - 'LOGNAME': 'cltbld', 03:23:52 INFO - 'MAIL': '/var/mail/cltbld', 03:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:52 INFO - 'MOZ_NO_REMOTE': '1', 03:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:52 INFO - 'NO_EM_RESTART': '1', 03:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:52 INFO - 'PWD': '/builds/slave/test', 03:23:52 INFO - 'SHELL': '/bin/bash', 03:23:52 INFO - 'SHLVL': '1', 03:23:52 INFO - 'TERM': 'linux', 03:23:52 INFO - 'TMOUT': '86400', 03:23:52 INFO - 'USER': 'cltbld', 03:23:52 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:52 INFO - '_': '/tools/buildbot/bin/python'} 03:23:53 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:23:53 INFO - Downloading/unpacking pip>=1.5 03:23:53 INFO - Running setup.py egg_info for package pip 03:23:53 INFO - warning: no files found matching 'pip/cacert.pem' 03:23:53 INFO - warning: no files found matching '*.html' under directory 'docs' 03:23:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:23:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:23:53 INFO - Installing collected packages: pip 03:23:53 INFO - Found existing installation: pip 1.1 03:23:53 INFO - Uninstalling pip: 03:23:53 INFO - Successfully uninstalled pip 03:23:53 INFO - Running setup.py install for pip 03:23:53 INFO - warning: no files found matching 'pip/cacert.pem' 03:23:53 INFO - warning: no files found matching '*.html' under directory 'docs' 03:23:53 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:23:53 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:23:53 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:23:53 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:23:53 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:23:53 INFO - Successfully installed pip 03:23:53 INFO - Cleaning up... 03:23:53 INFO - Return code: 0 03:23:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:53 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:23:53 INFO - Using env: {'DISPLAY': ':0', 03:23:53 INFO - 'HOME': '/home/cltbld', 03:23:53 INFO - 'LANG': 'en_US.UTF-8', 03:23:53 INFO - 'LANGUAGE': 'en_US:en', 03:23:53 INFO - 'LOGNAME': 'cltbld', 03:23:53 INFO - 'MAIL': '/var/mail/cltbld', 03:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:53 INFO - 'MOZ_NO_REMOTE': '1', 03:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:53 INFO - 'NO_EM_RESTART': '1', 03:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:53 INFO - 'PWD': '/builds/slave/test', 03:23:53 INFO - 'SHELL': '/bin/bash', 03:23:53 INFO - 'SHLVL': '1', 03:23:53 INFO - 'TERM': 'linux', 03:23:53 INFO - 'TMOUT': '86400', 03:23:53 INFO - 'USER': 'cltbld', 03:23:53 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:53 INFO - '_': '/tools/buildbot/bin/python'} 03:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:54 INFO - Downloading/unpacking psutil>=3.1.1 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:55 INFO - Installing collected packages: psutil 03:23:55 INFO - Running setup.py install for psutil 03:23:55 INFO - building 'psutil._psutil_linux' extension 03:23:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:23:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:23:55 INFO - building 'psutil._psutil_posix' extension 03:23:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:23:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:23:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:55 INFO - Successfully installed psutil 03:23:55 INFO - Cleaning up... 03:23:55 INFO - Return code: 0 03:23:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:23: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 mozsystemmonitor==0.3 03:23:55 INFO - Using env: {'DISPLAY': ':0', 03:23:55 INFO - 'HOME': '/home/cltbld', 03:23:55 INFO - 'LANG': 'en_US.UTF-8', 03:23:55 INFO - 'LANGUAGE': 'en_US:en', 03:23:55 INFO - 'LOGNAME': 'cltbld', 03:23:55 INFO - 'MAIL': '/var/mail/cltbld', 03:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:55 INFO - 'MOZ_NO_REMOTE': '1', 03:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:55 INFO - 'NO_EM_RESTART': '1', 03:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:55 INFO - 'PWD': '/builds/slave/test', 03:23:55 INFO - 'SHELL': '/bin/bash', 03:23:55 INFO - 'SHLVL': '1', 03:23:55 INFO - 'TERM': 'linux', 03:23:55 INFO - 'TMOUT': '86400', 03:23:55 INFO - 'USER': 'cltbld', 03:23:55 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:55 INFO - '_': '/tools/buildbot/bin/python'} 03:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:57 INFO - Installing collected packages: mozsystemmonitor 03:23:57 INFO - Running setup.py install for mozsystemmonitor 03:23:57 INFO - Successfully installed mozsystemmonitor 03:23:57 INFO - Cleaning up... 03:23:57 INFO - Return code: 0 03:23:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:57 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:23:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:23:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:23:57 INFO - Using env: {'DISPLAY': ':0', 03:23:58 INFO - 'HOME': '/home/cltbld', 03:23:58 INFO - 'LANG': 'en_US.UTF-8', 03:23:58 INFO - 'LANGUAGE': 'en_US:en', 03:23:58 INFO - 'LOGNAME': 'cltbld', 03:23:58 INFO - 'MAIL': '/var/mail/cltbld', 03:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:58 INFO - 'MOZ_NO_REMOTE': '1', 03:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:58 INFO - 'NO_EM_RESTART': '1', 03:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:58 INFO - 'PWD': '/builds/slave/test', 03:23:58 INFO - 'SHELL': '/bin/bash', 03:23:58 INFO - 'SHLVL': '1', 03:23:58 INFO - 'TERM': 'linux', 03:23:58 INFO - 'TMOUT': '86400', 03:23:58 INFO - 'USER': 'cltbld', 03:23:58 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:58 INFO - '_': '/tools/buildbot/bin/python'} 03:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:58 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:59 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:59 INFO - warning: no files found matching '*.txt' 03:23:59 INFO - no previously-included directories found matching 'build' 03:23:59 INFO - no previously-included directories found matching 'dist' 03:23:59 INFO - no previously-included directories found matching '.git*' 03:23:59 INFO - Installing collected packages: jsonschema, functools32 03:24:00 INFO - Running setup.py install for functools32 03:24:00 INFO - warning: no files found matching '*.txt' 03:24:00 INFO - no previously-included directories found matching 'build' 03:24:00 INFO - no previously-included directories found matching 'dist' 03:24:00 INFO - no previously-included directories found matching '.git*' 03:24:00 INFO - Successfully installed jsonschema functools32 03:24:00 INFO - Cleaning up... 03:24:00 INFO - Return code: 0 03:24:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:00 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:24:00 INFO - Using env: {'DISPLAY': ':0', 03:24:00 INFO - 'HOME': '/home/cltbld', 03:24:00 INFO - 'LANG': 'en_US.UTF-8', 03:24:00 INFO - 'LANGUAGE': 'en_US:en', 03:24:00 INFO - 'LOGNAME': 'cltbld', 03:24:00 INFO - 'MAIL': '/var/mail/cltbld', 03:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:00 INFO - 'MOZ_NO_REMOTE': '1', 03:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:00 INFO - 'NO_EM_RESTART': '1', 03:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:00 INFO - 'PWD': '/builds/slave/test', 03:24:00 INFO - 'SHELL': '/bin/bash', 03:24:00 INFO - 'SHLVL': '1', 03:24:00 INFO - 'TERM': 'linux', 03:24:00 INFO - 'TMOUT': '86400', 03:24:00 INFO - 'USER': 'cltbld', 03:24:00 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:00 INFO - '_': '/tools/buildbot/bin/python'} 03:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:24:00 INFO - Cleaning up... 03:24:00 INFO - Return code: 0 03:24:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:00 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:24:00 INFO - Using env: {'DISPLAY': ':0', 03:24:00 INFO - 'HOME': '/home/cltbld', 03:24:00 INFO - 'LANG': 'en_US.UTF-8', 03:24:00 INFO - 'LANGUAGE': 'en_US:en', 03:24:00 INFO - 'LOGNAME': 'cltbld', 03:24:00 INFO - 'MAIL': '/var/mail/cltbld', 03:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:00 INFO - 'MOZ_NO_REMOTE': '1', 03:24:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:00 INFO - 'NO_EM_RESTART': '1', 03:24:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:00 INFO - 'PWD': '/builds/slave/test', 03:24:00 INFO - 'SHELL': '/bin/bash', 03:24:00 INFO - 'SHLVL': '1', 03:24:00 INFO - 'TERM': 'linux', 03:24:00 INFO - 'TMOUT': '86400', 03:24:00 INFO - 'USER': 'cltbld', 03:24:00 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:00 INFO - '_': '/tools/buildbot/bin/python'} 03:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:00 INFO - Downloading/unpacking blobuploader==1.2.4 03:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:24:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:24:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:02 INFO - Downloading docopt-0.6.1.tar.gz 03:24:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:24:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:24:02 INFO - Running setup.py install for blobuploader 03:24:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:24:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:24:02 INFO - Running setup.py install for requests 03:24:02 INFO - Running setup.py install for docopt 03:24:02 INFO - Successfully installed blobuploader requests docopt 03:24:02 INFO - Cleaning up... 03:24:02 INFO - Return code: 0 03:24:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:02 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:24:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:03 INFO - Using env: {'DISPLAY': ':0', 03:24:03 INFO - 'HOME': '/home/cltbld', 03:24:03 INFO - 'LANG': 'en_US.UTF-8', 03:24:03 INFO - 'LANGUAGE': 'en_US:en', 03:24:03 INFO - 'LOGNAME': 'cltbld', 03:24:03 INFO - 'MAIL': '/var/mail/cltbld', 03:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:03 INFO - 'MOZ_NO_REMOTE': '1', 03:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:03 INFO - 'NO_EM_RESTART': '1', 03:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:03 INFO - 'PWD': '/builds/slave/test', 03:24:03 INFO - 'SHELL': '/bin/bash', 03:24:03 INFO - 'SHLVL': '1', 03:24:03 INFO - 'TERM': 'linux', 03:24:03 INFO - 'TMOUT': '86400', 03:24:03 INFO - 'USER': 'cltbld', 03:24:03 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:03 INFO - '_': '/tools/buildbot/bin/python'} 03:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:03 INFO - Running setup.py (path:/tmp/pip-pCE6OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:03 INFO - Running setup.py (path:/tmp/pip-GN7O0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:03 INFO - Running setup.py (path:/tmp/pip-k2Ba4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:03 INFO - Running setup.py (path:/tmp/pip-FAOf99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:03 INFO - Running setup.py (path:/tmp/pip-KUYAeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:03 INFO - Running setup.py (path:/tmp/pip-NYFB3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:03 INFO - Running setup.py (path:/tmp/pip-hwRgL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:03 INFO - Running setup.py (path:/tmp/pip-QSBlBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:03 INFO - Running setup.py (path:/tmp/pip-PmkxmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:03 INFO - Running setup.py (path:/tmp/pip-RcXVOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:03 INFO - Running setup.py (path:/tmp/pip-WrDmoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:03 INFO - Running setup.py (path:/tmp/pip-ZGsWRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:04 INFO - Running setup.py (path:/tmp/pip-oxatyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:04 INFO - Running setup.py (path:/tmp/pip-Wb9Wg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:04 INFO - Running setup.py (path:/tmp/pip-6vG3jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:04 INFO - Running setup.py (path:/tmp/pip-OFuSMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:04 INFO - Running setup.py (path:/tmp/pip-18aICO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:24:04 INFO - Running setup.py install for manifestparser 03:24:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:24:04 INFO - Running setup.py install for mozcrash 03:24:04 INFO - Running setup.py install for mozdebug 03:24:04 INFO - Running setup.py install for mozdevice 03:24:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:24:04 INFO - Running setup.py install for mozfile 03:24:04 INFO - Running setup.py install for mozhttpd 03:24:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:24:04 INFO - Running setup.py install for mozinfo 03:24:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Running setup.py install for mozInstall 03:24:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Running setup.py install for mozleak 03:24:05 INFO - Running setup.py install for mozlog 03:24:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Running setup.py install for moznetwork 03:24:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Running setup.py install for mozprocess 03:24:05 INFO - Running setup.py install for mozprofile 03:24:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Running setup.py install for mozrunner 03:24:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:24:05 INFO - Running setup.py install for mozscreenshot 03:24:05 INFO - Running setup.py install for moztest 03:24:06 INFO - Running setup.py install for mozversion 03:24:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:24:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:24:06 INFO - Cleaning up... 03:24:06 INFO - Return code: 0 03:24:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:06 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:06 INFO - Using env: {'DISPLAY': ':0', 03:24:06 INFO - 'HOME': '/home/cltbld', 03:24:06 INFO - 'LANG': 'en_US.UTF-8', 03:24:06 INFO - 'LANGUAGE': 'en_US:en', 03:24:06 INFO - 'LOGNAME': 'cltbld', 03:24:06 INFO - 'MAIL': '/var/mail/cltbld', 03:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:06 INFO - 'MOZ_NO_REMOTE': '1', 03:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:06 INFO - 'NO_EM_RESTART': '1', 03:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:06 INFO - 'PWD': '/builds/slave/test', 03:24:06 INFO - 'SHELL': '/bin/bash', 03:24:06 INFO - 'SHLVL': '1', 03:24:06 INFO - 'TERM': 'linux', 03:24:06 INFO - 'TMOUT': '86400', 03:24:06 INFO - 'USER': 'cltbld', 03:24:06 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:06 INFO - '_': '/tools/buildbot/bin/python'} 03:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:24:06 INFO - Running setup.py (path:/tmp/pip-kX9BpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:24:06 INFO - Running setup.py (path:/tmp/pip-RifniQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:24:06 INFO - Running setup.py (path:/tmp/pip-P27xKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:24:06 INFO - Running setup.py (path:/tmp/pip-QA709K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:24:06 INFO - Running setup.py (path:/tmp/pip-kYdtRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:24:06 INFO - Running setup.py (path:/tmp/pip-i9fw2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:24:06 INFO - Running setup.py (path:/tmp/pip-VrJwM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:24:06 INFO - Running setup.py (path:/tmp/pip-XUXqhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:24:06 INFO - Running setup.py (path:/tmp/pip-BGytts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:24:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:24:07 INFO - Running setup.py (path:/tmp/pip-5RXETC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:24:07 INFO - Running setup.py (path:/tmp/pip-BFHUOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:24:07 INFO - Running setup.py (path:/tmp/pip-xYwc4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:24:07 INFO - Running setup.py (path:/tmp/pip-ryl02E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:24:07 INFO - Running setup.py (path:/tmp/pip-KfIlvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:07 INFO - Running setup.py (path:/tmp/pip-43qZYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:24:07 INFO - Running setup.py (path:/tmp/pip-Q30Q4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:24:07 INFO - Running setup.py (path:/tmp/pip-jEYiQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:24:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:08 INFO - Downloading blessings-1.6.tar.gz 03:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:24:08 INFO - Installing collected packages: blessings 03:24:08 INFO - Running setup.py install for blessings 03:24:08 INFO - Successfully installed blessings 03:24:08 INFO - Cleaning up... 03:24:08 INFO - Return code: 0 03:24:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:09 INFO - Reading from file tmpfile_stdout 03:24:09 INFO - Current package versions: 03:24:09 INFO - argparse == 1.2.1 03:24:09 INFO - blessings == 1.6 03:24:09 INFO - blobuploader == 1.2.4 03:24:09 INFO - docopt == 0.6.1 03:24:09 INFO - functools32 == 3.2.3-2 03:24:09 INFO - jsonschema == 2.5.1 03:24:09 INFO - manifestparser == 1.1 03:24:09 INFO - mozInstall == 1.13 03:24:09 INFO - mozcrash == 1.0 03:24:09 INFO - mozdebug == 0.1 03:24:09 INFO - mozdevice == 0.51 03:24:09 INFO - mozfile == 1.2 03:24:09 INFO - mozhttpd == 0.7 03:24:09 INFO - mozinfo == 0.10 03:24:09 INFO - mozleak == 0.1 03:24:09 INFO - mozlog == 3.5 03:24:09 INFO - moznetwork == 0.27 03:24:09 INFO - mozprocess == 0.25 03:24:09 INFO - mozprofile == 0.28 03:24:09 INFO - mozrunner == 6.13 03:24:09 INFO - mozscreenshot == 0.1 03:24:09 INFO - mozsystemmonitor == 0.3 03:24:09 INFO - moztest == 0.8 03:24:09 INFO - mozversion == 1.4 03:24:09 INFO - psutil == 3.1.1 03:24:09 INFO - requests == 1.2.3 03:24:09 INFO - wsgiref == 0.1.2 03:24:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:09 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:24:09 INFO - Using env: {'DISPLAY': ':0', 03:24:09 INFO - 'HOME': '/home/cltbld', 03:24:09 INFO - 'LANG': 'en_US.UTF-8', 03:24:09 INFO - 'LANGUAGE': 'en_US:en', 03:24:09 INFO - 'LOGNAME': 'cltbld', 03:24:09 INFO - 'MAIL': '/var/mail/cltbld', 03:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:09 INFO - 'MOZ_NO_REMOTE': '1', 03:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:09 INFO - 'NO_EM_RESTART': '1', 03:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:09 INFO - 'PWD': '/builds/slave/test', 03:24:09 INFO - 'SHELL': '/bin/bash', 03:24:09 INFO - 'SHLVL': '1', 03:24:09 INFO - 'TERM': 'linux', 03:24:09 INFO - 'TMOUT': '86400', 03:24:09 INFO - 'USER': 'cltbld', 03:24:09 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:09 INFO - '_': '/tools/buildbot/bin/python'} 03:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:24:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:24:10 INFO - Installing collected packages: simplejson 03:24:10 INFO - Running setup.py install for simplejson 03:24:10 INFO - building 'simplejson._speedups' extension 03:24:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:24:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:24:11 INFO - Successfully installed simplejson 03:24:11 INFO - Cleaning up... 03:24:11 INFO - Return code: 0 03:24:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:24:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:24:11 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 0xb681f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd31a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed4a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, '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': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:24:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:24:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:24:11 INFO - Using env: {'DISPLAY': ':0', 03:24:11 INFO - 'HOME': '/home/cltbld', 03:24:11 INFO - 'LANG': 'en_US.UTF-8', 03:24:11 INFO - 'LANGUAGE': 'en_US:en', 03:24:11 INFO - 'LOGNAME': 'cltbld', 03:24:11 INFO - 'MAIL': '/var/mail/cltbld', 03:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:11 INFO - 'MOZ_NO_REMOTE': '1', 03:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:11 INFO - 'NO_EM_RESTART': '1', 03:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:11 INFO - 'PWD': '/builds/slave/test', 03:24:11 INFO - 'SHELL': '/bin/bash', 03:24:11 INFO - 'SHLVL': '1', 03:24:11 INFO - 'TERM': 'linux', 03:24:11 INFO - 'TMOUT': '86400', 03:24:11 INFO - 'USER': 'cltbld', 03:24:11 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:11 INFO - '_': '/tools/buildbot/bin/python'} 03:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:24:11 INFO - Cleaning up... 03:24:11 INFO - Return code: 0 03:24:11 INFO - Running post-action listener: _resource_record_post_action 03:24:11 INFO - Running post-action listener: _start_resource_monitoring 03:24:12 INFO - Starting resource monitoring. 03:24:12 INFO - [mozharness: 2017-09-19 10:24:12.016741Z] Finished create-virtualenv step (success) 03:24:12 INFO - [mozharness: 2017-09-19 10:24:12.017251Z] Running install step. 03:24:12 INFO - Running pre-action listener: _resource_record_pre_action 03:24:12 INFO - Running main action method: install 03:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:24:12 INFO - Reading from file tmpfile_stdout 03:24:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:24:12 INFO - Reading from file tmpfile_stdout 03:24:12 INFO - Output received: 03:24:12 INFO - Usage: mozinstall [options] installer 03:24:12 INFO - Options: 03:24:12 INFO - -h, --help show this help message and exit 03:24:12 INFO - -d DEST, --destination=DEST 03:24:12 INFO - Directory to install application into. [default: 03:24:12 INFO - "/builds/slave/test"] 03:24:12 INFO - --app=APP Application being installed. [default: firefox] 03:24:12 INFO - mkdir: /builds/slave/test/build/application 03:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:24:29 INFO - Reading from file tmpfile_stdout 03:24:29 INFO - Output received: 03:24:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:24:29 INFO - Running post-action listener: _resource_record_post_action 03:24:29 INFO - [mozharness: 2017-09-19 10:24:29.980888Z] Finished install step (success) 03:24:29 INFO - [mozharness: 2017-09-19 10:24:29.981138Z] Running setup-mitmproxy step. 03:24:29 INFO - Running pre-action listener: _resource_record_pre_action 03:24:29 INFO - Running main action method: setup_mitmproxy 03:24:29 INFO - Skipping: mitmproxy is not required 03:24:29 INFO - Running post-action listener: _resource_record_post_action 03:24:29 INFO - [mozharness: 2017-09-19 10:24:29.982258Z] Finished setup-mitmproxy step (success) 03:24:29 INFO - [mozharness: 2017-09-19 10:24:29.982543Z] Running run-tests step. 03:24:29 INFO - Running pre-action listener: _resource_record_pre_action 03:24:29 INFO - Running pre-action listener: _set_gcov_prefix 03:24:29 INFO - Running main action method: run_tests 03:24:29 WARNING - Try message not found. 03:24:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:29 INFO - Python 2.7.3 03:24:29 INFO - Return code: 0 03:24:29 INFO - grabbing minidump binary from tooltool 03:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:29 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 0xed8090>, '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 0xed8d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xed2f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:29 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:24:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:24:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:30 INFO - Return code: 0 03:24:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:24:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:30 INFO - ENV: RUST_BACKTRACE is now full 03:24:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:24:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:30 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/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 03:24:30 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/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-081 --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 03:24:30 INFO - Using env: {'DISPLAY': ':0', 03:24:30 INFO - 'HOME': '/home/cltbld', 03:24:30 INFO - 'LANG': 'en_US.UTF-8', 03:24:30 INFO - 'LANGUAGE': 'en_US:en', 03:24:30 INFO - 'LOGNAME': 'cltbld', 03:24:30 INFO - 'MAIL': '/var/mail/cltbld', 03:24:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:30 INFO - 'MOZ_NO_REMOTE': '1', 03:24:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:30 INFO - 'NO_EM_RESTART': '1', 03:24:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:30 INFO - 'PWD': '/builds/slave/test', 03:24:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:30 INFO - 'RUST_BACKTRACE': 'full', 03:24:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:24:30 INFO - 'SHELL': '/bin/bash', 03:24:30 INFO - 'SHLVL': '1', 03:24:30 INFO - 'TERM': 'linux', 03:24:30 INFO - 'TMOUT': '86400', 03:24:30 INFO - 'USER': 'cltbld', 03:24:30 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:30 INFO - '_': '/tools/buildbot/bin/python'} 03:24:30 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/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-081', '--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 03:24:30 INFO - mozversion application_buildid: 20170919090857 03:24:30 INFO - mozversion application_changeset: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac 03:24:30 INFO - mozversion application_display_name: Nightly 03:24:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:30 INFO - mozversion application_name: Firefox 03:24:30 INFO - mozversion application_remotingname: firefox 03:24:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:24:30 INFO - mozversion application_vendor: Mozilla 03:24:30 INFO - mozversion application_version: 57.0a1 03:24:30 INFO - mozversion platform_buildid: 20170919090857 03:24:30 INFO - mozversion platform_changeset: 7c12af6fd620adc74e9dfb622d17966bdebdf2ac 03:24:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:24:30 INFO - mozversion platform_version: 57.0a1 03:24:30 INFO - using testdate: 1505816670 03:24:30 INFO - actual date: 1505816670 03:24:30 INFO - starting webserver on 'localhost:48795' 03:24:30 INFO - SUITE-START | Running 2 tests 03:24:30 INFO - TEST-START | dromaeo_css 03:24:30 INFO - Initialising browser for dromaeo_css test... 03:24:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48795/getInfo.html -profile /tmp/tmp7c3Ypi/profile 03:24:30 INFO - TEST-INFO | started process 21767 (/builds/slave/test/build/application/firefox/firefox http://localhost:48795/getInfo.html) 03:24:35 INFO - TEST-INFO | 21767: exit 0 03:24:36 INFO - Browser initialized. 03:24:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:36 INFO - Using env: {'DISPLAY': ':0', 03:24:36 INFO - 'HOME': '/home/cltbld', 03:24:36 INFO - 'JSGC_DISABLE_POISONING': '1', 03:24:36 INFO - 'LANG': 'en_US.UTF-8', 03:24:36 INFO - 'LANGUAGE': 'en_US:en', 03:24:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:24:36 INFO - 'LOGNAME': 'cltbld', 03:24:36 INFO - 'MAIL': '/var/mail/cltbld', 03:24:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:24:36 INFO - 'MOZ_CRASHREPORTER': '1', 03:24:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:24:36 INFO - 'MOZ_NO_REMOTE': '1', 03:24:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:24:36 INFO - 'NO_EM_RESTART': '1', 03:24:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:24:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:36 INFO - 'PWD': '/builds/slave/test', 03:24:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:36 INFO - 'RUST_BACKTRACE': 'full', 03:24:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:24:36 INFO - 'SHELL': '/bin/bash', 03:24:36 INFO - 'SHLVL': '1', 03:24:36 INFO - 'STYLO_FORCE_DISABLED': '1', 03:24:36 INFO - 'TERM': 'linux', 03:24:36 INFO - 'TMOUT': '86400', 03:24:36 INFO - 'USER': 'cltbld', 03:24:36 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:24:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:36 INFO - '_': '/tools/buildbot/bin/python'} 03:24:36 INFO - TEST-INFO | started process 22006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7c3Ypi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:36 INFO - PID 22006 | 03:24:36 INFO - PID 22006 | (/builds/slave/test/build/application/firefox/firefox:22055): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:24:36 INFO - PID 22006 | 03:24:47 INFO - PID 22006 | RSS: Main: 147275776 03:24:47 INFO - PID 22006 | 03:27:44 INFO - PID 22006 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48795/tests/dromaeo/cssquery-ext.html) 03:27:45 INFO - PID 22006 | RSS: Main: 148205568 03:27:45 INFO - PID 22006 | 03:30:47 INFO - PID 22006 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-ext.html (next: http://localhost:48795/tests/dromaeo/cssquery-jquery.html) 03:30:48 INFO - PID 22006 | RSS: Main: 148267008 03:30:48 INFO - PID 22006 | 03:33:49 INFO - PID 22006 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48795/tests/dromaeo/cssquery-mootools.html) 03:33:50 INFO - PID 22006 | RSS: Main: 150204416 03:33:50 INFO - PID 22006 | 03:36:52 INFO - PID 22006 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48795/tests/dromaeo/cssquery-prototype.html) 03:36:52 INFO - PID 22006 | RSS: Main: 149024768 03:36:52 INFO - PID 22006 | 03:39:55 INFO - PID 22006 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48795/tests/dromaeo/cssquery-yui.html) 03:39:56 INFO - PID 22006 | RSS: Main: 150056960 03:39:56 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | Cycle 1(1): loaded http://localhost:48795/tests/dromaeo/cssquery-yui.html (next: http://localhost:48795/tests/dromaeo/cssquery-dojo.html) 03:42:57 INFO - PID 22006 | RSS: Main: 152231936 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | __start_tp_report 03:42:57 INFO - PID 22006 | _x_x_mozilla_page_load 03:42:57 INFO - PID 22006 | _x_x_mozilla_page_load_details 03:42:57 INFO - PID 22006 | |i|pagename|runs| 03:42:57 INFO - PID 22006 | |0;dojo.html;3843;3882.6311500407464;3891.708121890859;3922.784246866423;3927.430522574226;6123.050927106295;6219.222597175353;6246.281677607077;6271.247450305964;6395.744170233185;6200.131981522579;6240.687965601713;6247.687615619224;6262.436380725734;6273.466755325791;5615.691136987464;5623.690697011683;5637.661740295575;5664.745086471119;5681.914771278434;5714.285714285715;5738.254026976487;5741.3110426748635;5753.798617048405;5842.386549412315;5768.74040668171;5824.912626310609;5842.737076831531;5855.619384739978;5860.589758716891;5546.667199967975;5646.350669672958;5653.378128405872;5765.048766953448;5784.826455206329;5624.578156638268;5684.0905455127395;5725.3988331225455;5735.569832262555;5738.655680659173;6267.467265282411;6342.048692696087;6343.809685709436;6363.713632886531;6412.7114279857515;6700.061991321219;6759.662016899185;6781.6609169541325;6855.5886646801355;6864.897026544606;6734.865302693918;6909.827254318632;6935.618540980244;6945.270746571588;6952.895706564405;6322;6346.460550853183;6348.714307856158;6486.416222539994;6494.025896115573;7091.042709234187;7103.396211321992;7110.004599356094;7176.712931482786;7194.280571942869;6734.427573656196;6752.561083529555;6786.117804685359;6854.5201835872;6858.554193977376;6930.306969303029;6961.756338528228;6970;6986.336298051677;6989.790306290819;6828.385445309946;6832.726690932307;6917.89623155653;6918.8962165567555;6932.029515867783;6700.363465470772;6823.897641535381;6835.043093966849;6871.793846184622;6919.930800691928;4936.679115857458;4945.7774400152075;4946.0355230729665;4956.8760780980765;4961.08219979305;4521.909561808811;4563.931541026887;4584.541545845455;4616.538346165356;4636.933505293801;6345.904811427832;6351.2060992375955;6434;6444.967775161094;6461.289258181596;6608.570442921195;6835.453163746888;6853.554518956252;6937.445004399636;6948.270431604608;6219.782307619302;6309.684515774193;6326.841828954313;6338.714757835908;6344.397282258178;5522.30971128609;5579.191017302468;5595.188697638901;5604.355499117653;5610.971945140248;7014.614196219155;7096.361327480448;7175.784726458214;7189.96405017982;7217.133943926762;6727.159105111861;6736.225334086643;6807.863842723217;6817.01153332764;6826.556273842184;7067.434605231672;7161.785146445615;7191.496595238283;7211.819704507429;7222.6388680566815;6608.50436217276;6639.203295604559;6773.051772751917;6858.348456896587;6869.862602748017;6753.493487988322;6810.693518791765;6839.2476827547935;6903.930960690329;6906.723731050903;6579.374959379043;6697.330266973264;6703.195616526048;6704.128463299739;6723.327667233238;6605.2734199239;6631.403173714389;6684.866302674017;6701.32986701326;6708.027336036345;6518.967405162944;6545.770898018546;6607.504437167136;6631.602103873783;6661.966690166518;6661.3338666132995;6661.367170119025;6750.797476075725;6771.187457505131;6789.15135608049;6433.356664333529;6455.709493072729;6495.480361571157;6503.6097834130105;6563.540552161303 03:42:57 INFO - PID 22006 | |1;ext.html;961.4759955824076;988.4217732626415;989.2333441582772;990.5641517732192;990.7374545745374;40615;45010.54989450105;45019.324710129295;45043.54956450435;45102.548974510246;41737.7913110434;41898.37152442716;42025.78987105068;42072.15855682884;42082.368764468556;7668.501547399429;7788.14330423653;7793.376529877624;7803.18066603007;8312.418130730852;8389.286910612605;8471.957640211791;8518.27594654452;8538.70114545991;8541.35939804514;8407;8440.746777596682;8560.357973152008;8566.957165214197;8643.870341944876;8532.445391049561;8549;8569.057403685589;8570.314374849997;8573.828523429527;8327.292180164693;8383.16168383163;8391.244787969052;8402.621882015263;8406.747797566082;40820.79589602062;40932.181356372705;41269.793651031854;41281.587184128075;41293.1741365174;3668.523091998023;3708.388115960863;3709.610490898444;3714.888553343404;3717.8512859485586;33962.6603733962;33963;33976.15059623504;34011.319773604635;34024;5255.5795536357;5373.382061062989;5419.187121931703;5558.805441809517;5559.19391688207;220536;220882.89558552264;221644;221695;222727;47900.520994790306;52921.412357629335;52922.73538632282;52986;53017.2047419289;50655.24017139746;56670;57982.7100864493;57984.4201557979;57985;17163.656726865393;17246.568835778955;17256;17323.393681221096;17335.046572438383;14035.929820350833;14054.437822486985;14059.08615939981;14075.85924140766;14076.436942522389;15187.924060379628;15263.618409539627;15325.386984520494;15358.616034599225;15406;5831.708414579254;6015.30823955242;6067.423594758491;6101.298350689727;6239.937600624026;1100.3342977498658;1101.1961268274044;1104.4422566603814;1112.6161474291357;1114.6154576671036;25486.23541293764;25580.872095639403;25685.3578660535;25734.356641084123;25829.612555811676;1185.7806305833449;1209.8729633388368;1217.3183017510223;1228.0666693312967;1248.843894513186;13434.596962091153;13518.797218041736;13679.316034198251;13773.586792396043;13858.792118118236;269123;272220;272293;272497;273358;57361;57554.7122264386;57680;57721.42278577245;57837.71081144567;1484.5620541940154;1513.7805018272288;1527.9541613751605;1532.387045181914;1533.9539813805604;25191.606797354223;25233.243002709947;25395.238142855746;25557.744422555537;25715.228543143734;40735;40972.3854142194;41020;41028.1794364117;41126.79436602798;238614;239557;257024;258584;260140;37647.435288470144;38038.23923521459;41226.58773412227;41355.7932210337;41565.37651935284;52712.73643631911;53245.4675453256;53506.46493535015;53739.46260537345;53741.73129134329;38844;38849.80575097106;38924.80537597294;39039.6096039036;39574.60425395824;37871;37885.05287367838;38439;39268.21463570656;39306;45285;45459.31811022903;45576.088478230915;46069.07861842812;46106.07787844291;36096.63903361038;36178.8191059043;36812.815935920145;37286.44070339001;37584.624153758115;27383.726162738116;28493.430131397672;28561.571576425955;28748.856255719424;28942.85528572428 03:42:57 INFO - PID 22006 | |2;jquery.html;609.3145211636909;611.8256296955368;613.1722175063665;614.6680792372119;633.4172561243655;22345.217917372895;23202.88398558007;23295.534089318204;23307.300780976555;23347.999999999978;21483.462913427134;25699.87150064252;25788;25833.483330333383;25926.351841203978;6613.933860661392;6838.247792742794;6839.1451068616425;6858.965705171468;6863.794086177398;6601.834954126137;6710.26187119419;6727.293634168415;6732.023856540799;6737.6968036438475;6194.442500174983;6606.933930660704;6668.6332251726135;6680.899786503206;6704.061431399584;6669.199696036482;6752.324767523258;6752.729890804411;6753.189617245913;6754.290799466084;6268.749250029993;6273;6283.308836028079;6288.622682639057;6293;27453.450930981267;29407;29413.264668383246;29603.851980740175;29723.108306750833;2192.8793916334594;2270.71616047994;2272.397814579138;2274.2494976657663;2279.2250634784086;19213.231470741153;19669.803301966942;19793.307234246877;19807.702884456743;19811.90094049535;2431.9270421887372;2459.348272707734;2520.206135067448;2619.7904167666543;2627.1855724725397;137887;142235;154399;160786.19606902008;161090;15349;15639.765403518957;15697.607559811097;16052.197390130446;16058.036517808969;24931.376715582257;25014.749852501605;25083.372915677253;25139.371515712253;25191.74808251894;10206.795864082676;10527.894721052844;10543.630972915911;10655.89344106549;10764.192685548458;9397.436153830791;9439.76400589977;9563;9589.568469418893;9599.760005999906;9568.277710012126;9696.806063878683;9767.218622510181;9862.753431164136;9952.950235248922;2787.567926971323;2815.8028937974555;2853.857307134635;2892.1045545660045;2898.6086878271585;1087.2389327470803;1089.836524521328;1099.8269991075804;1099.8350247462945;1110.8889111088988;21055.157793688388;21228.681569776465;21241;21512.24707135274;21796.78203217979;1131.3042478875598;1133.2124173699365;1153.066016526616;1157.8089615213396;1161.2304653401698;11640.35978021217;11747.47136378865;11762.059035277158;11817.88182118185;11929.940350298366;576685;578192;583019;587597.1240287628;589412;125007.3749631246;127029;127957;129031;129422;1147.7991351513451;1206.1014544164655;1261.9621411357673;1269.904757143218;1328.030537707479;22324.10703571839;22494.21270255533;22774.20290289832;22799.31602051941;22802.315930522112;61382.38617613945;61941;62294.688526557075;62393.68803155955;63323.6833815828;76891.23108769064;77006.61496692481;77083.84374234278;77232.2276777225;77489;14579;14594.124352538882;14651.560453186421;14661.560153195422;15044.247787610795;24192.637110443004;24212.273631791075;24294.028238870247;24485.51028979446;24543.38641533976;19170.520736981685;19560.510987225432;19626.313079042164;19654.410367688994;19699.40901772949;16470.341186352412;16502.25739841734;16570.171491425623;16759.748603771197;16794.412195573095;19708.40874773759;19801.405957821287;20584.485387864825;20622.38132856017;20726.170953161705;14842.851571484147;14883.330250138553;14942.402303907722;14987.550373488813;15003.474878379204;19813.207471701546;19888.70166947526;19978.10098545598;20102;20134.59730805405 03:42:57 INFO - PID 22006 | |3;mootools.html;1397.4200706706717;1453.2588379926242;1464.2898194375732;1467.2956980649292;1468.8604582564653;16152.919235403835;17704.46886593401;17716.82283177168;17721.55696107598;17725.202365893518;17379.82620173798;17694.91152544239;17716.29134834605;17733.202005909734;17761.555961100978;2733.9474302393523;2820.830750154997;2826.60427540144;2829.4058247767994;2885.5815906693515;2762.7651649609807;2820.7320304571135;2839.1908306132755;2839.8864045438263;2840.2757296889367;2722.605222242774;2738.246982079934;2764.156932135698;2764.350377661248;2779.680336761268;2621.03021881903;2627.9737202628016;2630.710621831616;2634.196570046135;2636.0378461861474;2548.745125487455;2597.2467984284535;2597.493488769691;2600.0379859452123;2602.739726027382;16475.34098636053;16690.749638755427;16731.247093880804;16758.916205419016;16783;7966.362690984707;8269.545175015372;8279.089300176976;8288.129746376604;8291.253787159125;5072.51811077947;5207.687538747649;5327.280817089682;5363;5374.220737992969;2112.93661190163;2119.4913220827043;2129.2121914891436;2186.147402513021;2202.0861342542985;29646.851765741034;30285.545716814264;30313;30491.01808382448;31371.686283137333;7106.229298854699;7144.142702875688;7184.1019872515935;7288.854222915512;7422.517536360119;19492.415227543195;19562.902185489267;19581.902090489457;19681.90159049224;19696.21215151378;8286;8358;8410.495370277802;8438.493690378475;8446.408751387467;7257.637118144072;7362.153352364439;7579.279968402993;7651.923480765121;7763.68945242184;5643.5767317451355;5766.250387449605;5806.44838740319;5844.824655260349;5850;1646.3579204110406;1693.5766058485378;1701.2769572931454;1701.3459003953872;1702.6594681063837;932.244881645869;944.1031020530523;950.7147855643418;963.7012526116927;963.802420503795;8267.421280510307;8351;8368.832623347498;8375.748727538183;8499.065102838682;794.6304968189819;797.0515087046397;798.5368486277945;799.3844739550514;811.2860682599274;5641.2384328116;5825.300963884361;5846.795362162304;6026.668533230627;6076.179715738407;24784.628230576556;25399.873000634878;25442.618360724606;25737.485250295264;25820.35449113787;24523.632145517833;24555.140570079962;25124.371890702878;25181.87409062943;25412.872935635205;10493.160547156209;10975.451227438596;12027.218230815144;12521.812172817416;12723.363831808558;10051.949740251544;10335.121514671036;10441.68674939753;10467.633632822815;10512.106470950055;20456.386308410772;21209.575808484053;21431.357059288246;21473.78526214718;21859.45351366165;21114.472138196666;21737.34787956364;21793.346199614036;21911.12355505762;22230.110795567995;12194.573189938665;12434.37828108609;12487.687807804878;12507.437165327765;12517.874821252035;14649.414023438943;14679.045862018935;14794.852051479347;14873.628159296104;14875.776863347275;12258.387080645754;12431.44058517387;12505.56230531927;12749.93625031869;12848.550300739429;12187.634370968884;12300.446479908247;12306.446209920754;12620.873791261969;12629;11350.489227984595;11359.829602555803;11488.54045838157;11492.310461372344;11500.597479088192;8110.959445202736;8323.126071762377;8361.498310101413;8378.204070613281;8586.356023298153;8585.399022068395;8794.780130496789;8802.471851688919;8812.735617931472;8862.246709029805 03:42:57 INFO - PID 22006 | |4;prototype.html;532.3824363738062;549.5740800879317;564.4355644355644;577.2466930655493;587.6943989125655;6267.780627678032;6291.307956124822;6348.508100596357;6358.936410635893;6383.23401191857;6208.130861679358;6236.875262494747;6262.780802671908;6328.9683551582175;6356.173697419341;5148.124818780816;5156.561692256153;5167.586593072564;5167.612429067816;5182.922256166161;5031.698098114125;5122.282880396729;5122.412052263791;5142.305788718531;5152.355955505562;4872.147374209517;5001.399832020163;5019.171836646949;5021.723805190713;5126.436092029874;4978.502149785028;5001.699898006095;5010.574101201402;5030.999999999982;5041.521055499722;4466.665000125004;4516.1193567254395;4538.29656403258;4544.2047641662575;4551.067031258584;6144.170536977495;6183.628982261079;6189.9381006189815;6206.937930620727;6226.159468471789;5891.175235467038;5904.350521442638;5917.911231331534;5922.170896074553;5936.5547583931375;6722.361375669304;6747.392734653856;6768.49236307274;6771.052052712625;6771.544118014651;5051.444341122474;5059.4434612193;5066.670666406671;5090.440051594322;5104.106781313255;6612.43794277487;6767.729290828361;6853.897191542131;6865.5537390069985;7009.824754381181;5120.359955005624;5137.1010073237785;5157.303763991813;5187.351581052369;5200.66195697286;5220.399654039758;5230.770768869313;5275.757802933737;5276.3932147802725;5300.31095957523;5761;5762.596618236683;5834.8541286467325;5842.42254591258;5875.236219291465;6702.731890724316;6709.289131271495;6739.494537909676;6739.59562426256;6777.356151165632;1827.4608990347879;1830.6979348407363;1833.275856036858;1841.1070630744077;1841.8066103059255;1247.457356050121;1289.1749280460513;1290.7031382782013;1294.825198598196;1310.737852429518;6303.149074874925;6303.401176888188;6309.08518264849;6324.177856878577;6358.682065896686;6636.966815165893;6694.49791265657;6729.798106056826;6773.729050837911;6802.8299292517095;5997.940020599825;6158.291796443376;6185.969070154711;6218.782342617987;6260.342664020303;3545.7517973742106;3556.5376501054698;3584.336897673939;3588.982055089708;3595.6224596417;7049.823754406181;7050.294970503011;7083.150021997393;7131.89302160468;7134.92865071353;6888.345607167411;6984.546004509691;6998.475114366341;7000.544964577286;7024.964875175694;7097.396721278749;7102.762629771605;7151.713931442684;7165.7850264492145;7169.749058782918;6645.700943457459;6800.149981252343;6847.589144651337;6875.656217189221;6877.793666190022;6758.898616520854;6772.52592318533;6835.14560679915;6848.9657551711925;6861.965690171517;7153.463490238357;7170.2471240519;7173.641317934187;7203.927960720326;7215.891761623685;5142.151544995034;5207.791688332424;5244.396894357045;5257.106291930305;5277.868053298698;6601.834954126185;6679.2300040488335;6773.390394864486;6842.315768423118;6927.653617319214;6485.77299794505;6541.967290163519;6548.377904099103;6619.933800662125;6629.204495460575;6543.214814222324;6557.9344206557325;6572.286658038193;6578.427992545136;6580.440662543738;6425.261094973951;6442.613443193423;6471.741130354733;6483.157189565326;6504.877658723744;6649.63427011519;6670.433013193933;6689.464842812466;6699.129113215446;6756.594604323756;6459.5478316519275;6478.255000674794;6527.738890444519;6529.836754080996;6533.379328963741 03:42:57 INFO - PID 22006 | |5;yui.html;972.581789830373;994.4530508220479;1001.7645853224491;1022.6267412394478;1025.1593693171603;16931;16951.915240423798;16980.235889384978;17147.142642867853;17157.656846863054;17045.829541704577;17222.224999875005;17406.129693515304;17411.564710882234;17430.564235894108;1058.8517607534932;1073.2058276875134;1075.4998925499642;1080.3301952789282;1081.2863510083346;1082.5723839083557;1093.038126448724;1093.8413929980147;1094.0263165782421;1094.0536435982897;1075.451519724942;1119.451468780296;1121.388843080523;1139.5043156227068;1140.6064907606903;1114.0864491117286;1116.3748300951452;1120.3501968858084;1121.2823792772633;1123.2530367305774;796.3828033274201;816.2449733996029;825.7687847402677;830.887830142929;831.3183189784379;16677.08276044817;16870.578235544086;16924.23840927149;16935.915320423443;16942.49172524814;22327;22752.772472275232;22928.885355573282;23005.19481818145;23093.769062309497;15399.076055436597;15679.608009799733;15772.211389430482;15820.05079695222;15843.049417035014;3877.263319969197;3878.3406820840523;3925.3326934421216;3926.293267211901;3931.312020396419;119857;149680.2515987424;150672;152331;154209.2289538545;17795.19921603531;18297.908510457364;18431.72352414715;18552.907235464005;18562.350317738816;34171.658283417346;34745;34746.478802817976;34787;35592.28815423677;9346.439213647067;9365.157135857806;9402.059794020543;9408.811823763486;9415;4310.956890431055;4373.934390984138;4383.846565370197;4386.342048692658;4387.319965405367;5937.406259374115;6033.577649564576;6118.296395914438;6135.631862088289;6157.84605384869;1062.4315990944808;1089.1341383600056;1090.9890901090887;1104.5692180049787;1109.7392112853472;757.3373298363931;761.77146855943;772.3242163107282;780.1106738318322;786.7561056072636;12412.317322547347;12638.684032899251;12711.491540338468;13032.674183145496;13270.270135142468;754.1101500229781;758.5524540521119;764.3197554176787;773.9806504837425;777.5917643237233;5810.912836307459;5922.644641321448;5954.345022047572;6061.727222275008;6092.908606370819;136885.31557342148;141557;142316;142796.28601856926;144472;121333;125431.3728431352;125680.37159814325;126356.36821815833;126380.36809815893;107731;109400;112066;114014;114932;11037.172212084286;11124.61063862761;11178.496967636313;11224.15818813576;11346.432678366215;50901.49098508967;51193.7440312796;52127.73936130295;52959;53721;66080.66959665171;66133;66573.33426665672;66737.66631166813;66802.3319766796;15629.843701563294;15650.686986259983;15878.52364429069;15955.20223988819;15962.760558591863;17387;17409.56476088108;17646.91176544109;17713.557161071076;17743.911280443514;16082.919585401998;16159.353625854834;16204.513864584082;16741.832581674516;16840.326386944384;17319.826801732324;17343.739843902098;17367.392141274995;17467.56331091682;17614.11929403499;17424.73862892083;17428.651426971643;17550.473485795446;17712.645747084727;17786.199621016825;11450.198486105892;11549.6535103947;11611.303321800719;11657.300561966309;11798.882011179778;12055.939720301343;12151.635450936486;12397.93801030989;12417.254964702146;12484.43820028119 03:42:57 INFO - PID 22006 | __end_tp_report 03:42:57 INFO - PID 22006 | __start_cc_report 03:42:57 INFO - PID 22006 | _x_x_mozilla_cycle_collect,265 03:42:57 INFO - PID 22006 | __end_cc_report 03:42:57 INFO - PID 22006 | __startTimestamp1505817777897__endTimestamp 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | ------- Summary: start ------- 03:42:57 INFO - PID 22006 | Number of tests: 6 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | [#0] dojo.html Cycles:165 Average:6320.16 Median:6579.37 stddev:752.32 (11.4%) stddev-sans-first:729.10 03:42:57 INFO - PID 22006 | Values: 3843.0 3882.6 3891.7 3922.8 3927.4 6123.1 6219.2 6246.3 6271.2 6395.7 6200.1 6240.7 6247.7 6262.4 6273.5 5615.7 5623.7 5637.7 5664.7 5681.9 5714.3 5738.3 5741.3 5753.8 5842.4 5768.7 5824.9 5842.7 5855.6 5860.6 5546.7 5646.4 5653.4 5765.0 5784.8 5624.6 5684.1 5725.4 5735.6 5738.7 6267.5 6342.0 6343.8 6363.7 6412.7 6700.1 6759.7 6781.7 6855.6 6864.9 6734.9 6909.8 6935.6 6945.3 6952.9 6322.0 6346.5 6348.7 6486.4 6494.0 7091.0 7103.4 7110.0 7176.7 7194.3 6734.4 6752.6 6786.1 6854.5 6858.6 6930.3 6961.8 6970.0 6986.3 6989.8 6828.4 6832.7 6917.9 6918.9 6932.0 6700.4 6823.9 6835.0 6871.8 6919.9 4936.7 4945.8 4946.0 4956.9 4961.1 4521.9 4563.9 4584.5 4616.5 4636.9 6345.9 6351.2 6434.0 6445.0 6461.3 6608.6 6835.5 6853.6 6937.4 6948.3 6219.8 6309.7 6326.8 6338.7 6344.4 5522.3 5579.2 5595.2 5604.4 5611.0 7014.6 7096.4 7175.8 7190.0 7217.1 6727.2 6736.2 6807.9 6817.0 6826.6 7067.4 7161.8 7191.5 7211.8 7222.6 6608.5 6639.2 6773.1 6858.3 6869.9 6753.5 6810.7 6839.2 6903.9 6906.7 6579.4 6697.3 6703.2 6704.1 6723.3 6605.3 6631.4 6684.9 6701.3 6708.0 6519.0 6545.8 6607.5 6631.6 6662.0 6661.3 6661.4 6750.8 6771.2 6789.2 6433.4 6455.7 6495.5 6503.6 6563.5 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | [#1] ext.html Cycles:180 Average:43536.31 Median:39440.30 stddev:64632.42 (163.9%) stddev-sans-first:64734.68 03:42:57 INFO - PID 22006 | Values: 961.5 988.4 989.2 990.6 990.7 40615.0 45010.5 45019.3 45043.5 45102.5 41737.8 41898.4 42025.8 42072.2 42082.4 7668.5 7788.1 7793.4 7803.2 8312.4 8389.3 8472.0 8518.3 8538.7 8541.4 8407.0 8440.7 8560.4 8567.0 8643.9 8532.4 8549.0 8569.1 8570.3 8573.8 8327.3 8383.2 8391.2 8402.6 8406.7 40820.8 40932.2 41269.8 41281.6 41293.2 3668.5 3708.4 3709.6 3714.9 3717.9 33962.7 33963.0 33976.2 34011.3 34024.0 5255.6 5373.4 5419.2 5558.8 5559.2 220536.0 220882.9 221644.0 221695.0 222727.0 47900.5 52921.4 52922.7 52986.0 53017.2 50655.2 56670.0 57982.7 57984.4 57985.0 17163.7 17246.6 17256.0 17323.4 17335.0 14035.9 14054.4 14059.1 14075.9 14076.4 15187.9 15263.6 15325.4 15358.6 15406.0 5831.7 6015.3 6067.4 6101.3 6239.9 1100.3 1101.2 1104.4 1112.6 1114.6 25486.2 25580.9 25685.4 25734.4 25829.6 1185.8 1209.9 1217.3 1228.1 1248.8 13434.6 13518.8 13679.3 13773.6 13858.8 269123.0 272220.0 272293.0 272497.0 273358.0 57361.0 57554.7 57680.0 57721.4 57837.7 1484.6 1513.8 1528.0 1532.4 1534.0 25191.6 25233.2 25395.2 25557.7 25715.2 40735.0 40972.4 41020.0 41028.2 41126.8 238614.0 239557.0 257024.0 258584.0 260140.0 37647.4 38038.2 41226.6 41355.8 41565.4 52712.7 53245.5 53506.5 53739.5 53741.7 38844.0 38849.8 38924.8 39039.6 39574.6 37871.0 37885.1 38439.0 39268.2 39306.0 45285.0 45459.3 45576.1 46069.1 46106.1 36096.6 36178.8 36812.8 37286.4 37584.6 27383.7 28493.4 28561.6 28748.9 28942.9 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | [#2] jquery.html Cycles:180 Average:38885.56 Median:22800.82 stddev:97738.42 (428.7%) stddev-sans-first:97970.35 03:42:57 INFO - PID 22006 | Values: 609.3 611.8 613.2 614.7 633.4 22345.2 23202.9 23295.5 23307.3 23348.0 21483.5 25699.9 25788.0 25833.5 25926.4 6613.9 6838.2 6839.1 6859.0 6863.8 6601.8 6710.3 6727.3 6732.0 6737.7 6194.4 6606.9 6668.6 6680.9 6704.1 6669.2 6752.3 6752.7 6753.2 6754.3 6268.7 6273.0 6283.3 6288.6 6293.0 27453.5 29407.0 29413.3 29603.9 29723.1 2192.9 2270.7 2272.4 2274.2 2279.2 19213.2 19669.8 19793.3 19807.7 19811.9 2431.9 2459.3 2520.2 2619.8 2627.2 137887.0 142235.0 154399.0 160786.2 161090.0 15349.0 15639.8 15697.6 16052.2 16058.0 24931.4 25014.7 25083.4 25139.4 25191.7 10206.8 10527.9 10543.6 10655.9 10764.2 9397.4 9439.8 9563.0 9589.6 9599.8 9568.3 9696.8 9767.2 9862.8 9953.0 2787.6 2815.8 2853.9 2892.1 2898.6 1087.2 1089.8 1099.8 1099.8 1110.9 21055.2 21228.7 21241.0 21512.2 21796.8 1131.3 1133.2 1153.1 1157.8 1161.2 11640.4 11747.5 11762.1 11817.9 11929.9 576685.0 578192.0 583019.0 587597.1 589412.0 125007.4 127029.0 127957.0 129031.0 129422.0 1147.8 1206.1 1262.0 1269.9 1328.0 22324.1 22494.2 22774.2 22799.3 22802.3 61382.4 61941.0 62294.7 62393.7 63323.7 76891.2 77006.6 77083.8 77232.2 77489.0 14579.0 14594.1 14651.6 14661.6 15044.2 24192.6 24212.3 24294.0 24485.5 24543.4 19170.5 19560.5 19626.3 19654.4 19699.4 16470.3 16502.3 16570.2 16759.7 16794.4 19708.4 19801.4 20584.5 20622.4 20726.2 14842.9 14883.3 14942.4 14987.6 15003.5 19813.2 19888.7 19978.1 20102.0 20134.6 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | [#3] mootools.html Cycles:180 Average:10427.09 Median:14208.80 stddev:7760.41 (54.6%) stddev-sans-first:7752.52 03:42:57 INFO - PID 22006 | Values: 1397.4 1453.3 1464.3 1467.3 1468.9 16152.9 17704.5 17716.8 17721.6 17725.2 17379.8 17694.9 17716.3 17733.2 17761.6 2733.9 2820.8 2826.6 2829.4 2885.6 2762.8 2820.7 2839.2 2839.9 2840.3 2722.6 2738.2 2764.2 2764.4 2779.7 2621.0 2628.0 2630.7 2634.2 2636.0 2548.7 2597.2 2597.5 2600.0 2602.7 16475.3 16690.7 16731.2 16758.9 16783.0 7966.4 8269.5 8279.1 8288.1 8291.3 5072.5 5207.7 5327.3 5363.0 5374.2 2112.9 2119.5 2129.2 2186.1 2202.1 29646.9 30285.5 30313.0 30491.0 31371.7 7106.2 7144.1 7184.1 7288.9 7422.5 19492.4 19562.9 19581.9 19681.9 19696.2 8286.0 8358.0 8410.5 8438.5 8446.4 7257.6 7362.2 7579.3 7651.9 7763.7 5643.6 5766.3 5806.4 5844.8 5850.0 1646.4 1693.6 1701.3 1701.3 1702.7 932.2 944.1 950.7 963.7 963.8 8267.4 8351.0 8368.8 8375.7 8499.1 794.6 797.1 798.5 799.4 811.3 5641.2 5825.3 5846.8 6026.7 6076.2 24784.6 25399.9 25442.6 25737.5 25820.4 24523.6 24555.1 25124.4 25181.9 25412.9 10493.2 10975.5 12027.2 12521.8 12723.4 10051.9 10335.1 10441.7 10467.6 10512.1 20456.4 21209.6 21431.4 21473.8 21859.5 21114.5 21737.3 21793.3 21911.1 22230.1 12194.6 12434.4 12487.7 12507.4 12517.9 14649.4 14679.0 14794.9 14873.6 14875.8 12258.4 12431.4 12505.6 12749.9 12848.6 12187.6 12300.4 12306.4 12620.9 12629.0 11350.5 11359.8 11488.5 11492.3 11500.6 8111.0 8323.1 8361.5 8378.2 8586.4 8585.4 8794.8 8802.5 8812.7 8862.2 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | [#4] prototype.html Cycles:180 Average:5678.61 Median:6303.28 stddev:1592.27 (25.3%) stddev-sans-first:1549.17 03:42:57 INFO - PID 22006 | Values: 532.4 549.6 564.4 577.2 587.7 6267.8 6291.3 6348.5 6358.9 6383.2 6208.1 6236.9 6262.8 6329.0 6356.2 5148.1 5156.6 5167.6 5167.6 5182.9 5031.7 5122.3 5122.4 5142.3 5152.4 4872.1 5001.4 5019.2 5021.7 5126.4 4978.5 5001.7 5010.6 5031.0 5041.5 4466.7 4516.1 4538.3 4544.2 4551.1 6144.2 6183.6 6189.9 6206.9 6226.2 5891.2 5904.4 5917.9 5922.2 5936.6 6722.4 6747.4 6768.5 6771.1 6771.5 5051.4 5059.4 5066.7 5090.4 5104.1 6612.4 6767.7 6853.9 6865.6 7009.8 5120.4 5137.1 5157.3 5187.4 5200.7 5220.4 5230.8 5275.8 5276.4 5300.3 5761.0 5762.6 5834.9 5842.4 5875.2 6702.7 6709.3 6739.5 6739.6 6777.4 1827.5 1830.7 1833.3 1841.1 1841.8 1247.5 1289.2 1290.7 1294.8 1310.7 6303.1 6303.4 6309.1 6324.2 6358.7 6637.0 6694.5 6729.8 6773.7 6802.8 5997.9 6158.3 6186.0 6218.8 6260.3 3545.8 3556.5 3584.3 3589.0 3595.6 7049.8 7050.3 7083.2 7131.9 7134.9 6888.3 6984.5 6998.5 7000.5 7025.0 7097.4 7102.8 7151.7 7165.8 7169.7 6645.7 6800.1 6847.6 6875.7 6877.8 6758.9 6772.5 6835.1 6849.0 6862.0 7153.5 7170.2 7173.6 7203.9 7215.9 5142.2 5207.8 5244.4 5257.1 5277.9 6601.8 6679.2 6773.4 6842.3 6927.7 6485.8 6542.0 6548.4 6619.9 6629.2 6543.2 6557.9 6572.3 6578.4 6580.4 6425.3 6442.6 6471.7 6483.2 6504.9 6649.6 6670.4 6689.5 6699.1 6756.6 6459.5 6478.3 6527.7 6529.8 6533.4 03:42:57 INFO - PID 22006 | 03:42:57 INFO - PID 22006 | [#5] yui.html Cycles:180 Average:26567.03 Median:17013.03 stddev:39761.42 (233.7%) stddev-sans-first:39826.52 03:42:57 INFO - PID 22006 | Values: 972.6 994.5 1001.8 1022.6 1025.2 16931.0 16951.9 16980.2 17147.1 17157.7 17045.8 17222.2 17406.1 17411.6 17430.6 1058.9 1073.2 1075.5 1080.3 1081.3 1082.6 1093.0 1093.8 1094.0 1094.1 1075.5 1119.5 1121.4 1139.5 1140.6 1114.1 1116.4 1120.4 1121.3 1123.3 796.4 816.2 825.8 830.9 831.3 16677.1 16870.6 16924.2 16935.9 16942.5 22327.0 22752.8 22928.9 23005.2 23093.8 15399.1 15679.6 15772.2 15820.1 15843.0 3877.3 3878.3 3925.3 3926.3 3931.3 119857.0 149680.3 150672.0 152331.0 154209.2 17795.2 18297.9 18431.7 18552.9 18562.4 34171.7 34745.0 34746.5 34787.0 35592.3 9346.4 9365.2 9402.1 9408.8 9415.0 4311.0 4373.9 4383.8 4386.3 4387.3 5937.4 6033.6 6118.3 6135.6 6157.8 1062.4 1089.1 1091.0 1104.6 1109.7 757.3 761.8 772.3 780.1 786.8 12412.3 12638.7 12711.5 13032.7 13270.3 754.1 758.6 764.3 774.0 777.6 5810.9 5922.6 5954.3 6061.7 6092.9 136885.3 141557.0 142316.0 142796.3 144472.0 121333.0 125431.4 125680.4 126356.4 126380.4 107731.0 109400.0 112066.0 114014.0 114932.0 11037.2 11124.6 11178.5 11224.2 11346.4 50901.5 51193.7 52127.7 52959.0 53721.0 66080.7 66133.0 66573.3 66737.7 66802.3 15629.8 15650.7 15878.5 15955.2 15962.8 17387.0 17409.6 17646.9 17713.6 17743.9 16082.9 16159.4 16204.5 16741.8 16840.3 17319.8 17343.7 17367.4 17467.6 17614.1 17424.7 17428.7 17550.5 17712.6 17786.2 11450.2 11549.7 11611.3 11657.3 11798.9 12055.9 12151.6 12397.9 12417.3 12484.4 03:42:57 INFO - PID 22006 | -------- Summary: end -------- 03:42:57 INFO - PID 22006 | 03:42:58 INFO - TEST-INFO | 22006: exit 0 03:42:58 INFO - TEST-OK | dromaeo_css | took 1108151ms 03:42:58 INFO - TEST-START | kraken 03:42:58 INFO - Initialising browser for kraken test... 03:42:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48795/getInfo.html -profile /tmp/tmpbpCPgv/profile 03:42:58 INFO - TEST-INFO | started process 22373 (/builds/slave/test/build/application/firefox/firefox http://localhost:48795/getInfo.html) 03:43:03 INFO - TEST-INFO | 22373: exit 0 03:43:03 INFO - Browser initialized. 03:43:03 INFO - Running cycle 1/1 for kraken test... 03:43:03 INFO - Using env: {'DISPLAY': ':0', 03:43:03 INFO - 'HOME': '/home/cltbld', 03:43:03 INFO - 'JSGC_DISABLE_POISONING': '1', 03:43:03 INFO - 'LANG': 'en_US.UTF-8', 03:43:03 INFO - 'LANGUAGE': 'en_US:en', 03:43:03 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:43:03 INFO - 'LOGNAME': 'cltbld', 03:43:03 INFO - 'MAIL': '/var/mail/cltbld', 03:43:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:43:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:43:03 INFO - 'MOZ_CRASHREPORTER': '1', 03:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:43:03 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:43:03 INFO - 'MOZ_NO_REMOTE': '1', 03:43:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:43:03 INFO - 'NO_EM_RESTART': '1', 03:43:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:43:03 INFO - 'PWD': '/builds/slave/test', 03:43:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:43:03 INFO - 'RUST_BACKTRACE': 'full', 03:43:03 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:43:03 INFO - 'SHELL': '/bin/bash', 03:43:03 INFO - 'SHLVL': '1', 03:43:03 INFO - 'STYLO_FORCE_DISABLED': '1', 03:43:03 INFO - 'TERM': 'linux', 03:43:03 INFO - 'TMOUT': '86400', 03:43:03 INFO - 'USER': 'cltbld', 03:43:03 INFO - 'XDG_SESSION_COOKIE': '483e410453545d07cca6935c000001ab-1505816471.235603-1652916788', 03:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:43:03 INFO - '_': '/tools/buildbot/bin/python'} 03:43:03 INFO - TEST-INFO | started process 22608 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbpCPgv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:04 INFO - PID 22608 | 03:43:04 INFO - PID 22608 | (/builds/slave/test/build/application/firefox/firefox:22659): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:43:04 INFO - PID 22608 | 03:43:15 INFO - PID 22608 | RSS: Main: 147988480 03:43:15 INFO - PID 22608 | 03:43:17 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:18 INFO - PID 22608 | RSS: Main: 153288704 03:43:18 INFO - PID 22608 | 03:43:20 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-dft) 03:43:21 INFO - PID 22608 | RSS: Main: 153518080 03:43:21 INFO - PID 22608 | 03:43:24 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-fft) 03:43:25 INFO - PID 22608 | RSS: Main: 149721088 03:43:25 INFO - PID 22608 | 03:43:27 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48795/tests/kraken/driver.html?testName=audio-oscillator) 03:43:27 INFO - PID 22608 | RSS: Main: 150642688 03:43:27 INFO - PID 22608 | 03:43:29 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48795/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:30 INFO - PID 22608 | RSS: Main: 150663168 03:43:30 INFO - PID 22608 | 03:43:33 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48795/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:34 INFO - PID 22608 | RSS: Main: 150618112 03:43:34 INFO - PID 22608 | 03:43:37 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48795/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:38 INFO - PID 22608 | RSS: Main: 152043520 03:43:38 INFO - PID 22608 | 03:43:41 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48795/tests/kraken/driver.html?testName=json-parse-financial) 03:43:41 INFO - PID 22608 | RSS: Main: 153313280 03:43:41 INFO - PID 22608 | 03:43:43 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48795/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:43 INFO - PID 22608 | RSS: Main: 153321472 03:43:43 INFO - PID 22608 | 03:43:45 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:46 INFO - PID 22608 | RSS: Main: 153579520 03:43:46 INFO - PID 22608 | 03:43:48 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:48 INFO - PID 22608 | RSS: Main: 150560768 03:43:48 INFO - PID 22608 | 03:43:51 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:51 INFO - PID 22608 | RSS: Main: 150364160 03:43:51 INFO - PID 22608 | 03:43:54 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:54 INFO - PID 22608 | RSS: Main: 150958080 03:43:54 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | Cycle 1(1): loaded http://localhost:48795/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48795/tests/kraken/driver.html?testName=ai-astar) 03:43:56 INFO - PID 22608 | RSS: Main: 152645632 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | __start_tp_report 03:43:56 INFO - PID 22608 | _x_x_mozilla_page_load 03:43:56 INFO - PID 22608 | _x_x_mozilla_page_load_details 03:43:56 INFO - PID 22608 | |i|pagename|runs| 03:43:56 INFO - PID 22608 | |0;ai-astar;106;104;105;105;105;106;108;104;106;107 03:43:56 INFO - PID 22608 | |1;audio-beat-detection;114;115;111;112;137;115;114;121;112;113 03:43:56 INFO - PID 22608 | |2;audio-dft;163;162;162;163;162;163;163;162;161;163 03:43:56 INFO - PID 22608 | |3;audio-fft;73;74;74;73;73;73;72;71;76;78 03:43:56 INFO - PID 22608 | |4;audio-oscillator;78;79;77;76;78;78;76;77;77;78 03:43:56 INFO - PID 22608 | |5;imaging-gaussian-blur;114;113;110;114;114;114;113;113;111;115 03:43:56 INFO - PID 22608 | |6;imaging-darkroom;149;148;154;149;151;149;148;150;153;151 03:43:56 INFO - PID 22608 | |7;imaging-desaturate;94;94;95;98;94;95;94;93;94;94 03:43:56 INFO - PID 22608 | |8;json-parse-financial;47;45;44;43;48;47;44;47;45;43 03:43:56 INFO - PID 22608 | |9;json-stringify-tinderbox;38;38;38;39;39;38;38;38;39;38 03:43:56 INFO - PID 22608 | |10;stanford-crypto-aes;73;72;73;74;70;71;72;70;70;70 03:43:56 INFO - PID 22608 | |11;stanford-crypto-ccm;107;102;103;106;107;104;110;110;111;105 03:43:56 INFO - PID 22608 | |12;stanford-crypto-pbkdf2;152;156;151;151;158;155;151;159;159;151 03:43:56 INFO - PID 22608 | |13;stanford-crypto-sha256-iterative;61;58;61;59;58;60;62;59;64;58 03:43:56 INFO - PID 22608 | __end_tp_report 03:43:56 INFO - PID 22608 | __start_cc_report 03:43:56 INFO - PID 22608 | _x_x_mozilla_cycle_collect,748 03:43:56 INFO - PID 22608 | __end_cc_report 03:43:56 INFO - PID 22608 | __startTimestamp1505817836902__endTimestamp 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | ------- Summary: start ------- 03:43:56 INFO - PID 22608 | Number of tests: 14 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#0] ai-astar Cycles:10 Average:105.60 Median:106.00 stddev:1.26 (1.2%) stddev-sans-first:1.33 03:43:56 INFO - PID 22608 | Values: 106.0 104.0 105.0 105.0 105.0 106.0 108.0 104.0 106.0 107.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#1] audio-beat-detection Cycles:10 Average:116.40 Median:114.50 stddev:7.75 (6.8%) stddev-sans-first:8.17 03:43:56 INFO - PID 22608 | Values: 114.0 115.0 111.0 112.0 137.0 115.0 114.0 121.0 112.0 113.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 03:43:56 INFO - PID 22608 | Values: 163.0 162.0 162.0 163.0 162.0 163.0 163.0 162.0 161.0 163.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#3] audio-fft Cycles:10 Average:73.70 Median:73.50 stddev:2.00 (2.7%) stddev-sans-first:2.11 03:43:56 INFO - PID 22608 | Values: 73.0 74.0 74.0 73.0 73.0 73.0 72.0 71.0 76.0 78.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:78.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 03:43:56 INFO - PID 22608 | Values: 78.0 79.0 77.0 76.0 78.0 78.0 76.0 77.0 77.0 78.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.58 03:43:56 INFO - PID 22608 | Values: 114.0 113.0 110.0 114.0 114.0 114.0 113.0 113.0 111.0 115.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.50 stddev:2.04 (1.4%) stddev-sans-first:2.12 03:43:56 INFO - PID 22608 | Values: 149.0 148.0 154.0 149.0 151.0 149.0 148.0 150.0 153.0 151.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 03:43:56 INFO - PID 22608 | Values: 94.0 94.0 95.0 98.0 94.0 95.0 94.0 93.0 94.0 94.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#8] json-parse-financial Cycles:10 Average:45.30 Median:46.00 stddev:1.83 (4.0%) stddev-sans-first:1.83 03:43:56 INFO - PID 22608 | Values: 47.0 45.0 44.0 43.0 48.0 47.0 44.0 47.0 45.0 43.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.50 03:43:56 INFO - PID 22608 | Values: 38.0 38.0 38.0 39.0 39.0 38.0 38.0 38.0 39.0 38.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#10] stanford-crypto-aes Cycles:10 Average:71.50 Median:72.00 stddev:1.51 (2.1%) stddev-sans-first:1.50 03:43:56 INFO - PID 22608 | Values: 73.0 72.0 73.0 74.0 70.0 71.0 72.0 70.0 70.0 70.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#11] stanford-crypto-ccm Cycles:10 Average:106.50 Median:107.00 stddev:3.10 (2.9%) stddev-sans-first:3.28 03:43:56 INFO - PID 22608 | Values: 107.0 102.0 103.0 106.0 107.0 104.0 110.0 110.0 111.0 105.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.30 Median:155.50 stddev:3.50 (2.2%) stddev-sans-first:3.61 03:43:56 INFO - PID 22608 | Values: 152.0 156.0 151.0 151.0 158.0 155.0 151.0 159.0 159.0 151.0 03:43:56 INFO - PID 22608 | 03:43:56 INFO - PID 22608 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.50 stddev:2.00 (3.3%) stddev-sans-first:2.09 03:43:56 INFO - PID 22608 | Values: 61.0 58.0 61.0 59.0 58.0 60.0 62.0 59.0 64.0 58.0 03:43:56 INFO - PID 22608 | -------- Summary: end -------- 03:43:56 INFO - PID 22608 | 03:43:57 INFO - PID 22608 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:43:57 INFO - TEST-INFO | 22608: exit 0 03:43:57 INFO - TEST-OK | kraken | took 59002ms 03:43:57 INFO - SUITE-END | took 1167s 03:43:57 INFO - Completed test suite (00:19:27) 03:43:57 INFO - javascript benchmark 03:43:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9040.238983615614, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3843.0, 3882.6311500407464, 3891.708121890859, 3922.784246866423, 3927.430522574226, 6123.050927106295, 6219.222597175353, 6246.281677607077, 6271.247450305964, 6395.744170233185, 6200.131981522579, 6240.687965601713, 6247.687615619224, 6262.436380725734, 6273.466755325791, 5615.691136987464, 5623.690697011683, 5637.661740295575, 5664.745086471119, 5681.914771278434, 5714.285714285715, 5738.254026976487, 5741.3110426748635, 5753.798617048405, 5842.386549412315, 5768.74040668171, 5824.912626310609, 5842.737076831531, 5855.619384739978, 5860.589758716891, 5546.667199967975, 5646.350669672958, 5653.378128405872, 5765.048766953448, 5784.826455206329, 5624.578156638268, 5684.0905455127395, 5725.3988331225455, 5735.569832262555, 5738.655680659173, 6267.467265282411, 6342.048692696087, 6343.809685709436, 6363.713632886531, 6412.7114279857515, 6700.061991321219, 6759.662016899185, 6781.6609169541325, 6855.5886646801355, 6864.897026544606, 6734.865302693918, 6909.827254318632, 6935.618540980244, 6945.270746571588, 6952.895706564405, 6322.0, 6346.460550853183, 6348.714307856158, 6486.416222539994, 6494.025896115573, 7091.042709234187, 7103.396211321992, 7110.004599356094, 7176.712931482786, 7194.280571942869, 6734.427573656196, 6752.561083529555, 6786.117804685359, 6854.5201835872, 6858.554193977376, 6930.306969303029, 6961.756338528228, 6970.0, 6986.336298051677, 6989.790306290819, 6828.385445309946, 6832.726690932307, 6917.89623155653, 6918.8962165567555, 6932.029515867783, 6700.363465470772, 6823.897641535381, 6835.043093966849, 6871.793846184622, 6919.930800691928, 4936.679115857458, 4945.7774400152075, 4946.0355230729665, 4956.8760780980765, 4961.08219979305, 4521.909561808811, 4563.931541026887, 4584.541545845455, 4616.538346165356, 4636.933505293801, 6345.904811427832, 6351.2060992375955, 6434.0, 6444.967775161094, 6461.289258181596, 6608.570442921195, 6835.453163746888, 6853.554518956252, 6937.445004399636, 6948.270431604608, 6219.782307619302, 6309.684515774193, 6326.841828954313, 6338.714757835908, 6344.397282258178, 5522.30971128609, 5579.191017302468, 5595.188697638901, 5604.355499117653, 5610.971945140248, 7014.614196219155, 7096.361327480448, 7175.784726458214, 7189.96405017982, 7217.133943926762, 6727.159105111861, 6736.225334086643, 6807.863842723217, 6817.01153332764, 6826.556273842184, 7067.434605231672, 7161.785146445615, 7191.496595238283, 7211.819704507429, 7222.6388680566815, 6608.50436217276, 6639.203295604559, 6773.051772751917, 6858.348456896587, 6869.862602748017, 6753.493487988322, 6810.693518791765, 6839.2476827547935, 6903.930960690329, 6906.723731050903, 6579.374959379043, 6697.330266973264, 6703.195616526048, 6704.128463299739, 6723.327667233238, 6605.2734199239, 6631.403173714389, 6684.866302674017, 6701.32986701326, 6708.027336036345, 6518.967405162944, 6545.770898018546, 6607.504437167136, 6631.602103873783, 6661.966690166518, 6661.3338666132995, 6661.367170119025, 6750.797476075725, 6771.187457505131, 6789.15135608049, 6433.356664333529, 6455.709493072729, 6495.480361571157, 6503.6097834130105, 6563.540552161303], "value": 6268.930991472054, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [961.4759955824076, 988.4217732626415, 989.2333441582772, 990.5641517732192, 990.7374545745374, 40615.0, 45010.54989450105, 45019.324710129295, 45043.54956450435, 45102.548974510246, 41737.7913110434, 41898.37152442716, 42025.78987105068, 42072.15855682884, 42082.368764468556, 7668.501547399429, 7788.14330423653, 7793.376529877624, 7803.18066603007, 8312.418130730852, 8389.286910612605, 8471.957640211791, 8518.27594654452, 8538.70114545991, 8541.35939804514, 8407.0, 8440.746777596682, 8560.357973152008, 8566.957165214197, 8643.870341944876, 8532.445391049561, 8549.0, 8569.057403685589, 8570.314374849997, 8573.828523429527, 8327.292180164693, 8383.16168383163, 8391.244787969052, 8402.621882015263, 8406.747797566082, 40820.79589602062, 40932.181356372705, 41269.793651031854, 41281.587184128075, 41293.1741365174, 3668.523091998023, 3708.388115960863, 3709.610490898444, 3714.888553343404, 3717.8512859485586, 33962.6603733962, 33963.0, 33976.15059623504, 34011.319773604635, 34024.0, 5255.5795536357, 5373.382061062989, 5419.187121931703, 5558.805441809517, 5559.19391688207, 220536.0, 220882.89558552264, 221644.0, 221695.0, 222727.0, 47900.520994790306, 52921.412357629335, 52922.73538632282, 52986.0, 53017.2047419289, 50655.24017139746, 56670.0, 57982.7100864493, 57984.4201557979, 57985.0, 17163.656726865393, 17246.568835778955, 17256.0, 17323.393681221096, 17335.046572438383, 14035.929820350833, 14054.437822486985, 14059.08615939981, 14075.85924140766, 14076.436942522389, 15187.924060379628, 15263.618409539627, 15325.386984520494, 15358.616034599225, 15406.0, 5831.708414579254, 6015.30823955242, 6067.423594758491, 6101.298350689727, 6239.937600624026, 1100.3342977498658, 1101.1961268274044, 1104.4422566603814, 1112.6161474291357, 1114.6154576671036, 25486.23541293764, 25580.872095639403, 25685.3578660535, 25734.356641084123, 25829.612555811676, 1185.7806305833449, 1209.8729633388368, 1217.3183017510223, 1228.0666693312967, 1248.843894513186, 13434.596962091153, 13518.797218041736, 13679.316034198251, 13773.586792396043, 13858.792118118236, 269123.0, 272220.0, 272293.0, 272497.0, 273358.0, 57361.0, 57554.7122264386, 57680.0, 57721.42278577245, 57837.71081144567, 1484.5620541940154, 1513.7805018272288, 1527.9541613751605, 1532.387045181914, 1533.9539813805604, 25191.606797354223, 25233.243002709947, 25395.238142855746, 25557.744422555537, 25715.228543143734, 40735.0, 40972.3854142194, 41020.0, 41028.1794364117, 41126.79436602798, 238614.0, 239557.0, 257024.0, 258584.0, 260140.0, 37647.435288470144, 38038.23923521459, 41226.58773412227, 41355.7932210337, 41565.37651935284, 52712.73643631911, 53245.4675453256, 53506.46493535015, 53739.46260537345, 53741.73129134329, 38844.0, 38849.80575097106, 38924.80537597294, 39039.6096039036, 39574.60425395824, 37871.0, 37885.05287367838, 38439.0, 39268.21463570656, 39306.0, 45285.0, 45459.31811022903, 45576.088478230915, 46069.07861842812, 46106.07787844291, 36096.63903361038, 36178.8191059043, 36812.815935920145, 37286.44070339001, 37584.624153758115, 27383.726162738116, 28493.430131397672, 28561.571576425955, 28748.856255719424, 28942.85528572428], "value": 19127.78629067472, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.3145211636909, 611.8256296955368, 613.1722175063665, 614.6680792372119, 633.4172561243655, 22345.217917372895, 23202.88398558007, 23295.534089318204, 23307.300780976555, 23347.999999999978, 21483.462913427134, 25699.87150064252, 25788.0, 25833.483330333383, 25926.351841203978, 6613.933860661392, 6838.247792742794, 6839.1451068616425, 6858.965705171468, 6863.794086177398, 6601.834954126137, 6710.26187119419, 6727.293634168415, 6732.023856540799, 6737.6968036438475, 6194.442500174983, 6606.933930660704, 6668.6332251726135, 6680.899786503206, 6704.061431399584, 6669.199696036482, 6752.324767523258, 6752.729890804411, 6753.189617245913, 6754.290799466084, 6268.749250029993, 6273.0, 6283.308836028079, 6288.622682639057, 6293.0, 27453.450930981267, 29407.0, 29413.264668383246, 29603.851980740175, 29723.108306750833, 2192.8793916334594, 2270.71616047994, 2272.397814579138, 2274.2494976657663, 2279.2250634784086, 19213.231470741153, 19669.803301966942, 19793.307234246877, 19807.702884456743, 19811.90094049535, 2431.9270421887372, 2459.348272707734, 2520.206135067448, 2619.7904167666543, 2627.1855724725397, 137887.0, 142235.0, 154399.0, 160786.19606902008, 161090.0, 15349.0, 15639.765403518957, 15697.607559811097, 16052.197390130446, 16058.036517808969, 24931.376715582257, 25014.749852501605, 25083.372915677253, 25139.371515712253, 25191.74808251894, 10206.795864082676, 10527.894721052844, 10543.630972915911, 10655.89344106549, 10764.192685548458, 9397.436153830791, 9439.76400589977, 9563.0, 9589.568469418893, 9599.760005999906, 9568.277710012126, 9696.806063878683, 9767.218622510181, 9862.753431164136, 9952.950235248922, 2787.567926971323, 2815.8028937974555, 2853.857307134635, 2892.1045545660045, 2898.6086878271585, 1087.2389327470803, 1089.836524521328, 1099.8269991075804, 1099.8350247462945, 1110.8889111088988, 21055.157793688388, 21228.681569776465, 21241.0, 21512.24707135274, 21796.78203217979, 1131.3042478875598, 1133.2124173699365, 1153.066016526616, 1157.8089615213396, 1161.2304653401698, 11640.35978021217, 11747.47136378865, 11762.059035277158, 11817.88182118185, 11929.940350298366, 576685.0, 578192.0, 583019.0, 587597.1240287628, 589412.0, 125007.3749631246, 127029.0, 127957.0, 129031.0, 129422.0, 1147.7991351513451, 1206.1014544164655, 1261.9621411357673, 1269.904757143218, 1328.030537707479, 22324.10703571839, 22494.21270255533, 22774.20290289832, 22799.31602051941, 22802.315930522112, 61382.38617613945, 61941.0, 62294.688526557075, 62393.68803155955, 63323.6833815828, 76891.23108769064, 77006.61496692481, 77083.84374234278, 77232.2276777225, 77489.0, 14579.0, 14594.124352538882, 14651.560453186421, 14661.560153195422, 15044.247787610795, 24192.637110443004, 24212.273631791075, 24294.028238870247, 24485.51028979446, 24543.38641533976, 19170.520736981685, 19560.510987225432, 19626.313079042164, 19654.410367688994, 19699.40901772949, 16470.341186352412, 16502.25739841734, 16570.171491425623, 16759.748603771197, 16794.412195573095, 19708.40874773759, 19801.405957821287, 20584.485387864825, 20622.38132856017, 20726.170953161705, 14842.851571484147, 14883.330250138553, 14942.402303907722, 14987.550373488813, 15003.474878379204, 19813.207471701546, 19888.70166947526, 19978.10098545598, 20102.0, 20134.59730805405], "value": 12705.72964371336, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1397.4200706706717, 1453.2588379926242, 1464.2898194375732, 1467.2956980649292, 1468.8604582564653, 16152.919235403835, 17704.46886593401, 17716.82283177168, 17721.55696107598, 17725.202365893518, 17379.82620173798, 17694.91152544239, 17716.29134834605, 17733.202005909734, 17761.555961100978, 2733.9474302393523, 2820.830750154997, 2826.60427540144, 2829.4058247767994, 2885.5815906693515, 2762.7651649609807, 2820.7320304571135, 2839.1908306132755, 2839.8864045438263, 2840.2757296889367, 2722.605222242774, 2738.246982079934, 2764.156932135698, 2764.350377661248, 2779.680336761268, 2621.03021881903, 2627.9737202628016, 2630.710621831616, 2634.196570046135, 2636.0378461861474, 2548.745125487455, 2597.2467984284535, 2597.493488769691, 2600.0379859452123, 2602.739726027382, 16475.34098636053, 16690.749638755427, 16731.247093880804, 16758.916205419016, 16783.0, 7966.362690984707, 8269.545175015372, 8279.089300176976, 8288.129746376604, 8291.253787159125, 5072.51811077947, 5207.687538747649, 5327.280817089682, 5363.0, 5374.220737992969, 2112.93661190163, 2119.4913220827043, 2129.2121914891436, 2186.147402513021, 2202.0861342542985, 29646.851765741034, 30285.545716814264, 30313.0, 30491.01808382448, 31371.686283137333, 7106.229298854699, 7144.142702875688, 7184.1019872515935, 7288.854222915512, 7422.517536360119, 19492.415227543195, 19562.902185489267, 19581.902090489457, 19681.90159049224, 19696.21215151378, 8286.0, 8358.0, 8410.495370277802, 8438.493690378475, 8446.408751387467, 7257.637118144072, 7362.153352364439, 7579.279968402993, 7651.923480765121, 7763.68945242184, 5643.5767317451355, 5766.250387449605, 5806.44838740319, 5844.824655260349, 5850.0, 1646.3579204110406, 1693.5766058485378, 1701.2769572931454, 1701.3459003953872, 1702.6594681063837, 932.244881645869, 944.1031020530523, 950.7147855643418, 963.7012526116927, 963.802420503795, 8267.421280510307, 8351.0, 8368.832623347498, 8375.748727538183, 8499.065102838682, 794.6304968189819, 797.0515087046397, 798.5368486277945, 799.3844739550514, 811.2860682599274, 5641.2384328116, 5825.300963884361, 5846.795362162304, 6026.668533230627, 6076.179715738407, 24784.628230576556, 25399.873000634878, 25442.618360724606, 25737.485250295264, 25820.35449113787, 24523.632145517833, 24555.140570079962, 25124.371890702878, 25181.87409062943, 25412.872935635205, 10493.160547156209, 10975.451227438596, 12027.218230815144, 12521.812172817416, 12723.363831808558, 10051.949740251544, 10335.121514671036, 10441.68674939753, 10467.633632822815, 10512.106470950055, 20456.386308410772, 21209.575808484053, 21431.357059288246, 21473.78526214718, 21859.45351366165, 21114.472138196666, 21737.34787956364, 21793.346199614036, 21911.12355505762, 22230.110795567995, 12194.573189938665, 12434.37828108609, 12487.687807804878, 12507.437165327765, 12517.874821252035, 14649.414023438943, 14679.045862018935, 14794.852051479347, 14873.628159296104, 14875.776863347275, 12258.387080645754, 12431.44058517387, 12505.56230531927, 12749.93625031869, 12848.550300739429, 12187.634370968884, 12300.446479908247, 12306.446209920754, 12620.873791261969, 12629.0, 11350.489227984595, 11359.829602555803, 11488.54045838157, 11492.310461372344, 11500.597479088192, 8110.959445202736, 8323.126071762377, 8361.498310101413, 8378.204070613281, 8586.356023298153, 8585.399022068395, 8794.780130496789, 8802.471851688919, 8812.735617931472, 8862.246709029805], "value": 7238.4156200296175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.3824363738062, 549.5740800879317, 564.4355644355644, 577.2466930655493, 587.6943989125655, 6267.780627678032, 6291.307956124822, 6348.508100596357, 6358.936410635893, 6383.23401191857, 6208.130861679358, 6236.875262494747, 6262.780802671908, 6328.9683551582175, 6356.173697419341, 5148.124818780816, 5156.561692256153, 5167.586593072564, 5167.612429067816, 5182.922256166161, 5031.698098114125, 5122.282880396729, 5122.412052263791, 5142.305788718531, 5152.355955505562, 4872.147374209517, 5001.399832020163, 5019.171836646949, 5021.723805190713, 5126.436092029874, 4978.502149785028, 5001.699898006095, 5010.574101201402, 5030.999999999982, 5041.521055499722, 4466.665000125004, 4516.1193567254395, 4538.29656403258, 4544.2047641662575, 4551.067031258584, 6144.170536977495, 6183.628982261079, 6189.9381006189815, 6206.937930620727, 6226.159468471789, 5891.175235467038, 5904.350521442638, 5917.911231331534, 5922.170896074553, 5936.5547583931375, 6722.361375669304, 6747.392734653856, 6768.49236307274, 6771.052052712625, 6771.544118014651, 5051.444341122474, 5059.4434612193, 5066.670666406671, 5090.440051594322, 5104.106781313255, 6612.43794277487, 6767.729290828361, 6853.897191542131, 6865.5537390069985, 7009.824754381181, 5120.359955005624, 5137.1010073237785, 5157.303763991813, 5187.351581052369, 5200.66195697286, 5220.399654039758, 5230.770768869313, 5275.757802933737, 5276.3932147802725, 5300.31095957523, 5761.0, 5762.596618236683, 5834.8541286467325, 5842.42254591258, 5875.236219291465, 6702.731890724316, 6709.289131271495, 6739.494537909676, 6739.59562426256, 6777.356151165632, 1827.4608990347879, 1830.6979348407363, 1833.275856036858, 1841.1070630744077, 1841.8066103059255, 1247.457356050121, 1289.1749280460513, 1290.7031382782013, 1294.825198598196, 1310.737852429518, 6303.149074874925, 6303.401176888188, 6309.08518264849, 6324.177856878577, 6358.682065896686, 6636.966815165893, 6694.49791265657, 6729.798106056826, 6773.729050837911, 6802.8299292517095, 5997.940020599825, 6158.291796443376, 6185.969070154711, 6218.782342617987, 6260.342664020303, 3545.7517973742106, 3556.5376501054698, 3584.336897673939, 3588.982055089708, 3595.6224596417, 7049.823754406181, 7050.294970503011, 7083.150021997393, 7131.89302160468, 7134.92865071353, 6888.345607167411, 6984.546004509691, 6998.475114366341, 7000.544964577286, 7024.964875175694, 7097.396721278749, 7102.762629771605, 7151.713931442684, 7165.7850264492145, 7169.749058782918, 6645.700943457459, 6800.149981252343, 6847.589144651337, 6875.656217189221, 6877.793666190022, 6758.898616520854, 6772.52592318533, 6835.14560679915, 6848.9657551711925, 6861.965690171517, 7153.463490238357, 7170.2471240519, 7173.641317934187, 7203.927960720326, 7215.891761623685, 5142.151544995034, 5207.791688332424, 5244.396894357045, 5257.106291930305, 5277.868053298698, 6601.834954126185, 6679.2300040488335, 6773.390394864486, 6842.315768423118, 6927.653617319214, 6485.77299794505, 6541.967290163519, 6548.377904099103, 6619.933800662125, 6629.204495460575, 6543.214814222324, 6557.9344206557325, 6572.286658038193, 6578.427992545136, 6580.440662543738, 6425.261094973951, 6442.613443193423, 6471.741130354733, 6483.157189565326, 6504.877658723744, 6649.63427011519, 6670.433013193933, 6689.464842812466, 6699.129113215446, 6756.594604323756, 6459.5478316519275, 6478.255000674794, 6527.738890444519, 6529.836754080996, 6533.379328963741], "value": 5219.3773973128755, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [972.581789830373, 994.4530508220479, 1001.7645853224491, 1022.6267412394478, 1025.1593693171603, 16931.0, 16951.915240423798, 16980.235889384978, 17147.142642867853, 17157.656846863054, 17045.829541704577, 17222.224999875005, 17406.129693515304, 17411.564710882234, 17430.564235894108, 1058.8517607534932, 1073.2058276875134, 1075.4998925499642, 1080.3301952789282, 1081.2863510083346, 1082.5723839083557, 1093.038126448724, 1093.8413929980147, 1094.0263165782421, 1094.0536435982897, 1075.451519724942, 1119.451468780296, 1121.388843080523, 1139.5043156227068, 1140.6064907606903, 1114.0864491117286, 1116.3748300951452, 1120.3501968858084, 1121.2823792772633, 1123.2530367305774, 796.3828033274201, 816.2449733996029, 825.7687847402677, 830.887830142929, 831.3183189784379, 16677.08276044817, 16870.578235544086, 16924.23840927149, 16935.915320423443, 16942.49172524814, 22327.0, 22752.772472275232, 22928.885355573282, 23005.19481818145, 23093.769062309497, 15399.076055436597, 15679.608009799733, 15772.211389430482, 15820.05079695222, 15843.049417035014, 3877.263319969197, 3878.3406820840523, 3925.3326934421216, 3926.293267211901, 3931.312020396419, 119857.0, 149680.2515987424, 150672.0, 152331.0, 154209.2289538545, 17795.19921603531, 18297.908510457364, 18431.72352414715, 18552.907235464005, 18562.350317738816, 34171.658283417346, 34745.0, 34746.478802817976, 34787.0, 35592.28815423677, 9346.439213647067, 9365.157135857806, 9402.059794020543, 9408.811823763486, 9415.0, 4310.956890431055, 4373.934390984138, 4383.846565370197, 4386.342048692658, 4387.319965405367, 5937.406259374115, 6033.577649564576, 6118.296395914438, 6135.631862088289, 6157.84605384869, 1062.4315990944808, 1089.1341383600056, 1090.9890901090887, 1104.5692180049787, 1109.7392112853472, 757.3373298363931, 761.77146855943, 772.3242163107282, 780.1106738318322, 786.7561056072636, 12412.317322547347, 12638.684032899251, 12711.491540338468, 13032.674183145496, 13270.270135142468, 754.1101500229781, 758.5524540521119, 764.3197554176787, 773.9806504837425, 777.5917643237233, 5810.912836307459, 5922.644641321448, 5954.345022047572, 6061.727222275008, 6092.908606370819, 136885.31557342148, 141557.0, 142316.0, 142796.28601856926, 144472.0, 121333.0, 125431.3728431352, 125680.37159814325, 126356.36821815833, 126380.36809815893, 107731.0, 109400.0, 112066.0, 114014.0, 114932.0, 11037.172212084286, 11124.61063862761, 11178.496967636313, 11224.15818813576, 11346.432678366215, 50901.49098508967, 51193.7440312796, 52127.73936130295, 52959.0, 53721.0, 66080.66959665171, 66133.0, 66573.33426665672, 66737.66631166813, 66802.3319766796, 15629.843701563294, 15650.686986259983, 15878.52364429069, 15955.20223988819, 15962.760558591863, 17387.0, 17409.56476088108, 17646.91176544109, 17713.557161071076, 17743.911280443514, 16082.919585401998, 16159.353625854834, 16204.513864584082, 16741.832581674516, 16840.326386944384, 17319.826801732324, 17343.739843902098, 17367.392141274995, 17467.56331091682, 17614.11929403499, 17424.73862892083, 17428.651426971643, 17550.473485795446, 17712.645747084727, 17786.199621016825, 11450.198486105892, 11549.6535103947, 11611.303321800719, 11657.300561966309, 11798.882011179778, 12055.939720301343, 12151.635450936486, 12397.93801030989, 12417.254964702146, 12484.43820028119], "value": 9482.711121509257, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1369.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 105.0, 105.0, 106.0, 108.0, 104.0, 106.0, 107.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 111.0, 112.0, 137.0, 115.0, 114.0, 121.0, 112.0, 113.0], "value": 116.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 162.0, 163.0, 163.0, 162.0, 161.0, 163.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 73.0, 73.0, 73.0, 72.0, 71.0, 76.0, 78.0], "value": 73.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 77.0, 76.0, 78.0, 78.0, 76.0, 77.0, 77.0, 78.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 114.0, 114.0, 114.0, 113.0, 113.0, 111.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 154.0, 149.0, 151.0, 149.0, 148.0, 150.0, 153.0, 151.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 98.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 45.0, 44.0, 43.0, 48.0, 47.0, 44.0, 47.0, 45.0, 43.0], "value": 45.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 39.0, 39.0, 38.0, 38.0, 38.0, 39.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 74.0, 70.0, 71.0, 72.0, 70.0, 70.0, 70.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 102.0, 103.0, 106.0, 107.0, 104.0, 110.0, 110.0, 111.0, 105.0], "value": 106.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 156.0, 151.0, 151.0, 158.0, 155.0, 151.0, 159.0, 159.0, 151.0], "value": 154.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 61.0, 59.0, 58.0, 60.0, 62.0, 59.0, 64.0, 58.0], "value": 60.0, "unit": "score"}]}]} 03:43:57 INFO - Return code: 0 03:43:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:57 INFO - # TBPL SUCCESS # 03:43:57 INFO - Running post-action listener: _package_coverage_data 03:43:57 INFO - Running post-action listener: _resource_record_post_action 03:43:57 INFO - [mozharness: 2017-09-19 10:43:57.715052Z] Finished run-tests step (success) 03:43:57 INFO - Running post-run listener: _resource_record_post_run 03:43:57 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 326328320; Read time: 156; Write time: 148644 03:43:57 INFO - TinderboxPrint: CPU usage
13.0% 03:43:57 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 156 03:43:57 INFO - TinderboxPrint: I/O write bytes / time
326,328,320 / 148,644 03:43:57 INFO - TinderboxPrint: CPU idle
8,214.3 (86.9%) 03:43:57 INFO - TinderboxPrint: CPU user
1,185.1 (12.5%) 03:43:57 INFO - TinderboxPrint: Swap in / out
0 / 0 03:43:57 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9457664; Read time: 0; Write time: 608 03:43:57 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:43:57 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 8192; Write bytes: 316256256; Read time: 156; Write time: 148036 03:43:58 INFO - Running post-run listener: _upload_blobber_files 03:43:58 INFO - Blob upload gear active. 03:43:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:43:58 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'] 03:43:58 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 03:43:58 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:43:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:00 INFO - (blobuploader) - INFO - Done attempting. 03:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:44:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:01 INFO - (blobuploader) - INFO - Done attempting. 03:44:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:02 INFO - (blobuploader) - INFO - Done attempting. 03:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:06 INFO - (blobuploader) - INFO - Done attempting. 03:44:06 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:06 INFO - Return code: 0 03:44:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5bd49f30202446ff21a8caa32142b5a1ac87fdfcd70e61fce23e26276fd27773606d959cff85e813380eeef0b0e1ab876789b391d0ee454ed44ab88723be73e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ac4513e2847f3dbfbc566bddb61ba040352e01b106db168fba7ecdc4935d73fa5a4a9f9a5699ab6cd07536ffc636a17f9777f3dd158d823cc7b232b00c32fe", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb8dcccd90543d802773cf389b06f937bf118658132e168e4ba49636644a5fbbd4c74da34a8235a3e8160fa53b0b8d2607bb91a4dd970c5453df49870ee19cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/258725fbfa7c79d8295f47d25c28c14ae23a6c61eedd167360d27780791b292dec5ca6925c31d74a157763ac3885cc0d14ace523e8ee6929c4fb5f7e7c2378c2"} 03:44:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:06 INFO - Contents: 03:44:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5bd49f30202446ff21a8caa32142b5a1ac87fdfcd70e61fce23e26276fd27773606d959cff85e813380eeef0b0e1ab876789b391d0ee454ed44ab88723be73e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ac4513e2847f3dbfbc566bddb61ba040352e01b106db168fba7ecdc4935d73fa5a4a9f9a5699ab6cd07536ffc636a17f9777f3dd158d823cc7b232b00c32fe", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb8dcccd90543d802773cf389b06f937bf118658132e168e4ba49636644a5fbbd4c74da34a8235a3e8160fa53b0b8d2607bb91a4dd970c5453df49870ee19cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/258725fbfa7c79d8295f47d25c28c14ae23a6c61eedd167360d27780791b292dec5ca6925c31d74a157763ac3885cc0d14ace523e8ee6929c4fb5f7e7c2378c2"} 03:44:06 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:06 INFO - Copying logs to upload dir... 03:44:06 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.906328 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-09-19 03:44:06.425876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:44:06.429722) ========= 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=483e410453545d07cca6935c000001ab-1505816471.235603-1652916788 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/c5bd49f30202446ff21a8caa32142b5a1ac87fdfcd70e61fce23e26276fd27773606d959cff85e813380eeef0b0e1ab876789b391d0ee454ed44ab88723be73e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ac4513e2847f3dbfbc566bddb61ba040352e01b106db168fba7ecdc4935d73fa5a4a9f9a5699ab6cd07536ffc636a17f9777f3dd158d823cc7b232b00c32fe", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb8dcccd90543d802773cf389b06f937bf118658132e168e4ba49636644a5fbbd4c74da34a8235a3e8160fa53b0b8d2607bb91a4dd970c5453df49870ee19cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/258725fbfa7c79d8295f47d25c28c14ae23a6c61eedd167360d27780791b292dec5ca6925c31d74a157763ac3885cc0d14ace523e8ee6929c4fb5f7e7c2378c2"} build_url:https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/XOvwxOU7QG2Ewekbfzv2aw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5bd49f30202446ff21a8caa32142b5a1ac87fdfcd70e61fce23e26276fd27773606d959cff85e813380eeef0b0e1ab876789b391d0ee454ed44ab88723be73e", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/27ac4513e2847f3dbfbc566bddb61ba040352e01b106db168fba7ecdc4935d73fa5a4a9f9a5699ab6cd07536ffc636a17f9777f3dd158d823cc7b232b00c32fe", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ccb8dcccd90543d802773cf389b06f937bf118658132e168e4ba49636644a5fbbd4c74da34a8235a3e8160fa53b0b8d2607bb91a4dd970c5453df49870ee19cd", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/258725fbfa7c79d8295f47d25c28c14ae23a6c61eedd167360d27780791b292dec5ca6925c31d74a157763ac3885cc0d14ace523e8ee6929c4fb5f7e7c2378c2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-19 03:44:06.458236) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:44:06.458572) ========= 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=483e410453545d07cca6935c000001ab-1505816471.235603-1652916788 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-19 03:44:06.542285) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:44:06.542612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-19 03:44:06.542989) ========= ========= Total master_lag: 0.20 =========