builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-069 starttime: 1505915068.73 results: success (0) revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:28.725689) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:28.726108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:28.726373) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:28.747451) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:28.747748) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-20 06:44:29-- 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% 91.1M=0s 2017-09-20 06:44:29 (91.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.374333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.145058) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.145381) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018612 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:29.219978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 06:44:29.220306) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 --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=05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-20 06:44:29,686 truncating revision to first 12 chars 2017-09-20 06:44:29,686 Setting DEBUG logging. 2017-09-20 06:44:29,686 attempt 1/10 2017-09-20 06:44:29,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0c49ebf4195c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-20 06:44:30,407 unpacking tar archive at: mozilla-central-0c49ebf4195c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.061794 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-09-20 06:44:30.303097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.303416) ========= script_repo_revision: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.306822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.307100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-20 06:44:30.320292) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-20 06:44:30.320618) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-stylo-disabled-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:44:30 INFO - MultiFileLogger online at 20170920 06:44:30 in /builds/slave/test 06:44:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:44:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:44:30 INFO - {'append_to_log': False, 06:44:30 INFO - 'base_work_dir': '/builds/slave/test', 06:44:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:44:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:44:30 INFO - 'branch': 'Firefox-Non-PGO', 06:44:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:44:30 INFO - 'code_coverage': False, 06:44:30 INFO - 'config_files': ('talos/linux_config.py',), 06:44:30 INFO - 'default_actions': ('clobber', 06:44:30 INFO - 'read-buildbot-config', 06:44:30 INFO - 'download-and-extract', 06:44:30 INFO - 'populate-webroot', 06:44:30 INFO - 'create-virtualenv', 06:44:30 INFO - 'install', 06:44:30 INFO - 'setup-mitmproxy', 06:44:30 INFO - 'run-tests'), 06:44:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:44:30 INFO - 'disable_ccov_upload': False, 06:44:30 INFO - 'disable_stylo': False, 06:44:30 INFO - 'download_minidump_stackwalk': True, 06:44:30 INFO - 'download_symbols': 'ondemand', 06:44:30 INFO - 'enable_stylo': False, 06:44:30 INFO - 'enable_webrender': False, 06:44:30 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 06:44:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:44:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:44:30 INFO - 'gecko_profile': False, 06:44:30 INFO - 'gecko_profile_interval': 0, 06:44:30 INFO - 'installer_path': 'installer.exe', 06:44:30 INFO - 'log_level': 'info', 06:44:30 INFO - 'log_name': 'talos', 06:44:30 INFO - 'log_to_console': True, 06:44:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:44:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:44:30 INFO - 'opt_config_files': (), 06:44:30 INFO - 'pip_index': False, 06:44:30 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 06:44:30 INFO - 'system_bits': '32', 06:44:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:44:30 INFO - 'title': 'talos-linux64-ix-069', 06:44:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:44:30 INFO - 'use_talos_json': True, 06:44:30 INFO - 'verify': 'False', 06:44:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:44:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:44:30 INFO - 'work_dir': 'build'} 06:44:30 INFO - [mozharness: 2017-09-20 13:44:30.924420Z] Running clobber step. 06:44:30 INFO - Running pre-action listener: _resource_record_pre_action 06:44:30 INFO - Running main action method: clobber 06:44:30 INFO - rmtree: /builds/slave/test/build 06:44:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:44:31 INFO - Running post-action listener: _resource_record_post_action 06:44:31 INFO - [mozharness: 2017-09-20 13:44:31.940205Z] Finished clobber step (success) 06:44:31 INFO - [mozharness: 2017-09-20 13:44:31.940302Z] Running read-buildbot-config step. 06:44:31 INFO - Running pre-action listener: _resource_record_pre_action 06:44:31 INFO - Running main action method: read_buildbot_config 06:44:31 INFO - Using buildbot properties: 06:44:31 INFO - { 06:44:31 INFO - "project": "", 06:44:31 INFO - "product": "firefox", 06:44:31 INFO - "who": "archaeopteryx@coole-files.de", 06:44:31 INFO - "installer_path": "public/build/target.tar.bz2", 06:44:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 06:44:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 06:44:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 06:44:31 INFO - "stage_platform": "linux64", 06:44:31 INFO - "basedir": "/builds/slave/test", 06:44:31 INFO - "buildnumber": 47, 06:44:31 INFO - "platform": "ubuntu64_hw", 06:44:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:44:31 INFO - "slavebuilddir": "test", 06:44:31 INFO - "taskId": "aK1hFgJmR7yM_PWYPoLbWQ", 06:44:31 INFO - "branch": "mozilla-central", 06:44:31 INFO - "script_repo_revision": "production", 06:44:31 INFO - "revision": "0c49ebf4195ce51072b24aacf01eaaffdcff9be6", 06:44:31 INFO - "slavename": "talos-linux64-ix-069", 06:44:31 INFO - "repo_path": "mozilla-central" 06:44:31 INFO - } 06:44:31 INFO - Finding installer, test and symbols from parent task. 06:44:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aK1hFgJmR7yM_PWYPoLbWQ'}, attempt #1 06:44:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aK1hFgJmR7yM_PWYPoLbWQ'}, attempt #1 06:44:32 INFO - Task dependencies: VjX7h9b1Rg6WbANrHaKj3g 06:44:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g'}, attempt #1 06:44:33 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:33 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json 06:44:33 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip 06:44:33 INFO - Running post-action listener: _resource_record_post_action 06:44:33 INFO - [mozharness: 2017-09-20 13:44:33.292158Z] Finished read-buildbot-config step (success) 06:44:33 INFO - [mozharness: 2017-09-20 13:44:33.292375Z] Running download-and-extract step. 06:44:33 INFO - Running pre-action listener: _resource_record_pre_action 06:44:33 INFO - Running main action method: download_and_extract 06:44:33 INFO - mkdir: /builds/slave/test/build/tests 06:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:44:33 INFO - trying https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json 06:44:33 INFO - Downloading https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:44:33 INFO - Downloaded 989 bytes. 06:44:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:44:33 INFO - Using the following test package requirements: 06:44:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:44:33 INFO - u'common': [u'target.common.tests.zip'], 06:44:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:44:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:44:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:44:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:44:33 INFO - u'mozbase': [u'target.common.tests.zip'], 06:44:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:44:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:44:33 INFO - u'web-platform': [u'target.common.tests.zip', 06:44:33 INFO - u'target.web-platform.tests.tar.gz'], 06:44:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:44:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 06:44:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip 06:44:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:44:33 INFO - Fetch https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.common.tests.zip into memory 06:44:34 INFO - Content-Length response header: 54731862 06:44:34 INFO - Bytes received: 54731862 06:44:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip 06:44:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:44:45 INFO - Fetch https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.talos.tests.zip into memory 06:44:46 INFO - Content-Length response header: 14508893 06:44:46 INFO - Bytes received: 14508893 06:44:46 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')]} 06:44:46 INFO - trying https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:46 INFO - Downloading https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:44:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:44:48 INFO - Downloaded 61637786 bytes. 06:44:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:48 INFO - mkdir: /builds/slave/test/properties 06:44:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:44:48 INFO - Writing to file /builds/slave/test/properties/build_url 06:44:48 INFO - Contents: 06:44:48 INFO - build_url:https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 06:44:48 INFO - Running post-action listener: _resource_record_post_action 06:44:48 INFO - Running post-action listener: find_tests_for_verification 06:44:48 INFO - Running post-action listener: set_extra_try_arguments 06:44:48 INFO - [mozharness: 2017-09-20 13:44:48.826343Z] Finished download-and-extract step (success) 06:44:48 INFO - [mozharness: 2017-09-20 13:44:48.826438Z] Running populate-webroot step. 06:44:48 INFO - Running pre-action listener: _resource_record_pre_action 06:44:48 INFO - Running main action method: populate_webroot 06:44:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:44:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['tresize', 06:44:48 INFO - 'tcanvasmark']}, 06:44:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:44:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['dromaeo_css', 06:44:48 INFO - 'kraken']}, 06:44:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:44:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'tests': ['damp', 'tps']}, 06:44:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['damp', 'tps']}, 06:44:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:44:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['dromaeo_dom']}, 06:44:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:44:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['basic_compositor_video', 06:44:48 INFO - 'glvideo']}, 06:44:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:44:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['ts_paint_webext', 06:44:48 INFO - 'tp5o_webext']}, 06:44:48 INFO - 'other-e10s': {'tests': ['a11yr', 06:44:48 INFO - 'ts_paint', 06:44:48 INFO - 'tpaint', 06:44:48 INFO - 'sessionrestore', 06:44:48 INFO - 'sessionrestore_many_windows', 06:44:48 INFO - 'sessionrestore_no_auto_restore', 06:44:48 INFO - 'tabpaint']}, 06:44:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['a11yr', 06:44:48 INFO - 'ts_paint', 06:44:48 INFO - 'tpaint', 06:44:48 INFO - 'sessionrestore', 06:44:48 INFO - 'sessionrestore_many_windows', 06:44:48 INFO - 'sessionrestore_no_auto_restore', 06:44:48 INFO - 'tabpaint']}, 06:44:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:44:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 06:44:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['perf_reftest_singletons']}, 06:44:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['bloom_basic']}, 06:44:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:44:48 INFO - 'tsvgr_opacity', 06:44:48 INFO - 'tart', 06:44:48 INFO - 'tscrollx', 06:44:48 INFO - 'tsvg_static']}, 06:44:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['tsvgx', 06:44:48 INFO - 'tsvgr_opacity', 06:44:48 INFO - 'tart', 06:44:48 INFO - 'tscrollx', 06:44:48 INFO - 'tsvg_static']}, 06:44:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:44:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'talos_options': ['--disable-stylo'], 06:44:48 INFO - 'tests': ['tp5o']}, 06:44:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:48 INFO - 'talos_options': ['--mitmproxy', 06:44:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:48 INFO - '--firstNonBlankPaint'], 06:44:48 INFO - 'tests': ['tp6_google', 06:44:48 INFO - 'tp6_youtube', 06:44:48 INFO - 'tp6_amazon', 06:44:48 INFO - 'tp6_facebook']}, 06:44:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:48 INFO - 'talos_options': ['--disable-stylo', 06:44:48 INFO - '--mitmproxy', 06:44:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:48 INFO - '--firstNonBlankPaint'], 06:44:48 INFO - 'tests': ['tp6_google', 06:44:48 INFO - 'tp6_youtube', 06:44:48 INFO - 'tp6_amazon', 06:44:48 INFO - 'tp6_facebook']}, 06:44:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:44:48 INFO - 'talos_options': ['--stylo-threads=1', 06:44:48 INFO - '--mitmproxy', 06:44:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:44:48 INFO - '--firstNonBlankPaint'], 06:44:48 INFO - 'tests': ['tp6_google', 06:44:48 INFO - 'tp6_youtube', 06:44:48 INFO - 'tp6_amazon', 06:44:48 INFO - 'tp6_facebook']}, 06:44:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'talos_options': ['--xperf_path', 06:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:48 INFO - 'tests': ['tp5n']}, 06:44:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 06:44:48 INFO - 'talos_options': ['--disable-stylo', 06:44:48 INFO - '--xperf_path', 06:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:44:48 INFO - 'tests': ['tp5n']}}} 06:44:48 INFO - Running post-action listener: _resource_record_post_action 06:44:48 INFO - [mozharness: 2017-09-20 13:44:48.841409Z] Finished populate-webroot step (success) 06:44:48 INFO - [mozharness: 2017-09-20 13:44:48.841511Z] Running create-virtualenv step. 06:44:48 INFO - Running pre-action listener: _resource_record_pre_action 06:44:48 INFO - Running main action method: create_virtualenv 06:44:48 INFO - Creating virtualenv /builds/slave/test/build/venv 06:44:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:44:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 06:44:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:44:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:44:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:44:49 INFO - Installing distribute.............................................................................................................................................................................................done. 06:44:49 INFO - Installing pip...............done. 06:44:49 INFO - Return code: 0 06:44:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:44:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:44:49 INFO - Reading from file tmpfile_stdout 06:44:49 INFO - Output received: 06:44:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 06:44:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44: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')]} 06:44:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:49 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:44:49 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 06:44:49 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 06:44:49 INFO - Using env: {'DISPLAY': ':0', 06:44:49 INFO - 'HOME': '/home/cltbld', 06:44:49 INFO - 'LANG': 'en_US.UTF-8', 06:44:49 INFO - 'LANGUAGE': 'en_US:en', 06:44:49 INFO - 'LOGNAME': 'cltbld', 06:44:49 INFO - 'MAIL': '/var/mail/cltbld', 06:44:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:49 INFO - 'MOZ_NO_REMOTE': '1', 06:44:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:49 INFO - 'NO_EM_RESTART': '1', 06:44:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:49 INFO - 'PWD': '/builds/slave/test', 06:44:49 INFO - 'SHELL': '/bin/bash', 06:44:49 INFO - 'SHLVL': '1', 06:44:49 INFO - 'TERM': 'linux', 06:44:49 INFO - 'TMOUT': '86400', 06:44:49 INFO - 'USER': 'cltbld', 06:44:49 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:44:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:49 INFO - '_': '/tools/buildbot/bin/python'} 06:44:51 INFO - Ignoring indexes: http://pypi.python.org/simple/ 06:44:51 INFO - Downloading/unpacking pip>=1.5 06:44:51 INFO - Running setup.py egg_info for package pip 06:44:51 INFO - warning: no files found matching 'pip/cacert.pem' 06:44:51 INFO - warning: no files found matching '*.html' under directory 'docs' 06:44:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:44:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:44:51 INFO - Installing collected packages: pip 06:44:51 INFO - Found existing installation: pip 1.1 06:44:51 INFO - Uninstalling pip: 06:44:51 INFO - Successfully uninstalled pip 06:44:51 INFO - Running setup.py install for pip 06:44:51 INFO - warning: no files found matching 'pip/cacert.pem' 06:44:51 INFO - warning: no files found matching '*.html' under directory 'docs' 06:44:51 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 06:44:51 INFO - no previously-included directories found matching 'docs/_build/_sources' 06:44:51 INFO - Installing pip script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 06:44:51 INFO - Successfully installed pip 06:44:51 INFO - Cleaning up... 06:44:51 INFO - Return code: 0 06:44:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:44:51 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')]} 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:51 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')]} 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:51 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:44:51 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 06:44:51 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 06:44:51 INFO - Using env: {'DISPLAY': ':0', 06:44:51 INFO - 'HOME': '/home/cltbld', 06:44:51 INFO - 'LANG': 'en_US.UTF-8', 06:44:51 INFO - 'LANGUAGE': 'en_US:en', 06:44:51 INFO - 'LOGNAME': 'cltbld', 06:44:51 INFO - 'MAIL': '/var/mail/cltbld', 06:44:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:51 INFO - 'MOZ_NO_REMOTE': '1', 06:44:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:51 INFO - 'NO_EM_RESTART': '1', 06:44:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:51 INFO - 'PWD': '/builds/slave/test', 06:44:51 INFO - 'SHELL': '/bin/bash', 06:44:51 INFO - 'SHLVL': '1', 06:44:51 INFO - 'TERM': 'linux', 06:44:51 INFO - 'TMOUT': '86400', 06:44:51 INFO - 'USER': 'cltbld', 06:44:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:44:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:51 INFO - '_': '/tools/buildbot/bin/python'} 06:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:51 INFO - Downloading/unpacking psutil>=3.1.1 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:44:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:52 INFO - Installing collected packages: psutil 06:44:52 INFO - Running setup.py install for psutil 06:44:52 INFO - building 'psutil._psutil_linux' extension 06:44:52 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 06:44:52 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 06:44:52 INFO - building 'psutil._psutil_posix' extension 06:44:52 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 06:44:53 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 06:44:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:44:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:44:53 INFO - Successfully installed psutil 06:44:53 INFO - Cleaning up... 06:44:53 INFO - Return code: 0 06:44:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:44: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')]} 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44: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')]} 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:44: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:44: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 mozsystemmonitor==0.3 06:44:53 INFO - Using env: {'DISPLAY': ':0', 06:44:53 INFO - 'HOME': '/home/cltbld', 06:44:53 INFO - 'LANG': 'en_US.UTF-8', 06:44:53 INFO - 'LANGUAGE': 'en_US:en', 06:44:53 INFO - 'LOGNAME': 'cltbld', 06:44:53 INFO - 'MAIL': '/var/mail/cltbld', 06:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:53 INFO - 'MOZ_NO_REMOTE': '1', 06:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:53 INFO - 'NO_EM_RESTART': '1', 06:44:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:53 INFO - 'PWD': '/builds/slave/test', 06:44:53 INFO - 'SHELL': '/bin/bash', 06:44:53 INFO - 'SHLVL': '1', 06:44:53 INFO - 'TERM': 'linux', 06:44:53 INFO - 'TMOUT': '86400', 06:44:53 INFO - 'USER': 'cltbld', 06:44:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:53 INFO - '_': '/tools/buildbot/bin/python'} 06:44:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:44:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:44:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:44:54 INFO - Installing collected packages: mozsystemmonitor 06:44:54 INFO - Running setup.py install for mozsystemmonitor 06:44:54 INFO - Successfully installed mozsystemmonitor 06:44:54 INFO - Cleaning up... 06:44:56 INFO - Return code: 0 06:44:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:44:56 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')]} 06:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:56 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')]} 06:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:56 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:44:56 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 06:44:56 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 06:44:56 INFO - Using env: {'DISPLAY': ':0', 06:44:56 INFO - 'HOME': '/home/cltbld', 06:44:56 INFO - 'LANG': 'en_US.UTF-8', 06:44:56 INFO - 'LANGUAGE': 'en_US:en', 06:44:56 INFO - 'LOGNAME': 'cltbld', 06:44:56 INFO - 'MAIL': '/var/mail/cltbld', 06:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:56 INFO - 'MOZ_NO_REMOTE': '1', 06:44:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:56 INFO - 'NO_EM_RESTART': '1', 06:44:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:56 INFO - 'PWD': '/builds/slave/test', 06:44:56 INFO - 'SHELL': '/bin/bash', 06:44:56 INFO - 'SHLVL': '1', 06:44:56 INFO - 'TERM': 'linux', 06:44:56 INFO - 'TMOUT': '86400', 06:44:56 INFO - 'USER': 'cltbld', 06:44:56 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:56 INFO - '_': '/tools/buildbot/bin/python'} 06:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:56 INFO - Downloading/unpacking jsonschema==2.5.1 06:44: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 06:44: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 06:44: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 06:44: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 06:44:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:44:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:44:57 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 06:44:57 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 06:44:57 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 06:44:57 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 06:44:57 INFO - Downloading functools32-3.2.3-2.tar.gz 06:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:44:57 INFO - warning: no files found matching '*.txt' 06:44:57 INFO - no previously-included directories found matching 'build' 06:44:57 INFO - no previously-included directories found matching 'dist' 06:44:57 INFO - no previously-included directories found matching '.git*' 06:44:57 INFO - Installing collected packages: jsonschema, functools32 06:44:57 INFO - Running setup.py install for functools32 06:44:57 INFO - warning: no files found matching '*.txt' 06:44:57 INFO - no previously-included directories found matching 'build' 06:44:57 INFO - no previously-included directories found matching 'dist' 06:44:57 INFO - no previously-included directories found matching '.git*' 06:44:57 INFO - Successfully installed jsonschema functools32 06:44:57 INFO - Cleaning up... 06:44:58 INFO - Return code: 0 06:44:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:44:58 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')]} 06:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:58 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')]} 06:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:58 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:44:58 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 06:44:58 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 06:44:58 INFO - Using env: {'DISPLAY': ':0', 06:44:58 INFO - 'HOME': '/home/cltbld', 06:44:58 INFO - 'LANG': 'en_US.UTF-8', 06:44:58 INFO - 'LANGUAGE': 'en_US:en', 06:44:58 INFO - 'LOGNAME': 'cltbld', 06:44:58 INFO - 'MAIL': '/var/mail/cltbld', 06:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:58 INFO - 'MOZ_NO_REMOTE': '1', 06:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:58 INFO - 'NO_EM_RESTART': '1', 06:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:58 INFO - 'PWD': '/builds/slave/test', 06:44:58 INFO - 'SHELL': '/bin/bash', 06:44:58 INFO - 'SHLVL': '1', 06:44:58 INFO - 'TERM': 'linux', 06:44:58 INFO - 'TMOUT': '86400', 06:44:58 INFO - 'USER': 'cltbld', 06:44:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:58 INFO - '_': '/tools/buildbot/bin/python'} 06:44:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:44:58 INFO - Cleaning up... 06:44:58 INFO - Return code: 0 06:44:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:44:58 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')]} 06:44:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:44:58 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')]} 06:44:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:44:58 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:44:58 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 06:44:58 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 06:44:58 INFO - Using env: {'DISPLAY': ':0', 06:44:58 INFO - 'HOME': '/home/cltbld', 06:44:58 INFO - 'LANG': 'en_US.UTF-8', 06:44:58 INFO - 'LANGUAGE': 'en_US:en', 06:44:58 INFO - 'LOGNAME': 'cltbld', 06:44:58 INFO - 'MAIL': '/var/mail/cltbld', 06:44:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:44:58 INFO - 'MOZ_NO_REMOTE': '1', 06:44:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:44:58 INFO - 'NO_EM_RESTART': '1', 06:44:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:44:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:44:58 INFO - 'PWD': '/builds/slave/test', 06:44:58 INFO - 'SHELL': '/bin/bash', 06:44:58 INFO - 'SHLVL': '1', 06:44:58 INFO - 'TERM': 'linux', 06:44:58 INFO - 'TMOUT': '86400', 06:44:58 INFO - 'USER': 'cltbld', 06:44:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:44:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:44:58 INFO - '_': '/tools/buildbot/bin/python'} 06:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:44:59 INFO - Downloading/unpacking blobuploader==1.2.4 06:44: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 06:44: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 06:44: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 06:44: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 06:45:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:45:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:45: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 06:45: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 06:45: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 06:45: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 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:45:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:45: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 06:45: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 06:45: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 06:45: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 06:45:00 INFO - Downloading docopt-0.6.1.tar.gz 06:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:45:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:45:00 INFO - Running setup.py install for blobuploader 06:45:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:45:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:45:00 INFO - Running setup.py install for requests 06:45:01 INFO - Running setup.py install for docopt 06:45:01 INFO - Successfully installed blobuploader requests docopt 06:45:01 INFO - Cleaning up... 06:45:01 INFO - Return code: 0 06:45:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:01 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')]} 06:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:01 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')]} 06:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:01 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:45:01 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 06:45:01 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 06:45:01 INFO - Using env: {'DISPLAY': ':0', 06:45:01 INFO - 'HOME': '/home/cltbld', 06:45:01 INFO - 'LANG': 'en_US.UTF-8', 06:45:01 INFO - 'LANGUAGE': 'en_US:en', 06:45:01 INFO - 'LOGNAME': 'cltbld', 06:45:01 INFO - 'MAIL': '/var/mail/cltbld', 06:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:01 INFO - 'MOZ_NO_REMOTE': '1', 06:45:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:01 INFO - 'NO_EM_RESTART': '1', 06:45:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:01 INFO - 'PWD': '/builds/slave/test', 06:45:01 INFO - 'SHELL': '/bin/bash', 06:45:01 INFO - 'SHLVL': '1', 06:45:01 INFO - 'TERM': 'linux', 06:45:01 INFO - 'TMOUT': '86400', 06:45:01 INFO - 'USER': 'cltbld', 06:45:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:01 INFO - '_': '/tools/buildbot/bin/python'} 06:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:01 INFO - Running setup.py (path:/tmp/pip-T5YCWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:01 INFO - Running setup.py (path:/tmp/pip-hgVO1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:01 INFO - Running setup.py (path:/tmp/pip-9ryeK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:01 INFO - Running setup.py (path:/tmp/pip-FMqGbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:01 INFO - Running setup.py (path:/tmp/pip-iuxKha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:02 INFO - Running setup.py (path:/tmp/pip-KXBAWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:02 INFO - Running setup.py (path:/tmp/pip-g6quGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:02 INFO - Running setup.py (path:/tmp/pip-ULxAHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:02 INFO - Running setup.py (path:/tmp/pip-gpo0Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:02 INFO - Running setup.py (path:/tmp/pip-VMvv93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:02 INFO - Running setup.py (path:/tmp/pip-mClL0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:02 INFO - Running setup.py (path:/tmp/pip-rnf_Qt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:02 INFO - Running setup.py (path:/tmp/pip-JLsD9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:02 INFO - Running setup.py (path:/tmp/pip-UDqCnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:02 INFO - Running setup.py (path:/tmp/pip-tPCdU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:02 INFO - Running setup.py (path:/tmp/pip-VMcyl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:02 INFO - Running setup.py (path:/tmp/pip-6ueTHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:45:02 INFO - Running setup.py install for manifestparser 06:45:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:45:02 INFO - Running setup.py install for mozcrash 06:45:03 INFO - Running setup.py install for mozdebug 06:45:03 INFO - Running setup.py install for mozdevice 06:45:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozfile 06:45:03 INFO - Running setup.py install for mozhttpd 06:45:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozinfo 06:45:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozInstall 06:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for mozleak 06:45:03 INFO - Running setup.py install for mozlog 06:45:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:45:03 INFO - Running setup.py install for moznetwork 06:45:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozprocess 06:45:04 INFO - Running setup.py install for mozprofile 06:45:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozrunner 06:45:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Running setup.py install for mozscreenshot 06:45:04 INFO - Running setup.py install for moztest 06:45:04 INFO - Running setup.py install for mozversion 06:45:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:45:04 INFO - Cleaning up... 06:45:04 INFO - Return code: 0 06:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:04 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')]} 06:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:04 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')]} 06:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:04 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:45:04 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 06:45:04 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 06:45:04 INFO - Using env: {'DISPLAY': ':0', 06:45:04 INFO - 'HOME': '/home/cltbld', 06:45:04 INFO - 'LANG': 'en_US.UTF-8', 06:45:04 INFO - 'LANGUAGE': 'en_US:en', 06:45:04 INFO - 'LOGNAME': 'cltbld', 06:45:04 INFO - 'MAIL': '/var/mail/cltbld', 06:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:04 INFO - 'MOZ_NO_REMOTE': '1', 06:45:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:04 INFO - 'NO_EM_RESTART': '1', 06:45:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:04 INFO - 'PWD': '/builds/slave/test', 06:45:04 INFO - 'SHELL': '/bin/bash', 06:45:04 INFO - 'SHLVL': '1', 06:45:04 INFO - 'TERM': 'linux', 06:45:04 INFO - 'TMOUT': '86400', 06:45:04 INFO - 'USER': 'cltbld', 06:45:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:04 INFO - '_': '/tools/buildbot/bin/python'} 06:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:45:04 INFO - Running setup.py (path:/tmp/pip-1ANeVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:45:04 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)) 06:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:45:04 INFO - Running setup.py (path:/tmp/pip-dtz3Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:45:05 INFO - Running setup.py (path:/tmp/pip-11DCG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:45:05 INFO - Running setup.py (path:/tmp/pip-1iNwgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:45:05 INFO - Running setup.py (path:/tmp/pip-wtsXKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:45:05 INFO - Running setup.py (path:/tmp/pip-YJJ1Rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:45:05 INFO - Running setup.py (path:/tmp/pip-ax4jMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:45:05 INFO - Running setup.py (path:/tmp/pip-MKLJfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:45:05 INFO - Running setup.py (path:/tmp/pip-RHo8K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:45:05 INFO - Running setup.py (path:/tmp/pip-ELkHZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:45:05 INFO - Running setup.py (path:/tmp/pip-I5mtVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:45:05 INFO - Running setup.py (path:/tmp/pip-k9YB_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:45:05 INFO - Running setup.py (path:/tmp/pip-lGqt_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:45:05 INFO - Running setup.py (path:/tmp/pip-w9wmzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:05 INFO - Running setup.py (path:/tmp/pip-NjYlbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:45:05 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)) 06:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:45:05 INFO - Running setup.py (path:/tmp/pip-DBdVvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:45:06 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)) 06:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:45:06 INFO - Running setup.py (path:/tmp/pip-abZf0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 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)) 06:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:45:06 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 06:45:06 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 06:45:06 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 06:45:06 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 06:45:07 INFO - Downloading blessings-1.6.tar.gz 06:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:45:07 INFO - Installing collected packages: blessings 06:45:07 INFO - Running setup.py install for blessings 06:45:07 INFO - Successfully installed blessings 06:45:07 INFO - Cleaning up... 06:45:07 INFO - Return code: 0 06:45:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:45:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:07 INFO - Reading from file tmpfile_stdout 06:45:07 INFO - Current package versions: 06:45:07 INFO - argparse == 1.2.1 06:45:07 INFO - blessings == 1.6 06:45:07 INFO - blobuploader == 1.2.4 06:45:07 INFO - docopt == 0.6.1 06:45:07 INFO - functools32 == 3.2.3-2 06:45:07 INFO - jsonschema == 2.5.1 06:45:07 INFO - manifestparser == 1.1 06:45:07 INFO - mozInstall == 1.13 06:45:07 INFO - mozcrash == 1.0 06:45:07 INFO - mozdebug == 0.1 06:45:07 INFO - mozdevice == 0.51 06:45:07 INFO - mozfile == 1.2 06:45:07 INFO - mozhttpd == 0.7 06:45:07 INFO - mozinfo == 0.10 06:45:07 INFO - mozleak == 0.1 06:45:07 INFO - mozlog == 3.5 06:45:07 INFO - moznetwork == 0.27 06:45:07 INFO - mozprocess == 0.25 06:45:07 INFO - mozprofile == 0.28 06:45:07 INFO - mozrunner == 6.13 06:45:07 INFO - mozscreenshot == 0.1 06:45:07 INFO - mozsystemmonitor == 0.3 06:45:07 INFO - moztest == 0.8 06:45:07 INFO - mozversion == 1.4 06:45:07 INFO - psutil == 3.1.1 06:45:07 INFO - requests == 1.2.3 06:45:07 INFO - wsgiref == 0.1.2 06:45:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:45:07 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')]} 06:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:07 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')]} 06:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:07 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:45:07 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 06:45:07 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 06:45:07 INFO - Using env: {'DISPLAY': ':0', 06:45:07 INFO - 'HOME': '/home/cltbld', 06:45:07 INFO - 'LANG': 'en_US.UTF-8', 06:45:07 INFO - 'LANGUAGE': 'en_US:en', 06:45:07 INFO - 'LOGNAME': 'cltbld', 06:45:07 INFO - 'MAIL': '/var/mail/cltbld', 06:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:07 INFO - 'MOZ_NO_REMOTE': '1', 06:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:07 INFO - 'NO_EM_RESTART': '1', 06:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:07 INFO - 'PWD': '/builds/slave/test', 06:45:07 INFO - 'SHELL': '/bin/bash', 06:45:07 INFO - 'SHLVL': '1', 06:45:07 INFO - 'TERM': 'linux', 06:45:07 INFO - 'TMOUT': '86400', 06:45:07 INFO - 'USER': 'cltbld', 06:45:07 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:07 INFO - '_': '/tools/buildbot/bin/python'} 06:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 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)) 06:45:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:45: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 06:45: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 06:45: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 06:45: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 06:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:45:09 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)) 06:45:09 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)) 06:45:09 INFO - Installing collected packages: simplejson 06:45:09 INFO - Running setup.py install for simplejson 06:45:09 INFO - building 'simplejson._speedups' extension 06:45:09 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 06:45:09 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 06:45:10 INFO - Successfully installed simplejson 06:45:10 INFO - Cleaning up... 06:45:10 INFO - Return code: 0 06:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:45:10 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')]} 06:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:45:10 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')]} 06:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:45:10 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 0x28ef1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c5ba60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', '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 06:45:10 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 06:45:10 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 06:45:10 INFO - Using env: {'DISPLAY': ':0', 06:45:10 INFO - 'HOME': '/home/cltbld', 06:45:10 INFO - 'LANG': 'en_US.UTF-8', 06:45:10 INFO - 'LANGUAGE': 'en_US:en', 06:45:10 INFO - 'LOGNAME': 'cltbld', 06:45:10 INFO - 'MAIL': '/var/mail/cltbld', 06:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:10 INFO - 'MOZ_NO_REMOTE': '1', 06:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:10 INFO - 'NO_EM_RESTART': '1', 06:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:10 INFO - 'PWD': '/builds/slave/test', 06:45:10 INFO - 'SHELL': '/bin/bash', 06:45:10 INFO - 'SHLVL': '1', 06:45:10 INFO - 'TERM': 'linux', 06:45:10 INFO - 'TMOUT': '86400', 06:45:10 INFO - 'USER': 'cltbld', 06:45:10 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:10 INFO - '_': '/tools/buildbot/bin/python'} 06:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:45:10 INFO - Cleaning up... 06:45:10 INFO - Return code: 0 06:45:10 INFO - Running post-action listener: _resource_record_post_action 06:45:10 INFO - Running post-action listener: _start_resource_monitoring 06:45:10 INFO - Starting resource monitoring. 06:45:10 INFO - [mozharness: 2017-09-20 13:45:10.381358Z] Finished create-virtualenv step (success) 06:45:10 INFO - [mozharness: 2017-09-20 13:45:10.381943Z] Running install step. 06:45:10 INFO - Running pre-action listener: _resource_record_pre_action 06:45:10 INFO - Running main action method: install 06:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:45:10 INFO - Reading from file tmpfile_stdout 06:45:10 INFO - Detecting whether we're running mozinstall >=1.0... 06:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:45:10 INFO - Reading from file tmpfile_stdout 06:45:10 INFO - Output received: 06:45:10 INFO - Usage: mozinstall [options] installer 06:45:10 INFO - Options: 06:45:10 INFO - -h, --help show this help message and exit 06:45:10 INFO - -d DEST, --destination=DEST 06:45:10 INFO - Directory to install application into. [default: 06:45:10 INFO - "/builds/slave/test"] 06:45:10 INFO - --app=APP Application being installed. [default: firefox] 06:45:10 INFO - mkdir: /builds/slave/test/build/application 06:45:10 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'] 06:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:45:28 INFO - Reading from file tmpfile_stdout 06:45:28 INFO - Output received: 06:45:28 INFO - /builds/slave/test/build/application/firefox/firefox 06:45:28 INFO - Running post-action listener: _resource_record_post_action 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.525392Z] Finished install step (success) 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.525689Z] Running setup-mitmproxy step. 06:45:28 INFO - Running pre-action listener: _resource_record_pre_action 06:45:28 INFO - Running main action method: setup_mitmproxy 06:45:28 INFO - Skipping: mitmproxy is not required 06:45:28 INFO - Running post-action listener: _resource_record_post_action 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.526821Z] Finished setup-mitmproxy step (success) 06:45:28 INFO - [mozharness: 2017-09-20 13:45:28.527041Z] Running run-tests step. 06:45:28 INFO - Running pre-action listener: _resource_record_pre_action 06:45:28 INFO - Running pre-action listener: _set_gcov_prefix 06:45:28 INFO - Running main action method: run_tests 06:45:28 WARNING - Try message not found. 06:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:45:28 INFO - Python 2.7.3 06:45:28 INFO - Return code: 0 06:45:28 INFO - grabbing minidump binary from tooltool 06:45:28 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')]} 06:45:28 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 0x2c5f090>, '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 0x2c5fd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c59f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:45:28 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 06:45:28 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 06:45:28 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 06:45:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:45:28 INFO - Return code: 0 06:45:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:45:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - ENV: RUST_BACKTRACE is now full 06:45:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:45:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 06:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --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 06:45:28 INFO - Using env: {'DISPLAY': ':0', 06:45:28 INFO - 'HOME': '/home/cltbld', 06:45:28 INFO - 'LANG': 'en_US.UTF-8', 06:45:28 INFO - 'LANGUAGE': 'en_US:en', 06:45:28 INFO - 'LOGNAME': 'cltbld', 06:45:28 INFO - 'MAIL': '/var/mail/cltbld', 06:45:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:28 INFO - 'MOZ_NO_REMOTE': '1', 06:45:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:28 INFO - 'NO_EM_RESTART': '1', 06:45:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:28 INFO - 'PWD': '/builds/slave/test', 06:45:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:28 INFO - 'RUST_BACKTRACE': 'full', 06:45:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:45:28 INFO - 'SHELL': '/bin/bash', 06:45:28 INFO - 'SHLVL': '1', 06:45:28 INFO - 'TERM': 'linux', 06:45:28 INFO - 'TMOUT': '86400', 06:45:28 INFO - 'USER': 'cltbld', 06:45:28 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:28 INFO - '_': '/tools/buildbot/bin/python'} 06:45:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--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 06:45:28 INFO - mozversion application_buildid: 20170920125558 06:45:28 INFO - mozversion application_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 06:45:28 INFO - mozversion application_display_name: Nightly 06:45:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:45:28 INFO - mozversion application_name: Firefox 06:45:28 INFO - mozversion application_remotingname: firefox 06:45:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:45:28 INFO - mozversion application_vendor: Mozilla 06:45:28 INFO - mozversion application_version: 57.0a1 06:45:28 INFO - mozversion platform_buildid: 20170920125558 06:45:28 INFO - mozversion platform_changeset: 0c49ebf4195ce51072b24aacf01eaaffdcff9be6 06:45:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:45:28 INFO - mozversion platform_version: 57.0a1 06:45:28 INFO - using testdate: 1505915128 06:45:28 INFO - actual date: 1505915128 06:45:28 INFO - starting webserver on 'localhost:37287' 06:45:28 INFO - SUITE-START | Running 2 tests 06:45:28 INFO - TEST-START | dromaeo_css 06:45:28 INFO - Initialising browser for dromaeo_css test... 06:45:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37287/getInfo.html -profile /tmp/tmpmQ3z6V/profile 06:45:28 INFO - TEST-INFO | started process 19722 (/builds/slave/test/build/application/firefox/firefox http://localhost:37287/getInfo.html) 06:45:34 INFO - TEST-INFO | 19722: exit 0 06:45:34 INFO - Browser initialized. 06:45:34 INFO - Running cycle 1/1 for dromaeo_css test... 06:45:34 INFO - Using env: {'DISPLAY': ':0', 06:45:34 INFO - 'HOME': '/home/cltbld', 06:45:34 INFO - 'JSGC_DISABLE_POISONING': '1', 06:45:34 INFO - 'LANG': 'en_US.UTF-8', 06:45:34 INFO - 'LANGUAGE': 'en_US:en', 06:45:34 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 06:45:34 INFO - 'LOGNAME': 'cltbld', 06:45:34 INFO - 'MAIL': '/var/mail/cltbld', 06:45:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:45:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:45:34 INFO - 'MOZ_CRASHREPORTER': '1', 06:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:45:34 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 06:45:34 INFO - 'MOZ_NO_REMOTE': '1', 06:45:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:45:34 INFO - 'NO_EM_RESTART': '1', 06:45:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:45:34 INFO - 'PWD': '/builds/slave/test', 06:45:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:45:34 INFO - 'RUST_BACKTRACE': 'full', 06:45:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:45:34 INFO - 'SHELL': '/bin/bash', 06:45:34 INFO - 'SHLVL': '1', 06:45:34 INFO - 'STYLO_FORCE_DISABLED': '1', 06:45:34 INFO - 'TERM': 'linux', 06:45:34 INFO - 'TMOUT': '86400', 06:45:34 INFO - 'USER': 'cltbld', 06:45:34 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 06:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:45:34 INFO - '_': '/tools/buildbot/bin/python'} 06:45:34 INFO - TEST-INFO | started process 19956 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmQ3z6V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:45:35 INFO - PID 19956 | 06:45:35 INFO - PID 19956 | (/builds/slave/test/build/application/firefox/firefox:20006): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:45:35 INFO - PID 19956 | 06:45:45 INFO - PID 19956 | RSS: Main: 156135424 06:45:45 INFO - PID 19956 | 06:48:42 INFO - PID 19956 | Cycle 1(1): loaded http://localhost:37287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37287/tests/dromaeo/cssquery-ext.html) 06:48:43 INFO - PID 19956 | RSS: Main: 156151808 06:48:43 INFO - PID 19956 | 06:51:45 INFO - PID 19956 | Cycle 1(1): loaded http://localhost:37287/tests/dromaeo/cssquery-ext.html (next: http://localhost:37287/tests/dromaeo/cssquery-jquery.html) 06:51:45 INFO - PID 19956 | RSS: Main: 154406912 06:51:45 INFO - PID 19956 | 06:54:47 INFO - PID 19956 | Cycle 1(1): loaded http://localhost:37287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37287/tests/dromaeo/cssquery-mootools.html) 06:54:48 INFO - PID 19956 | RSS: Main: 157913088 06:54:48 INFO - PID 19956 | 06:57:49 INFO - PID 19956 | Cycle 1(1): loaded http://localhost:37287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37287/tests/dromaeo/cssquery-prototype.html) 06:57:50 INFO - PID 19956 | RSS: Main: 156471296 06:57:50 INFO - PID 19956 | 07:00:53 INFO - PID 19956 | Cycle 1(1): loaded http://localhost:37287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37287/tests/dromaeo/cssquery-yui.html) 07:00:54 INFO - PID 19956 | RSS: Main: 158089216 07:00:54 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | Cycle 1(1): loaded http://localhost:37287/tests/dromaeo/cssquery-yui.html (next: http://localhost:37287/tests/dromaeo/cssquery-dojo.html) 07:03:56 INFO - PID 19956 | RSS: Main: 160489472 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | __start_tp_report 07:03:56 INFO - PID 19956 | _x_x_mozilla_page_load 07:03:56 INFO - PID 19956 | _x_x_mozilla_page_load_details 07:03:56 INFO - PID 19956 | |i|pagename|runs| 07:03:56 INFO - PID 19956 | |0;dojo.html;3111.5643809866615;3134.7335476484504;3136.3256899766548;3140.1678555182866;3172.873085076597;6390.4887608991285;6434.0670602762575;6463.289038205806;6464.8060558183215;6490.513211509132;6258.687065646711;6342.460890824285;6379.330170332107;6394.232692076957;6425.775097871576;5817.970910145444;5825.30096388434;5919.052951527757;5923.792667256647;6013.428724271187;5959.70201489926;5996.070609055581;6006.8798624027495;6032.215811944463;6059.272887253535;5774.711264436783;5824.737886795062;5953.732082056296;5954.345022047572;6038.396160383971;5811.912821307684;5896.233489646319;5930;5967.43309385612;5988.880222395571;5860.150278209679;5873.85315367115;5924.7333869975955;5963.194968679216;5973.731182096816;6274.403931626488;6275.780347687809;6329.8417539561415;6330.050492426127;6341.460975817061;6848.14398200225;6922.238553759083;6923.757668481579;6924.376806087426;6936.34104760047;6898.379145876845;6928.44572434204;6960.443164546824;6975.441964642816;6979.511434199608;6361.141245931786;6389;6408.839779005515;6465.903011454832;6495.707693153772;6947.062146610244;7048.977898204834;7061.611611361424;7083.468739844532;7155.212926578072;6694.665266736643;6706;6715.227748808852;6727.62998035103;6737.191537015589;6724.495662825308;6726.192856857208;6779.389854913082;6824.522283440211;6828.726850926007;6699.497537684693;6755.560888542229;6797.354251346114;6838.316168383122;6848.931510684929;6914.274001229798;6943.097397338313;6974.476914231453;6977;6985.301469853076;5319.521243088063;5395.325584301962;5452.182172674131;5456.91814622781;5468.9726551367785;4628.143793398232;4632.536746325341;4632.652551058684;4632.907341853144;4646.697964632355;5860.794872179454;5861.3552509223955;5862.384449632812;5862.472377486047;5867.471927526543;6810.5913645181445;6814.761483348059;6820.624865632339;6821.658917054127;6822.692978815965;5762.855928601734;5802.0426629605645;5845.824625261249;5851.882962340729;5868.706564671835;5834.154047663065;5840.3575606683235;5899.321578018583;5979.5515336349945;5991.161237426763;6594.175728033996;6614.371634694697;6684.83287917806;6687.398134167948;6698.263191048981;6913.827154321182;6923.9653801730665;6985.126859142607;7002.4398048157045;7018.789436317021;6411.6794160290865;6554.80335589933;6562.639054852029;6567.704453299518;6570.770023049362;6716.966415167893;6727.125473688389;6731.596104233761;6807.829804254735;6841.281665425058;6982.860342793014;6995.615241161785;7030;7035.0150978861975;7040.366367026787;6681.1314529110905;6696.363845434676;6705.22889867652;6784.21981472137;6790.049393084873;6542.34576542342;6628.304028077176;6654.534182607171;6669.199696036507;6754.425873800782;6588.40704336612;6623.668816559057;6643.302453242533;6677;6685.966570167118;6733.057371968026;6743.52795304324;6765.086713293839;6795.966020169867;6840.213375461686;6463.450606698483;6503.869922601427;6563;6566.8358291043105;6576.539642224999 07:03:56 INFO - PID 19956 | |1;ext.html;867.9088695686953;895.3642913531393;895.6238379880451;896.2202883491364;897.4211633496395;38680.613193868056;42073;42107.78946105273;42260.15479690404;42277.577224227745;38371.23257534855;38519.807400962956;38741;38771.612283877155;38811;7190.532615379997;7303.598302093383;7307.451941104412;7343.669534870917;7356.411487081047;7207.495475316704;7302.1967583565765;7313.085864266966;7320.304571065741;7322.707091716325;7278.81802954925;7303.050603421548;7323.560586364809;7335.083114610674;7338.6697598607925;7784.805379865492;7986.6805327786815;8013.2387423194705;8016.238457346542;8026.117127116013;7859.174786647377;7962.163972782832;7981.401394895406;7982.161873003367;7997.200279972015;38142.23715525674;38327.233455331014;38596.421053684215;38597.42103868444;38817.223655527014;3500.194955160302;3553.928921421557;3575.249197668493;3577.713782897362;3579.713622910161;32350.838245808856;32448.675513245038;32557.51163732546;32581.674183258103;32608.184795380068;5183.974080129575;5185.377754669464;5213.113770658997;5220.686758794484;5259.289995850588;194638;195858;196376;196853.01573492185;197001;41043.589564103975;41806.1638767223;46946.29580556294;47023.52976470192;48420.75789621029;50392.74803625958;50457.495425046014;50490;50507.74746126319;50739;15927.283272252776;15978.280977355815;16091.195440227943;16110.919445402933;16120;13264;13284.667883302995;13286;13302.201867887958;13327.866721332857;13577;13616.591502254949;13653.86346136526;13667.658308542168;13767.518136865361;5678.801241956512;5708.400617935057;5787.623804452782;5818.0981947798155;5847.415258474203;1036.7563622548696;1038.4651904269308;1044.9425281609585;1044.9791004179874;1053.8629978102797;23541.646875296883;23708.762912371;23779;23976.56733398525;24109.276721698378;1143.8455808465917;1148.2134737704698;1151.3667482884548;1158.449736375215;1160.2922217447351;12288.262704237774;12532.561360352527;12757.808632870514;12816.615501534969;12838;235467;238331;238430;238973;239555;53040.469595303555;53157.46842531602;53186.202206966926;53277.73361133169;53316.46683533193;1425.9215743134228;1449.7970284160438;1493.529538195465;1493.6191271225985;1496.6034000989746;23071.88464057669;23124.190653327052;23191;23192.4201894954;23324.883375583693;37693.246135077694;37750.43374349332;37804.43293350547;37827.62172378351;37955.81022094872;201240;201248;201668;201889;201927;29857;30003;30051.849740751157;30179;33291.334173316885;35536.822315888254;38557.42163867488;43245;43394.78302608467;44036;32250.516242256854;32445.675543244266;32983.01050968475;33018.33963320768;33046.17384565405;31533.8423307882;31886.52170217495;31956.840215798773;32545.674543254263;32551.511727323636;35172.47241291332;35336.823315884285;35494.29011419809;35877;35962.46056309105;31265.374692506477;31347.373052538365;31516.52725209078;31537.8423107883;31708.84145579257;22377.216797412013;23127.537449251256;23729;23894.761052389254;24239.75760242375 07:03:56 INFO - PID 19956 | |2;jquery.html;561.8146011816101;569.3054473542277;581.183437270635;591.2018774654217;599.1372423709857;22093.558128837434;22985.4253643659;23036.424089397773;23090.538189236227;23132.074717011343;23591.41021474464;23791.04835806566;23985.880070599622;24110.517789644196;24207.152749653767;6276.309605943354;6368.936310636904;6403.679816009181;6413.198350206224;6423.261324947621;6173.876522469548;6300.810975670737;6377.776777812777;6386.393292637192;6438.581492203015;6408.295087540367;6428.550001499897;6438.5171112166545;6455.806325810233;6458.612483250997;6177.969110154466;6448;6451.741930322782;6457.2896981332015;6458.870822583522;5917.556183286228;5958.7616495340135;5960.0761881908375;5964.671943043131;5966.701664916737;27812.860935695393;28208.858955705295;28218.435631287466;28428.28929276764;28504.857475712488;1994.7905469925738;2028.1076326416478;2039.479932617188;2043.9182432702673;2044.8977551122384;18492.907535462236;18652.626947460976;19206;19226.423207303804;19277.421677349703;2423.7333893271725;2446.0949448703914;2473.4682043360763;2473.666055082577;2477.5168842075805;138181.30909345488;146554;146953.2652336742;147373;147388.0522389546;14303.642408939651;14465.49370772039;14549.563513094625;14738.852611473962;14765.852341476662;22494.100235990703;22591.435214119778;22643.43391415195;22657.093716251165;22750.08999639996;9475.952620236854;9640.276979226586;9913.504324783731;10027.09756121938;10243.84634230487;9260.610908363664;9280.7679808004;9317.16145546904;9444.8583271251;9445.386049906734;8705.695300664447;8878.689245876363;8919.197272245528;9036.728898133066;9171.174594286545;2633.85513796743;2646.563317052703;2648.4173481833964;2684.885293515855;2774.736400041993;948.4451595816524;958.547800082875;958.8705524754208;968.1045033344269;978.1636700620867;18560.350387736635;18863.81136188648;18883.244670213036;19013.714794278098;19068.237270509024;1016.4409574733867;1027.1012863744224;1030.9278350515392;1037.766502536923;1038.8026275007724;10343.534540945675;10381.117605003508;10494.422806745702;10641.840372394265;10739.409332486632;492253;496640;501474;503520;519178;108946;110593;112021.43989280002;112218.43890780494;112278;1160.9825852612219;1172.6482055383522;1192.7554851255472;1199.9520019199308;1201.1651901928076;16289.755653664968;16692.41576544815;16827.892480720056;16859;17204.397846075328;55338.16992745193;55732.72133639306;56143.71928140333;56588;57606.71196644157;65368;65697.67151164214;68188.6590567044;68643;70072.29927700658;13585.932070339584;13859.237741924291;13931.58205253844;13973.580792576238;14009.789853152415;21527;21577.136914523242;21650.35048948534;21678.132874684838;21915.561688765818;17473;17522.123893805005;17659.38192163268;17775;17798.733019004983;15647.295871685574;15687.764683529527;15903.443379481663;16201.75697364517;16314.102724350274;17542;17755.289788408318;18106;18214.90892545529;18264.99542525174;13618.93190534041;13718.519851805138;13723.833474154808;13745.450181993008;13818.723625527635;17245.741313880553;17381.478555643353;17432.651346972736;17529.737053944456;17693.292268309637 07:03:56 INFO - PID 19956 | |3;mootools.html;1340.9195448273103;1426.3367534096642;1433.8422773494913;1440.330246435408;1440.3878351700525;15038.849611503882;15661.686766264667;15668.686626267468;15678.137702426362;15679.372825086997;15204.771928421083;15361.231938403063;15365.539033829004;15386.61533461664;15401.152936588483;2656.760891519763;2790.079273839638;2796.5385711357603;2800.7339302766204;2800.845953472558;2771.3071732066983;2798.3563780330537;2855.543113101904;2859.4281143771227;2860.156253905103;2834.1780883543747;2850.073726039035;2856.828590284579;2860.2992266894535;2860.6567211934494;2750.22993561803;2780.638516992788;2781.582762585618;2782.9721702782917;2783.4433113377204;2684.7583717465327;2689.731026897314;2706.1069846950654;2711.3357227479396;2722.8502432366213;15102.848971510364;15210.619734506727;15220.619484512865;15221.31504082319;15243.771343429857;8164;8168.795780105485;8502.979642442884;8503.064662887078;8505.489670619721;5704.458076482769;5824.213731146283;5825.592208545403;5849.502792262663;5916.792912248051;1919.8368138708227;1950.8634395592314;1951.5655992845248;1995.7704863940687;2019.2225992992658;26521.602175967182;26921.59617605757;26943.461130777276;26969.325766855985;26979.46041079187;6794.932050679528;6904.551204171813;7007.4394048476;7057.647117644097;7100.2899710029615;17559;17575.472735817944;17621.383251586132;17649.294028238983;17665.11674416274;7825.100113487022;8108.148644392372;8124.390670699721;8124.431289809657;8134.918650813534;7244.782656520313;7458;7494.40044796415;7666.65500052499;7672.424568157299;5328.547073498796;5353.4646535346155;5361.329833770778;5441.673499589958;5467.480589344006;1575.3619783987504;1586.952391428259;1587.1508742822766;1597;1622.6430185359202;888.5779254853893;903.3134817538718;906.0712769411274;907.1654078247896;913.8766266554063;7799.961000194962;7805.219478052263;7812.765617031499;7899;7902.960485197652;719.5285640864445;722.6567380494223;729.8430837369991;732.8827387617955;741.1809950005166;4874.829380971649;5465.890682186334;5534.972325138348;5538.418466061086;5611.130274807411;21190.78809211919;22079.33761987143;22197.334079977627;22258;22283.331500055025;21823.890880545812;22252.88873555622;22662.433439164153;22667.433314167276;22695.886520567623;11623.76752464963;11705.999999999829;11715.472803723853;11727.824082638766;11746.471408786625;8546.615402307036;8619.267362274277;8674.349423793366;8727.30181585459;8746.562671866508;18261.452156435327;18877.811221887605;18909.810901891356;19069;19346.903265483583;19703.60592788165;19726.802731972497;19752.802471975097;20182.596348072664;20353.898230508752;10884.61903833362;11112.333260004425;11204.66386008421;11206.159538034517;11209.383483908463;13924.234167120905;14121.576352709435;14124.576262712135;14126.646833829236;14136.858631413965;11339.149563782914;11391.943040284745;11470.598529051444;11539.134564907497;11927.045836333245;10872.347659140476;11083.279586826831;11091.279066860629;11268.887311127111;11382.772344553228;9553.47455889905;9797.608095676092;9824.21406287481;9830.262730295113;9841.507924603598;7092.432605391453;7146.071010768567;7206.603636800026;7219.0976127984;7291.8541629168185;7520.586367749826;7740.535567865946;7822.843543128992;7832.373410127062;7863.174366691415 07:03:56 INFO - PID 19956 | |4;prototype.html;504.2260130699377;505.66878694455136;531.0944839049421;533.8131653921125;536.9355677318722;6281.403266689663;6353.428191462767;6396.96801515993;6432.614043157408;6478.125453063835;6156.692165391735;6240.032794916784;6241.563090583661;6336.45158711121;6399.648019358945;4963.851084467472;5079.4412614612365;5080.542751152396;5116.386033675964;5148.74256287186;5080.644354895159;5083.551892094418;5090.778213228817;5102.1836506159025;5120.871978200556;5013.824516141935;5063.468335824722;5083.949160508403;5108.412532558747;5123.769430375642;5040.521150490716;5047.9747601262125;5060.114479965991;5074.162763144077;5120;4541.296099104644;4542.523035081335;4552.863414097583;4580.198465268598;4580.335851301543;6235.469985051276;6272.905906411407;6277.748890044393;6298.464630506367;6311.147995020659;5735.655860648374;5740.196372507852;5782.392848750863;5793.073108302651;5794.623349482313;6545.770898018546;6553.868922621521;6579.440747536465;6584.9012264816065;6643.103181070542;4924.374956264424;4941.295253137661;4946.8763280918265;4960.751962401865;4961.156603377434;6959.19969203543;6983.301669832976;6999.790006299768;7066.929330706678;7096.893546596805;5009.323741294951;5026.547610715053;5043.193089105799;5046.39443266803;5096.719680417538;5139.383274007068;5146;5163.328767260307;5179.689218646818;5194.4805519447755;5675.829725108253;5799.536037117021;5816.796412125555;5817.418258174149;5835.562332825055;6326.778562750374;6396;6540.771073012517;6601.603903765789;6730.697118629673;1749.8162692917315;1754.7716598381185;1755.806861245262;1765.3556451894965;1768.8054314025446;1183.8401815754935;1208.6434501821984;1218.9268643881396;1229.1948773553158;1242.9875701243052;5692.861427714473;5706.457886500776;5821.679807610537;5835.124731290255;5840.649561026352;6844.589324640438;6866.519343645997;6906.689198986058;6917.169939607279;6933.930660693329;5766.8269951900675;5802.390748971297;5816.941830581724;5843.912341314884;5874.825034993019;3571.5357003589365;3613.7831730095754;3651.653092956165;3657.743957922973;3676.1361080146144;6487.610743355413;6518.543701940914;6584.967075164594;6595.01074838778;6640.63476508787;6832.419244364185;6917.371398868398;6932.7226910923;6945.201301850352;7042.964785176041;6443.194600674916;6443.387878151568;6519.706613202417;6524.608523488606;6524.999999999905;6629.2376376715365;6715.630640314829;6722.697478613376;6755.399171318979;6776.2207346153855;6600.768973085919;6647.767328143492;6662.233843108104;6717.630530320879;6740.258571557027;6274.46667033289;6329.810105696836;6349.3650634937985;6405.7117429714845;6479;4920.384951881015;4930.285108659296;4942.92585611209;4953.786322351047;4962.741952411716;5960.5827592068135;6571.671416429063;6665;6711.9995603275875;6744.5616034957575;6483.513736469689;6549.075618501666;6553.246376666744;6584.308647592125;6629.5359324846795;6496.545241833215;6504.869902601827;6576.408123268929;6618.966905165444;6635.2037755469655;6364.331745166691;6469.77355792545;6543.836404089745;6597.954634063456;6616.470682345497;6650.334966503311;6662.200535935719;6690.832729181615;6708.731650733916;6729.629870357177;6361.173047503795;6384.425401713868;6414.61512309263;6476.967615161894;6530.701995492246 07:03:56 INFO - PID 19956 | |5;yui.html;894.8255090257402;910.4446287764465;913.8355096082706;917.8256131335044;922.97692557686;19186.80813191871;19261.903690481544;20111.095000724985;20239.49401264969;20275.594488110248;22192.445188870286;22250.666240006412;22297.777022229813;22318.330450086483;22449.32652020438;1002.2810879341945;1011.6560369474378;1012.3622118065608;1022.5551884930079;1024.4826362686833;729.7008226627084;749.6439191384076;967.7774111954254;988.3131223799462;997.326804407026;1060.8833028366873;1061.5010944855906;1062.1768129699506;1064.5156453813536;1068.9518971646294;1050.1179009631946;1051.1328154272717;1055.973600659982;1063.393865496667;1063.4523220541428;770.2528547309157;770.4914756260897;776.4836383804819;779.949303295284;782.4131901074194;20298.797012029838;20310.187592496284;20491.59016819655;20493.38519844407;20535;21569.46076348088;22055.779442205694;22118.668219976713;22183.778162218332;22216.333509994725;16671.49985500437;16964.236609352607;16979.91510042442;17013.23440445183;17142.485725428258;3701.9629803701887;3732.253549290153;3807.1053302473897;3815.179736356669;3844.308024555579;140665.296673517;142532;143313;145227.27386363212;145447;16697.165141743106;16781.328746849988;16832.915835420743;16983.150842457828;17028.57428564271;31097;31126.533102003035;31747.365052698817;31805.363892722016;31919.52120718191;8809.735707928772;8897.332700047393;8925.062868398854;8928.508932008803;8931.240844528158;3557.092941299952;4316.676249281317;4364.650827933821;4434.800433980478;4436.26801577736;4589.403377560896;5978.133170690313;6105.267367915879;6144.477719393813;6144.477719393902;1125.6960620632383;1160.651804458676;1180.816973369129;1184.7630473905253;1187.2935603316187;675.4258879952001;694.7429451103023;695.5965539986795;713.989290160648;720.1682057223915;12460.190087644274;12521.812172817416;12757.872421275853;13153.473861045451;13168;715.3597530210433;715.8818794898888;719.6833393306928;723.6562632749507;729.5586170366958;5669.40471250521;5808.564357673192;5903.409659034062;5946.10808378738;5972.193753843262;118594;118820;120328.39835800765;124411.3779431097;125353.37323313326;109153.45423272833;110206;111958.44020779844;113339.4333028346;116463.41768291274;93368.53315733378;93748.53125734327;94822;97089;97147.51426242823;10386.896131038593;10617.097546708615;10813;10830.51262693165;10863.728406789893;42210.57789422067;43722.562774373124;44054.779726102446;44411.55588444074;44571.331430029226;55397;56808.715956419954;56925.43074569367;57120.42879571151;59458;15579.610509736895;15833.129177895325;15910.840891590937;15975.600609984844;16003.439879604159;16316.42892498757;17855.37506187277;18002.5499362517;18162.909185453987;19978.60042799165;18322.816771832644;18328.358507452176;18344.72482912784;18396.448106556825;18561.25754969786;17541.649167016843;17630.471085867444;17639.206235719168;17831;17864.821351786315;18056.638867222846;18154.81845181584;18218.72671909896;18335.90832045831;18440.631187376446;12699.111062225555;13190.868091318964;13310.068295219242;13447.529336473177;13488.460461581819;13484.325783710972;13549.796753048515;13572.524961626295;13673.658158546115;13712.588622341345 07:03:56 INFO - PID 19956 | __end_tp_report 07:03:56 INFO - PID 19956 | __start_cc_report 07:03:56 INFO - PID 19956 | _x_x_mozilla_cycle_collect,288 07:03:56 INFO - PID 19956 | __end_cc_report 07:03:56 INFO - PID 19956 | __startTimestamp1505916236375__endTimestamp 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | ------- Summary: start ------- 07:03:56 INFO - PID 19956 | Number of tests: 6 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | [#0] dojo.html Cycles:165 Average:6310.39 Median:6566.84 stddev:774.69 (11.8%) stddev-sans-first:735.30 07:03:56 INFO - PID 19956 | Values: 3111.6 3134.7 3136.3 3140.2 3172.9 6390.5 6434.1 6463.3 6464.8 6490.5 6258.7 6342.5 6379.3 6394.2 6425.8 5818.0 5825.3 5919.1 5923.8 6013.4 5959.7 5996.1 6006.9 6032.2 6059.3 5774.7 5824.7 5953.7 5954.3 6038.4 5811.9 5896.2 5930.0 5967.4 5988.9 5860.2 5873.9 5924.7 5963.2 5973.7 6274.4 6275.8 6329.8 6330.1 6341.5 6848.1 6922.2 6923.8 6924.4 6936.3 6898.4 6928.4 6960.4 6975.4 6979.5 6361.1 6389.0 6408.8 6465.9 6495.7 6947.1 7049.0 7061.6 7083.5 7155.2 6694.7 6706.0 6715.2 6727.6 6737.2 6724.5 6726.2 6779.4 6824.5 6828.7 6699.5 6755.6 6797.4 6838.3 6848.9 6914.3 6943.1 6974.5 6977.0 6985.3 5319.5 5395.3 5452.2 5456.9 5469.0 4628.1 4632.5 4632.7 4632.9 4646.7 5860.8 5861.4 5862.4 5862.5 5867.5 6810.6 6814.8 6820.6 6821.7 6822.7 5762.9 5802.0 5845.8 5851.9 5868.7 5834.2 5840.4 5899.3 5979.6 5991.2 6594.2 6614.4 6684.8 6687.4 6698.3 6913.8 6924.0 6985.1 7002.4 7018.8 6411.7 6554.8 6562.6 6567.7 6570.8 6717.0 6727.1 6731.6 6807.8 6841.3 6982.9 6995.6 7030.0 7035.0 7040.4 6681.1 6696.4 6705.2 6784.2 6790.0 6542.3 6628.3 6654.5 6669.2 6754.4 6588.4 6623.7 6643.3 6677.0 6686.0 6733.1 6743.5 6765.1 6796.0 6840.2 6463.5 6503.9 6563.0 6566.8 6576.5 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | [#1] ext.html Cycles:180 Average:37781.98 Median:19336.33 stddev:55138.05 (285.2%) stddev-sans-first:55223.06 07:03:56 INFO - PID 19956 | Values: 867.9 895.4 895.6 896.2 897.4 38680.6 42073.0 42107.8 42260.2 42277.6 38371.2 38519.8 38741.0 38771.6 38811.0 7190.5 7303.6 7307.5 7343.7 7356.4 7207.5 7302.2 7313.1 7320.3 7322.7 7278.8 7303.1 7323.6 7335.1 7338.7 7784.8 7986.7 8013.2 8016.2 8026.1 7859.2 7962.2 7981.4 7982.2 7997.2 38142.2 38327.2 38596.4 38597.4 38817.2 3500.2 3553.9 3575.2 3577.7 3579.7 32350.8 32448.7 32557.5 32581.7 32608.2 5184.0 5185.4 5213.1 5220.7 5259.3 194638.0 195858.0 196376.0 196853.0 197001.0 41043.6 41806.2 46946.3 47023.5 48420.8 50392.7 50457.5 50490.0 50507.7 50739.0 15927.3 15978.3 16091.2 16110.9 16120.0 13264.0 13284.7 13286.0 13302.2 13327.9 13577.0 13616.6 13653.9 13667.7 13767.5 5678.8 5708.4 5787.6 5818.1 5847.4 1036.8 1038.5 1044.9 1045.0 1053.9 23541.6 23708.8 23779.0 23976.6 24109.3 1143.8 1148.2 1151.4 1158.4 1160.3 12288.3 12532.6 12757.8 12816.6 12838.0 235467.0 238331.0 238430.0 238973.0 239555.0 53040.5 53157.5 53186.2 53277.7 53316.5 1425.9 1449.8 1493.5 1493.6 1496.6 23071.9 23124.2 23191.0 23192.4 23324.9 37693.2 37750.4 37804.4 37827.6 37955.8 201240.0 201248.0 201668.0 201889.0 201927.0 29857.0 30003.0 30051.8 30179.0 33291.3 35536.8 38557.4 43245.0 43394.8 44036.0 32250.5 32445.7 32983.0 33018.3 33046.2 31533.8 31886.5 31956.8 32545.7 32551.5 35172.5 35336.8 35494.3 35877.0 35962.5 31265.4 31347.4 31516.5 31537.8 31708.8 22377.2 23127.5 23729.0 23894.8 24239.8 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | [#2] jquery.html Cycles:180 Average:34701.17 Median:22650.26 stddev:84701.31 (374.0%) stddev-sans-first:84900.14 07:03:56 INFO - PID 19956 | Values: 561.8 569.3 581.2 591.2 599.1 22093.6 22985.4 23036.4 23090.5 23132.1 23591.4 23791.0 23985.9 24110.5 24207.2 6276.3 6368.9 6403.7 6413.2 6423.3 6173.9 6300.8 6377.8 6386.4 6438.6 6408.3 6428.6 6438.5 6455.8 6458.6 6178.0 6448.0 6451.7 6457.3 6458.9 5917.6 5958.8 5960.1 5964.7 5966.7 27812.9 28208.9 28218.4 28428.3 28504.9 1994.8 2028.1 2039.5 2043.9 2044.9 18492.9 18652.6 19206.0 19226.4 19277.4 2423.7 2446.1 2473.5 2473.7 2477.5 138181.3 146554.0 146953.3 147373.0 147388.1 14303.6 14465.5 14549.6 14738.9 14765.9 22494.1 22591.4 22643.4 22657.1 22750.1 9476.0 9640.3 9913.5 10027.1 10243.8 9260.6 9280.8 9317.2 9444.9 9445.4 8705.7 8878.7 8919.2 9036.7 9171.2 2633.9 2646.6 2648.4 2684.9 2774.7 948.4 958.5 958.9 968.1 978.2 18560.4 18863.8 18883.2 19013.7 19068.2 1016.4 1027.1 1030.9 1037.8 1038.8 10343.5 10381.1 10494.4 10641.8 10739.4 492253.0 496640.0 501474.0 503520.0 519178.0 108946.0 110593.0 112021.4 112218.4 112278.0 1161.0 1172.6 1192.8 1200.0 1201.2 16289.8 16692.4 16827.9 16859.0 17204.4 55338.2 55732.7 56143.7 56588.0 57606.7 65368.0 65697.7 68188.7 68643.0 70072.3 13585.9 13859.2 13931.6 13973.6 14009.8 21527.0 21577.1 21650.4 21678.1 21915.6 17473.0 17522.1 17659.4 17775.0 17798.7 15647.3 15687.8 15903.4 16201.8 16314.1 17542.0 17755.3 18106.0 18214.9 18265.0 13618.9 13718.5 13723.8 13745.5 13818.7 17245.7 17381.5 17432.7 17529.7 17693.3 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | [#3] mootools.html Cycles:180 Average:9519.78 Median:2736.54 stddev:6811.50 (248.9%) stddev-sans-first:6802.89 07:03:56 INFO - PID 19956 | Values: 1340.9 1426.3 1433.8 1440.3 1440.4 15038.8 15661.7 15668.7 15678.1 15679.4 15204.8 15361.2 15365.5 15386.6 15401.2 2656.8 2790.1 2796.5 2800.7 2800.8 2771.3 2798.4 2855.5 2859.4 2860.2 2834.2 2850.1 2856.8 2860.3 2860.7 2750.2 2780.6 2781.6 2783.0 2783.4 2684.8 2689.7 2706.1 2711.3 2722.9 15102.8 15210.6 15220.6 15221.3 15243.8 8164.0 8168.8 8503.0 8503.1 8505.5 5704.5 5824.2 5825.6 5849.5 5916.8 1919.8 1950.9 1951.6 1995.8 2019.2 26521.6 26921.6 26943.5 26969.3 26979.5 6794.9 6904.6 7007.4 7057.6 7100.3 17559.0 17575.5 17621.4 17649.3 17665.1 7825.1 8108.1 8124.4 8124.4 8134.9 7244.8 7458.0 7494.4 7666.7 7672.4 5328.5 5353.5 5361.3 5441.7 5467.5 1575.4 1587.0 1587.2 1597.0 1622.6 888.6 903.3 906.1 907.2 913.9 7800.0 7805.2 7812.8 7899.0 7903.0 719.5 722.7 729.8 732.9 741.2 4874.8 5465.9 5535.0 5538.4 5611.1 21190.8 22079.3 22197.3 22258.0 22283.3 21823.9 22252.9 22662.4 22667.4 22695.9 11623.8 11706.0 11715.5 11727.8 11746.5 8546.6 8619.3 8674.3 8727.3 8746.6 18261.5 18877.8 18909.8 19069.0 19346.9 19703.6 19726.8 19752.8 20182.6 20353.9 10884.6 11112.3 11204.7 11206.2 11209.4 13924.2 14121.6 14124.6 14126.6 14136.9 11339.1 11391.9 11470.6 11539.1 11927.0 10872.3 11083.3 11091.3 11268.9 11382.8 9553.5 9797.6 9824.2 9830.3 9841.5 7092.4 7146.1 7206.6 7219.1 7291.9 7520.6 7740.5 7822.8 7832.4 7863.2 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | [#4] prototype.html Cycles:180 Average:5563.23 Median:6273.69 stddev:1553.52 (24.8%) stddev-sans-first:1510.76 07:03:56 INFO - PID 19956 | Values: 504.2 505.7 531.1 533.8 536.9 6281.4 6353.4 6397.0 6432.6 6478.1 6156.7 6240.0 6241.6 6336.5 6399.6 4963.9 5079.4 5080.5 5116.4 5148.7 5080.6 5083.6 5090.8 5102.2 5120.9 5013.8 5063.5 5083.9 5108.4 5123.8 5040.5 5048.0 5060.1 5074.2 5120.0 4541.3 4542.5 4552.9 4580.2 4580.3 6235.5 6272.9 6277.7 6298.5 6311.1 5735.7 5740.2 5782.4 5793.1 5794.6 6545.8 6553.9 6579.4 6584.9 6643.1 4924.4 4941.3 4946.9 4960.8 4961.2 6959.2 6983.3 6999.8 7066.9 7096.9 5009.3 5026.5 5043.2 5046.4 5096.7 5139.4 5146.0 5163.3 5179.7 5194.5 5675.8 5799.5 5816.8 5817.4 5835.6 6326.8 6396.0 6540.8 6601.6 6730.7 1749.8 1754.8 1755.8 1765.4 1768.8 1183.8 1208.6 1218.9 1229.2 1243.0 5692.9 5706.5 5821.7 5835.1 5840.6 6844.6 6866.5 6906.7 6917.2 6933.9 5766.8 5802.4 5816.9 5843.9 5874.8 3571.5 3613.8 3651.7 3657.7 3676.1 6487.6 6518.5 6585.0 6595.0 6640.6 6832.4 6917.4 6932.7 6945.2 7043.0 6443.2 6443.4 6519.7 6524.6 6525.0 6629.2 6715.6 6722.7 6755.4 6776.2 6600.8 6647.8 6662.2 6717.6 6740.3 6274.5 6329.8 6349.4 6405.7 6479.0 4920.4 4930.3 4942.9 4953.8 4962.7 5960.6 6571.7 6665.0 6712.0 6744.6 6483.5 6549.1 6553.2 6584.3 6629.5 6496.5 6504.9 6576.4 6619.0 6635.2 6364.3 6469.8 6543.8 6598.0 6616.5 6650.3 6662.2 6690.8 6708.7 6729.6 6361.2 6384.4 6414.6 6477.0 6530.7 07:03:56 INFO - PID 19956 | 07:03:56 INFO - PID 19956 | [#5] yui.html Cycles:180 Average:24964.21 Median:19620.25 stddev:35658.40 (181.7%) stddev-sans-first:35712.64 07:03:56 INFO - PID 19956 | Values: 894.8 910.4 913.8 917.8 923.0 19186.8 19261.9 20111.1 20239.5 20275.6 22192.4 22250.7 22297.8 22318.3 22449.3 1002.3 1011.7 1012.4 1022.6 1024.5 729.7 749.6 967.8 988.3 997.3 1060.9 1061.5 1062.2 1064.5 1069.0 1050.1 1051.1 1056.0 1063.4 1063.5 770.3 770.5 776.5 779.9 782.4 20298.8 20310.2 20491.6 20493.4 20535.0 21569.5 22055.8 22118.7 22183.8 22216.3 16671.5 16964.2 16979.9 17013.2 17142.5 3702.0 3732.3 3807.1 3815.2 3844.3 140665.3 142532.0 143313.0 145227.3 145447.0 16697.2 16781.3 16832.9 16983.2 17028.6 31097.0 31126.5 31747.4 31805.4 31919.5 8809.7 8897.3 8925.1 8928.5 8931.2 3557.1 4316.7 4364.7 4434.8 4436.3 4589.4 5978.1 6105.3 6144.5 6144.5 1125.7 1160.7 1180.8 1184.8 1187.3 675.4 694.7 695.6 714.0 720.2 12460.2 12521.8 12757.9 13153.5 13168.0 715.4 715.9 719.7 723.7 729.6 5669.4 5808.6 5903.4 5946.1 5972.2 118594.0 118820.0 120328.4 124411.4 125353.4 109153.5 110206.0 111958.4 113339.4 116463.4 93368.5 93748.5 94822.0 97089.0 97147.5 10386.9 10617.1 10813.0 10830.5 10863.7 42210.6 43722.6 44054.8 44411.6 44571.3 55397.0 56808.7 56925.4 57120.4 59458.0 15579.6 15833.1 15910.8 15975.6 16003.4 16316.4 17855.4 18002.5 18162.9 19978.6 18322.8 18328.4 18344.7 18396.4 18561.3 17541.6 17630.5 17639.2 17831.0 17864.8 18056.6 18154.8 18218.7 18335.9 18440.6 12699.1 13190.9 13310.1 13447.5 13488.5 13484.3 13549.8 13572.5 13673.7 13712.6 07:03:56 INFO - PID 19956 | -------- Summary: end -------- 07:03:56 INFO - PID 19956 | 07:03:57 INFO - TEST-INFO | 19956: exit 0 07:03:57 INFO - TEST-OK | dromaeo_css | took 1108156ms 07:03:57 INFO - TEST-START | kraken 07:03:57 INFO - Initialising browser for kraken test... 07:03:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37287/getInfo.html -profile /tmp/tmpJYHDvK/profile 07:03:57 INFO - TEST-INFO | started process 20327 (/builds/slave/test/build/application/firefox/firefox http://localhost:37287/getInfo.html) 07:04:02 INFO - TEST-INFO | 20327: exit 0 07:04:02 INFO - Browser initialized. 07:04:02 INFO - Running cycle 1/1 for kraken test... 07:04:02 INFO - Using env: {'DISPLAY': ':0', 07:04:02 INFO - 'HOME': '/home/cltbld', 07:04:02 INFO - 'JSGC_DISABLE_POISONING': '1', 07:04:02 INFO - 'LANG': 'en_US.UTF-8', 07:04:02 INFO - 'LANGUAGE': 'en_US:en', 07:04:02 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:04:02 INFO - 'LOGNAME': 'cltbld', 07:04:02 INFO - 'MAIL': '/var/mail/cltbld', 07:04:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:04:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:04:02 INFO - 'MOZ_CRASHREPORTER': '1', 07:04:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:04:02 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:04:02 INFO - 'MOZ_NO_REMOTE': '1', 07:04:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:04:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:04:02 INFO - 'NO_EM_RESTART': '1', 07:04:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:04:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:04:02 INFO - 'PWD': '/builds/slave/test', 07:04:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:04:02 INFO - 'RUST_BACKTRACE': 'full', 07:04:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:04:02 INFO - 'SHELL': '/bin/bash', 07:04:02 INFO - 'SHLVL': '1', 07:04:02 INFO - 'STYLO_FORCE_DISABLED': '1', 07:04:02 INFO - 'TERM': 'linux', 07:04:02 INFO - 'TMOUT': '86400', 07:04:02 INFO - 'USER': 'cltbld', 07:04:02 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954', 07:04:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:04:02 INFO - '_': '/tools/buildbot/bin/python'} 07:04:02 INFO - TEST-INFO | started process 20564 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJYHDvK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:03 INFO - PID 20564 | 07:04:03 INFO - PID 20564 | (/builds/slave/test/build/application/firefox/firefox:20613): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:04:03 INFO - PID 20564 | 07:04:13 INFO - PID 20564 | RSS: Main: 153710592 07:04:13 INFO - PID 20564 | 07:04:16 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37287/tests/kraken/driver.html?testName=audio-beat-detection) 07:04:17 INFO - PID 20564 | RSS: Main: 158928896 07:04:17 INFO - PID 20564 | 07:04:19 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37287/tests/kraken/driver.html?testName=audio-dft) 07:04:20 INFO - PID 20564 | RSS: Main: 159391744 07:04:20 INFO - PID 20564 | 07:04:23 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37287/tests/kraken/driver.html?testName=audio-fft) 07:04:23 INFO - PID 20564 | RSS: Main: 156389376 07:04:23 INFO - PID 20564 | 07:04:26 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37287/tests/kraken/driver.html?testName=audio-oscillator) 07:04:26 INFO - PID 20564 | RSS: Main: 156835840 07:04:26 INFO - PID 20564 | 07:04:28 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:04:29 INFO - PID 20564 | RSS: Main: 156721152 07:04:29 INFO - PID 20564 | 07:04:32 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37287/tests/kraken/driver.html?testName=imaging-darkroom) 07:04:33 INFO - PID 20564 | RSS: Main: 160018432 07:04:33 INFO - PID 20564 | 07:04:36 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37287/tests/kraken/driver.html?testName=imaging-desaturate) 07:04:37 INFO - PID 20564 | RSS: Main: 159551488 07:04:37 INFO - PID 20564 | 07:04:40 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37287/tests/kraken/driver.html?testName=json-parse-financial) 07:04:41 INFO - PID 20564 | RSS: Main: 159801344 07:04:41 INFO - PID 20564 | 07:04:42 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:04:43 INFO - PID 20564 | RSS: Main: 159645696 07:04:43 INFO - PID 20564 | 07:04:44 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:04:45 INFO - PID 20564 | RSS: Main: 159453184 07:04:45 INFO - PID 20564 | 07:04:47 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:04:48 INFO - PID 20564 | RSS: Main: 156647424 07:04:48 INFO - PID 20564 | 07:04:50 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:04:51 INFO - PID 20564 | RSS: Main: 156303360 07:04:51 INFO - PID 20564 | 07:04:54 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:04:54 INFO - PID 20564 | RSS: Main: 156917760 07:04:54 INFO - PID 20564 | 07:04:56 INFO - PID 20564 | Cycle 1(1): loaded http://localhost:37287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37287/tests/kraken/driver.html?testName=ai-astar) 07:04:57 INFO - PID 20564 | RSS: Main: 158040064 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | __start_tp_report 07:04:57 INFO - PID 20564 | _x_x_mozilla_page_load 07:04:57 INFO - PID 20564 | _x_x_mozilla_page_load_details 07:04:57 INFO - PID 20564 | |i|pagename|runs| 07:04:57 INFO - PID 20564 | |0;ai-astar;109;109;108;107;108;110;107;109;107;108 07:04:57 INFO - PID 20564 | |1;audio-beat-detection;116;120;116;120;118;114;118;120;116;140 07:04:57 INFO - PID 20564 | |2;audio-dft;165;164;162;166;163;163;161;169;166;164 07:04:57 INFO - PID 20564 | |3;audio-fft;74;74;74;75;74;75;75;74;76;74 07:04:57 INFO - PID 20564 | |4;audio-oscillator;80;83;90;79;80;80;79;79;79;80 07:04:57 INFO - PID 20564 | |5;imaging-gaussian-blur;114;114;113;114;113;115;114;115;114;115 07:04:57 INFO - PID 20564 | |6;imaging-darkroom;148;147;148;148;148;148;147;148;149;148 07:04:57 INFO - PID 20564 | |7;imaging-desaturate;96;94;94;97;93;98;98;99;99;94 07:04:57 INFO - PID 20564 | |8;json-parse-financial;53;53;54;53;55;54;53;53;52;51 07:04:57 INFO - PID 20564 | |9;json-stringify-tinderbox;37;38;37;38;38;38;38;38;37;38 07:04:57 INFO - PID 20564 | |10;stanford-crypto-aes;72;73;73;73;78;73;76;75;73;76 07:04:57 INFO - PID 20564 | |11;stanford-crypto-ccm;111;116;115;115;119;114;110;113;112;113 07:04:57 INFO - PID 20564 | |12;stanford-crypto-pbkdf2;191;172;169;172;176;180;170;171;174;186 07:04:57 INFO - PID 20564 | |13;stanford-crypto-sha256-iterative;71;68;65;66;67;69;66;66;65;67 07:04:57 INFO - PID 20564 | __end_tp_report 07:04:57 INFO - PID 20564 | __start_cc_report 07:04:57 INFO - PID 20564 | _x_x_mozilla_cycle_collect,724 07:04:57 INFO - PID 20564 | __end_cc_report 07:04:57 INFO - PID 20564 | __startTimestamp1505916297013__endTimestamp 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | ------- Summary: start ------- 07:04:57 INFO - PID 20564 | Number of tests: 14 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#0] ai-astar Cycles:10 Average:108.20 Median:108.50 stddev:1.03 (1.0%) stddev-sans-first:1.05 07:04:57 INFO - PID 20564 | Values: 109.0 109.0 108.0 107.0 108.0 110.0 107.0 109.0 107.0 108.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:119.00 stddev:7.39 (6.2%) stddev-sans-first:7.71 07:04:57 INFO - PID 20564 | Values: 116.0 120.0 116.0 120.0 118.0 114.0 118.0 120.0 116.0 140.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.31 (1.4%) stddev-sans-first:2.44 07:04:57 INFO - PID 20564 | Values: 165.0 164.0 162.0 166.0 163.0 163.0 161.0 169.0 166.0 164.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#3] audio-fft Cycles:10 Average:74.50 Median:74.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 07:04:57 INFO - PID 20564 | Values: 74.0 74.0 74.0 75.0 74.0 75.0 75.0 74.0 76.0 74.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#4] audio-oscillator Cycles:10 Average:80.90 Median:80.00 stddev:3.41 (4.3%) stddev-sans-first:3.61 07:04:57 INFO - PID 20564 | Values: 80.0 83.0 90.0 79.0 80.0 80.0 79.0 79.0 79.0 80.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 07:04:57 INFO - PID 20564 | Values: 114.0 114.0 113.0 114.0 113.0 115.0 114.0 115.0 114.0 115.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:04:57 INFO - PID 20564 | Values: 148.0 147.0 148.0 148.0 148.0 148.0 147.0 148.0 149.0 148.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:97.50 stddev:2.30 (2.4%) stddev-sans-first:2.44 07:04:57 INFO - PID 20564 | Values: 96.0 94.0 94.0 97.0 93.0 98.0 98.0 99.0 99.0 94.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:53.00 stddev:1.10 (2.1%) stddev-sans-first:1.17 07:04:57 INFO - PID 20564 | Values: 53.0 53.0 54.0 53.0 55.0 54.0 53.0 53.0 52.0 51.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#9] json-stringify-tinderbox Cycles:10 Average:37.70 Median:38.00 stddev:0.48 (1.3%) stddev-sans-first:0.44 07:04:57 INFO - PID 20564 | Values: 37.0 38.0 37.0 38.0 38.0 38.0 38.0 38.0 37.0 38.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#10] stanford-crypto-aes Cycles:10 Average:74.20 Median:74.00 stddev:1.93 (2.6%) stddev-sans-first:1.88 07:04:57 INFO - PID 20564 | Values: 72.0 73.0 73.0 73.0 78.0 73.0 76.0 75.0 73.0 76.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:114.50 stddev:2.62 (2.3%) stddev-sans-first:2.57 07:04:57 INFO - PID 20564 | Values: 111.0 116.0 115.0 115.0 119.0 114.0 110.0 113.0 112.0 113.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:175.00 stddev:7.36 (4.2%) stddev-sans-first:5.48 07:04:57 INFO - PID 20564 | Values: 191.0 172.0 169.0 172.0 176.0 180.0 170.0 171.0 174.0 186.0 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.89 (2.8%) stddev-sans-first:1.33 07:04:57 INFO - PID 20564 | Values: 71.0 68.0 65.0 66.0 67.0 69.0 66.0 66.0 65.0 67.0 07:04:57 INFO - PID 20564 | -------- Summary: end -------- 07:04:57 INFO - PID 20564 | 07:04:57 INFO - PID 20564 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:04:57 INFO - TEST-INFO | 20564: exit 0 07:04:57 INFO - TEST-OK | kraken | took 60635ms 07:04:57 INFO - SUITE-END | took 1168s 07:04:58 INFO - Completed test suite (00:19:29) 07:04:58 INFO - javascript benchmark 07:04:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8590.661345923629, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.5643809866615, 3134.7335476484504, 3136.3256899766548, 3140.1678555182866, 3172.873085076597, 6390.4887608991285, 6434.0670602762575, 6463.289038205806, 6464.8060558183215, 6490.513211509132, 6258.687065646711, 6342.460890824285, 6379.330170332107, 6394.232692076957, 6425.775097871576, 5817.970910145444, 5825.30096388434, 5919.052951527757, 5923.792667256647, 6013.428724271187, 5959.70201489926, 5996.070609055581, 6006.8798624027495, 6032.215811944463, 6059.272887253535, 5774.711264436783, 5824.737886795062, 5953.732082056296, 5954.345022047572, 6038.396160383971, 5811.912821307684, 5896.233489646319, 5930.0, 5967.43309385612, 5988.880222395571, 5860.150278209679, 5873.85315367115, 5924.7333869975955, 5963.194968679216, 5973.731182096816, 6274.403931626488, 6275.780347687809, 6329.8417539561415, 6330.050492426127, 6341.460975817061, 6848.14398200225, 6922.238553759083, 6923.757668481579, 6924.376806087426, 6936.34104760047, 6898.379145876845, 6928.44572434204, 6960.443164546824, 6975.441964642816, 6979.511434199608, 6361.141245931786, 6389.0, 6408.839779005515, 6465.903011454832, 6495.707693153772, 6947.062146610244, 7048.977898204834, 7061.611611361424, 7083.468739844532, 7155.212926578072, 6694.665266736643, 6706.0, 6715.227748808852, 6727.62998035103, 6737.191537015589, 6724.495662825308, 6726.192856857208, 6779.389854913082, 6824.522283440211, 6828.726850926007, 6699.497537684693, 6755.560888542229, 6797.354251346114, 6838.316168383122, 6848.931510684929, 6914.274001229798, 6943.097397338313, 6974.476914231453, 6977.0, 6985.301469853076, 5319.521243088063, 5395.325584301962, 5452.182172674131, 5456.91814622781, 5468.9726551367785, 4628.143793398232, 4632.536746325341, 4632.652551058684, 4632.907341853144, 4646.697964632355, 5860.794872179454, 5861.3552509223955, 5862.384449632812, 5862.472377486047, 5867.471927526543, 6810.5913645181445, 6814.761483348059, 6820.624865632339, 6821.658917054127, 6822.692978815965, 5762.855928601734, 5802.0426629605645, 5845.824625261249, 5851.882962340729, 5868.706564671835, 5834.154047663065, 5840.3575606683235, 5899.321578018583, 5979.5515336349945, 5991.161237426763, 6594.175728033996, 6614.371634694697, 6684.83287917806, 6687.398134167948, 6698.263191048981, 6913.827154321182, 6923.9653801730665, 6985.126859142607, 7002.4398048157045, 7018.789436317021, 6411.6794160290865, 6554.80335589933, 6562.639054852029, 6567.704453299518, 6570.770023049362, 6716.966415167893, 6727.125473688389, 6731.596104233761, 6807.829804254735, 6841.281665425058, 6982.860342793014, 6995.615241161785, 7030.0, 7035.0150978861975, 7040.366367026787, 6681.1314529110905, 6696.363845434676, 6705.22889867652, 6784.21981472137, 6790.049393084873, 6542.34576542342, 6628.304028077176, 6654.534182607171, 6669.199696036507, 6754.425873800782, 6588.40704336612, 6623.668816559057, 6643.302453242533, 6677.0, 6685.966570167118, 6733.057371968026, 6743.52795304324, 6765.086713293839, 6795.966020169867, 6840.213375461686, 6463.450606698483, 6503.869922601427, 6563.0, 6566.8358291043105, 6576.539642224999], "value": 6249.114105978788, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.9088695686953, 895.3642913531393, 895.6238379880451, 896.2202883491364, 897.4211633496395, 38680.613193868056, 42073.0, 42107.78946105273, 42260.15479690404, 42277.577224227745, 38371.23257534855, 38519.807400962956, 38741.0, 38771.612283877155, 38811.0, 7190.532615379997, 7303.598302093383, 7307.451941104412, 7343.669534870917, 7356.411487081047, 7207.495475316704, 7302.1967583565765, 7313.085864266966, 7320.304571065741, 7322.707091716325, 7278.81802954925, 7303.050603421548, 7323.560586364809, 7335.083114610674, 7338.6697598607925, 7784.805379865492, 7986.6805327786815, 8013.2387423194705, 8016.238457346542, 8026.117127116013, 7859.174786647377, 7962.163972782832, 7981.401394895406, 7982.161873003367, 7997.200279972015, 38142.23715525674, 38327.233455331014, 38596.421053684215, 38597.42103868444, 38817.223655527014, 3500.194955160302, 3553.928921421557, 3575.249197668493, 3577.713782897362, 3579.713622910161, 32350.838245808856, 32448.675513245038, 32557.51163732546, 32581.674183258103, 32608.184795380068, 5183.974080129575, 5185.377754669464, 5213.113770658997, 5220.686758794484, 5259.289995850588, 194638.0, 195858.0, 196376.0, 196853.01573492185, 197001.0, 41043.589564103975, 41806.1638767223, 46946.29580556294, 47023.52976470192, 48420.75789621029, 50392.74803625958, 50457.495425046014, 50490.0, 50507.74746126319, 50739.0, 15927.283272252776, 15978.280977355815, 16091.195440227943, 16110.919445402933, 16120.0, 13264.0, 13284.667883302995, 13286.0, 13302.201867887958, 13327.866721332857, 13577.0, 13616.591502254949, 13653.86346136526, 13667.658308542168, 13767.518136865361, 5678.801241956512, 5708.400617935057, 5787.623804452782, 5818.0981947798155, 5847.415258474203, 1036.7563622548696, 1038.4651904269308, 1044.9425281609585, 1044.9791004179874, 1053.8629978102797, 23541.646875296883, 23708.762912371, 23779.0, 23976.56733398525, 24109.276721698378, 1143.8455808465917, 1148.2134737704698, 1151.3667482884548, 1158.449736375215, 1160.2922217447351, 12288.262704237774, 12532.561360352527, 12757.808632870514, 12816.615501534969, 12838.0, 235467.0, 238331.0, 238430.0, 238973.0, 239555.0, 53040.469595303555, 53157.46842531602, 53186.202206966926, 53277.73361133169, 53316.46683533193, 1425.9215743134228, 1449.7970284160438, 1493.529538195465, 1493.6191271225985, 1496.6034000989746, 23071.88464057669, 23124.190653327052, 23191.0, 23192.4201894954, 23324.883375583693, 37693.246135077694, 37750.43374349332, 37804.43293350547, 37827.62172378351, 37955.81022094872, 201240.0, 201248.0, 201668.0, 201889.0, 201927.0, 29857.0, 30003.0, 30051.849740751157, 30179.0, 33291.334173316885, 35536.822315888254, 38557.42163867488, 43245.0, 43394.78302608467, 44036.0, 32250.516242256854, 32445.675543244266, 32983.01050968475, 33018.33963320768, 33046.17384565405, 31533.8423307882, 31886.52170217495, 31956.840215798773, 32545.674543254263, 32551.511727323636, 35172.47241291332, 35336.823315884285, 35494.29011419809, 35877.0, 35962.46056309105, 31265.374692506477, 31347.373052538365, 31516.52725209078, 31537.8423107883, 31708.84145579257, 22377.216797412013, 23127.537449251256, 23729.0, 23894.761052389254, 24239.75760242375], "value": 17120.44755779667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.8146011816101, 569.3054473542277, 581.183437270635, 591.2018774654217, 599.1372423709857, 22093.558128837434, 22985.4253643659, 23036.424089397773, 23090.538189236227, 23132.074717011343, 23591.41021474464, 23791.04835806566, 23985.880070599622, 24110.517789644196, 24207.152749653767, 6276.309605943354, 6368.936310636904, 6403.679816009181, 6413.198350206224, 6423.261324947621, 6173.876522469548, 6300.810975670737, 6377.776777812777, 6386.393292637192, 6438.581492203015, 6408.295087540367, 6428.550001499897, 6438.5171112166545, 6455.806325810233, 6458.612483250997, 6177.969110154466, 6448.0, 6451.741930322782, 6457.2896981332015, 6458.870822583522, 5917.556183286228, 5958.7616495340135, 5960.0761881908375, 5964.671943043131, 5966.701664916737, 27812.860935695393, 28208.858955705295, 28218.435631287466, 28428.28929276764, 28504.857475712488, 1994.7905469925738, 2028.1076326416478, 2039.479932617188, 2043.9182432702673, 2044.8977551122384, 18492.907535462236, 18652.626947460976, 19206.0, 19226.423207303804, 19277.421677349703, 2423.7333893271725, 2446.0949448703914, 2473.4682043360763, 2473.666055082577, 2477.5168842075805, 138181.30909345488, 146554.0, 146953.2652336742, 147373.0, 147388.0522389546, 14303.642408939651, 14465.49370772039, 14549.563513094625, 14738.852611473962, 14765.852341476662, 22494.100235990703, 22591.435214119778, 22643.43391415195, 22657.093716251165, 22750.08999639996, 9475.952620236854, 9640.276979226586, 9913.504324783731, 10027.09756121938, 10243.84634230487, 9260.610908363664, 9280.7679808004, 9317.16145546904, 9444.8583271251, 9445.386049906734, 8705.695300664447, 8878.689245876363, 8919.197272245528, 9036.728898133066, 9171.174594286545, 2633.85513796743, 2646.563317052703, 2648.4173481833964, 2684.885293515855, 2774.736400041993, 948.4451595816524, 958.547800082875, 958.8705524754208, 968.1045033344269, 978.1636700620867, 18560.350387736635, 18863.81136188648, 18883.244670213036, 19013.714794278098, 19068.237270509024, 1016.4409574733867, 1027.1012863744224, 1030.9278350515392, 1037.766502536923, 1038.8026275007724, 10343.534540945675, 10381.117605003508, 10494.422806745702, 10641.840372394265, 10739.409332486632, 492253.0, 496640.0, 501474.0, 503520.0, 519178.0, 108946.0, 110593.0, 112021.43989280002, 112218.43890780494, 112278.0, 1160.9825852612219, 1172.6482055383522, 1192.7554851255472, 1199.9520019199308, 1201.1651901928076, 16289.755653664968, 16692.41576544815, 16827.892480720056, 16859.0, 17204.397846075328, 55338.16992745193, 55732.72133639306, 56143.71928140333, 56588.0, 57606.71196644157, 65368.0, 65697.67151164214, 68188.6590567044, 68643.0, 70072.29927700658, 13585.932070339584, 13859.237741924291, 13931.58205253844, 13973.580792576238, 14009.789853152415, 21527.0, 21577.136914523242, 21650.35048948534, 21678.132874684838, 21915.561688765818, 17473.0, 17522.123893805005, 17659.38192163268, 17775.0, 17798.733019004983, 15647.295871685574, 15687.764683529527, 15903.443379481663, 16201.75697364517, 16314.102724350274, 17542.0, 17755.289788408318, 18106.0, 18214.90892545529, 18264.99542525174, 13618.93190534041, 13718.519851805138, 13723.833474154808, 13745.450181993008, 13818.723625527635, 17245.741313880553, 17381.478555643353, 17432.651346972736, 17529.737053944456, 17693.292268309637], "value": 11684.185166228823, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.9195448273103, 1426.3367534096642, 1433.8422773494913, 1440.330246435408, 1440.3878351700525, 15038.849611503882, 15661.686766264667, 15668.686626267468, 15678.137702426362, 15679.372825086997, 15204.771928421083, 15361.231938403063, 15365.539033829004, 15386.61533461664, 15401.152936588483, 2656.760891519763, 2790.079273839638, 2796.5385711357603, 2800.7339302766204, 2800.845953472558, 2771.3071732066983, 2798.3563780330537, 2855.543113101904, 2859.4281143771227, 2860.156253905103, 2834.1780883543747, 2850.073726039035, 2856.828590284579, 2860.2992266894535, 2860.6567211934494, 2750.22993561803, 2780.638516992788, 2781.582762585618, 2782.9721702782917, 2783.4433113377204, 2684.7583717465327, 2689.731026897314, 2706.1069846950654, 2711.3357227479396, 2722.8502432366213, 15102.848971510364, 15210.619734506727, 15220.619484512865, 15221.31504082319, 15243.771343429857, 8164.0, 8168.795780105485, 8502.979642442884, 8503.064662887078, 8505.489670619721, 5704.458076482769, 5824.213731146283, 5825.592208545403, 5849.502792262663, 5916.792912248051, 1919.8368138708227, 1950.8634395592314, 1951.5655992845248, 1995.7704863940687, 2019.2225992992658, 26521.602175967182, 26921.59617605757, 26943.461130777276, 26969.325766855985, 26979.46041079187, 6794.932050679528, 6904.551204171813, 7007.4394048476, 7057.647117644097, 7100.2899710029615, 17559.0, 17575.472735817944, 17621.383251586132, 17649.294028238983, 17665.11674416274, 7825.100113487022, 8108.148644392372, 8124.390670699721, 8124.431289809657, 8134.918650813534, 7244.782656520313, 7458.0, 7494.40044796415, 7666.65500052499, 7672.424568157299, 5328.547073498796, 5353.4646535346155, 5361.329833770778, 5441.673499589958, 5467.480589344006, 1575.3619783987504, 1586.952391428259, 1587.1508742822766, 1597.0, 1622.6430185359202, 888.5779254853893, 903.3134817538718, 906.0712769411274, 907.1654078247896, 913.8766266554063, 7799.961000194962, 7805.219478052263, 7812.765617031499, 7899.0, 7902.960485197652, 719.5285640864445, 722.6567380494223, 729.8430837369991, 732.8827387617955, 741.1809950005166, 4874.829380971649, 5465.890682186334, 5534.972325138348, 5538.418466061086, 5611.130274807411, 21190.78809211919, 22079.33761987143, 22197.334079977627, 22258.0, 22283.331500055025, 21823.890880545812, 22252.88873555622, 22662.433439164153, 22667.433314167276, 22695.886520567623, 11623.76752464963, 11705.999999999829, 11715.472803723853, 11727.824082638766, 11746.471408786625, 8546.615402307036, 8619.267362274277, 8674.349423793366, 8727.30181585459, 8746.562671866508, 18261.452156435327, 18877.811221887605, 18909.810901891356, 19069.0, 19346.903265483583, 19703.60592788165, 19726.802731972497, 19752.802471975097, 20182.596348072664, 20353.898230508752, 10884.61903833362, 11112.333260004425, 11204.66386008421, 11206.159538034517, 11209.383483908463, 13924.234167120905, 14121.576352709435, 14124.576262712135, 14126.646833829236, 14136.858631413965, 11339.149563782914, 11391.943040284745, 11470.598529051444, 11539.134564907497, 11927.045836333245, 10872.347659140476, 11083.279586826831, 11091.279066860629, 11268.887311127111, 11382.772344553228, 9553.47455889905, 9797.608095676092, 9824.21406287481, 9830.262730295113, 9841.507924603598, 7092.432605391453, 7146.071010768567, 7206.603636800026, 7219.0976127984, 7291.8541629168185, 7520.586367749826, 7740.535567865946, 7822.843543128992, 7832.373410127062, 7863.174366691415], "value": 6775.733875304545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.2260130699377, 505.66878694455136, 531.0944839049421, 533.8131653921125, 536.9355677318722, 6281.403266689663, 6353.428191462767, 6396.96801515993, 6432.614043157408, 6478.125453063835, 6156.692165391735, 6240.032794916784, 6241.563090583661, 6336.45158711121, 6399.648019358945, 4963.851084467472, 5079.4412614612365, 5080.542751152396, 5116.386033675964, 5148.74256287186, 5080.644354895159, 5083.551892094418, 5090.778213228817, 5102.1836506159025, 5120.871978200556, 5013.824516141935, 5063.468335824722, 5083.949160508403, 5108.412532558747, 5123.769430375642, 5040.521150490716, 5047.9747601262125, 5060.114479965991, 5074.162763144077, 5120.0, 4541.296099104644, 4542.523035081335, 4552.863414097583, 4580.198465268598, 4580.335851301543, 6235.469985051276, 6272.905906411407, 6277.748890044393, 6298.464630506367, 6311.147995020659, 5735.655860648374, 5740.196372507852, 5782.392848750863, 5793.073108302651, 5794.623349482313, 6545.770898018546, 6553.868922621521, 6579.440747536465, 6584.9012264816065, 6643.103181070542, 4924.374956264424, 4941.295253137661, 4946.8763280918265, 4960.751962401865, 4961.156603377434, 6959.19969203543, 6983.301669832976, 6999.790006299768, 7066.929330706678, 7096.893546596805, 5009.323741294951, 5026.547610715053, 5043.193089105799, 5046.39443266803, 5096.719680417538, 5139.383274007068, 5146.0, 5163.328767260307, 5179.689218646818, 5194.4805519447755, 5675.829725108253, 5799.536037117021, 5816.796412125555, 5817.418258174149, 5835.562332825055, 6326.778562750374, 6396.0, 6540.771073012517, 6601.603903765789, 6730.697118629673, 1749.8162692917315, 1754.7716598381185, 1755.806861245262, 1765.3556451894965, 1768.8054314025446, 1183.8401815754935, 1208.6434501821984, 1218.9268643881396, 1229.1948773553158, 1242.9875701243052, 5692.861427714473, 5706.457886500776, 5821.679807610537, 5835.124731290255, 5840.649561026352, 6844.589324640438, 6866.519343645997, 6906.689198986058, 6917.169939607279, 6933.930660693329, 5766.8269951900675, 5802.390748971297, 5816.941830581724, 5843.912341314884, 5874.825034993019, 3571.5357003589365, 3613.7831730095754, 3651.653092956165, 3657.743957922973, 3676.1361080146144, 6487.610743355413, 6518.543701940914, 6584.967075164594, 6595.01074838778, 6640.63476508787, 6832.419244364185, 6917.371398868398, 6932.7226910923, 6945.201301850352, 7042.964785176041, 6443.194600674916, 6443.387878151568, 6519.706613202417, 6524.608523488606, 6524.999999999905, 6629.2376376715365, 6715.630640314829, 6722.697478613376, 6755.399171318979, 6776.2207346153855, 6600.768973085919, 6647.767328143492, 6662.233843108104, 6717.630530320879, 6740.258571557027, 6274.46667033289, 6329.810105696836, 6349.3650634937985, 6405.7117429714845, 6479.0, 4920.384951881015, 4930.285108659296, 4942.92585611209, 4953.786322351047, 4962.741952411716, 5960.5827592068135, 6571.671416429063, 6665.0, 6711.9995603275875, 6744.5616034957575, 6483.513736469689, 6549.075618501666, 6553.246376666744, 6584.308647592125, 6629.5359324846795, 6496.545241833215, 6504.869902601827, 6576.408123268929, 6618.966905165444, 6635.2037755469655, 6364.331745166691, 6469.77355792545, 6543.836404089745, 6597.954634063456, 6616.470682345497, 6650.334966503311, 6662.200535935719, 6690.832729181615, 6708.731650733916, 6729.629870357177, 6361.173047503795, 6384.425401713868, 6414.61512309263, 6476.967615161894, 6530.701995492246], "value": 5105.182064396085, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.8255090257402, 910.4446287764465, 913.8355096082706, 917.8256131335044, 922.97692557686, 19186.80813191871, 19261.903690481544, 20111.095000724985, 20239.49401264969, 20275.594488110248, 22192.445188870286, 22250.666240006412, 22297.777022229813, 22318.330450086483, 22449.32652020438, 1002.2810879341945, 1011.6560369474378, 1012.3622118065608, 1022.5551884930079, 1024.4826362686833, 729.7008226627084, 749.6439191384076, 967.7774111954254, 988.3131223799462, 997.326804407026, 1060.8833028366873, 1061.5010944855906, 1062.1768129699506, 1064.5156453813536, 1068.9518971646294, 1050.1179009631946, 1051.1328154272717, 1055.973600659982, 1063.393865496667, 1063.4523220541428, 770.2528547309157, 770.4914756260897, 776.4836383804819, 779.949303295284, 782.4131901074194, 20298.797012029838, 20310.187592496284, 20491.59016819655, 20493.38519844407, 20535.0, 21569.46076348088, 22055.779442205694, 22118.668219976713, 22183.778162218332, 22216.333509994725, 16671.49985500437, 16964.236609352607, 16979.91510042442, 17013.23440445183, 17142.485725428258, 3701.9629803701887, 3732.253549290153, 3807.1053302473897, 3815.179736356669, 3844.308024555579, 140665.296673517, 142532.0, 143313.0, 145227.27386363212, 145447.0, 16697.165141743106, 16781.328746849988, 16832.915835420743, 16983.150842457828, 17028.57428564271, 31097.0, 31126.533102003035, 31747.365052698817, 31805.363892722016, 31919.52120718191, 8809.735707928772, 8897.332700047393, 8925.062868398854, 8928.508932008803, 8931.240844528158, 3557.092941299952, 4316.676249281317, 4364.650827933821, 4434.800433980478, 4436.26801577736, 4589.403377560896, 5978.133170690313, 6105.267367915879, 6144.477719393813, 6144.477719393902, 1125.6960620632383, 1160.651804458676, 1180.816973369129, 1184.7630473905253, 1187.2935603316187, 675.4258879952001, 694.7429451103023, 695.5965539986795, 713.989290160648, 720.1682057223915, 12460.190087644274, 12521.812172817416, 12757.872421275853, 13153.473861045451, 13168.0, 715.3597530210433, 715.8818794898888, 719.6833393306928, 723.6562632749507, 729.5586170366958, 5669.40471250521, 5808.564357673192, 5903.409659034062, 5946.10808378738, 5972.193753843262, 118594.0, 118820.0, 120328.39835800765, 124411.3779431097, 125353.37323313326, 109153.45423272833, 110206.0, 111958.44020779844, 113339.4333028346, 116463.41768291274, 93368.53315733378, 93748.53125734327, 94822.0, 97089.0, 97147.51426242823, 10386.896131038593, 10617.097546708615, 10813.0, 10830.51262693165, 10863.728406789893, 42210.57789422067, 43722.562774373124, 44054.779726102446, 44411.55588444074, 44571.331430029226, 55397.0, 56808.715956419954, 56925.43074569367, 57120.42879571151, 59458.0, 15579.610509736895, 15833.129177895325, 15910.840891590937, 15975.600609984844, 16003.439879604159, 16316.42892498757, 17855.37506187277, 18002.5499362517, 18162.909185453987, 19978.60042799165, 18322.816771832644, 18328.358507452176, 18344.72482912784, 18396.448106556825, 18561.25754969786, 17541.649167016843, 17630.471085867444, 17639.206235719168, 17831.0, 17864.821351786315, 18056.638867222846, 18154.81845181584, 18218.72671909896, 18335.90832045831, 18440.631187376446, 12699.111062225555, 13190.868091318964, 13310.068295219242, 13447.529336473177, 13488.460461581819, 13484.325783710972, 13549.796753048515, 13572.524961626295, 13673.658158546115, 13712.588622341345], "value": 9294.701084465525, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 109.0, 108.0, 107.0, 108.0, 110.0, 107.0, 109.0, 107.0, 108.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 120.0, 116.0, 120.0, 118.0, 114.0, 118.0, 120.0, 116.0, 140.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 162.0, 166.0, 163.0, 163.0, 161.0, 169.0, 166.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 75.0, 74.0, 75.0, 75.0, 74.0, 76.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 90.0, 79.0, 80.0, 80.0, 79.0, 79.0, 79.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 113.0, 115.0, 114.0, 115.0, 114.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 149.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 94.0, 97.0, 93.0, 98.0, 98.0, 99.0, 99.0, 94.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 55.0, 54.0, 53.0, 53.0, 52.0, 51.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 38.0, 38.0, 38.0, 38.0, 38.0, 37.0, 38.0], "value": 37.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 73.0, 73.0, 78.0, 73.0, 76.0, 75.0, 73.0, 76.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 115.0, 115.0, 119.0, 114.0, 110.0, 113.0, 112.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 172.0, 169.0, 172.0, 176.0, 180.0, 170.0, 171.0, 174.0, 186.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 65.0, 66.0, 67.0, 69.0, 66.0, 66.0, 65.0, 67.0], "value": 67.0, "unit": "score"}]}]} 07:04:58 INFO - Return code: 0 07:04:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:04:58 INFO - # TBPL SUCCESS # 07:04:58 INFO - Running post-action listener: _package_coverage_data 07:04:58 INFO - Running post-action listener: _resource_record_post_action 07:04:58 INFO - [mozharness: 2017-09-20 14:04:58.310211Z] Finished run-tests step (success) 07:04:58 INFO - Running post-run listener: _resource_record_post_run 07:04:58 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 336556032; Read time: 16; Write time: 286140 07:04:58 INFO - TinderboxPrint: CPU usage
13.1% 07:04:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:04:58 INFO - TinderboxPrint: I/O write bytes / time
336,556,032 / 286,140 07:04:58 INFO - TinderboxPrint: CPU idle
8,223.4 (86.9%) 07:04:58 INFO - TinderboxPrint: CPU user
1,192.2 (12.6%) 07:04:58 INFO - TinderboxPrint: Swap in / out
0 / 0 07:04:58 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 9838592; Read time: 0; Write time: 1752 07:04:58 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:04:58 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 326131712; Read time: 0; Write time: 284384 07:04:58 INFO - Running post-run listener: _upload_blobber_files 07:04:58 INFO - Blob upload gear active. 07:04:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:04: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 07:04: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:04: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:04:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:04:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:04:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:02 INFO - (blobuploader) - INFO - Done attempting. 07:05:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 07:05:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 07:05:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:03 INFO - (blobuploader) - INFO - Done attempting. 07:05:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:05:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:05:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:05 INFO - (blobuploader) - INFO - Done attempting. 07:05:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 07:05:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:05:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:05:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 07:05:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:05:05 INFO - (blobuploader) - INFO - Done attempting. 07:05:05 INFO - (blobuploader) - INFO - Iteration through files over. 07:05:05 INFO - Return code: 0 07:05:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:05:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:05:05 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7863ced8b221e8d2bec3ac2fad7e57995cf311aee8db62e086044c72556e796254cad779777ea6f87e61db4c2a1a8bb6e7cd540f8e5d2998a1b573009e6061c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c108b60497037299f11c029b7a0063e353de1f6d1b393f41573b6c297a4bc0cc9c0c1d5d136a96bff09a2030fcfeabc5aea0427820a2af0f65d58c9b1f9a5cb7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/501c5acebe7572045fe9cd290aaf528819c52aca583dce2e279dc46b962b583026d5d90d6668aba5f36cfbbabb99850238695c198d1edd2bf7a9206f6a076e51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/929ae8f6405c0e9c18c2eab00f3f829ab5770be75a908ee55d33a1d6edaaa054bbc834945a4dd2a3c67d3679835483222596ced596fd1a7349ffe069a3e9d279"} 07:05:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:05:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:05:05 INFO - Contents: 07:05:05 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7863ced8b221e8d2bec3ac2fad7e57995cf311aee8db62e086044c72556e796254cad779777ea6f87e61db4c2a1a8bb6e7cd540f8e5d2998a1b573009e6061c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c108b60497037299f11c029b7a0063e353de1f6d1b393f41573b6c297a4bc0cc9c0c1d5d136a96bff09a2030fcfeabc5aea0427820a2af0f65d58c9b1f9a5cb7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/501c5acebe7572045fe9cd290aaf528819c52aca583dce2e279dc46b962b583026d5d90d6668aba5f36cfbbabb99850238695c198d1edd2bf7a9206f6a076e51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/929ae8f6405c0e9c18c2eab00f3f829ab5770be75a908ee55d33a1d6edaaa054bbc834945a4dd2a3c67d3679835483222596ced596fd1a7349ffe069a3e9d279"} 07:05:05 INFO - Running post-run listener: copy_logs_to_upload_dir 07:05:05 INFO - Copying logs to upload dir... 07:05:05 INFO - mkdir: /builds/slave/test/build/upload/logs 07:05:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.260881 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-09-20 07:05:05.663611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:05.666993) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7863ced8b221e8d2bec3ac2fad7e57995cf311aee8db62e086044c72556e796254cad779777ea6f87e61db4c2a1a8bb6e7cd540f8e5d2998a1b573009e6061c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c108b60497037299f11c029b7a0063e353de1f6d1b393f41573b6c297a4bc0cc9c0c1d5d136a96bff09a2030fcfeabc5aea0427820a2af0f65d58c9b1f9a5cb7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/501c5acebe7572045fe9cd290aaf528819c52aca583dce2e279dc46b962b583026d5d90d6668aba5f36cfbbabb99850238695c198d1edd2bf7a9206f6a076e51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/929ae8f6405c0e9c18c2eab00f3f829ab5770be75a908ee55d33a1d6edaaa054bbc834945a4dd2a3c67d3679835483222596ced596fd1a7349ffe069a3e9d279"} build_url:https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/VjX7h9b1Rg6WbANrHaKj3g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7863ced8b221e8d2bec3ac2fad7e57995cf311aee8db62e086044c72556e796254cad779777ea6f87e61db4c2a1a8bb6e7cd540f8e5d2998a1b573009e6061c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c108b60497037299f11c029b7a0063e353de1f6d1b393f41573b6c297a4bc0cc9c0c1d5d136a96bff09a2030fcfeabc5aea0427820a2af0f65d58c9b1f9a5cb7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/501c5acebe7572045fe9cd290aaf528819c52aca583dce2e279dc46b962b583026d5d90d6668aba5f36cfbbabb99850238695c198d1edd2bf7a9206f6a076e51", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/929ae8f6405c0e9c18c2eab00f3f829ab5770be75a908ee55d33a1d6edaaa054bbc834945a4dd2a3c67d3679835483222596ced596fd1a7349ffe069a3e9d279"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:05.698820) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:05.699242) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1505914072.833117-256028954 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-20 07:05:05.781373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:05:05.784869) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-20 07:05:05.785312) ========= ========= Total master_lag: 0.28 =========